-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sat 2024-04-13 15:55:46 CEST. -- Apr 13 15:54:06 volumio volumio[730]: info: CoreCommandRouter::volumioGetState Apr 13 15:54:06 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 13 15:54:06 volumio volumio[730]: info: Listing playlists Apr 13 15:54:06 volumio volumio[730]: info: Listing playlists Apr 13 15:54:13 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 15:54:13 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 15:54:13 volumio volumio[730]: info: Discovery: Getting this device information Apr 13 15:54:13 volumio volumio[730]: info: CoreCommandRouter::volumioGetState Apr 13 15:54:13 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 13 15:54:13 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 15:54:14 volumio volumio[730]: verbose: New Socket.io Connection to 192.168.20.156 from 192.168.20.123 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 7 Apr 13 15:54:16 volumio sudo[24600]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 13 15:54:16 volumio sudo[24600]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 15:54:16 volumio sudo[24600]: pam_unix(sudo:session): session closed for user root Apr 13 15:54:16 volumio sudo[24602]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 13 15:54:16 volumio sudo[24602]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 15:54:16 volumio sudo[24602]: pam_unix(sudo:session): session closed for user root Apr 13 15:54:16 volumio volumio[730]: verbose: New Socket.io Connection to 192.168.20.156 from 192.168.20.123 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 8 Apr 13 15:54:16 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 13 15:54:16 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 13 15:54:16 volumio volumio[730]: info: CoreCommandRouter::volumioGetVisibleSources Apr 13 15:54:16 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 13 15:54:16 volumio volumio[730]: info: CoreCommandRouter::volumioGetState Apr 13 15:54:16 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 13 15:54:16 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 13 15:54:16 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 13 15:54:16 volumio volumio[730]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Apr 13 15:54:16 volumio volumio[730]: info: Received Get System Info Apr 13 15:54:16 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 15:54:16 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 15:54:16 volumio volumio[730]: info: Discovery: Getting this device information Apr 13 15:54:16 volumio volumio[730]: info: CoreCommandRouter::volumioGetState Apr 13 15:54:16 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 13 15:54:16 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 15:54:16 volumio volumio[730]: info: CoreCommandRouter::volumioGetState Apr 13 15:54:16 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 13 15:54:16 volumio volumio[730]: info: Listing playlists Apr 13 15:54:16 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 13 15:54:16 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 13 15:54:16 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 13 15:54:16 volumio volumio[730]: info: CoreCommandRouter::volumioGetState Apr 13 15:54:16 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 13 15:54:18 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 13 15:54:18 volumio volumio[730]: info: Received Get System Info Apr 13 15:54:18 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 15:54:18 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 15:54:18 volumio volumio[730]: info: Discovery: Getting this device information Apr 13 15:54:18 volumio volumio[730]: info: CoreCommandRouter::volumioGetState Apr 13 15:54:18 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 13 15:54:18 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 15:54:19 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 13 15:54:19 volumio volumio[730]: info: Received Get System Info Apr 13 15:54:19 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 15:54:19 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 15:54:19 volumio volumio[730]: info: Discovery: Getting this device information Apr 13 15:54:19 volumio volumio[730]: info: CoreCommandRouter::volumioGetState Apr 13 15:54:19 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 13 15:54:19 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 15:54:20 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 13 15:54:20 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 13 15:54:26 volumio volumio[730]: info: CoreCommandRouter::volumioGetState Apr 13 15:54:26 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 13 15:54:26 volumio volumio[730]: info: Listing playlists Apr 13 15:54:26 volumio volumio[730]: info: Listing playlists Apr 13 15:54:28 volumio volumio[730]: info: Starting Uninstall of plugin user_interface - Systeminfo Apr 13 15:54:28 volumio volumio[730]: info: Uninstalling plugin Systeminfo Apr 13 15:54:28 volumio volumio[730]: info: Disabling plugin Systeminfo Apr 13 15:54:28 volumio volumio[730]: info: Checking if uninstall.sh is present Apr 13 15:54:28 volumio volumio[730]: info: Executing uninstall.sh Apr 13 15:54:28 volumio sudo[24618]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/user_interface/Systeminfo/uninstall.sh Apr 13 15:54:28 volumio sudo[24618]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 15:54:28 volumio sudo[24621]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm /etc/systemd/system/playonconnect.* Apr 13 15:54:28 volumio sudo[24621]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 15:54:28 volumio sudo[24621]: pam_unix(sudo:session): session closed for user root Apr 13 15:54:28 volumio sudo[24618]: pam_unix(sudo:session): session closed for user root Apr 13 15:54:28 volumio volumio[730]: info: Uninstall script completed Apr 13 15:54:28 volumio volumio[730]: info: Removing plugin Systeminfo from configuration Apr 13 15:54:28 volumio volumio[730]: info: Successfully removed Systeminfo configuration files Apr 13 15:54:28 volumio volumio[730]: info: Plugin folders cleanup Apr 13 15:54:28 volumio volumio[730]: info: Scanning into folder /volumio/app/plugins/ Apr 13 15:54:28 volumio volumio[730]: info: Scanning category audio_interface Apr 13 15:54:28 volumio volumio[730]: info: Scanning category miscellanea Apr 13 15:54:28 volumio volumio[730]: info: Scanning category music_service Apr 13 15:54:28 volumio volumio[730]: info: Scanning category plugins.json Apr 13 15:54:28 volumio volumio[730]: info: Scanning category system_controller Apr 13 15:54:28 volumio volumio[730]: info: Scanning category user_interface Apr 13 15:54:28 volumio volumio[730]: info: Scanning into folder /data/plugins/ Apr 13 15:54:28 volumio volumio[730]: info: Scanning category music_service Apr 13 15:54:28 volumio volumio[730]: info: Scanning category user_interface Apr 13 15:54:28 volumio volumio[730]: info: Cleaning folder for Systeminfo Apr 13 15:54:28 volumio volumio[730]: info: Plugin folders cleanup completed Apr 13 15:54:28 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 13 15:54:28 volumio volumio[730]: info: [{"prettyName":"Spotify","name":"spop","category":"music_service","version":"4.0.4","icon":"fa-spotify","isManuallyInstalled":false,"enabled":true,"active":true}] Apr 13 15:54:28 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 13 15:54:34 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 13 15:54:34 volumio volumio[730]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 13 15:54:34 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 13 15:54:34 volumio volumio[730]: info: Received Get System Version Apr 13 15:54:34 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 13 15:54:34 volumio volumio[730]: info: Received Get System Info Apr 13 15:54:34 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 15:54:34 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 15:54:34 volumio volumio[730]: info: Discovery: Getting this device information Apr 13 15:54:34 volumio volumio[730]: info: CoreCommandRouter::volumioGetState Apr 13 15:54:34 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 13 15:54:34 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 15:54:34 volumio volumio[730]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/lastfm/volumio/buster/armhf Apr 13 15:54:36 volumio volumio[730]: info: CoreCommandRouter::volumioGetState Apr 13 15:54:36 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 13 15:54:36 volumio volumio[730]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/lastfm/volumio/buster/armhf Apr 13 15:54:36 volumio volumio[730]: info: Folder /tmp/plugins removed Apr 13 15:54:37 volumio volumio[730]: info: Check plugin dependencies Apr 13 15:54:37 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 13 15:54:37 volumio volumio[730]: info: Checking if plugin already exists Apr 13 15:54:37 volumio volumio[730]: info: Rename folder Apr 13 15:54:37 volumio volumio[730]: info: Folder /tmp/downloaded_plugin.zip removed Apr 13 15:54:37 volumio volumio[730]: info: Move to category Apr 13 15:54:40 volumio volumio[730]: info: Checking if install.sh is present Apr 13 15:54:40 volumio volumio[730]: info: Executing install.sh Apr 13 15:54:40 volumio sudo[24654]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/user_interface/lastfm/install.sh Apr 13 15:54:40 volumio sudo[24654]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 15:54:40 volumio volumio[730]: info: Installing LastFM and its dependencies... Apr 13 15:54:40 volumio volumio[730]: info: Downloading installation package... Apr 13 15:54:40 volumio sudo[24654]: pam_unix(sudo:session): session closed for user root Apr 13 15:54:40 volumio volumio[730]: info: Install script completed Apr 13 15:54:40 volumio volumio[730]: info: Adding reference to registry Apr 13 15:54:40 volumio volumio[730]: info: Done installing plugin. Apr 13 15:54:41 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 13 15:54:41 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 13 15:54:41 volumio volumio[730]: Plugin install end detected on script Apr 13 15:54:41 volumio volumio[730]: info: Folder /tmp/plugins removed Apr 13 15:54:41 volumio volumio[730]: info: Folder /tmp/downloaded_plugin.zip removed Apr 13 15:54:41 volumio volumio[730]: info: Folder /data/temp removed Apr 13 15:54:46 volumio volumio[730]: info: CoreCommandRouter::volumioGetState Apr 13 15:54:46 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 13 15:54:46 volumio volumio[730]: info: Listing playlists Apr 13 15:54:46 volumio volumio[730]: info: Listing playlists Apr 13 15:54:52 volumio volumio[730]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 15:54:52 volumio volumio[730]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 15:54:52 volumio volumio[730]: info: Retrieving Cloud Streaming UI Apr 13 15:54:52 volumio volumio[730]: info: Getting Tidal Cloud Configuration Apr 13 15:54:52 volumio volumio[730]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 15:54:52 volumio volumio[730]: info: Getting Qobuz Cloud Configuration Apr 13 15:54:52 volumio volumio[730]: info: Asking plugin for UI Config Apr 13 15:54:52 volumio volumio[730]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 15:54:52 volumio volumio[730]: info: Getting Spotify Cloud Configuration Apr 13 15:54:52 volumio volumio[730]: info: Asking plugin for UI Config Apr 13 15:54:52 volumio volumio[730]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 15:54:52 volumio volumio[730]: info: Saving Spotify Acccount Apr 13 15:54:52 volumio volumio[730]: info: Got it Apr 13 15:54:52 volumio volumio[730]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 13 15:54:52 volumio volumio[730]: info: Got it Apr 13 15:54:52 volumio volumio[730]: info: Got Tidal Cloud Configuration Apr 13 15:54:52 volumio volumio[730]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 15:54:52 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 13 15:54:52 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 13 15:54:52 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 13 15:54:52 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 13 15:54:52 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 13 15:54:52 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 13 15:54:52 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 13 15:54:52 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 13 15:54:52 volumio volumio[730]: info: CoreCommandRouter::volumioGetBrowseSources Apr 13 15:54:52 volumio volumio[730]: info: CoreCommandRouter::volumioGetBrowseSources Apr 13 15:54:52 volumio volumio[730]: info: CoreCommandRouter::volumioGetBrowseSources Apr 13 15:54:52 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 13 15:54:52 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 13 15:54:54 volumio volumio[730]: info: Disabling MyMusic plugin tidalconnect Apr 13 15:54:54 volumio volumio[730]: info: [MyVolumio PluginManager] Disabling and stopping plugin music_service tidalconnect Apr 13 15:54:54 volumio vtcs[24474]: [2024-04-13 15:54:54.470] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Apr 13 15:54:54 volumio vtcs[24474]: [2024-04-13 15:54:54.470] [tisoc] [error] [SpkconServer.cpp:377] recv error. socket disconnected Apr 13 15:54:54 volumio volumio[730]: info: Disabling plugin tidalconnect Apr 13 15:54:54 volumio sudo[24671]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 13 15:54:54 volumio sudo[24671]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 15:54:54 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Apr 13 15:54:54 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Apr 13 15:54:54 volumio volumio[730]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 13 15:54:54 volumio systemd[1]: vtcs.service: Succeeded. Apr 13 15:54:54 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Apr 13 15:54:54 volumio sudo[24671]: pam_unix(sudo:session): session closed for user root Apr 13 15:54:56 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 13 15:54:56 volumio volumio[730]: info: CoreCommandRouter::volumioGetState Apr 13 15:54:56 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 13 15:54:57 volumio volumio[730]: info: TidalConnect service stoped! Apr 13 15:54:59 volumio volumio[730]: info: Enabling MyMusic plugin tidalconnect Apr 13 15:54:59 volumio volumio[730]: info: [MyVolumio PluginManager] Enabling and starting plugin music_service tidalconnect Apr 13 15:54:59 volumio volumio[730]: info: Enabling plugin tidalconnect Apr 13 15:54:59 volumio volumio[730]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Apr 13 15:54:59 volumio sudo[24686]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 13 15:54:59 volumio sudo[24686]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 15:54:59 volumio sudo[24686]: pam_unix(sudo:session): session closed for user root Apr 13 15:55:00 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 13 15:55:02 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 15:55:02 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 15:55:02 volumio volumio[730]: info: Discovery: Getting this device information Apr 13 15:55:02 volumio volumio[730]: info: CoreCommandRouter::volumioGetState Apr 13 15:55:02 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 13 15:55:02 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 15:55:02 volumio volumio[730]: info: TidalConnect service stoped! Apr 13 15:55:02 volumio volumio[730]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Apr 13 15:55:02 volumio volumio[730]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Apr 13 15:55:02 volumio sudo[24699]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Apr 13 15:55:02 volumio sudo[24699]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 15:55:02 volumio systemd[1]: Started Volumio Tidal Connect Service. Apr 13 15:55:02 volumio sudo[24699]: pam_unix(sudo:session): session closed for user root Apr 13 15:55:02 volumio volumio[730]: info: Executing endpoint tc_getconfig Apr 13 15:55:02 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Apr 13 15:55:02 volumio vtcs[24701]: STARTING TidalConnect services, version: 1.3.0.19 Apr 13 15:55:02 volumio vtcs[24701]: STARTED TidalConnect services. Apr 13 15:55:02 volumio volumio[730]: info: Executing endpoint tc_connect Apr 13 15:55:02 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Apr 13 15:55:02 volumio volumio[730]: info: Connecting to TidalConnect Apr 13 15:55:02 volumio volumio[730]: info: CoreCommandRouter::servicePushState Apr 13 15:55:02 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 13 15:55:02 volumio volumio[730]: verbose: STATE SERVICE {"status":"pause","service":"tidalconnect","title":"Dream of You","artist":"Lionlimb, Angel Olsen","album":"Dream of You","albumart":"https://resources.tidal.com/images/7f9cd5c3/5882/4cd0/9575/934db7bdaf59/1280x1280.jpg","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"flac","seek":0,"duration":238,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":1411200,"channels":2,"random":false,"repeat":false,"repeatSingle":false,"stream":false,"repeatMode":"all"} Apr 13 15:55:02 volumio volumio[730]: verbose: CURRENT POSITION 0 Apr 13 15:55:02 volumio volumio[730]: info: CoreStateMachine::syncState stateService pause Apr 13 15:55:02 volumio volumio[730]: info: CoreStateMachine::syncState currentStatus play Apr 13 15:55:02 volumio volumio[730]: info: CoreStateMachine::pushState Apr 13 15:55:02 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 13 15:55:02 volumio volumio[730]: info: CoreCommandRouter::volumioPushState Apr 13 15:55:02 volumio volumio[730]: info: MRS: Pushing multiroomSync output update for this device Apr 13 15:55:02 volumio volumio[730]: info: MRS: Pushing multiroomSync output Apr 13 15:55:02 volumio volumio[730]: info: CoreCommandRouter::servicePushState Apr 13 15:55:02 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 13 15:55:02 volumio volumio[730]: verbose: STATE SERVICE {"status":"pause","service":"tidalconnect","title":"Dream of You","artist":"Lionlimb, Angel Olsen","album":"Dream of You","albumart":"https://resources.tidal.com/images/7f9cd5c3/5882/4cd0/9575/934db7bdaf59/1280x1280.jpg","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"flac","seek":0,"duration":238,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":1411200,"channels":2,"random":false,"repeat":false,"repeatSingle":false,"stream":false,"repeatMode":"all"} Apr 13 15:55:02 volumio volumio[730]: verbose: CURRENT POSITION 0 Apr 13 15:55:02 volumio volumio[730]: info: CoreStateMachine::syncState stateService pause Apr 13 15:55:02 volumio volumio[730]: info: CoreStateMachine::syncState currentStatus play Apr 13 15:55:02 volumio volumio[730]: info: CoreStateMachine::pushState Apr 13 15:55:02 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 13 15:55:02 volumio volumio[730]: info: CoreCommandRouter::volumioPushState Apr 13 15:55:02 volumio volumio[730]: info: MRS: Pushing multiroomSync output update for this device Apr 13 15:55:02 volumio volumio[730]: info: MRS: Pushing multiroomSync output Apr 13 15:55:02 volumio volumio[730]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 13 15:55:02 volumio volumio[730]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 13 15:55:04 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 13 15:55:04 volumio volumio[730]: info: Disabling MyMusic plugin tidalconnect Apr 13 15:55:04 volumio volumio[730]: info: [MyVolumio PluginManager] Disabling and stopping plugin music_service tidalconnect Apr 13 15:55:04 volumio vtcs[24701]: [2024-04-13 15:55:04.434] [tisoc] [error] [SpkconServer.cpp:377] recv error. socket disconnected Apr 13 15:55:04 volumio vtcs[24701]: [2024-04-13 15:55:04.434] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Apr 13 15:55:04 volumio volumio[730]: info: Disabling plugin tidalconnect Apr 13 15:55:04 volumio sudo[24720]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 13 15:55:04 volumio sudo[24720]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 15:55:04 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Apr 13 15:55:04 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Apr 13 15:55:04 volumio systemd[1]: vtcs.service: Succeeded. Apr 13 15:55:04 volumio volumio[730]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 13 15:55:04 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Apr 13 15:55:04 volumio sudo[24720]: pam_unix(sudo:session): session closed for user root Apr 13 15:55:05 volumio volumio[730]: info: TidalConnect service started! Apr 13 15:55:05 volumio volumio[730]: info: Done. Apr 13 15:55:06 volumio volumio[730]: info: CoreCommandRouter::volumioGetState Apr 13 15:55:06 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 13 15:55:06 volumio volumio[730]: info: Listing playlists Apr 13 15:55:06 volumio volumio[730]: info: Listing playlists Apr 13 15:55:07 volumio volumio[730]: info: TidalConnect service stoped! Apr 13 15:55:08 volumio volumio[730]: info: Enabling MyMusic plugin tidalconnect Apr 13 15:55:08 volumio volumio[730]: info: [MyVolumio PluginManager] Enabling and starting plugin music_service tidalconnect Apr 13 15:55:08 volumio volumio[730]: info: Enabling plugin tidalconnect Apr 13 15:55:08 volumio volumio[730]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Apr 13 15:55:08 volumio sudo[24774]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 13 15:55:08 volumio sudo[24774]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 15:55:08 volumio sudo[24774]: pam_unix(sudo:session): session closed for user root Apr 13 15:55:08 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 13 15:55:11 volumio volumio[730]: info: TidalConnect service stoped! Apr 13 15:55:11 volumio volumio[730]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Apr 13 15:55:11 volumio volumio[730]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Apr 13 15:55:11 volumio sudo[24786]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Apr 13 15:55:11 volumio sudo[24786]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 15:55:11 volumio systemd[1]: Started Volumio Tidal Connect Service. Apr 13 15:55:11 volumio sudo[24786]: pam_unix(sudo:session): session closed for user root Apr 13 15:55:11 volumio volumio[730]: info: Executing endpoint tc_getconfig Apr 13 15:55:11 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Apr 13 15:55:11 volumio vtcs[24788]: STARTING TidalConnect services, version: 1.3.0.19 Apr 13 15:55:11 volumio vtcs[24788]: STARTED TidalConnect services. Apr 13 15:55:11 volumio volumio[730]: info: Executing endpoint tc_connect Apr 13 15:55:11 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Apr 13 15:55:11 volumio volumio[730]: info: Connecting to TidalConnect Apr 13 15:55:11 volumio volumio[730]: info: CoreCommandRouter::servicePushState Apr 13 15:55:11 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 13 15:55:11 volumio volumio[730]: verbose: STATE SERVICE {"status":"pause","service":"tidalconnect","title":"Dream of You","artist":"Lionlimb, Angel Olsen","album":"Dream of You","albumart":"https://resources.tidal.com/images/7f9cd5c3/5882/4cd0/9575/934db7bdaf59/1280x1280.jpg","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"flac","seek":0,"duration":238,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":1411200,"channels":2,"random":false,"repeat":false,"repeatSingle":false,"stream":false,"repeatMode":"all"} Apr 13 15:55:11 volumio volumio[730]: verbose: CURRENT POSITION 0 Apr 13 15:55:11 volumio volumio[730]: info: CoreStateMachine::syncState stateService pause Apr 13 15:55:11 volumio volumio[730]: info: CoreStateMachine::syncState currentStatus play Apr 13 15:55:11 volumio volumio[730]: info: CoreStateMachine::pushState Apr 13 15:55:11 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 13 15:55:11 volumio volumio[730]: info: CoreCommandRouter::volumioPushState Apr 13 15:55:11 volumio volumio[730]: info: MRS: Pushing multiroomSync output update for this device Apr 13 15:55:11 volumio volumio[730]: info: MRS: Pushing multiroomSync output Apr 13 15:55:11 volumio volumio[730]: info: CoreCommandRouter::servicePushState Apr 13 15:55:11 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 13 15:55:11 volumio volumio[730]: verbose: STATE SERVICE {"status":"pause","service":"tidalconnect","title":"Dream of You","artist":"Lionlimb, Angel Olsen","album":"Dream of You","albumart":"https://resources.tidal.com/images/7f9cd5c3/5882/4cd0/9575/934db7bdaf59/1280x1280.jpg","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"flac","seek":0,"duration":238,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":1411200,"channels":2,"random":false,"repeat":false,"repeatSingle":false,"stream":false,"repeatMode":"all"} Apr 13 15:55:11 volumio volumio[730]: verbose: CURRENT POSITION 0 Apr 13 15:55:11 volumio volumio[730]: info: CoreStateMachine::syncState stateService pause Apr 13 15:55:11 volumio volumio[730]: info: CoreStateMachine::syncState currentStatus play Apr 13 15:55:11 volumio volumio[730]: info: CoreStateMachine::pushState Apr 13 15:55:11 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 13 15:55:11 volumio volumio[730]: info: CoreCommandRouter::volumioPushState Apr 13 15:55:11 volumio volumio[730]: info: MRS: Pushing multiroomSync output update for this device Apr 13 15:55:11 volumio volumio[730]: info: MRS: Pushing multiroomSync output Apr 13 15:55:11 volumio volumio[730]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 13 15:55:11 volumio volumio[730]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 13 15:55:12 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 13 15:55:14 volumio volumio[730]: info: TidalConnect service started! Apr 13 15:55:14 volumio volumio[730]: info: Done. Apr 13 15:55:16 volumio volumio[730]: info: CoreCommandRouter::volumioGetState Apr 13 15:55:16 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 13 15:55:17 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 13 15:55:22 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 13 15:55:26 volumio volumio[730]: info: CoreCommandRouter::volumioGetState Apr 13 15:55:26 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 13 15:55:26 volumio volumio[730]: info: Listing playlists Apr 13 15:55:26 volumio volumio[730]: info: Listing playlists Apr 13 15:55:27 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 13 15:55:32 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 13 15:55:34 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 15:55:34 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 15:55:34 volumio volumio[730]: info: Discovery: Getting this device information Apr 13 15:55:34 volumio volumio[730]: info: CoreCommandRouter::volumioGetState Apr 13 15:55:34 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 13 15:55:34 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 15:55:36 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 13 15:55:36 volumio volumio[730]: info: Disabling MyMusic plugin tidalconnect Apr 13 15:55:36 volumio volumio[730]: info: [MyVolumio PluginManager] Disabling and stopping plugin music_service tidalconnect Apr 13 15:55:36 volumio vtcs[24788]: [2024-04-13 15:55:36.092] [tisoc] [error] [SpkconServer.cpp:377] recv error. socket disconnected Apr 13 15:55:36 volumio vtcs[24788]: [2024-04-13 15:55:36.093] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Apr 13 15:55:36 volumio volumio[730]: info: Disabling plugin tidalconnect Apr 13 15:55:36 volumio sudo[24842]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 13 15:55:36 volumio sudo[24842]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 15:55:36 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Apr 13 15:55:36 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Apr 13 15:55:36 volumio systemd[1]: vtcs.service: Succeeded. Apr 13 15:55:36 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Apr 13 15:55:36 volumio volumio[730]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 13 15:55:36 volumio sudo[24842]: pam_unix(sudo:session): session closed for user root Apr 13 15:55:36 volumio volumio[730]: info: Disabling MyMusic plugin smart_inputs Apr 13 15:55:36 volumio volumio[730]: info: [MyVolumio PluginManager] Disabling and stopping plugin music_service smart_inputs Apr 13 15:55:36 volumio volumio[730]: info: Removeing all smart Inputs Apr 13 15:55:36 volumio volumio[730]: info: Disabling plugin smart_inputs Apr 13 15:55:36 volumio volumio[730]: info: CoreCommandRouter::volumioGetState Apr 13 15:55:36 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 13 15:55:37 volumio volumio[730]: info: Disabling MyMusic plugin cd_controller Apr 13 15:55:37 volumio volumio[730]: info: [MyVolumio PluginManager] Disabling and stopping plugin music_service cd_controller Apr 13 15:55:37 volumio volumio[730]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesAudio CD Apr 13 15:55:37 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 13 15:55:37 volumio volumio[730]: Cannot find translation for source Spotify Apr 13 15:55:37 volumio volumio[730]: Cannot find translation for source TIDAL Apr 13 15:55:37 volumio volumio[730]: info: Stopping UDEV Watcher for CD Apr 13 15:55:37 volumio volumio[730]: info: Disabling plugin cd_controller Apr 13 15:55:38 volumio volumio[730]: info: Disabling MyMusic plugin metavolumio Apr 13 15:55:38 volumio volumio[730]: info: [MyVolumio PluginManager] Disabling and stopping plugin miscellanea metavolumio Apr 13 15:55:38 volumio volumio[730]: info: Removing METAVOLUMIO REST API Endpoints Apr 13 15:55:38 volumio volumio[730]: info: Removing metavolumio REST Endpoint Apr 13 15:55:38 volumio volumio[730]: info: Removing getSimilarArtists REST Endpoint Apr 13 15:55:38 volumio volumio[730]: info: Removing getSimilarAlbums REST Endpoint Apr 13 15:55:38 volumio volumio[730]: info: Removing getSimilarTracks REST Endpoint Apr 13 15:55:38 volumio volumio[730]: info: Disabling plugin metavolumio Apr 13 15:55:39 volumio volumio[730]: info: TidalConnect service stoped! Apr 13 15:55:39 volumio volumio[730]: info: Disabling MyMusic plugin multiroom Apr 13 15:55:39 volumio volumio[730]: info: [MyVolumio PluginManager] Disabling and stopping plugin audio_interface multiroom Apr 13 15:55:39 volumio volumio[730]: info: Disabling plugin multiroom Apr 13 15:55:39 volumio volumio[730]: info: Preparing to generate the ALSA configuration file Apr 13 15:55:39 volumio volumio[730]: info: Asound.conf file written Apr 13 15:55:39 volumio sudo[24846]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Apr 13 15:55:39 volumio sudo[24846]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 15:55:39 volumio sudo[24846]: pam_unix(sudo:session): session closed for user root Apr 13 15:55:39 volumio volumio[730]: xcb_connection_has_error() returned true Apr 13 15:55:39 volumio volumio[730]: info: Output device has changed, restarting MPD Apr 13 15:55:39 volumio sudo[24851]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 13 15:55:39 volumio sudo[24851]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 15:55:39 volumio volumio[730]: info: Output device has changed, restarting Shairport Sync Apr 13 15:55:39 volumio sudo[24851]: pam_unix(sudo:session): session closed for user root Apr 13 15:55:39 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 15:55:39 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 15:55:39 volumio sudo[24854]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 13 15:55:39 volumio sudo[24854]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 15:55:39 volumio systemd[1]: Stopping Music Player Daemon... Apr 13 15:55:39 volumio volumio[730]: xcb_connection_has_error() returned true Apr 13 15:55:39 volumio volumio[730]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 13 15:55:39 volumio volumio[730]: xcb_connection_has_error() returned true Apr 13 15:55:39 volumio systemd[1]: mpd.service: Succeeded. Apr 13 15:55:39 volumio volumio[730]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 13 15:55:39 volumio systemd[1]: Stopped Music Player Daemon. Apr 13 15:55:40 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 15:55:40 volumio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Apr 13 15:55:40 volumio systemd[1]: Starting Music Player Daemon... Apr 13 15:55:40 volumio sudo[24866]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 13 15:55:40 volumio sudo[24866]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 15:55:40 volumio volumio[730]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 13 15:55:40 volumio volumio[730]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 13 15:55:40 volumio volumio[730]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 13 15:55:40 volumio sudo[24866]: pam_unix(sudo:session): session closed for user root Apr 13 15:55:40 volumio volumio[730]: info: MPD Permissions set Apr 13 15:55:40 volumio sudo[24869]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 13 15:55:40 volumio sudo[24869]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 15:55:40 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 15:55:40 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 15:55:40 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 15:55:40 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 15:55:40 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 15:55:40 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 15:55:40 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 15:55:40 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 15:55:40 volumio sudo[24869]: pam_unix(sudo:session): session closed for user root Apr 13 15:55:40 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 15:55:40 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 15:55:40 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 13 15:55:40 volumio volumio[730]: error: MPD error: Error: This socket has been ended by the other party Apr 13 15:55:40 volumio volumio[730]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 13 15:55:40 volumio volumio[730]: error: MPD error: Error: This socket has been ended by the other party Apr 13 15:55:40 volumio volumio[730]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 13 15:55:40 volumio volumio[730]: error: MPD error: Error: This socket has been ended by the other party Apr 13 15:55:40 volumio volumio[730]: error: This socket has been ended by the other party {"code":"EPIPE"} Apr 13 15:55:40 volumio volumio[730]: info: Starting Shairport Sync Apr 13 15:55:40 volumio sudo[24878]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 13 15:55:40 volumio sudo[24878]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 15:55:40 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 13 15:55:40 volumio volumio[730]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 13 15:55:40 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 13 15:55:40 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 13 15:55:40 volumio volumio[730]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 13 15:55:40 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 13 15:55:40 volumio sudo[24878]: pam_unix(sudo:session): session closed for user root Apr 13 15:55:40 volumio volumio[730]: info: Shairport-Sync Started Apr 13 15:55:40 volumio volumio[730]: info: Disabling MyMusic plugin bluetooth Apr 13 15:55:40 volumio volumio[730]: info: [MyVolumio PluginManager] Disabling and stopping plugin audio_interface bluetooth Apr 13 15:55:40 volumio sudo[24885]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumiobt.service Apr 13 15:55:40 volumio sudo[24885]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 15:55:40 volumio systemd[1]: Stopping Volumio Bluetooth Module... Apr 13 15:55:40 volumio volumio[730]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 13 15:55:40 volumio volumiobt[24887]: Killing pulse Apr 13 15:55:40 volumio bluetoothd[683]: Endpoint unregistered: sender=:1.45 path=/MediaEndpoint/A2DPSource Apr 13 15:55:40 volumio bluetoothd[683]: Endpoint unregistered: sender=:1.45 path=/MediaEndpoint/A2DPSink Apr 13 15:55:40 volumio volumiobt[24887]: Killing BT Pair agent Apr 13 15:55:40 volumio volumiobt[1186]: Terminated Apr 13 15:55:40 volumio systemd[1]: volumiobt.service: Main process exited, code=killed, status=15/TERM Apr 13 15:55:40 volumio systemd[1]: volumiobt.service: Succeeded. Apr 13 15:55:40 volumio systemd[1]: Stopped Volumio Bluetooth Module. Apr 13 15:55:40 volumio sudo[24885]: pam_unix(sudo:session): session closed for user root Apr 13 15:55:40 volumio volumio[730]: info: Volumio BT Module successfully stopped Apr 13 15:55:40 volumio volumio[730]: info: Disabling plugin bluetooth Apr 13 15:55:41 volumio mpd[24859]: Apr 13 15:55 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 13 15:55:41 volumio systemd[1]: Started Music Player Daemon. Apr 13 15:55:41 volumio sudo[24854]: pam_unix(sudo:session): session closed for user root Apr 13 15:55:41 volumio volumio[730]: info: Disabling MyMusic plugin upnp_browser Apr 13 15:55:41 volumio volumio[730]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesMediaservrar Apr 13 15:55:41 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 13 15:55:41 volumio volumio[730]: Cannot find translation for source Spotify Apr 13 15:55:41 volumio volumio[730]: Cannot find translation for source TIDAL Apr 13 15:55:41 volumio volumio[730]: info: Disabling plugin upnp_browser Apr 13 15:55:41 volumio volumio[730]: info: Done. Apr 13 15:55:41 volumio volumio[730]: error: updateQueue error: null Apr 13 15:55:42 volumio volumio[730]: info: Disabling MyMusic plugin airplay_emulation Apr 13 15:55:42 volumio volumio[730]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesShairport-Sync Apr 13 15:55:42 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 13 15:55:42 volumio volumio[730]: Cannot find translation for source Spotify Apr 13 15:55:42 volumio volumio[730]: Cannot find translation for source TIDAL Apr 13 15:55:42 volumio volumio[730]: info: Disabling plugin airplay_emulation Apr 13 15:55:42 volumio volumio[730]: info: Done. Apr 13 15:55:42 volumio sudo[24895]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync Apr 13 15:55:42 volumio sudo[24895]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 15:55:42 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 13 15:55:42 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 13 15:55:42 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 13 15:55:42 volumio sudo[24895]: pam_unix(sudo:session): session closed for user root Apr 13 15:55:42 volumio volumio[730]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 13 15:55:42 volumio volumio[730]: info: Shairport-Sync Stopped Apr 13 15:55:42 volumio volumio[730]: info: Disabling MyMusic plugin upnp Apr 13 15:55:43 volumio sudo[24898]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Apr 13 15:55:43 volumio sudo[24898]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 15:55:43 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD... Apr 13 15:55:43 volumio volumio[730]: error: Upnp client error: Error: This socket has been ended by the other party Apr 13 15:55:43 volumio volumio[730]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 13 15:55:43 volumio volumio[730]: info: TidalConnect service stoped! Apr 13 15:55:43 volumio volumio[730]: info: TidalConnect service stoped! Apr 13 15:55:43 volumio volumio[730]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Apr 13 15:55:43 volumio volumio[730]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Apr 13 15:55:43 volumio sudo[24909]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Apr 13 15:55:43 volumio sudo[24909]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 15:55:43 volumio systemd[1]: Started Volumio Tidal Connect Service. Apr 13 15:55:43 volumio sudo[24909]: pam_unix(sudo:session): session closed for user root Apr 13 15:55:43 volumio volumio[730]: info: Executing endpoint tc_getconfig Apr 13 15:55:43 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Apr 13 15:55:43 volumio vtcs[24911]: STARTING TidalConnect services, version: 1.3.0.19 Apr 13 15:55:43 volumio vtcs[24911]: STARTED TidalConnect services. Apr 13 15:55:43 volumio volumio[730]: info: Executing endpoint tc_connect Apr 13 15:55:43 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Apr 13 15:55:43 volumio volumio[730]: info: Connecting to TidalConnect Apr 13 15:55:43 volumio volumio[730]: info: CoreCommandRouter::servicePushState Apr 13 15:55:43 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 13 15:55:43 volumio volumio[730]: verbose: STATE SERVICE {"status":"pause","service":"tidalconnect","title":"Dream of You","artist":"Lionlimb, Angel Olsen","album":"Dream of You","albumart":"https://resources.tidal.com/images/7f9cd5c3/5882/4cd0/9575/934db7bdaf59/1280x1280.jpg","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"flac","seek":0,"duration":238,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":1411200,"channels":2,"random":false,"repeat":false,"repeatSingle":false,"stream":false,"repeatMode":"all"} Apr 13 15:55:43 volumio volumio[730]: verbose: CURRENT POSITION 0 Apr 13 15:55:43 volumio volumio[730]: info: CoreStateMachine::syncState stateService pause Apr 13 15:55:43 volumio volumio[730]: info: CoreStateMachine::syncState currentStatus play Apr 13 15:55:43 volumio volumio[730]: info: CoreStateMachine::pushState Apr 13 15:55:43 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 13 15:55:43 volumio volumio[730]: info: CoreCommandRouter::volumioPushState Apr 13 15:55:43 volumio volumio[730]: info: MRS: Pushing multiroomSync output update for this device Apr 13 15:55:43 volumio volumio[730]: info: MRS: Pushing multiroomSync output Apr 13 15:55:43 volumio volumio[730]: info: CoreCommandRouter::servicePushState Apr 13 15:55:43 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 13 15:55:43 volumio volumio[730]: verbose: STATE SERVICE {"status":"pause","service":"tidalconnect","title":"Dream of You","artist":"Lionlimb, Angel Olsen","album":"Dream of You","albumart":"https://resources.tidal.com/images/7f9cd5c3/5882/4cd0/9575/934db7bdaf59/1280x1280.jpg","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"flac","seek":0,"duration":238,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":1411200,"channels":2,"random":false,"repeat":false,"repeatSingle":false,"stream":false,"repeatMode":"all"} Apr 13 15:55:43 volumio volumio[730]: verbose: CURRENT POSITION 0 Apr 13 15:55:43 volumio volumio[730]: info: CoreStateMachine::syncState stateService pause Apr 13 15:55:43 volumio volumio[730]: info: CoreStateMachine::syncState currentStatus play Apr 13 15:55:43 volumio volumio[730]: info: CoreStateMachine::pushState Apr 13 15:55:43 volumio volumio[730]: info: CorePlayQueue::getTrack 0 Apr 13 15:55:43 volumio volumio[730]: info: CoreCommandRouter::volumioPushState Apr 13 15:55:43 volumio volumio[730]: info: MRS: Pushing multiroomSync output update for this device Apr 13 15:55:43 volumio volumio[730]: info: MRS: Pushing multiroomSync output Apr 13 15:55:43 volumio volumio[730]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 13 15:55:43 volumio volumio[730]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Apr 13 15:55:44 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 13 15:55:45 volumio volumio[730]: info: Enabling MyMusic plugin upnp Apr 13 15:55:45 volumio volumio[730]: info: Enabling plugin upnp Apr 13 15:55:46 volumio volumio[730]: info: Loading plugin "upnp"... Apr 13 15:55:46 volumio volumio[730]: info: [1713016546003] Starting Upmpd Daemon Apr 13 15:55:46 volumio volumio[730]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 13 15:55:46 volumio volumio[730]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 13 15:55:46 volumio volumio[730]: Error: listen EADDRINUSE: address already in use :::6599 Apr 13 15:55:46 volumio volumio[730]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Apr 13 15:55:46 volumio volumio[730]: at listenInCluster (net.js:1366:12) Apr 13 15:55:46 volumio volumio[730]: at Server.listen (net.js:1452:7) Apr 13 15:55:46 volumio volumio[730]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Apr 13 15:55:46 volumio volumio[730]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Apr 13 15:55:46 volumio volumio[730]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Apr 13 15:55:46 volumio volumio[730]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Apr 13 15:55:46 volumio volumio[730]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Apr 13 15:55:46 volumio volumio[730]: code: 'EADDRINUSE', Apr 13 15:55:46 volumio volumio[730]: errno: -98, Apr 13 15:55:46 volumio volumio[730]: syscall: 'listen', Apr 13 15:55:46 volumio volumio[730]: address: '::', Apr 13 15:55:46 volumio volumio[730]: port: 6599 Apr 13 15:55:46 volumio volumio[730]: } Apr 13 15:55:46 volumio volumio[730]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 13 15:55:46 volumio sudo[24949]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-13 15:54 Apr 13 15:55:46 volumio sudo[24949]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"