-- Logs begin at Mon 2025-11-03 11:47:37 PST, end at Mon 2025-11-03 11:49:56 PST. -- Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Loading plugin "outputs"... Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Loading plugin "albumart"... Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Plugin example_plugin is not enabled Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Loading plugin "inputs"... Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Loading plugin "updater_comm"... Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Plugin mpdemulation is not enabled Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Loading plugin "rest_api"... Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Loading plugin "websocket"... Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Starting Socket.io Server version 2.3.0 Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Loading plugin "mpdoutput"... Nov 03 11:48:00 dirtyvolumio volumio[1153]: Forking 3 albumart workers Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Loading plugin "minidlna"... Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Applying required configuration parameters for plugin minidlna Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Loading plugin "podcast"... Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: ControllerPodcast::constructor Nov 03 11:48:00 dirtyvolumio volumio[1153]: Starting albumart workers Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Loading plugin "music_services_shield"... Nov 03 11:48:00 dirtyvolumio volumio[1153]: Starting albumart workers Nov 03 11:48:00 dirtyvolumio volumio[1153]: Starting albumart workers Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Applying required configuration parameters for plugin music_services_shield Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Loading plugin "Systeminfo"... Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Loading plugin "peppyspectrum"... Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Loading i18n strings for locale en Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored. Nov 03 11:48:00 dirtyvolumio volumio[1153]: Updating browse sources language Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CoreCommandRouter::initPlayerControls Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 11:48:00 dirtyvolumio volumio[1153]: Express server listening on port 3000 Nov 03 11:48:00 dirtyvolumio volumio[1153]: [Metrics] WebUI: 3s 661.17ms Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CoreStateMachine::resetVolumioState Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CoreStateMachine::getcurrentVolume Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioRetrievevolume Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CoreStateMachine::pushState Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPushState Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Volumio Network Manager: Network status updated: 3 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 1 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 2 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 3 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 4 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 5 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 6 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 7 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 8 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 9 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 10 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 11 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 12 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 13 Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Reloading queue from file Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 14 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 15 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 16 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 17 Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CoreStateMachine::setRepeat null single undefined Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CoreStateMachine::pushState Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPushState Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CoreStateMachine::setRandom null Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CoreStateMachine::pushState Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPushState Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c04170 Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Setting Device type: Raspberry PI Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 18 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 19 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 20 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 21 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 22 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 23 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 24 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 25 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 26 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 27 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 28 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 29 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 30 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 31 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 32 Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Completed loading Core Plugins Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Preparing to generate the ALSA configuration file Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Reading ALSA contributions from plugins. Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 33 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 34 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 35 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 36 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 37 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 38 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 39 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 40 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 41 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 42 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 43 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 44 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 45 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 46 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 47 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 48 Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Discovery: adding 86071fc5-6bb9-41af-99bc-3f1bb519811e Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Discovery: Found device DirtyVolumio Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioGetState Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 49 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 50 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 51 Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Discovery: this is already registered, 86071fc5-6bb9-41af-99bc-3f1bb519811e Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Discovery: Found device DirtyVolumio Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioGetState Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 52 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 53 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 54 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 55 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 56 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 57 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 58 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 59 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 60 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 61 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 62 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 63 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 64 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 65 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 66 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 67 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 68 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 69 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 70 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 71 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 72 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 73 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 74 Nov 03 11:48:00 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 75 Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Asound.conf file written Nov 03 11:48:00 dirtyvolumio sudo[1312]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Nov 03 11:48:00 dirtyvolumio sudo[1312]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:00 dirtyvolumio sudo[1312]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Output device has changed, restarting MPD Nov 03 11:48:00 dirtyvolumio sudo[1317]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 03 11:48:00 dirtyvolumio sudo[1317]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Output device has changed, restarting Shairport Sync Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:00 dirtyvolumio sudo[1317]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:00 dirtyvolumio sudo[1320]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 03 11:48:00 dirtyvolumio sudo[1320]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:00 dirtyvolumio systemd[1]: musicservicesshield.service: Succeeded. Nov 03 11:48:00 dirtyvolumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Nov 03 11:48:00 dirtyvolumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Nov 03 11:48:00 dirtyvolumio systemd[1]: Stopping Music Player Daemon... Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: ___________ START PLUGINS ___________ Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: ControllerMpd::onStart: Initializing MPD Nov 03 11:48:00 dirtyvolumio volumio[1153]: info: Creating MPD Configuration file Nov 03 11:48:01 dirtyvolumio sudo[1326]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 03 11:48:01 dirtyvolumio sudo[1326]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:01 dirtyvolumio sudo[1326]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: [1762199281013] CoreMusicLibrary::Adding element Media Servers Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 11:48:01 dirtyvolumio sudo[1329]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 03 11:48:01 dirtyvolumio sudo[1329]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:01 dirtyvolumio systemd[1]: mpd.service: Succeeded. Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:01 dirtyvolumio systemd[1]: Stopped Music Player Daemon. Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:01 dirtyvolumio systemd[1]: Starting Music Player Daemon... Nov 03 11:48:01 dirtyvolumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Nov 03 11:48:01 dirtyvolumio systemd[1]: mpd.service: Succeeded. Nov 03 11:48:01 dirtyvolumio systemd[1]: Stopped Music Player Daemon. Nov 03 11:48:01 dirtyvolumio systemd[1]: Starting Music Player Daemon... Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: [1762199281056] CoreMusicLibrary::Adding element Last_100 Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: [1762199281057] CoreMusicLibrary::Adding element Webradio Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: Initializing BBC Radios Nov 03 11:48:01 dirtyvolumio sudo[1338]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 03 11:48:01 dirtyvolumio sudo[1338]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:01 dirtyvolumio sudo[1338]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: [1762199281098] CoreMusicLibrary::Adding element Mixcloud Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 11:48:01 dirtyvolumio volumio[1153]: Cannot find translation for source Mixcloud Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: [1762199281101] CoreMusicLibrary::Adding element SoundCloud Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 11:48:01 dirtyvolumio volumio[1153]: Cannot find translation for source Mixcloud Nov 03 11:48:01 dirtyvolumio volumio[1153]: Cannot find translation for source SoundCloud Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: [1762199281104] CoreMusicLibrary::Adding element YouTube Music Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 11:48:01 dirtyvolumio volumio[1153]: Cannot find translation for source Mixcloud Nov 03 11:48:01 dirtyvolumio volumio[1153]: Cannot find translation for source SoundCloud Nov 03 11:48:01 dirtyvolumio volumio[1153]: Cannot find translation for source YouTube Music Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: [now-playing] ConfigUpdater: config is up to date. Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: Loading i18n strings for locale en Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored. Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: [1762199281129] CoreMusicLibrary::Adding element Podcast Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 11:48:01 dirtyvolumio volumio[1153]: Cannot find translation for source Mixcloud Nov 03 11:48:01 dirtyvolumio volumio[1153]: Cannot find translation for source SoundCloud Nov 03 11:48:01 dirtyvolumio volumio[1153]: Cannot find translation for source YouTube Music Nov 03 11:48:01 dirtyvolumio volumio[1153]: Cannot find translation for source Podcast Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: Volumio Calling Home Nov 03 11:48:01 dirtyvolumio sudo[1379]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/moveallprocesses.sh Nov 03 11:48:01 dirtyvolumio sudo[1379]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: Preparing to generate the ALSA configuration file Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: [now-playing] App is listening on port 4004. Nov 03 11:48:01 dirtyvolumio volumio[1153]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Nov 03 11:48:01 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 76 Nov 03 11:48:01 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 77 Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: Reading ALSA contributions from plugins. Nov 03 11:48:01 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 78 Nov 03 11:48:01 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 79 Nov 03 11:48:01 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 80 Nov 03 11:48:01 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 81 Nov 03 11:48:01 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 82 Nov 03 11:48:01 dirtyvolumio mpd[1347]: Nov 03 11:48 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 03 11:48:01 dirtyvolumio systemd[1]: Started Music Player Daemon. Nov 03 11:48:01 dirtyvolumio sudo[1320]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:01 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 83 Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: minidlna: Found miniDLNA version 1.2.1 Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: minidlna: Starting minidlna.service Nov 03 11:48:01 dirtyvolumio sudo[1329]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:01 dirtyvolumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: MPD Permissions set Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: MPD Permissions set Nov 03 11:48:01 dirtyvolumio sudo[1400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start minidlna.service Nov 03 11:48:01 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 84 Nov 03 11:48:01 dirtyvolumio sudo[1400]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:01 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 85 Nov 03 11:48:01 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 86 Nov 03 11:48:01 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 87 Nov 03 11:48:01 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 88 Nov 03 11:48:01 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 89 Nov 03 11:48:01 dirtyvolumio systemd[1]: Started MiniDLNA lightweight DLNA/UPnP-AV server. Nov 03 11:48:01 dirtyvolumio sudo[1400]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioGetState Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioGetVisibleSources Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioGetQueue Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreStateMachine::getQueue Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CorePlayQueue::getQueue Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: Listing playlists Nov 03 11:48:01 dirtyvolumio systemd[1]: minidlna.service: Succeeded. Nov 03 11:48:01 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 90 Nov 03 11:48:01 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 91 Nov 03 11:48:01 dirtyvolumio volumio[1394]: cset: --> shielding system active with Nov 03 11:48:01 dirtyvolumio volumio[1394]: cset: "system" cpuset of CPUSPEC(1-3) with 113 tasks running Nov 03 11:48:01 dirtyvolumio volumio[1394]: cset: "user" cpuset of CPUSPEC(0) with 3 tasks running Nov 03 11:48:01 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 92 Nov 03 11:48:01 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 93 Nov 03 11:48:01 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 94 Nov 03 11:48:01 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 95 Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:01 dirtyvolumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:01 dirtyvolumio sudo[1379]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:01 dirtyvolumio volumio[1153]: error: MPD error: The expression evaluated to a falsy value: Nov 03 11:48:01 dirtyvolumio volumio[1153]: assert.ok(self.idling) Nov 03 11:48:01 dirtyvolumio volumio[1153]: error: The expression evaluated to a falsy value: Nov 03 11:48:01 dirtyvolumio volumio[1153]: assert.ok(self.idling) Nov 03 11:48:01 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 96 Nov 03 11:48:01 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 97 Nov 03 11:48:01 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 98 Nov 03 11:48:01 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 192.168.0.123 from 192.168.0.244 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:145.0) Gecko/20100101 Firefox/145.0 Engine version: 3 Transport: polling Total Clients: 99 Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: minidlna: systemctl start minidlna.service succeeded. Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: MPD running with PID1347 Nov 03 11:48:01 dirtyvolumio volumio[1153]: ,establishing connection Nov 03 11:48:01 dirtyvolumio volumio[1153]: error: updateQueue error: null Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: Volumio called home Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: Completed starting Core Plugins Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: ------------------------------------------- Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: ----- MyVolumio plugins startup ---- Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: ------------------------------------------- Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Fetching plans data.... Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: Starting Shairport Sync Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: Starting Shairport Sync Nov 03 11:48:01 dirtyvolumio sudo[1444]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/addservice.sh Nov 03 11:48:01 dirtyvolumio sudo[1444]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:01 dirtyvolumio sudo[1446]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 03 11:48:01 dirtyvolumio sudo[1446]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: Starting Shairport Sync Nov 03 11:48:01 dirtyvolumio sudo[1451]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 03 11:48:01 dirtyvolumio sudo[1451]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:01 dirtyvolumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 03 11:48:01 dirtyvolumio systemd[1]: shairport-sync.service: Succeeded. Nov 03 11:48:01 dirtyvolumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 03 11:48:01 dirtyvolumio sudo[1455]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 03 11:48:01 dirtyvolumio sudo[1455]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:01 dirtyvolumio volumio[1153]: error: updateQueue error: null Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioGetState Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:48:01 dirtyvolumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 03 11:48:01 dirtyvolumio sudo[1446]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:01 dirtyvolumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 03 11:48:01 dirtyvolumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Nov 03 11:48:01 dirtyvolumio systemd[1]: shairport-sync.service: Succeeded. Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: Asound.conf file unchanged, so no further update is needed Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: Output device has changed, restarting MPD Nov 03 11:48:01 dirtyvolumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 03 11:48:01 dirtyvolumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 03 11:48:01 dirtyvolumio sudo[1451]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:01 dirtyvolumio systemd[1]: Reloading. Nov 03 11:48:01 dirtyvolumio sudo[1455]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: Output device has changed, restarting Shairport Sync Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:01 dirtyvolumio sudo[1463]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 03 11:48:01 dirtyvolumio sudo[1463]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:01 dirtyvolumio sudo[1461]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 03 11:48:01 dirtyvolumio sudo[1461]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:01 dirtyvolumio sudo[1461]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: Shairport-Sync Started Nov 03 11:48:01 dirtyvolumio volumio[1153]: Error adding Membership: Error: addMembership EINVAL Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: MPD Permissions set Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: Shairport-Sync Started Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: Shairport-Sync Started Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: Starting Shairport Sync Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioGetState Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPause Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: CoreStateMachine::pause Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: mpdhttpout --- Volumio set on pause Nov 03 11:48:01 dirtyvolumio volumio[1153]: info: mpdhttpout ---Configuration successfully added to mpd.conf. Nov 03 11:48:01 dirtyvolumio sudo[1492]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 03 11:48:01 dirtyvolumio sudo[1492]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:01 dirtyvolumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Nov 03 11:48:01 dirtyvolumio volumio-remote-updater[566]: [2025-11-03 11:48:01] [connect] Successful connection Nov 03 11:48:01 dirtyvolumio volumio-remote-updater[566]: [2025-11-03 11:48:01] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1762199281 101 Nov 03 11:48:01 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 100 Nov 03 11:48:02 dirtyvolumio systemd[1]: serial-getty@ttyAMA10.service: Current command vanished from the unit file, execution of the command list won't be resumed. Nov 03 11:48:02 dirtyvolumio systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed. Nov 03 11:48:02 dirtyvolumio sudo[1196]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:02 dirtyvolumio sudo[1444]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:02 dirtyvolumio volumio[1153]: info: succeeded Nov 03 11:48:02 dirtyvolumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 03 11:48:02 dirtyvolumio systemd[1]: musicservicesshield.service: Succeeded. Nov 03 11:48:02 dirtyvolumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Nov 03 11:48:02 dirtyvolumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Nov 03 11:48:02 dirtyvolumio systemd[1]: Stopping Music Player Daemon... Nov 03 11:48:02 dirtyvolumio systemd[1]: shairport-sync.service: Succeeded. Nov 03 11:48:02 dirtyvolumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 03 11:48:02 dirtyvolumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 03 11:48:02 dirtyvolumio systemd[1]: mpd.service: Succeeded. Nov 03 11:48:02 dirtyvolumio systemd[1]: Stopped Music Player Daemon. Nov 03 11:48:02 dirtyvolumio sudo[1492]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:02 dirtyvolumio volumio[1153]: info: Shairport-Sync Started Nov 03 11:48:02 dirtyvolumio systemd[1]: Starting Music Player Daemon... Nov 03 11:48:02 dirtyvolumio sudo[1495]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 03 11:48:02 dirtyvolumio sudo[1495]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:02 dirtyvolumio sudo[1495]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:02 dirtyvolumio mpd[1499]: Nov 03 11:48 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 03 11:48:02 dirtyvolumio systemd[1]: Started Music Player Daemon. Nov 03 11:48:02 dirtyvolumio sudo[1463]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:02 dirtyvolumio volumio[1153]: error: updateQueue error: null Nov 03 11:48:02 dirtyvolumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Nov 03 11:48:02 dirtyvolumio volumio[1504]: cset: --> shielding system active with Nov 03 11:48:02 dirtyvolumio volumio[1504]: cset: "system" cpuset of CPUSPEC(1-3) with 103 tasks running Nov 03 11:48:02 dirtyvolumio volumio[1504]: cset: "user" cpuset of CPUSPEC(0) with 3 tasks running Nov 03 11:48:02 dirtyvolumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Nov 03 11:48:03 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Nov 03 11:48:03 dirtyvolumio sudo[1526]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 03 11:48:03 dirtyvolumio sudo[1526]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:03 dirtyvolumio systemd[1]: musicservicesshield.service: Succeeded. Nov 03 11:48:03 dirtyvolumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Nov 03 11:48:03 dirtyvolumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Nov 03 11:48:03 dirtyvolumio systemd[1]: Stopping Music Player Daemon... Nov 03 11:48:04 dirtyvolumio systemd[1]: mpd.service: Succeeded. Nov 03 11:48:04 dirtyvolumio systemd[1]: Stopped Music Player Daemon. Nov 03 11:48:04 dirtyvolumio systemd[1]: Starting Music Player Daemon... Nov 03 11:48:04 dirtyvolumio sudo[1528]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 03 11:48:04 dirtyvolumio sudo[1528]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:04 dirtyvolumio sudo[1528]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:04 dirtyvolumio mpd[1530]: Nov 03 11:48 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 03 11:48:04 dirtyvolumio systemd[1]: Started Music Player Daemon. Nov 03 11:48:04 dirtyvolumio sudo[1526]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:04 dirtyvolumio volumio[1153]: error: updateQueue error: null Nov 03 11:48:04 dirtyvolumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Nov 03 11:48:04 dirtyvolumio volumio[1533]: cset: --> shielding system active with Nov 03 11:48:04 dirtyvolumio volumio[1533]: cset: "system" cpuset of CPUSPEC(1-3) with 103 tasks running Nov 03 11:48:04 dirtyvolumio volumio[1533]: cset: "user" cpuset of CPUSPEC(0) with 3 tasks running Nov 03 11:48:04 dirtyvolumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Nov 03 11:48:06 dirtyvolumio volumio[1153]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Nov 03 11:48:08 dirtyvolumio sudo[1569]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 03 11:48:08 dirtyvolumio sudo[1569]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:08 dirtyvolumio sudo[1569]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:08 dirtyvolumio sudo[1572]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 03 11:48:08 dirtyvolumio sudo[1572]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:08 dirtyvolumio sudo[1572]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:08 dirtyvolumio sudo[1575]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Nov 03 11:48:08 dirtyvolumio sudo[1575]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:08 dirtyvolumio systemd[1]: Started UPnP Renderer front-end to MPD. Nov 03 11:48:08 dirtyvolumio sudo[1575]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:08 dirtyvolumio volumio[1153]: info: Upmpdcli Daemon Started Nov 03 11:48:08 dirtyvolumio volumio[1577]: Generating RSA private key, 4096 bit long modulus (2 primes) Nov 03 11:48:08 dirtyvolumio systemd[1]: systemd-fsckd.service: Succeeded. Nov 03 11:48:09 dirtyvolumio systemd[1]: systemd-hostnamed.service: Succeeded. Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: Adding plugin bluetooth to MyMusic Plugins Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: Adding plugin multiroom to MyMusic Plugins Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: Adding plugin metavolumio to MyMusic Plugins Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: Adding plugin cd_controller to MyMusic Plugins Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: Adding plugin qobuzconnect to MyMusic Plugins Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: Adding plugin smart_inputs to MyMusic Plugins Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: Adding plugin tidalconnect to MyMusic Plugins Nov 03 11:48:09 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Nov 03 11:48:10 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Nov 03 11:48:10 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Nov 03 11:48:10 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:10 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:10 dirtyvolumio volumio[1153]: info: Starting MyVolumio Remote Streaming Endpoints Nov 03 11:48:10 dirtyvolumio volumio[1153]: info: MyVolumio login type: Token Nov 03 11:48:10 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Nov 03 11:48:10 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Nov 03 11:48:10 dirtyvolumio volumio[1153]: info: Starting Streaming Service Transparent Proxy Nov 03 11:48:10 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Nov 03 11:48:10 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Nov 03 11:48:10 dirtyvolumio volumio[1153]: info: Streaming services startup Nov 03 11:48:10 dirtyvolumio volumio[1153]: info: Starting Streaming Daemon Nov 03 11:48:10 dirtyvolumio sudo[1603]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Nov 03 11:48:10 dirtyvolumio sudo[1603]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:10 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Nov 03 11:48:10 dirtyvolumio sudo[1603]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:10 dirtyvolumio volumio[1153]: error: Cannot start Volumio Streaming Daemon Nov 03 11:48:10 dirtyvolumio volumio[1153]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Nov 03 11:48:10 dirtyvolumio volumio[1153]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Nov 03 11:48:10 dirtyvolumio volumio[1153]: STREAMING PROXY: Starting server on port 3245 Nov 03 11:48:10 dirtyvolumio volumio[1153]: Node JS runtime: 14 Nov 03 11:48:10 dirtyvolumio volumio[1153]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Nov 03 11:48:12 dirtyvolumio volumio[1153]: info: MyVolumio token set successfully Nov 03 11:48:12 dirtyvolumio volumio[1153]: info: MYVOLUMIO: Adding device Nov 03 11:48:12 dirtyvolumio volumio[1153]: info: MYVOLUMIO: Evaluating Server Nov 03 11:48:12 dirtyvolumio volumio[1153]: info: MyVolumio Plan changed: premium Nov 03 11:48:12 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Nov 03 11:48:12 dirtyvolumio volumio[1153]: info: Removing browser output: myVolumio user plan is not superstar Nov 03 11:48:12 dirtyvolumio volumio[1153]: info: Removing audio output: Nov 03 11:48:12 dirtyvolumio volumio[1153]: info: MYVOLUMIO: Adding device Nov 03 11:48:12 dirtyvolumio volumio[1153]: info: MYVOLUMIO: Evaluating Server Nov 03 11:48:12 dirtyvolumio volumio[1153]: info: Remote config written successfully Nov 03 11:48:12 dirtyvolumio volumio[1153]: info: Starting Tunnel 1 Nov 03 11:48:12 dirtyvolumio volumio[1153]: info: Starting Tunnel Connection Checker Nov 03 11:48:12 dirtyvolumio volumio[1153]: info: Completed starting MyVolumio Plugin Nov 03 11:48:12 dirtyvolumio volumio[1153]: info: MYVolumio Device enabled Nov 03 11:48:12 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Nov 03 11:48:12 dirtyvolumio volumio[1153]: info: MyVolumio status changed Nov 03 11:48:12 dirtyvolumio volumio[1153]: info: Streaming services startup Nov 03 11:48:12 dirtyvolumio volumio[1153]: info: Starting Streaming Daemon Nov 03 11:48:12 dirtyvolumio sudo[1643]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Nov 03 11:48:12 dirtyvolumio sudo[1643]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:12 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Nov 03 11:48:12 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Nov 03 11:48:12 dirtyvolumio sudo[1643]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:12 dirtyvolumio volumio[1153]: info: [1762199292494] Starting BluetoothController Nov 03 11:48:12 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Nov 03 11:48:12 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Nov 03 11:48:12 dirtyvolumio sudo[1646]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Nov 03 11:48:12 dirtyvolumio sudo[1646]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:12 dirtyvolumio sudo[1646]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:12 dirtyvolumio volumio[1153]: info: MRS: MultiRoom plugin initialized Nov 03 11:48:12 dirtyvolumio volumio[1153]: info: MRS: STOPPING SNAPCLIENT Nov 03 11:48:12 dirtyvolumio volumio[1153]: info: MRS: Snap server stop Nov 03 11:48:12 dirtyvolumio sudo[1662]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Nov 03 11:48:12 dirtyvolumio sudo[1662]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:12 dirtyvolumio volumio[1153]: info: MRS: STOPPING volumioStreaming Nov 03 11:48:12 dirtyvolumio sudo[1665]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Nov 03 11:48:12 dirtyvolumio sudo[1662]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:12 dirtyvolumio sudo[1665]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:12 dirtyvolumio sudo[1668]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Nov 03 11:48:12 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Nov 03 11:48:12 dirtyvolumio sudo[1665]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:12 dirtyvolumio sudo[1668]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:12 dirtyvolumio sudo[1670]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Nov 03 11:48:12 dirtyvolumio sudo[1670]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:12 dirtyvolumio sudo[1670]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:12 dirtyvolumio sudo[1668]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:12 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Nov 03 11:48:12 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Nov 03 11:48:12 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Nov 03 11:48:12 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"... Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Preparing to generate the ALSA configuration file Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Setting Geolocation for MyVolumio to us2 Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Setting Geolocation for MyVolumio to us2 Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPlay Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CoreStateMachine::play index undefined Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CoreStateMachine::startPlaybackTimer Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:48:13 dirtyvolumio volumio[1153]: verbose: ControllerMpd::clearAddPlayTracks USB/New_Volume/Music/Amelie Lens/Amelie Lens WE2 ｜ Tomorrowland 2025.m4a Nov 03 11:48:13 dirtyvolumio volumio[1153]: verbose: ControllerMpd::sendMpdCommand stop Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: MRS: Removed streaming files Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: MRS: volumioStreaming STOPPED Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: MRS: SNAPSERVER STOPPED Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: MRS: SNAPCLIENT STOPPED Nov 03 11:48:13 dirtyvolumio volumio[1153]: error: Cannot start Volumio Streaming Daemon Nov 03 11:48:13 dirtyvolumio volumio[1153]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Nov 03 11:48:13 dirtyvolumio volumio[1153]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Reading ALSA contributions from plugins. Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: sendMpdCommand stop took 10 milliseconds Nov 03 11:48:13 dirtyvolumio volumio[1153]: verbose: ControllerMpd::sendMpdCommand clear Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Nov 03 11:48:13 dirtyvolumio volumio[1153]: ---------------------------- MPD announces system playlist update Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Ignoring MPD Status Update Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: sendMpdCommand clear took 2 milliseconds Nov 03 11:48:13 dirtyvolumio volumio[1153]: verbose: ControllerMpd::sendMpdCommand add "USB/New_Volume/Music/Amelie Lens/Amelie Lens WE2 ｜ Tomorrowland 2025.m4a" Nov 03 11:48:13 dirtyvolumio volumio[1153]: error: updateQueue error: null Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: ------------------------------ 7ms Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Asound.conf file written Nov 03 11:48:13 dirtyvolumio sudo[1676]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Nov 03 11:48:13 dirtyvolumio sudo[1676]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:13 dirtyvolumio sudo[1676]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Output device has changed, restarting MPD Nov 03 11:48:13 dirtyvolumio sudo[1681]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 03 11:48:13 dirtyvolumio sudo[1681]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Output device has changed, restarting Shairport Sync Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:13 dirtyvolumio sudo[1681]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:13 dirtyvolumio sudo[1684]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 03 11:48:13 dirtyvolumio sudo[1684]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Nov 03 11:48:13 dirtyvolumio systemd[1]: musicservicesshield.service: Succeeded. Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:13 dirtyvolumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Nov 03 11:48:13 dirtyvolumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Nov 03 11:48:13 dirtyvolumio systemd[1]: Stopping Music Player Daemon... Nov 03 11:48:13 dirtyvolumio systemd[1]: mpd.service: Succeeded. Nov 03 11:48:13 dirtyvolumio systemd[1]: Stopped Music Player Daemon. Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output for this device Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Adding audio output: Nov 03 11:48:13 dirtyvolumio sudo[1693]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name DirtyVolumio Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Adding METAVOLUMIO REST API Endpoints Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Plugin cd_controller disabled by user. Not starting Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Adding inputs REST Endpoints Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Scanning Audio Inputs Nov 03 11:48:13 dirtyvolumio sudo[1693]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:13 dirtyvolumio sudo[1693]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:13 dirtyvolumio systemd[1]: Starting Music Player Daemon... Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Checking against Known Cards name Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Adding Server instance for streaming Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Nov 03 11:48:13 dirtyvolumio volumio[1153]: error: Hi Res Audio Failed Login: Missing Login Data Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Adding HIGHRESAUDIO REST API Endpoints Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Plugin tidalconnect disabled by user. Not starting Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuzconnect Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: [MyVolumio PluginManager] Plugin qobuzconnect disabled by user. Not starting Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Stopping AccessToken refresher cron Nov 03 11:48:13 dirtyvolumio sudo[1691]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 03 11:48:13 dirtyvolumio sudo[1691]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:13 dirtyvolumio sudo[1691]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: AccessToken refresher cron started Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Stopping AccessToken refresher cron for QOBUZ Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: AccessToken refresher cron started for QOBUZ Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Adding TIDAL REST API Endpoints Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Adding QOBUZ REST API Endpoints Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Bluetooth name changed to DirtyVolumio Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: MPD Permissions set Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:13 dirtyvolumio volumio[1153]: [Metrics] CommandRouter: 15s 977.29ms Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumiosetStartupVolume Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CoreCommandRouter::Close All Modals sent Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CoreCommandRouter::Close All Modals sent Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Starting Shairport Sync Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: mpdhttpout ---Configuration successfully replaced in mpd.conf. Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioGetState Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPause Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: CoreStateMachine::pause Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: mpdhttpout --- Volumio set on pause Nov 03 11:48:13 dirtyvolumio sudo[1709]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 03 11:48:13 dirtyvolumio sudo[1709]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:13 dirtyvolumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 03 11:48:13 dirtyvolumio systemd[1]: shairport-sync.service: Succeeded. Nov 03 11:48:13 dirtyvolumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: MRS: Found cast device: Google-Cast-Group-e670e2de3ada4d4eb3c8059643433c78 Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Adding audio output: Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: MRS: Found cast device: Chromecast-HD-5ccf2324840472f8397d76742f26bbde Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Adding audio output: Nov 03 11:48:13 dirtyvolumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 03 11:48:13 dirtyvolumio sudo[1709]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Shairport-Sync Started Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: MRS: Found cast device: Chromecast-HD-5ccf2324840472f8397d76742f26bbde Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: MRS: Found cast device: Google-Cast-Group-e670e2de3ada4d4eb3c8059643433c78 Nov 03 11:48:13 dirtyvolumio mpd[1701]: Nov 03 11:48 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 03 11:48:13 dirtyvolumio systemd[1]: Started Music Player Daemon. Nov 03 11:48:13 dirtyvolumio sudo[1684]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:13 dirtyvolumio volumio[1153]: error: updateQueue error: null Nov 03 11:48:13 dirtyvolumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Nov 03 11:48:13 dirtyvolumio volumio[1153]: info: Successfully Added MyVolumio device Nov 03 11:48:13 dirtyvolumio volumio[1721]: cset: --> shielding system active with Nov 03 11:48:13 dirtyvolumio volumio[1721]: cset: "system" cpuset of CPUSPEC(1-3) with 122 tasks running Nov 03 11:48:13 dirtyvolumio volumio[1721]: cset: "user" cpuset of CPUSPEC(0) with 3 tasks running Nov 03 11:48:13 dirtyvolumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Nov 03 11:48:14 dirtyvolumio volumio[1153]: info: Updating MyVolumio device info Nov 03 11:48:14 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:14 dirtyvolumio volumio[1153]: info: Updating MyVolumio device info Nov 03 11:48:14 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:14 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:14 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:14 dirtyvolumio volumio[1153]: error: Upnp client error: Error: This socket has been ended by the other party Nov 03 11:48:14 dirtyvolumio volumio[1153]: info: Successfully Added MyVolumio device Nov 03 11:48:14 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Nov 03 11:48:14 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 03 11:48:14 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Nov 03 11:48:14 dirtyvolumio volumio[1153]: info: Successfully Updated MyVolumio device Nov 03 11:48:14 dirtyvolumio volumio[1153]: info: Successfully Updated MyVolumio device Nov 03 11:48:15 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Nov 03 11:48:15 dirtyvolumio sudo[1745]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 03 11:48:15 dirtyvolumio sudo[1745]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:15 dirtyvolumio systemd[1]: musicservicesshield.service: Succeeded. Nov 03 11:48:15 dirtyvolumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Nov 03 11:48:15 dirtyvolumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Nov 03 11:48:15 dirtyvolumio systemd[1]: Stopping Music Player Daemon... Nov 03 11:48:15 dirtyvolumio systemd[1]: mpd.service: Succeeded. Nov 03 11:48:15 dirtyvolumio systemd[1]: Stopped Music Player Daemon. Nov 03 11:48:15 dirtyvolumio systemd[1]: Starting Music Player Daemon... Nov 03 11:48:15 dirtyvolumio sudo[1747]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 03 11:48:15 dirtyvolumio sudo[1747]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:15 dirtyvolumio sudo[1747]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:15 dirtyvolumio mpd[1749]: Nov 03 11:48 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 03 11:48:15 dirtyvolumio systemd[1]: Started Music Player Daemon. Nov 03 11:48:15 dirtyvolumio sudo[1745]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:15 dirtyvolumio volumio[1153]: error: updateQueue error: null Nov 03 11:48:15 dirtyvolumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Nov 03 11:48:15 dirtyvolumio volumio[1752]: cset: --> shielding system active with Nov 03 11:48:15 dirtyvolumio volumio[1752]: cset: "system" cpuset of CPUSPEC(1-3) with 122 tasks running Nov 03 11:48:15 dirtyvolumio volumio[1752]: cset: "user" cpuset of CPUSPEC(0) with 3 tasks running Nov 03 11:48:15 dirtyvolumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Nov 03 11:48:16 dirtyvolumio sudo[1774]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Nov 03 11:48:16 dirtyvolumio sudo[1774]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:16 dirtyvolumio systemd[1]: Started Volumio Bluetooth Module. Nov 03 11:48:16 dirtyvolumio sudo[1774]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:16 dirtyvolumio volumio[1153]: info: Volumio BT Module successfully started Nov 03 11:48:16 dirtyvolumio sudo[1777]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Nov 03 11:48:16 dirtyvolumio sudo[1777]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:16 dirtyvolumio volumiobt[1776]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Nov 03 11:48:16 dirtyvolumio sudo[1777]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:17 dirtyvolumio sudo[1786]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Nov 03 11:48:17 dirtyvolumio sudo[1785]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Nov 03 11:48:17 dirtyvolumio sudo[1786]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:17 dirtyvolumio sudo[1785]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:17 dirtyvolumio volumiobt[1776]: pulseaudio: no process found Nov 03 11:48:17 dirtyvolumio sudo[1786]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:17 dirtyvolumio dbus-daemon[577]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.26' (uid=1000 pid=1792 comm="/usr/bin/pulseaudio --high-priority=true ") Nov 03 11:48:17 dirtyvolumio systemd[1]: Started MyVolumio SSH Tunnel. Nov 03 11:48:17 dirtyvolumio sudo[1785]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:17 dirtyvolumio systemd[1]: Starting RealtimeKit Scheduling Policy Service... Nov 03 11:48:17 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 03 11:48:17 dirtyvolumio volumio[1153]: info: Remote SSH Started Nov 03 11:48:17 dirtyvolumio autossh[1793]: port set to 0, monitoring disabled Nov 03 11:48:17 dirtyvolumio autossh[1793]: starting ssh (count 1) Nov 03 11:48:17 dirtyvolumio autossh[1793]: ssh child pid is 1798 Nov 03 11:48:17 dirtyvolumio dbus-daemon[577]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Nov 03 11:48:17 dirtyvolumio systemd[1]: Started RealtimeKit Scheduling Policy Service. Nov 03 11:48:17 dirtyvolumio rtkit-daemon[1796]: Successfully called chroot. Nov 03 11:48:17 dirtyvolumio rtkit-daemon[1796]: Successfully dropped privileges. Nov 03 11:48:17 dirtyvolumio rtkit-daemon[1796]: Successfully limited resources. Nov 03 11:48:17 dirtyvolumio rtkit-daemon[1796]: Running. Nov 03 11:48:17 dirtyvolumio rtkit-daemon[1796]: Canary thread running. Nov 03 11:48:17 dirtyvolumio rtkit-daemon[1796]: Watchdog thread running. Nov 03 11:48:17 dirtyvolumio dbus-daemon[577]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.27' (uid=0 pid=1796 comm="/usr/lib/rtkit/rtkit-daemon ") Nov 03 11:48:17 dirtyvolumio systemd[1]: Starting Authorization Manager... Nov 03 11:48:17 dirtyvolumio polkitd[1801]: started daemon version 0.105 using authority implementation `local' version `0.105' Nov 03 11:48:17 dirtyvolumio dbus-daemon[577]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Nov 03 11:48:17 dirtyvolumio systemd[1]: Started Authorization Manager. Nov 03 11:48:17 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 03 11:48:17 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 101 Nov 03 11:48:17 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioGetState Nov 03 11:48:17 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:48:17 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:17 dirtyvolumio pulseaudio[1792]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Nov 03 11:48:17 dirtyvolumio pulseaudio[1792]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Nov 03 11:48:17 dirtyvolumio volumiobt[1776]: Applying permissions Nov 03 11:48:17 dirtyvolumio volumiobt[1776]: Setting BT discoverable and pairable Nov 03 11:48:17 dirtyvolumio pulseaudio[1792]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files Nov 03 11:48:17 dirtyvolumio bluetoothd[822]: Endpoint registered: sender=:1.47 path=/MediaEndpoint/A2DPSource Nov 03 11:48:17 dirtyvolumio bluetoothd[822]: Endpoint registered: sender=:1.47 path=/MediaEndpoint/A2DPSink Nov 03 11:48:17 dirtyvolumio volumiobt[1776]: [CHG] Controller D8:3A:DD:C1:DB:74 Class: 0x0008041c Nov 03 11:48:17 dirtyvolumio volumiobt[1776]: [55B blob data] Nov 03 11:48:17 dirtyvolumio volumiobt[1776]: [bluetooth]# -e power on Nov 03 11:48:17 dirtyvolumio volumiobt[1776]: Invalid command in menu main: -e Nov 03 11:48:17 dirtyvolumio volumiobt[1776]: Nov 03 11:48:17 dirtyvolumio volumiobt[1776]: Use "help" for a list of available commands in a menu. Nov 03 11:48:17 dirtyvolumio volumiobt[1776]: Use "menu " if you want to enter any submenu. Nov 03 11:48:17 dirtyvolumio volumiobt[1776]: Use "back" if you want to return to menu main. Nov 03 11:48:17 dirtyvolumio kernel: Bluetooth: RFCOMM TTY layer initialized Nov 03 11:48:17 dirtyvolumio kernel: Bluetooth: RFCOMM socket layer initialized Nov 03 11:48:17 dirtyvolumio kernel: Bluetooth: RFCOMM ver 1.11 Nov 03 11:48:17 dirtyvolumio volumiobt[1776]: [bluetooth]# agent on Nov 03 11:48:17 dirtyvolumio volumiobt[1776]: Agent is already registered Nov 03 11:48:17 dirtyvolumio volumiobt[1776]: [bluetooth]# discoverable on Nov 03 11:48:17 dirtyvolumio volumiobt[1776]: [bluetooth]# pairable on Nov 03 11:48:17 dirtyvolumio volumiobt[1776]: [bluetooth]# agent NoInputNoOutput Nov 03 11:48:17 dirtyvolumio volumiobt[1776]: Agent is already registered Nov 03 11:48:17 dirtyvolumio volumiobt[1776]: [bluetooth]# default-agent Nov 03 11:48:17 dirtyvolumio volumiobt[1776]: [bluetooth]# quit Nov 03 11:48:17 dirtyvolumio volumiobt[1776]: [59B blob data] Nov 03 11:48:17 dirtyvolumio volumiossh-tunnel[1790]: Warning: Permanently added '[us2.myvolumio.org]:2222,[137.184.235.84]:2222' (RSA) to the list of known hosts. Nov 03 11:48:18 dirtyvolumio volumio[1153]: info: MRS: Getting audio outputs on start Nov 03 11:48:18 dirtyvolumio volumio[1153]: info: MRS: Requesting all other devices output Nov 03 11:48:18 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:19 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:19 dirtyvolumio systemd[1]: systemd-timedated.service: Succeeded. Nov 03 11:48:20 dirtyvolumio volumio[1153]: info: BOOT COMPLETED Nov 03 11:48:20 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:20 dirtyvolumio volumio[1153]: info: mpdhttpout ---Boot completed detected! Patching mpd now! Nov 03 11:48:20 dirtyvolumio volumio[1153]: info: mpdhttpout ---Configuration successfully replaced in mpd.conf. Nov 03 11:48:20 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioGetState Nov 03 11:48:20 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:48:20 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPause Nov 03 11:48:20 dirtyvolumio volumio[1153]: info: CoreStateMachine::pause Nov 03 11:48:20 dirtyvolumio volumio[1153]: info: mpdhttpout --- Volumio set on pause Nov 03 11:48:21 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:22 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:22 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Nov 03 11:48:22 dirtyvolumio sudo[1831]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 03 11:48:22 dirtyvolumio sudo[1831]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:22 dirtyvolumio systemd[1]: musicservicesshield.service: Succeeded. Nov 03 11:48:22 dirtyvolumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Nov 03 11:48:22 dirtyvolumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Nov 03 11:48:22 dirtyvolumio systemd[1]: Stopping Music Player Daemon... Nov 03 11:48:22 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 03 11:48:22 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 03 11:48:22 dirtyvolumio systemd[1]: mpd.service: Succeeded. Nov 03 11:48:22 dirtyvolumio systemd[1]: Stopped Music Player Daemon. Nov 03 11:48:22 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 03 11:48:22 dirtyvolumio systemd[1]: Starting Music Player Daemon... Nov 03 11:48:22 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 03 11:48:22 dirtyvolumio sudo[1833]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 03 11:48:22 dirtyvolumio sudo[1833]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:22 dirtyvolumio sudo[1833]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:22 dirtyvolumio mpd[1835]: Nov 03 11:48 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 03 11:48:22 dirtyvolumio systemd[1]: Started Music Player Daemon. Nov 03 11:48:22 dirtyvolumio sudo[1831]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:22 dirtyvolumio volumio[1153]: error: updateQueue error: null Nov 03 11:48:22 dirtyvolumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Nov 03 11:48:22 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 03 11:48:23 dirtyvolumio volumio[1838]: cset: --> shielding system active with Nov 03 11:48:23 dirtyvolumio volumio[1838]: cset: "system" cpuset of CPUSPEC(1-3) with 131 tasks running Nov 03 11:48:23 dirtyvolumio volumio[1838]: cset: "user" cpuset of CPUSPEC(0) with 3 tasks running Nov 03 11:48:23 dirtyvolumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Nov 03 11:48:23 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:24 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:25 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 03 11:48:25 dirtyvolumio volumio[1153]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 102 Nov 03 11:48:25 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioGetState Nov 03 11:48:25 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:48:25 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:26 dirtyvolumio volumio[1577]: ................................................................................................................................................................................................................................................................................................................................................................................++++ Nov 03 11:48:26 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:27 dirtyvolumio volumio[1153]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 03 11:48:27 dirtyvolumio volumio[1153]: xcb_connection_has_error() returned true Nov 03 11:48:27 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 03 11:48:27 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:27 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 03 11:48:27 dirtyvolumio volumio[1153]: xcb_connection_has_error() returned true Nov 03 11:48:27 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 11:48:27 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 11:48:27 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 11:48:27 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 11:48:27 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 11:48:27 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 11:48:27 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 11:48:27 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Nov 03 11:48:27 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 03 11:48:27 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:28 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:29 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:30 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:30 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Nov 03 11:48:30 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 03 11:48:30 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Nov 03 11:48:30 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioGetBrowseSources Nov 03 11:48:30 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 03 11:48:30 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:31 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 03 11:48:31 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:31 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 03 11:48:31 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Nov 03 11:48:31 dirtyvolumio volumio-remote-updater[566]: No test mode Nov 03 11:48:31 dirtyvolumio volumio-remote-updater[566]: No alpha test mode Nov 03 11:48:31 dirtyvolumio volumio[1153]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Nov 03 11:48:31 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Nov 03 11:48:31 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: Preparing to save Alsa Options, stopping services first Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioGetState Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPause Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreStateMachine::pause Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: Saving Audio Output to: {"output_device":{"value":"1","label":"HDMI 1 Out"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}} Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 03 11:48:32 dirtyvolumio volumio[1153]: xcb_connection_has_error() returned true Nov 03 11:48:32 dirtyvolumio volumio[1153]: xcb_connection_has_error() returned true Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: Found match in Cards Database: setting mixer for card HDMI 1 Out Nov 03 11:48:32 dirtyvolumio volumio[1153]: xcb_connection_has_error() returned true Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: Device 1 does not have any Mixer Control Available Nov 03 11:48:32 dirtyvolumio volumio[1153]: xcb_connection_has_error() returned true Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioUpdateVolumeSettings Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: Updating Volume Controller Parameters: Device: 1 Name: HDMI 1 Out Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: Disabling external Volume Control Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreStateMachine::pushState Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPushState Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output update for this device Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: Preparing to generate the ALSA configuration file Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: Reading ALSA contributions from plugins. Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: PeppySpectrum ---peppyspectrum status stop Nov 03 11:48:32 dirtyvolumio sudo[1889]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Nov 03 11:48:32 dirtyvolumio sudo[1889]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:32 dirtyvolumio sudo[1889]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:32 dirtyvolumio volumio[1153]: xcb_connection_has_error() returned true Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 03 11:48:32 dirtyvolumio volumio[1153]: xcb_connection_has_error() returned true Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: peppyspectrum Daemon Stop Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: mpdhttpout ---Configuration successfully replaced in mpd.conf. Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioGetState Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPause Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreStateMachine::pause Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: mpdhttpout --- Volumio set on pause Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: mpdhttpout ---Configuration successfully replaced in mpd.conf. Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioGetState Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPause Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreStateMachine::pause Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: mpdhttpout --- Volumio set on pause Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: Asound.conf file written Nov 03 11:48:32 dirtyvolumio sudo[1896]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Nov 03 11:48:32 dirtyvolumio sudo[1896]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:32 dirtyvolumio sudo[1896]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:32 dirtyvolumio volumio[1153]: xcb_connection_has_error() returned true Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: Output device has changed, restarting MPD Nov 03 11:48:32 dirtyvolumio sudo[1901]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 03 11:48:32 dirtyvolumio sudo[1901]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:32 dirtyvolumio sudo[1901]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: Output device has changed, restarting Shairport Sync Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:32 dirtyvolumio sudo[1904]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 03 11:48:32 dirtyvolumio sudo[1904]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:32 dirtyvolumio systemd[1]: musicservicesshield.service: Succeeded. Nov 03 11:48:32 dirtyvolumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Nov 03 11:48:32 dirtyvolumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Nov 03 11:48:32 dirtyvolumio systemd[1]: Stopping Music Player Daemon... Nov 03 11:48:32 dirtyvolumio volumio[1153]: xcb_connection_has_error() returned true Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 03 11:48:32 dirtyvolumio volumio[1153]: xcb_connection_has_error() returned true Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:32 dirtyvolumio systemd[1]: mpd.service: Succeeded. Nov 03 11:48:32 dirtyvolumio systemd[1]: Stopped Music Player Daemon. Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: Output device has changed, restarting MPD Nov 03 11:48:32 dirtyvolumio sudo[1913]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 03 11:48:32 dirtyvolumio sudo[1913]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:32 dirtyvolumio systemd[1]: Starting Music Player Daemon... Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: Output device has changed, restarting Shairport Sync Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:32 dirtyvolumio sudo[1913]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:32 dirtyvolumio sudo[1916]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 03 11:48:32 dirtyvolumio sudo[1916]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:32 dirtyvolumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Nov 03 11:48:32 dirtyvolumio systemd[1]: mpd.service: Succeeded. Nov 03 11:48:32 dirtyvolumio systemd[1]: Stopped Music Player Daemon. Nov 03 11:48:32 dirtyvolumio systemd[1]: Starting Music Player Daemon... Nov 03 11:48:32 dirtyvolumio volumio[1153]: xcb_connection_has_error() returned true Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 03 11:48:32 dirtyvolumio volumio[1153]: xcb_connection_has_error() returned true Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:32 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 03 11:48:32 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 03 11:48:32 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 03 11:48:32 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 03 11:48:32 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 03 11:48:32 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 03 11:48:32 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 03 11:48:32 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 03 11:48:32 dirtyvolumio sudo[1921]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 03 11:48:32 dirtyvolumio sudo[1921]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: MPD Permissions set Nov 03 11:48:32 dirtyvolumio volumio[1153]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: MPD Permissions set Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:32 dirtyvolumio sudo[1921]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:32 dirtyvolumio volumio[1153]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: Starting Shairport Sync Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: Starting Shairport Sync Nov 03 11:48:32 dirtyvolumio sudo[1935]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 03 11:48:32 dirtyvolumio sudo[1935]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:32 dirtyvolumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: mpdhttpout ---Configuration successfully replaced in mpd.conf. Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioGetState Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPause Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreStateMachine::pause Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: mpdhttpout --- Volumio set on pause Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: mpdhttpout ---Configuration successfully replaced in mpd.conf. Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioGetState Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPause Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: CoreStateMachine::pause Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: mpdhttpout --- Volumio set on pause Nov 03 11:48:32 dirtyvolumio systemd[1]: shairport-sync.service: Succeeded. Nov 03 11:48:32 dirtyvolumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: Preparing to generate the ALSA configuration file Nov 03 11:48:32 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 03 11:48:32 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: Reading ALSA contributions from plugins. Nov 03 11:48:32 dirtyvolumio sudo[1938]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 03 11:48:32 dirtyvolumio sudo[1938]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:32 dirtyvolumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 03 11:48:32 dirtyvolumio sudo[1935]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:32 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: Shairport-Sync Started Nov 03 11:48:32 dirtyvolumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 03 11:48:32 dirtyvolumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Nov 03 11:48:32 dirtyvolumio volumio[1153]: info: Asound.conf file written Nov 03 11:48:32 dirtyvolumio systemd[1]: shairport-sync.service: Succeeded. Nov 03 11:48:32 dirtyvolumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 03 11:48:32 dirtyvolumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 03 11:48:32 dirtyvolumio sudo[1938]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:32 dirtyvolumio sudo[1943]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Nov 03 11:48:32 dirtyvolumio sudo[1943]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:32 dirtyvolumio sudo[1943]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:33 dirtyvolumio volumio[1153]: xcb_connection_has_error() returned true Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: Output device has changed, restarting MPD Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: Output device has changed, restarting Shairport Sync Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:33 dirtyvolumio sudo[1950]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 03 11:48:33 dirtyvolumio sudo[1950]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:33 dirtyvolumio sudo[1952]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 03 11:48:33 dirtyvolumio sudo[1952]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:33 dirtyvolumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Nov 03 11:48:33 dirtyvolumio systemd[1]: mpd.service: Succeeded. Nov 03 11:48:33 dirtyvolumio systemd[1]: Stopped Music Player Daemon. Nov 03 11:48:33 dirtyvolumio sudo[1950]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:33 dirtyvolumio volumio[1153]: xcb_connection_has_error() returned true Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 03 11:48:33 dirtyvolumio volumio[1153]: xcb_connection_has_error() returned true Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:33 dirtyvolumio systemd[1]: Starting Music Player Daemon... Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: Preparing to generate the ALSA configuration file Nov 03 11:48:33 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 03 11:48:33 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 03 11:48:33 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 03 11:48:33 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 03 11:48:33 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 03 11:48:33 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 03 11:48:33 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: Reading ALSA contributions from plugins. Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: MPD Permissions set Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: Shairport-Sync Started Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:33 dirtyvolumio sudo[1958]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 03 11:48:33 dirtyvolumio sudo[1958]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:33 dirtyvolumio sudo[1958]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:33 dirtyvolumio volumio[1153]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: Starting Shairport Sync Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: mpdhttpout ---Configuration successfully replaced in mpd.conf. Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioGetState Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPause Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: CoreStateMachine::pause Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: mpdhttpout --- Volumio set on pause Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: Asound.conf file unchanged, so no further update is needed Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: Output device has changed, restarting MPD Nov 03 11:48:33 dirtyvolumio sudo[1968]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 03 11:48:33 dirtyvolumio sudo[1968]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:33 dirtyvolumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 03 11:48:33 dirtyvolumio systemd[1]: shairport-sync.service: Succeeded. Nov 03 11:48:33 dirtyvolumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: Output device has changed, restarting Shairport Sync Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:33 dirtyvolumio sudo[1974]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 03 11:48:33 dirtyvolumio sudo[1970]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 03 11:48:33 dirtyvolumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 03 11:48:33 dirtyvolumio sudo[1970]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:33 dirtyvolumio sudo[1974]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:33 dirtyvolumio sudo[1970]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:33 dirtyvolumio sudo[1968]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:33 dirtyvolumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Nov 03 11:48:33 dirtyvolumio systemd[1]: mpd.service: Succeeded. Nov 03 11:48:33 dirtyvolumio systemd[1]: Stopped Music Player Daemon. Nov 03 11:48:33 dirtyvolumio systemd[1]: Starting Music Player Daemon... Nov 03 11:48:33 dirtyvolumio volumio[1153]: xcb_connection_has_error() returned true Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 03 11:48:33 dirtyvolumio volumio[1153]: xcb_connection_has_error() returned true Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:33 dirtyvolumio sudo[1981]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 03 11:48:33 dirtyvolumio sudo[1981]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:33 dirtyvolumio sudo[1981]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:33 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 03 11:48:33 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 03 11:48:33 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 03 11:48:33 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 03 11:48:33 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 03 11:48:33 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 03 11:48:33 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 03 11:48:33 dirtyvolumio volumio[1153]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: MPD Permissions set Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: Shairport-Sync Started Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: Starting Shairport Sync Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: mpdhttpout ---Configuration successfully replaced in mpd.conf. Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioGetState Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPause Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: CoreStateMachine::pause Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: mpdhttpout --- Volumio set on pause Nov 03 11:48:33 dirtyvolumio sudo[1993]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 03 11:48:33 dirtyvolumio sudo[1993]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:33 dirtyvolumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 03 11:48:33 dirtyvolumio systemd[1]: shairport-sync.service: Succeeded. Nov 03 11:48:33 dirtyvolumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 03 11:48:33 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 03 11:48:33 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 03 11:48:33 dirtyvolumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 03 11:48:33 dirtyvolumio sudo[1993]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:33 dirtyvolumio volumio[1153]: info: Shairport-Sync Started Nov 03 11:48:33 dirtyvolumio mpd[1987]: Nov 03 11:48 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 03 11:48:33 dirtyvolumio systemd[1]: Started Music Player Daemon. Nov 03 11:48:33 dirtyvolumio sudo[1974]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:33 dirtyvolumio sudo[1952]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:33 dirtyvolumio sudo[1916]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:33 dirtyvolumio sudo[1904]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:33 dirtyvolumio volumio[1153]: error: MPD error: The expression evaluated to a falsy value: Nov 03 11:48:33 dirtyvolumio volumio[1153]: assert.ok(self.idling) Nov 03 11:48:33 dirtyvolumio volumio[1153]: error: The expression evaluated to a falsy value: Nov 03 11:48:33 dirtyvolumio volumio[1153]: assert.ok(self.idling) Nov 03 11:48:33 dirtyvolumio volumio[1153]: error: MPD error: The expression evaluated to a falsy value: Nov 03 11:48:33 dirtyvolumio volumio[1153]: assert.ok(self.idling) Nov 03 11:48:33 dirtyvolumio volumio[1153]: error: The expression evaluated to a falsy value: Nov 03 11:48:33 dirtyvolumio volumio[1153]: assert.ok(self.idling) Nov 03 11:48:33 dirtyvolumio volumio[1153]: error: MPD error: The expression evaluated to a falsy value: Nov 03 11:48:33 dirtyvolumio volumio[1153]: assert.ok(self.idling) Nov 03 11:48:33 dirtyvolumio volumio[1153]: error: The expression evaluated to a falsy value: Nov 03 11:48:33 dirtyvolumio volumio[1153]: assert.ok(self.idling) Nov 03 11:48:33 dirtyvolumio volumio[1153]: error: updateQueue error: null Nov 03 11:48:33 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 03 11:48:33 dirtyvolumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Nov 03 11:48:33 dirtyvolumio volumio[2000]: cset: --> shielding system active with Nov 03 11:48:33 dirtyvolumio volumio[2000]: cset: "system" cpuset of CPUSPEC(1-3) with 130 tasks running Nov 03 11:48:33 dirtyvolumio volumio[2000]: cset: "user" cpuset of CPUSPEC(0) with 3 tasks running Nov 03 11:48:33 dirtyvolumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Nov 03 11:48:33 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:34 dirtyvolumio volumio[1577]: ...................................................................................................................................................................++++ Nov 03 11:48:34 dirtyvolumio volumio[1577]: e is 65537 (0x010001) Nov 03 11:48:34 dirtyvolumio volumio[1577]: writing RSA key Nov 03 11:48:34 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Nov 03 11:48:34 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Nov 03 11:48:34 dirtyvolumio sudo[2037]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 03 11:48:34 dirtyvolumio sudo[2037]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:34 dirtyvolumio systemd[1]: musicservicesshield.service: Succeeded. Nov 03 11:48:34 dirtyvolumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Nov 03 11:48:34 dirtyvolumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Nov 03 11:48:34 dirtyvolumio systemd[1]: Stopping Music Player Daemon... Nov 03 11:48:34 dirtyvolumio sudo[2040]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 03 11:48:34 dirtyvolumio sudo[2040]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:34 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 03 11:48:34 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 03 11:48:34 dirtyvolumio systemd[1]: mpd.service: Succeeded. Nov 03 11:48:34 dirtyvolumio systemd[1]: Stopped Music Player Daemon. Nov 03 11:48:34 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 03 11:48:34 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 03 11:48:34 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 03 11:48:34 dirtyvolumio systemd[1]: Starting Music Player Daemon... Nov 03 11:48:34 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 03 11:48:34 dirtyvolumio sudo[2042]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 03 11:48:34 dirtyvolumio sudo[2042]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:34 dirtyvolumio sudo[2042]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:35 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:35 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Nov 03 11:48:35 dirtyvolumio mpd[2044]: Nov 03 11:48 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 03 11:48:35 dirtyvolumio systemd[1]: Started Music Player Daemon. Nov 03 11:48:35 dirtyvolumio sudo[2040]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:35 dirtyvolumio sudo[2037]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:35 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Nov 03 11:48:35 dirtyvolumio sudo[2049]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 03 11:48:35 dirtyvolumio sudo[2049]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:35 dirtyvolumio volumio[1153]: error: MPD error: The expression evaluated to a falsy value: Nov 03 11:48:35 dirtyvolumio volumio[1153]: assert.ok(self.idling) Nov 03 11:48:35 dirtyvolumio volumio[1153]: error: The expression evaluated to a falsy value: Nov 03 11:48:35 dirtyvolumio volumio[1153]: assert.ok(self.idling) Nov 03 11:48:35 dirtyvolumio volumio[1153]: error: updateQueue error: null Nov 03 11:48:35 dirtyvolumio sudo[2052]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 03 11:48:35 dirtyvolumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Nov 03 11:48:35 dirtyvolumio sudo[2052]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:35 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 03 11:48:35 dirtyvolumio systemd[1]: Stopping Music Player Daemon... Nov 03 11:48:35 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 03 11:48:35 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 03 11:48:35 dirtyvolumio systemd[1]: mpd.service: Succeeded. Nov 03 11:48:35 dirtyvolumio systemd[1]: Stopped Music Player Daemon. Nov 03 11:48:35 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 03 11:48:35 dirtyvolumio systemd[1]: Starting Music Player Daemon... Nov 03 11:48:35 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 03 11:48:35 dirtyvolumio sudo[2062]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 03 11:48:35 dirtyvolumio sudo[2062]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:35 dirtyvolumio sudo[2062]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:35 dirtyvolumio volumio[2048]: cset: --> shielding system active with Nov 03 11:48:35 dirtyvolumio volumio[2048]: cset: "system" cpuset of CPUSPEC(1-3) with 148 tasks running Nov 03 11:48:35 dirtyvolumio volumio[2048]: cset: "user" cpuset of CPUSPEC(0) with 0 tasks running Nov 03 11:48:35 dirtyvolumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Nov 03 11:48:35 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Nov 03 11:48:35 dirtyvolumio sudo[2077]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 03 11:48:35 dirtyvolumio sudo[2077]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:35 dirtyvolumio systemd[1]: musicservicesshield.service: Succeeded. Nov 03 11:48:35 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 03 11:48:35 dirtyvolumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Nov 03 11:48:35 dirtyvolumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Nov 03 11:48:35 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 03 11:48:35 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 03 11:48:35 dirtyvolumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Nov 03 11:48:35 dirtyvolumio systemd[1]: mpd.service: Succeeded. Nov 03 11:48:35 dirtyvolumio systemd[1]: Stopped Music Player Daemon. Nov 03 11:48:35 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 03 11:48:35 dirtyvolumio systemd[1]: Starting Music Player Daemon... Nov 03 11:48:35 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 03 11:48:35 dirtyvolumio sudo[2079]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 03 11:48:35 dirtyvolumio sudo[2079]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:35 dirtyvolumio sudo[2079]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:35 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Nov 03 11:48:35 dirtyvolumio sudo[2083]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 03 11:48:35 dirtyvolumio sudo[2083]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:35 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 03 11:48:35 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 03 11:48:35 dirtyvolumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Nov 03 11:48:35 dirtyvolumio systemd[1]: mpd.service: Succeeded. Nov 03 11:48:35 dirtyvolumio systemd[1]: Stopped Music Player Daemon. Nov 03 11:48:35 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 03 11:48:35 dirtyvolumio systemd[1]: Starting Music Player Daemon... Nov 03 11:48:35 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 03 11:48:35 dirtyvolumio sudo[2085]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 03 11:48:35 dirtyvolumio sudo[2085]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:35 dirtyvolumio sudo[2085]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:35 dirtyvolumio mpd[2087]: Nov 03 11:48 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 03 11:48:35 dirtyvolumio systemd[1]: Started Music Player Daemon. Nov 03 11:48:35 dirtyvolumio sudo[2052]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:35 dirtyvolumio sudo[2083]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:35 dirtyvolumio sudo[2077]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:35 dirtyvolumio sudo[2049]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:35 dirtyvolumio volumio[1153]: error: updateQueue error: null Nov 03 11:48:35 dirtyvolumio volumio[1153]: error: updateQueue error: null Nov 03 11:48:35 dirtyvolumio volumio[1153]: error: updateQueue error: null Nov 03 11:48:35 dirtyvolumio volumio[1153]: error: updateQueue error: null Nov 03 11:48:35 dirtyvolumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Nov 03 11:48:35 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 03 11:48:35 dirtyvolumio volumio[2090]: cset: --> shielding system active with Nov 03 11:48:35 dirtyvolumio volumio[2090]: cset: "system" cpuset of CPUSPEC(1-3) with 141 tasks running Nov 03 11:48:35 dirtyvolumio volumio[2090]: cset: "user" cpuset of CPUSPEC(0) with 3 tasks running Nov 03 11:48:35 dirtyvolumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Nov 03 11:48:36 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:36 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Nov 03 11:48:36 dirtyvolumio volumio[1153]: info: CoreStateMachine::getcurrentVolume Nov 03 11:48:36 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioRetrievevolume Nov 03 11:48:36 dirtyvolumio volumio[1153]: info: CoreStateMachine::pushState Nov 03 11:48:36 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:48:36 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 03 11:48:36 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPushState Nov 03 11:48:36 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output update for this device Nov 03 11:48:36 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output Nov 03 11:48:36 dirtyvolumio volumio[1153]: info: PeppySpectrum ---peppyspectrum status stop Nov 03 11:48:36 dirtyvolumio sudo[2112]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppyspectrum.service Nov 03 11:48:36 dirtyvolumio sudo[2112]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:48:36 dirtyvolumio sudo[2112]: pam_unix(sudo:session): session closed for user root Nov 03 11:48:36 dirtyvolumio volumio[1153]: info: peppyspectrum Daemon Stop Nov 03 11:48:37 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:38 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:39 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:40 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:41 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:42 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:43 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:44 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:45 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:46 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:47 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPlay Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: CoreStateMachine::play index 0 Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: CoreStateMachine::stop Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: CoreStateMachine::play index undefined Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: CoreStateMachine::startPlaybackTimer Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:48:48 dirtyvolumio volumio[1153]: verbose: ControllerMpd::clearAddPlayTracks USB/New_Volume/Music/Amelie Lens/Amelie Lens WE2 ｜ Tomorrowland 2025.m4a Nov 03 11:48:48 dirtyvolumio volumio[1153]: verbose: ControllerMpd::sendMpdCommand stop Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: sendMpdCommand stop took 0 milliseconds Nov 03 11:48:48 dirtyvolumio volumio[1153]: verbose: ControllerMpd::sendMpdCommand clear Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: Nov 03 11:48:48 dirtyvolumio volumio[1153]: ---------------------------- MPD announces system playlist update Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: Ignoring MPD Status Update Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: sendMpdCommand clear took 1 milliseconds Nov 03 11:48:48 dirtyvolumio volumio[1153]: verbose: ControllerMpd::sendMpdCommand add "USB/New_Volume/Music/Amelie Lens/Amelie Lens WE2 ｜ Tomorrowland 2025.m4a" Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: Nov 03 11:48:48 dirtyvolumio volumio[1153]: ---------------------------- MPD announces system playlist update Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: Ignoring MPD Status Update Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: Nov 03 11:48:48 dirtyvolumio volumio[1153]: ---------------------------- MPD announces system playlist update Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: Ignoring MPD Status Update Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: Nov 03 11:48:48 dirtyvolumio volumio[1153]: ---------------------------- MPD announces system playlist update Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: Ignoring MPD Status Update Nov 03 11:48:48 dirtyvolumio volumio[1153]: error: updateQueue error: null Nov 03 11:48:48 dirtyvolumio volumio[1153]: error: updateQueue error: null Nov 03 11:48:48 dirtyvolumio volumio[1153]: error: updateQueue error: null Nov 03 11:48:48 dirtyvolumio volumio[1153]: error: updateQueue error: null Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: ------------------------------ 2ms Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: ------------------------------ 2ms Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: ------------------------------ 1ms Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: ------------------------------ 1ms Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPlay Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: CoreStateMachine::play index 0 Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: CoreStateMachine::stop Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: CoreStateMachine::play index undefined Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: CoreStateMachine::startPlaybackTimer Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:48:48 dirtyvolumio volumio[1153]: verbose: ControllerMpd::clearAddPlayTracks USB/New_Volume/Music/Amelie Lens/Amelie Lens WE2 ｜ Tomorrowland 2025.m4a Nov 03 11:48:48 dirtyvolumio volumio[1153]: verbose: ControllerMpd::sendMpdCommand stop Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: sendMpdCommand stop took 1 milliseconds Nov 03 11:48:48 dirtyvolumio volumio[1153]: verbose: ControllerMpd::sendMpdCommand clear Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: Nov 03 11:48:48 dirtyvolumio volumio[1153]: ---------------------------- MPD announces system playlist update Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: Ignoring MPD Status Update Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: sendMpdCommand clear took 0 milliseconds Nov 03 11:48:48 dirtyvolumio volumio[1153]: verbose: ControllerMpd::sendMpdCommand add "USB/New_Volume/Music/Amelie Lens/Amelie Lens WE2 ｜ Tomorrowland 2025.m4a" Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: Nov 03 11:48:48 dirtyvolumio volumio[1153]: ---------------------------- MPD announces system playlist update Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: Ignoring MPD Status Update Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: Nov 03 11:48:48 dirtyvolumio volumio[1153]: ---------------------------- MPD announces system playlist update Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: Ignoring MPD Status Update Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: Nov 03 11:48:48 dirtyvolumio volumio[1153]: ---------------------------- MPD announces system playlist update Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: Ignoring MPD Status Update Nov 03 11:48:48 dirtyvolumio volumio[1153]: error: updateQueue error: null Nov 03 11:48:48 dirtyvolumio volumio[1153]: error: updateQueue error: null Nov 03 11:48:48 dirtyvolumio volumio[1153]: error: updateQueue error: null Nov 03 11:48:48 dirtyvolumio volumio[1153]: error: updateQueue error: null Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: ------------------------------ 2ms Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: ------------------------------ 2ms Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: ------------------------------ 1ms Nov 03 11:48:48 dirtyvolumio volumio[1153]: info: ------------------------------ 1ms Nov 03 11:48:48 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:49 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:49 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPlay Nov 03 11:48:49 dirtyvolumio volumio[1153]: info: CoreStateMachine::play index 0 Nov 03 11:48:49 dirtyvolumio volumio[1153]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 03 11:48:49 dirtyvolumio volumio[1153]: info: CoreStateMachine::stop Nov 03 11:48:49 dirtyvolumio volumio[1153]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 03 11:48:49 dirtyvolumio volumio[1153]: info: CoreStateMachine::play index undefined Nov 03 11:48:49 dirtyvolumio volumio[1153]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 03 11:48:49 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:48:49 dirtyvolumio volumio[1153]: info: CoreStateMachine::startPlaybackTimer Nov 03 11:48:49 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:48:49 dirtyvolumio volumio[1153]: verbose: ControllerMpd::clearAddPlayTracks USB/New_Volume/Music/Amelie Lens/Amelie Lens WE2 ｜ Tomorrowland 2025.m4a Nov 03 11:48:49 dirtyvolumio volumio[1153]: verbose: ControllerMpd::sendMpdCommand stop Nov 03 11:48:49 dirtyvolumio volumio[1153]: info: sendMpdCommand stop took 0 milliseconds Nov 03 11:48:49 dirtyvolumio volumio[1153]: verbose: ControllerMpd::sendMpdCommand clear Nov 03 11:48:49 dirtyvolumio volumio[1153]: info: Nov 03 11:48:49 dirtyvolumio volumio[1153]: ---------------------------- MPD announces system playlist update Nov 03 11:48:49 dirtyvolumio volumio[1153]: info: Ignoring MPD Status Update Nov 03 11:48:49 dirtyvolumio volumio[1153]: info: sendMpdCommand clear took 0 milliseconds Nov 03 11:48:49 dirtyvolumio volumio[1153]: verbose: ControllerMpd::sendMpdCommand add "USB/New_Volume/Music/Amelie Lens/Amelie Lens WE2 ｜ Tomorrowland 2025.m4a" Nov 03 11:48:49 dirtyvolumio volumio[1153]: info: Nov 03 11:48:49 dirtyvolumio volumio[1153]: ---------------------------- MPD announces system playlist update Nov 03 11:48:49 dirtyvolumio volumio[1153]: info: Ignoring MPD Status Update Nov 03 11:48:49 dirtyvolumio volumio[1153]: info: Nov 03 11:48:49 dirtyvolumio volumio[1153]: ---------------------------- MPD announces system playlist update Nov 03 11:48:49 dirtyvolumio volumio[1153]: info: Ignoring MPD Status Update Nov 03 11:48:49 dirtyvolumio volumio[1153]: info: Nov 03 11:48:49 dirtyvolumio volumio[1153]: ---------------------------- MPD announces system playlist update Nov 03 11:48:49 dirtyvolumio volumio[1153]: info: Ignoring MPD Status Update Nov 03 11:48:49 dirtyvolumio volumio[1153]: error: updateQueue error: null Nov 03 11:48:49 dirtyvolumio volumio[1153]: error: updateQueue error: null Nov 03 11:48:49 dirtyvolumio volumio[1153]: error: updateQueue error: null Nov 03 11:48:49 dirtyvolumio volumio[1153]: error: updateQueue error: null Nov 03 11:48:49 dirtyvolumio volumio[1153]: info: ------------------------------ 2ms Nov 03 11:48:49 dirtyvolumio volumio[1153]: info: ------------------------------ 1ms Nov 03 11:48:49 dirtyvolumio volumio[1153]: info: ------------------------------ 1ms Nov 03 11:48:49 dirtyvolumio volumio[1153]: info: ------------------------------ 1ms Nov 03 11:48:50 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:51 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:52 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 03 11:48:52 dirtyvolumio volumio[1153]: info: CURURI: albums:// Nov 03 11:48:52 dirtyvolumio volumio[1153]: info: listAlbums - loading Albums from cache Nov 03 11:48:52 dirtyvolumio volumio[1153]: info: Preload queue cleared Nov 03 11:48:52 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:53 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:54 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:55 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:56 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mixcloud , handleBrowseUri Nov 03 11:48:56 dirtyvolumio volumio[1153]: info: [mixcloud] browseUri: mixcloud Nov 03 11:48:56 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:57 dirtyvolumio volumio[1153]: info: Preload queue cleared Nov 03 11:48:57 dirtyvolumio volumio[1153]: info: Preload queue cleared Nov 03 11:48:57 dirtyvolumio volumio[1153]: info: Preload queue cleared Nov 03 11:48:57 dirtyvolumio volumio[1153]: info: Preload queue cleared Nov 03 11:48:57 dirtyvolumio volumio[1153]: info: Preload queue cleared Nov 03 11:48:57 dirtyvolumio volumio[1153]: info: Preload queue cleared Nov 03 11:48:57 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:58 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:48:59 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:00 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:01 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:02 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:03 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:04 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:05 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:06 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:08 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:08 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mixcloud , handleBrowseUri Nov 03 11:49:08 dirtyvolumio volumio[1153]: info: [mixcloud] browseUri: mixcloud/liveStreams@startIndex=0@limit=11@orderBy=popular@category=@select=orderBy Nov 03 11:49:08 dirtyvolumio volumio[1153]: info: Preload queue cleared Nov 03 11:49:09 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:10 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mixcloud , handleBrowseUri Nov 03 11:49:10 dirtyvolumio volumio[1153]: info: [mixcloud] browseUri: mixcloud/liveStreams@startIndex=0@limit=11@orderBy=popular@category= Nov 03 11:49:10 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:11 dirtyvolumio volumio[1153]: info: Preload queue cleared Nov 03 11:49:11 dirtyvolumio volumio[1153]: info: Preload queue cleared Nov 03 11:49:11 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:12 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:13 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:14 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:15 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:16 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:17 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:18 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:19 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:19 dirtyvolumio volumio[1153]: Searching plugin music_service/mixcloud Nov 03 11:49:19 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mixcloud , search Nov 03 11:49:20 dirtyvolumio volumio[1153]: info: All search sources collected, pushing search results Nov 03 11:49:20 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:21 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:21 dirtyvolumio volumio[1153]: Searching plugin music_service/mixcloud Nov 03 11:49:21 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mixcloud , search Nov 03 11:49:22 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:22 dirtyvolumio volumio[1153]: info: All search sources collected, pushing search results Nov 03 11:49:23 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:24 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:25 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:26 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:27 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:28 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:29 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:30 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:31 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:32 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:33 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:34 dirtyvolumio volumio[1153]: info: Preload queue cleared Nov 03 11:49:34 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 03 11:49:34 dirtyvolumio volumio[1153]: info: CoreStateMachine::ClearQueue Nov 03 11:49:34 dirtyvolumio volumio[1153]: info: CoreStateMachine::stop Nov 03 11:49:34 dirtyvolumio volumio[1153]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 03 11:49:34 dirtyvolumio volumio[1153]: info: CorePlayQueue::clearPlayQueue Nov 03 11:49:34 dirtyvolumio volumio[1153]: info: CorePlayQueue::saveQueue Nov 03 11:49:34 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPushQueue Nov 03 11:49:34 dirtyvolumio volumio[1153]: info: CoreStateMachine::addQueueItems Nov 03 11:49:34 dirtyvolumio volumio[1153]: info: CorePlayQueue::addQueueItems Nov 03 11:49:34 dirtyvolumio volumio[1153]: info: Preload queue cleared Nov 03 11:49:34 dirtyvolumio volumio[1153]: info: Adding Item to queue: mixcloud/cloudcasts@keywords=wesley%20holmes@inSection=1/cloudcast@cloudcastId=Q2xvdWRjYXN0OjUxMTkwNDM4OQ%3D%3D@showMoreFromUser=1 Nov 03 11:49:34 dirtyvolumio volumio[1153]: info: Exploding uri mixcloud/cloudcasts@keywords=wesley%20holmes@inSection=1/cloudcast@cloudcastId=Q2xvdWRjYXN0OjUxMTkwNDM4OQ%3D%3D@showMoreFromUser=1 in service mixcloud Nov 03 11:49:34 dirtyvolumio volumio[1153]: info: [mixcloud] explodeUri: mixcloud/cloudcasts@keywords=wesley%20holmes@inSection=1/cloudcast@cloudcastId=Q2xvdWRjYXN0OjUxMTkwNDM4OQ%3D%3D@showMoreFromUser=1 Nov 03 11:49:34 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPushQueue Nov 03 11:49:34 dirtyvolumio volumio[1153]: info: CorePlayQueue::saveQueue Nov 03 11:49:34 dirtyvolumio volumio[1153]: info: CoreStateMachine::updateTrackBlock Nov 03 11:49:34 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrackBlock Nov 03 11:49:34 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPlay Nov 03 11:49:34 dirtyvolumio volumio[1153]: info: CoreStateMachine::play index 0 Nov 03 11:49:34 dirtyvolumio volumio[1153]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 03 11:49:34 dirtyvolumio volumio[1153]: info: CoreStateMachine::stop Nov 03 11:49:34 dirtyvolumio volumio[1153]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 03 11:49:34 dirtyvolumio volumio[1153]: info: CoreStateMachine::play index undefined Nov 03 11:49:34 dirtyvolumio volumio[1153]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 03 11:49:34 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:49:34 dirtyvolumio volumio[1153]: info: CoreStateMachine::startPlaybackTimer Nov 03 11:49:34 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:49:34 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioGetVisibleSources Nov 03 11:49:34 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 11:49:34 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Nov 03 11:49:34 dirtyvolumio volumio[1153]: info: [mixcloud] clearAddPlayTrack: mixcloud/cloudcast@cloudcastId=Q2xvdWRjYXN0OjUxMTkwNDM4OQ%3D%3D@owner=kexp Nov 03 11:49:34 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:35 dirtyvolumio volumio[1153]: verbose: ControllerMpd::sendMpdCommand stop Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: sendMpdCommand stop took 1 milliseconds Nov 03 11:49:35 dirtyvolumio volumio[1153]: verbose: ControllerMpd::sendMpdCommand clear Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: Nov 03 11:49:35 dirtyvolumio volumio[1153]: ---------------------------- MPD announces system playlist update Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: Ignoring MPD Status Update Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: sendMpdCommand clear took 1 milliseconds Nov 03 11:49:35 dirtyvolumio volumio[1153]: verbose: ControllerMpd::sendMpdCommand addid "https://audio.mixcloud.stream/secure/hls/f/b/e/5/9a76-5c90-43f3-af97-e72934bbf064.m4a/index.m3u8" Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: Nov 03 11:49:35 dirtyvolumio volumio[1153]: ---------------------------- MPD announces system playlist update Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: Ignoring MPD Status Update Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: Nov 03 11:49:35 dirtyvolumio volumio[1153]: ---------------------------- MPD announces system playlist update Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: Ignoring MPD Status Update Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: Nov 03 11:49:35 dirtyvolumio volumio[1153]: ---------------------------- MPD announces system playlist update Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: Ignoring MPD Status Update Nov 03 11:49:35 dirtyvolumio volumio[1153]: error: updateQueue error: null Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: Nov 03 11:49:35 dirtyvolumio volumio[1153]: ---------------------------- MPD announces system playlist update Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: Ignoring MPD Status Update Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: ------------------------------ 3ms Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: sendMpdCommand addid "https://audio.mixcloud.stream/secure/hls/f/b/e/5/9a76-5c90-43f3-af97-e72934bbf064.m4a/index.m3u8" took 2 milliseconds Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: ------------------------------ 2ms Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: ------------------------------ 2ms Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: ------------------------------ 1ms Nov 03 11:49:35 dirtyvolumio volumio[1153]: verbose: MPD COMMAND [object Object] Nov 03 11:49:35 dirtyvolumio volumio[1153]: verbose: MPD COMMAND [object Object] Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: Nov 03 11:49:35 dirtyvolumio volumio[1153]: ---------------------------- MPD announces system playlist update Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: Ignoring MPD Status Update Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: Nov 03 11:49:35 dirtyvolumio volumio[1153]: ---------------------------- MPD announces system playlist update Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: Ignoring MPD Status Update Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: Nov 03 11:49:35 dirtyvolumio volumio[1153]: ---------------------------- MPD announces system playlist update Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: Ignoring MPD Status Update Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: Nov 03 11:49:35 dirtyvolumio volumio[1153]: ---------------------------- MPD announces system playlist update Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: Ignoring MPD Status Update Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: ------------------------------ 3ms Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: ------------------------------ 1ms Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: ------------------------------ 1ms Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: ------------------------------ 0ms Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 03 11:49:35 dirtyvolumio volumio[1153]: verbose: ControllerMpd::sendMpdCommand play Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: Nov 03 11:49:35 dirtyvolumio volumio[1153]: ---------------------------- MPD announces system playlist update Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: Ignoring MPD Status Update Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: Nov 03 11:49:35 dirtyvolumio volumio[1153]: ---------------------------- MPD announces system playlist update Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: Ignoring MPD Status Update Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: Nov 03 11:49:35 dirtyvolumio volumio[1153]: ---------------------------- MPD announces system playlist update Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: Ignoring MPD Status Update Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: ------------------------------ 2ms Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: sendMpdCommand play took 1 milliseconds Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: ------------------------------ 1ms Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: ------------------------------ 1ms Nov 03 11:49:35 dirtyvolumio volumio[1153]: info: ------------------------------ 1ms Nov 03 11:49:35 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:36 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:37 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: Nov 03 11:49:38 dirtyvolumio volumio[1153]: ---------------------------- MPD announces state update: player Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: ControllerMpd::getState Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: ControllerMpd::sendMpdCommand status Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: Nov 03 11:49:38 dirtyvolumio volumio[1153]: ---------------------------- MPD announces state update: player Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: ControllerMpd::getState Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: ControllerMpd::sendMpdCommand status Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: Nov 03 11:49:38 dirtyvolumio volumio[1153]: ---------------------------- MPD announces state update: player Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: ControllerMpd::getState Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: ControllerMpd::sendMpdCommand status Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: Nov 03 11:49:38 dirtyvolumio volumio[1153]: ---------------------------- MPD announces state update: player Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: ControllerMpd::getState Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: ControllerMpd::sendMpdCommand status Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: sendMpdCommand status took 16 milliseconds Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: ControllerMpd::parseState Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: Nov 03 11:49:38 dirtyvolumio volumio[1153]: ---------------------------- MPD announces state update: player Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: ControllerMpd::getState Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: ControllerMpd::sendMpdCommand status Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: sendMpdCommand status took 16 milliseconds Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: ControllerMpd::parseState Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: ControllerMpd::parseState Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: ControllerMpd::parseState Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: ControllerMpd::parseTrackInfo Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: ControllerMpd::pushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreCommandRouter::servicePushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3502,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"KEXP Presents Midnight In A Perfect World with Wesley Holmes","artist":"KEXP","album":null,"uri":"https://audio.mixcloud.stream/secure/hls/f/b/e/5/9a76-5c90-43f3-af97-e72934bbf064.m4a/index.m3u8","trackType":"m3u8"} Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: CURRENT POSITION 0 Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreStateMachine::syncState stateService play Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreStateMachine::syncState currentStatus stop Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: ------------------------------ 22ms Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: Nov 03 11:49:38 dirtyvolumio volumio[1153]: ---------------------------- MPD announces state update: player Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: ControllerMpd::getState Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: ControllerMpd::sendMpdCommand status Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: Nov 03 11:49:38 dirtyvolumio volumio[1153]: ---------------------------- MPD announces state update: player Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: ControllerMpd::getState Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: ControllerMpd::sendMpdCommand status Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: Nov 03 11:49:38 dirtyvolumio volumio[1153]: ---------------------------- MPD announces state update: player Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: ControllerMpd::getState Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: ControllerMpd::sendMpdCommand status Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: sendMpdCommand status took 6 milliseconds Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: sendMpdCommand playlistinfo took 6 milliseconds Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: sendMpdCommand playlistinfo took 5 milliseconds Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: sendMpdCommand status took 2 milliseconds Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: sendMpdCommand status took 1 milliseconds Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: ControllerMpd::parseState Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: ControllerMpd::parseTrackInfo Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: ControllerMpd::parseState Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: ControllerMpd::parseState Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: ControllerMpd::parseState Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: ControllerMpd::pushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreCommandRouter::servicePushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3502,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"KEXP Presents Midnight In A Perfect World with Wesley Holmes","artist":"KEXP","album":null,"uri":"https://audio.mixcloud.stream/secure/hls/f/b/e/5/9a76-5c90-43f3-af97-e72934bbf064.m4a/index.m3u8","trackType":"m3u8"} Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: CURRENT POSITION 0 Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreStateMachine::syncState stateService play Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreStateMachine::syncState currentStatus play Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: Received an update from plugin. extracting info from payload Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreStateMachine::pushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output update for this device Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreStateMachine::pushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output update for this device Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: ControllerMpd::pushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreCommandRouter::servicePushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3502,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"KEXP Presents Midnight In A Perfect World with Wesley Holmes","artist":"KEXP","album":null,"uri":"https://audio.mixcloud.stream/secure/hls/f/b/e/5/9a76-5c90-43f3-af97-e72934bbf064.m4a/index.m3u8","trackType":"m3u8"} Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: CURRENT POSITION 0 Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreStateMachine::syncState stateService play Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreStateMachine::syncState currentStatus play Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: Received an update from plugin. extracting info from payload Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreStateMachine::pushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output update for this device Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreStateMachine::pushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output update for this device Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: ControllerMpd::pushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreCommandRouter::servicePushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3502,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"KEXP Presents Midnight In A Perfect World with Wesley Holmes","artist":"KEXP","album":null,"uri":"https://audio.mixcloud.stream/secure/hls/f/b/e/5/9a76-5c90-43f3-af97-e72934bbf064.m4a/index.m3u8","trackType":"m3u8"} Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: CURRENT POSITION 0 Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreStateMachine::syncState stateService play Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreStateMachine::syncState currentStatus play Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: Received an update from plugin. extracting info from payload Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreStateMachine::pushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output update for this device Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreStateMachine::pushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output update for this device Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: ------------------------------ 51ms Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: ------------------------------ 50ms Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: ------------------------------ 50ms Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: sendMpdCommand playlistinfo took 28 milliseconds Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: sendMpdCommand playlistinfo took 28 milliseconds Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: sendMpdCommand playlistinfo took 28 milliseconds Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: sendMpdCommand playlistinfo took 28 milliseconds Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: ControllerMpd::parseTrackInfo Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: ControllerMpd::parseTrackInfo Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: ControllerMpd::parseTrackInfo Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: ControllerMpd::parseTrackInfo Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: ControllerMpd::pushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreCommandRouter::servicePushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11,"duration":3502,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"KEXP Presents Midnight In A Perfect World with Wesley Holmes","artist":"KEXP","album":null,"uri":"https://audio.mixcloud.stream/secure/hls/f/b/e/5/9a76-5c90-43f3-af97-e72934bbf064.m4a/index.m3u8","trackType":"m3u8"} Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: CURRENT POSITION 0 Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreStateMachine::syncState stateService play Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreStateMachine::syncState currentStatus play Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: Received an update from plugin. extracting info from payload Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreStateMachine::pushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output update for this device Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreStateMachine::pushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output update for this device Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: ControllerMpd::pushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreCommandRouter::servicePushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11,"duration":3502,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"KEXP Presents Midnight In A Perfect World with Wesley Holmes","artist":"KEXP","album":null,"uri":"https://audio.mixcloud.stream/secure/hls/f/b/e/5/9a76-5c90-43f3-af97-e72934bbf064.m4a/index.m3u8","trackType":"m3u8"} Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: CURRENT POSITION 0 Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreStateMachine::syncState stateService play Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreStateMachine::syncState currentStatus play Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: Received an update from plugin. extracting info from payload Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreStateMachine::pushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output update for this device Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreStateMachine::pushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output update for this device Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: ControllerMpd::pushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreCommandRouter::servicePushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11,"duration":3502,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"KEXP Presents Midnight In A Perfect World with Wesley Holmes","artist":"KEXP","album":null,"uri":"https://audio.mixcloud.stream/secure/hls/f/b/e/5/9a76-5c90-43f3-af97-e72934bbf064.m4a/index.m3u8","trackType":"m3u8"} Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: CURRENT POSITION 0 Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreStateMachine::syncState stateService play Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreStateMachine::syncState currentStatus play Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: Received an update from plugin. extracting info from payload Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreStateMachine::pushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output update for this device Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreStateMachine::pushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output update for this device Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: ControllerMpd::pushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreCommandRouter::servicePushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CorePlayQueue::getTrack 0 Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11,"duration":3502,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"KEXP Presents Midnight In A Perfect World with Wesley Holmes","artist":"KEXP","album":null,"uri":"https://audio.mixcloud.stream/secure/hls/f/b/e/5/9a76-5c90-43f3-af97-e72934bbf064.m4a/index.m3u8","trackType":"m3u8"} Nov 03 11:49:38 dirtyvolumio volumio[1153]: verbose: CURRENT POSITION 0 Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreStateMachine::syncState stateService play Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreStateMachine::syncState currentStatus play Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: Received an update from plugin. extracting info from payload Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreStateMachine::pushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output update for this device Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreStateMachine::pushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: CoreCommandRouter::volumioPushState Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output update for this device Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: MRS: Pushing multiroomSync output Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: ------------------------------ 59ms Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: ------------------------------ 56ms Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: ------------------------------ 55ms Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: ------------------------------ 55ms Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: PeppySpectrum ---peppyspectrum status play Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: PeppySpectrum ---peppyspectrum status play Nov 03 11:49:38 dirtyvolumio sudo[2266]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Nov 03 11:49:38 dirtyvolumio sudo[2266]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: PeppySpectrum ---peppyspectrum status play Nov 03 11:49:38 dirtyvolumio sudo[2269]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Nov 03 11:49:38 dirtyvolumio sudo[2269]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: PeppySpectrum ---peppyspectrum status play Nov 03 11:49:38 dirtyvolumio sudo[2273]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Nov 03 11:49:38 dirtyvolumio sudo[2273]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: PeppySpectrum ---peppyspectrum status play Nov 03 11:49:38 dirtyvolumio systemd[1]: Started peppyspectrum Daemon. Nov 03 11:49:38 dirtyvolumio sudo[2276]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Nov 03 11:49:38 dirtyvolumio sudo[2276]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:49:38 dirtyvolumio sudo[2279]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Nov 03 11:49:38 dirtyvolumio sudo[2279]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:49:38 dirtyvolumio sudo[2276]: pam_unix(sudo:session): session closed for user root Nov 03 11:49:38 dirtyvolumio sudo[2269]: pam_unix(sudo:session): session closed for user root Nov 03 11:49:38 dirtyvolumio sudo[2279]: pam_unix(sudo:session): session closed for user root Nov 03 11:49:38 dirtyvolumio sudo[2266]: pam_unix(sudo:session): session closed for user root Nov 03 11:49:38 dirtyvolumio sudo[2273]: pam_unix(sudo:session): session closed for user root Nov 03 11:49:38 dirtyvolumio sudo[2283]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Nov 03 11:49:38 dirtyvolumio sudo[2283]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:49:38 dirtyvolumio sudo[2283]: pam_unix(sudo:session): session closed for user root Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: PeppySpectrum ---peppyspectrum status play Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: PeppySpectrum ---peppyspectrum status play Nov 03 11:49:38 dirtyvolumio sudo[2286]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Nov 03 11:49:38 dirtyvolumio sudo[2286]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: PeppySpectrum ---peppyspectrum status play Nov 03 11:49:38 dirtyvolumio sudo[2286]: pam_unix(sudo:session): session closed for user root Nov 03 11:49:38 dirtyvolumio sudo[2289]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Nov 03 11:49:38 dirtyvolumio sudo[2289]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: PeppySpectrum ---peppyspectrum status play Nov 03 11:49:38 dirtyvolumio sudo[2291]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Nov 03 11:49:38 dirtyvolumio sudo[2291]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: PeppySpectrum ---peppyspectrum status play Nov 03 11:49:38 dirtyvolumio sudo[2291]: pam_unix(sudo:session): session closed for user root Nov 03 11:49:38 dirtyvolumio sudo[2289]: pam_unix(sudo:session): session closed for user root Nov 03 11:49:38 dirtyvolumio sudo[2295]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Nov 03 11:49:38 dirtyvolumio sudo[2295]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: PeppySpectrum ---peppyspectrum status play Nov 03 11:49:38 dirtyvolumio sudo[2295]: pam_unix(sudo:session): session closed for user root Nov 03 11:49:38 dirtyvolumio sudo[2298]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Nov 03 11:49:38 dirtyvolumio sudo[2298]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: PeppySpectrum ---peppyspectrum status play Nov 03 11:49:38 dirtyvolumio sudo[2298]: pam_unix(sudo:session): session closed for user root Nov 03 11:49:38 dirtyvolumio sudo[2301]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Nov 03 11:49:38 dirtyvolumio sudo[2301]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:49:38 dirtyvolumio volumio[1153]: info: PeppySpectrum ---peppyspectrum status play Nov 03 11:49:39 dirtyvolumio sudo[2301]: pam_unix(sudo:session): session closed for user root Nov 03 11:49:39 dirtyvolumio sudo[2304]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Nov 03 11:49:39 dirtyvolumio sudo[2304]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:49:39 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 03 11:49:39 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 03 11:49:39 dirtyvolumio volumio[1153]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Nov 03 11:49:39 dirtyvolumio sudo[2304]: pam_unix(sudo:session): session closed for user root Nov 03 11:49:39 dirtyvolumio sudo[2311]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppyspectrum.service Nov 03 11:49:39 dirtyvolumio sudo[2311]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 11:49:39 dirtyvolumio volumio[1153]: info: peppyspectrum Daemon Started Nov 03 11:49:39 dirtyvolumio volumio[1153]: info: peppyspectrum Daemon Started Nov 03 11:49:39 dirtyvolumio sudo[2311]: pam_unix(sudo:session): session closed for user root Nov 03 11:49:39 dirtyvolumio volumio[1153]: info: peppyspectrum Daemon Started Nov 03 11:49:39 dirtyvolumio volumio[1153]: info: peppyspectrum Daemon Started Nov 03 11:49:39 dirtyvolumio volumio[1153]: info: peppyspectrum Daemon Started Nov 03 11:49:39 dirtyvolumio volumio[1153]: info: peppyspectrum Daemon Started Nov 03 11:49:39 dirtyvolumio volumio[1153]: info: peppyspectrum Daemon Started Nov 03 11:49:39 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:40 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:41 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:41 dirtyvolumio volumio[2272]: pygame 1.9.4.post1 Nov 03 11:49:41 dirtyvolumio volumio[2272]: Hello from the pygame community. https://www.pygame.org/contribute.html Nov 03 11:49:41 dirtyvolumio volumio[2272]: Traceback (most recent call last): Nov 03 11:49:41 dirtyvolumio volumio[2272]: File "spectrum.py", line 715, in Nov 03 11:49:41 dirtyvolumio volumio[2272]: pm = Spectrum(None, True) Nov 03 11:49:41 dirtyvolumio volumio[2272]: File "spectrum.py", line 63, in __init__ Nov 03 11:49:41 dirtyvolumio volumio[2272]: self.init_display() Nov 03 11:49:41 dirtyvolumio volumio[2272]: File "spectrum.py", line 104, in init_display Nov 03 11:49:41 dirtyvolumio volumio[2272]: pygame.display.init() Nov 03 11:49:41 dirtyvolumio volumio[2272]: pygame.error: Unable to open a console terminal Nov 03 11:49:41 dirtyvolumio systemd[1]: peppyspectrum.service: Main process exited, code=exited, status=1/FAILURE Nov 03 11:49:41 dirtyvolumio systemd[1]: peppyspectrum.service: Failed with result 'exit-code'. Nov 03 11:49:42 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:43 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:44 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:45 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:46 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:47 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:48 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:49 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:50 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:51 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:52 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:53 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:54 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:55 dirtyvolumio volumio[1153]: error: MyVolumio MQTT error: Error: Not supported Nov 03 11:49:56 dirtyvolumio volumio[1153]: info: CoreCommandRouter::executeOnPlugin: multiroom , audioOutputPlay Nov 03 11:49:56 dirtyvolumio volumio[1153]: info: Error : CoreCommandRouter::executeOnPlugin: No method [audioOutputPlay] in plugin multiroom Nov 03 11:49:56 dirtyvolumio volumio[1153]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 03 11:49:56 dirtyvolumio volumio[1153]: TypeError: Cannot read property 'then' of undefined Nov 03 11:49:56 dirtyvolumio volumio[1153]: at outputs.audioOutputPlay (/volumio/app/plugins/audio_interface/outputs/index.js:367:9) Nov 03 11:49:56 dirtyvolumio volumio[1153]: at CoreCommandRouter.audioOutputPlay (/volumio/app/index.js:2279:30) Nov 03 11:49:56 dirtyvolumio volumio[1153]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1456:26) Nov 03 11:49:56 dirtyvolumio volumio[1153]: at Socket.emit (events.js:315:20) Nov 03 11:49:56 dirtyvolumio volumio[1153]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Nov 03 11:49:56 dirtyvolumio volumio[1153]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Nov 03 11:49:56 dirtyvolumio volumio[1153]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 03 11:49:56 dirtyvolumio sudo[2373]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-11-03 11:48 Nov 03 11:49:56 dirtyvolumio sudo[2373]: 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="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"