-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Mon 2024-04-22 22:29:53 UTC. -- Apr 22 22:28:06 motivo volumio[11711]: verbose: New Socket.io Connection to 192.168.1.164 from 192.168.1.34 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 17 Apr 22 22:28:06 motivo volumio[11711]: verbose: New Socket.io Connection to 192.168.1.164 from 192.168.1.34 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 18 Apr 22 22:28:06 motivo volumio[11711]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 22 22:28:06 motivo volumio[11711]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 22 22:28:06 motivo volumio[11711]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 22 22:28:06 motivo volumio[11711]: info: CoreCommandRouter::volumioGetVisibleSources Apr 22 22:28:06 motivo volumio[11711]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 22:28:06 motivo volumio[11711]: info: CoreCommandRouter::volumioGetState Apr 22 22:28:06 motivo volumio[11711]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:06 motivo volumio[11711]: info: CoreCommandRouter::volumioGetState Apr 22 22:28:06 motivo volumio[11711]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:06 motivo volumio[11711]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 22 22:28:06 motivo volumio[11711]: info: CoreCommandRouter::volumioGetQueue Apr 22 22:28:06 motivo volumio[11711]: info: CoreStateMachine::getQueue Apr 22 22:28:06 motivo volumio[11711]: info: CorePlayQueue::getQueue Apr 22 22:28:06 motivo volumio[11711]: info: Listing playlists Apr 22 22:28:06 motivo volumio[11711]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 22 22:28:06 motivo volumio[11711]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Apr 22 22:28:06 motivo volumio[11711]: info: Received Get System Info Apr 22 22:28:06 motivo volumio[11711]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 22 22:28:06 motivo volumio[11711]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 22 22:28:06 motivo volumio[11711]: info: Discovery: Getting this device information Apr 22 22:28:06 motivo volumio[11711]: info: CoreCommandRouter::volumioGetState Apr 22 22:28:06 motivo volumio[11711]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:06 motivo volumio[11711]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 22 22:28:06 motivo volumio[11711]: info: CoreCommandRouter::volumioGetState Apr 22 22:28:06 motivo volumio[11711]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:06 motivo volumio[11711]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 22 22:28:06 motivo volumio[11711]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 22 22:28:06 motivo volumio[11711]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 22 22:28:06 motivo volumio[11711]: info: CoreCommandRouter::volumioGetVisibleSources Apr 22 22:28:06 motivo volumio[11711]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 22:28:06 motivo volumio[11711]: info: CoreCommandRouter::volumioGetState Apr 22 22:28:06 motivo volumio[11711]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:06 motivo volumio[11711]: info: CoreCommandRouter::volumioGetState Apr 22 22:28:06 motivo volumio[11711]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:06 motivo volumio[11711]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 22 22:28:06 motivo volumio[11711]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 22 22:28:06 motivo volumio[11711]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Apr 22 22:28:06 motivo volumio[11711]: info: Received Get System Info Apr 22 22:28:06 motivo volumio[11711]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 22 22:28:06 motivo volumio[11711]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 22 22:28:06 motivo volumio[11711]: info: Discovery: Getting this device information Apr 22 22:28:06 motivo volumio[11711]: info: CoreCommandRouter::volumioGetState Apr 22 22:28:06 motivo volumio[11711]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:06 motivo volumio[11711]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 22 22:28:06 motivo volumio[11711]: info: CoreCommandRouter::volumioGetState Apr 22 22:28:06 motivo volumio[11711]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:06 motivo volumio[11711]: info: Listing playlists Apr 22 22:28:12 motivo sudo[11701]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:12 motivo sudo[12114]: volumio : TTY=pts/0 ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/cp -rp volumio-serial-plugin/README.md volumio-serial-plugin/UIConfigAudio.json volumio-serial-plugin/UIConfigSystem.json volumio-serial-plugin/config.json volumio-serial-plugin/dacFiltersMapFile.json volumio-serial-plugin/deploy.sh volumio-serial-plugin/i18n volumio-serial-plugin/i2sHdmiMapFile.json volumio-serial-plugin/icons volumio-serial-plugin/index.js volumio-serial-plugin/inputMapFile.json volumio-serial-plugin/inputs.json volumio-serial-plugin/install.sh volumio-serial-plugin/package.json volumio-serial-plugin/requiredConf.json volumio-serial-plugin/serialTest.js volumio-serial-plugin/touchevents.sh /volumio/app/plugins/music_service/inputs/ Apr 22 22:28:12 motivo sudo[12114]: pam_unix(sudo:session): session opened for user root by volumio(uid=0) Apr 22 22:28:12 motivo sudo[12114]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:13 motivo sudo[12117]: volumio : TTY=pts/0 ; PWD=/home/volumio ; USER=root ; COMMAND=/usr/bin/killall node Apr 22 22:28:13 motivo sudo[12117]: pam_unix(sudo:session): session opened for user root by volumio(uid=0) Apr 22 22:28:13 motivo sudo[12117]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:13 motivo sudo[12120]: volumio : TTY=pts/0 ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/journalctl -f Apr 22 22:28:13 motivo vtcs[12035]: [2024-04-22 22:28:13.081] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Apr 22 22:28:13 motivo sudo[12120]: pam_unix(sudo:session): session opened for user root by volumio(uid=0) Apr 22 22:28:13 motivo volumio-remote-updater[567]: [2024-04-22 22:28:13] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Apr 22 22:28:13 motivo volumio-remote-updater[567]: [2024-04-22 22:28:13] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Apr 22 22:28:13 motivo systemd[1]: volumio.service: Main process exited, code=killed, status=15/TERM Apr 22 22:28:13 motivo sudo[11945]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:13 motivo systemd[1]: volumio.service: Succeeded. Apr 22 22:28:13 motivo systemd[1]: Started dynamicswap service. Apr 22 22:28:13 motivo systemd[1]: dynamicswap.service: Succeeded. Apr 22 22:28:13 motivo systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Apr 22 22:28:13 motivo systemd[1]: volumio.service: Scheduled restart job, restart counter is at 11. Apr 22 22:28:13 motivo systemd[1]: Stopped Volumio Backend Module. Apr 22 22:28:13 motivo systemd[1]: Started Volumio Backend Module. Apr 22 22:28:13 motivo systemd[1]: Started dynamicswap service. Apr 22 22:28:13 motivo systemd[1]: dynamicswap.service: Succeeded. Apr 22 22:28:14 motivo volumio[12129]: info: ------------------------------------------- Apr 22 22:28:14 motivo volumio[12129]: info: ----- Volumio3 ---- Apr 22 22:28:14 motivo volumio[12129]: info: ------------------------------------------- Apr 22 22:28:14 motivo volumio[12129]: info: ----- System startup ---- Apr 22 22:28:14 motivo volumio[12129]: info: ------------------------------------------- Apr 22 22:28:14 motivo volumio[12129]: info: MYVOLUMIO Environment detected Apr 22 22:28:14 motivo volumio[12129]: info: Plugin folders cleanup Apr 22 22:28:14 motivo volumio[12129]: info: Scanning into folder /volumio/app/plugins/ Apr 22 22:28:14 motivo volumio[12129]: info: Scanning category audio_interface Apr 22 22:28:14 motivo volumio[12129]: info: Scanning category miscellanea Apr 22 22:28:14 motivo volumio[12129]: info: Scanning category music_service Apr 22 22:28:15 motivo volumio[12129]: info: Scanning category plugins.json Apr 22 22:28:15 motivo volumio[12129]: info: Scanning category system_controller Apr 22 22:28:15 motivo volumio[12129]: info: Scanning category user_interface Apr 22 22:28:15 motivo volumio[12129]: info: Scanning into folder /data/plugins/ Apr 22 22:28:15 motivo volumio[12129]: info: Plugin folders cleanup completed Apr 22 22:28:15 motivo volumio[12129]: info: ------------------------------------------- Apr 22 22:28:15 motivo volumio[12129]: info: ----- Core plugins startup ---- Apr 22 22:28:15 motivo volumio[12129]: info: ------------------------------------------- Apr 22 22:28:15 motivo volumio[12129]: info: Loading plugins from folder /volumio/app/plugins/ Apr 22 22:28:15 motivo volumio[12129]: info: Adding plugin bluetooth to MyMusic Plugins Apr 22 22:28:15 motivo volumio[12129]: info: Adding plugin multiroom to MyMusic Plugins Apr 22 22:28:15 motivo volumio[12129]: info: Adding plugin upnp to MyMusic Plugins Apr 22 22:28:15 motivo volumio[12129]: info: Adding plugin metavolumio to MyMusic Plugins Apr 22 22:28:15 motivo volumio[12129]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 22 22:28:15 motivo volumio[12129]: info: Adding plugin cd_controller to MyMusic Plugins Apr 22 22:28:15 motivo volumio[12129]: info: Adding plugin raat to MyMusic Plugins Apr 22 22:28:15 motivo volumio[12129]: info: Adding plugin smart_inputs to MyMusic Plugins Apr 22 22:28:15 motivo volumio[12129]: info: Adding plugin tidalconnect to MyMusic Plugins Apr 22 22:28:15 motivo volumio[12129]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 22 22:28:15 motivo volumio[12129]: info: Loading plugins from folder /data/plugins/ Apr 22 22:28:15 motivo volumio[12129]: info: Loading plugin "system"... Apr 22 22:28:15 motivo volumio[12129]: info: Loading plugin "appearance"... Apr 22 22:28:15 motivo volumio[12129]: info: Loading plugin "network"... Apr 22 22:28:15 motivo volumio[12129]: info: Refreshing Cached IP Addresses Apr 22 22:28:15 motivo sudo[12156]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 22 22:28:15 motivo sudo[12156]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:28:15 motivo sudo[12156]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:15 motivo sudo[12158]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 22 22:28:15 motivo sudo[12158]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:28:15 motivo sudo[12158]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:15 motivo volumio[12129]: info: Loading plugin "services"... Apr 22 22:28:15 motivo volumio[12129]: info: Loading plugin "alsa_controller"... Apr 22 22:28:15 motivo sudo[12162]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 22 22:28:15 motivo sudo[12162]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:28:15 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 22 22:28:15 motivo volumio[12129]: info: Loading plugin "wizard"... Apr 22 22:28:15 motivo volumio[12129]: info: Loading plugin "networkfs"... Apr 22 22:28:15 motivo volumio[12129]: info: Starting Udev Watcher for removable devices Apr 22 22:28:15 motivo volumio[12129]: info: Ignoring mount for partition: boot Apr 22 22:28:15 motivo volumio[12129]: info: Ignoring mount for partition: volumio Apr 22 22:28:15 motivo volumio[12129]: info: Ignoring mount for partition: volumio_data Apr 22 22:28:15 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 22 22:28:15 motivo volumio[12129]: info: Loading plugin "volumio_command_line_client"... Apr 22 22:28:15 motivo volumio[12129]: info: Loading plugin "upnp"... Apr 22 22:28:15 motivo volumio[12129]: info: [1713824895880] Starting Upmpd Daemon Apr 22 22:28:15 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 22 22:28:15 motivo volumio[12129]: info: Loading plugin "my_music"... Apr 22 22:28:15 motivo volumio[12129]: info: Loading plugin "mpd"... Apr 22 22:28:16 motivo volumio[12129]: info: Loading plugin "upnp_browser"... Apr 22 22:28:16 motivo volumio[12129]: info: Loading plugin "bluetooth"... Apr 22 22:28:16 motivo volumio[12129]: info: [1713824896397] Starting BluetoothController Apr 22 22:28:16 motivo volumio[12129]: info: Loading plugin "alarm-clock"... Apr 22 22:28:16 motivo volumio[12129]: info: Loading plugin "manifestui"... Apr 22 22:28:16 motivo volumio[12129]: info: Loading plugin "metavolumio"... Apr 22 22:28:17 motivo volumio[12129]: info: Loading plugin "airplay_emulation"... Apr 22 22:28:17 motivo volumio[12129]: info: Starting Shairport Sync Apr 22 22:28:17 motivo volumio[12129]: info: Loading plugin "cd_controller"... Apr 22 22:28:17 motivo volumio[12129]: info: Loading plugin "last_100"... Apr 22 22:28:17 motivo volumio[12129]: info: Loading plugin "raat"... Apr 22 22:28:17 motivo volumio[12129]: info: RAAT Plugin loaded Apr 22 22:28:17 motivo volumio[12129]: info: Adding restartRAATSocket REST API Endpoint Apr 22 22:28:17 motivo volumio[12129]: info: Adding restartRAATSocket REST Endpoint for plugin: music_service/raat Apr 22 22:28:17 motivo volumio[12129]: info: Loading plugin "streaming_services"... Apr 22 22:28:18 motivo volumio[12129]: info: Starting Streaming Service Transparent Proxy Apr 22 22:28:18 motivo volumio[12129]: info: Loading plugin "tidalconnect"... Apr 22 22:28:18 motivo volumio-remote-updater[567]: [2024-04-22 22:28:18] [connect] Successful connection Apr 22 22:28:18 motivo volumio[12129]: info: Loading plugin "webradio"... Apr 22 22:28:18 motivo volumio[12129]: info: Loading plugin "i2s_dacs"... Apr 22 22:28:18 motivo volumio[12129]: info: I2S DAC not set, start Auto-detection Apr 22 22:28:18 motivo volumio[12129]: info: Loading plugin "volumiodiscovery"... Apr 22 22:28:18 motivo volumio[12129]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 22 22:28:18 motivo node[12129]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 22 22:28:18 motivo volumio[12129]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 22 22:28:18 motivo node[12129]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 22 22:28:18 motivo volumio[12129]: *** WARNING *** For more information see Apr 22 22:28:18 motivo node[12129]: *** WARNING *** For more information see Apr 22 22:28:18 motivo volumio[12129]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 22 22:28:18 motivo node[12129]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 22 22:28:18 motivo volumio[12129]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 22 22:28:18 motivo node[12129]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 22 22:28:18 motivo volumio[12129]: *** WARNING *** For more information see Apr 22 22:28:18 motivo node[12129]: *** WARNING *** For more information see Apr 22 22:28:18 motivo volumio[12129]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 22 22:28:18 motivo volumio[12129]: info: Discovery: Started advertising with name: Motivo Apr 22 22:28:18 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 22 22:28:18 motivo volumio[12129]: info: Loading plugin "multiroom"... Apr 22 22:28:18 motivo volumio[12129]: STREAMING PROXY: Starting server on port 3245 Apr 22 22:28:18 motivo volumio[12129]: Node JS runtime: 14 Apr 22 22:28:19 motivo volumio[12129]: info: Applying required configuration parameters for plugin multiroom Apr 22 22:28:19 motivo sudo[12219]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Apr 22 22:28:19 motivo sudo[12219]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:28:19 motivo sudo[12219]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:19 motivo volumio[12129]: /bin/mkdir: cannot create directory ‘/tmp/hls’: File exists Apr 22 22:28:19 motivo volumio[12129]: info: MRS: MultiRoom plugin initialized Apr 22 22:28:19 motivo volumio[12129]: info: MRS: STOPPING SNAPCLIENT Apr 22 22:28:19 motivo volumio[12129]: info: MRS: Snap server stop Apr 22 22:28:19 motivo sudo[12235]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Apr 22 22:28:19 motivo sudo[12235]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:28:19 motivo volumio[12129]: info: MRS: STOPPING volumioStreaming Apr 22 22:28:19 motivo sudo[12238]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Apr 22 22:28:19 motivo sudo[12238]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:28:19 motivo sudo[12235]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:19 motivo sudo[12241]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Apr 22 22:28:19 motivo sudo[12241]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:28:19 motivo volumio[12129]: info: Loading plugin "outputs"... Apr 22 22:28:19 motivo sudo[12238]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:19 motivo sudo[12244]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Apr 22 22:28:19 motivo sudo[12244]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:28:19 motivo sudo[12244]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:19 motivo sudo[12241]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:19 motivo volumio[12129]: info: Loading plugin "albumart"... Apr 22 22:28:19 motivo volumio[12129]: info: Plugin example_plugin is not enabled Apr 22 22:28:19 motivo volumio[12129]: info: Loading plugin "hi_res_audio"... Apr 22 22:28:19 motivo volumio[12129]: Forking 3 albumart workers Apr 22 22:28:19 motivo sudo[12162]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:20 motivo volumio[12129]: info: Applying required configuration parameters for plugin hi_res_audio Apr 22 22:28:20 motivo volumio[12129]: info: Loading plugin "inputs"... Apr 22 22:28:20 motivo volumio[12129]: Starting albumart workers Apr 22 22:28:20 motivo volumio[12129]: Starting albumart workers Apr 22 22:28:20 motivo volumio[12129]: Starting albumart workers Apr 22 22:28:20 motivo volumio[12129]: info: Loading plugin "qobuz"... Apr 22 22:28:21 motivo volumio[12129]: info: Loading plugin "smart_inputs"... Apr 22 22:28:21 motivo volumio[12129]: info: Loading plugin "tidal"... Apr 22 22:28:22 motivo volumio[12129]: info: Loading plugin "motivocontrol"... Apr 22 22:28:22 motivo volumio[12129]: info: Adding this device properties Apr 22 22:28:22 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Apr 22 22:28:22 motivo volumio[12129]: info: Setting Additional Device Volumio Properties: [object Object] Apr 22 22:28:22 motivo volumio[12129]: info: Checking For Motivo Hardware Apr 22 22:28:22 motivo volumio[12129]: info: Loading plugin "updater_comm"... Apr 22 22:28:22 motivo volumio[12129]: info: Plugin mpdemulation is not enabled Apr 22 22:28:22 motivo volumio[12129]: info: Loading plugin "rest_api"... Apr 22 22:28:22 motivo volumio[12129]: info: Loading plugin "websocket"... Apr 22 22:28:22 motivo volumio[12129]: info: Loading i18n strings for locale it Apr 22 22:28:22 motivo volumio[12129]: Updating browse sources language Apr 22 22:28:22 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 22:28:22 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 22 22:28:22 motivo volumio[12129]: info: CoreCommandRouter::initPlayerControls Apr 22 22:28:22 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:22 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:22 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:22 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:22 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:22 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:22 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:22 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:22 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 22 22:28:22 motivo volumio[12129]: Express server listening on port 3000 Apr 22 22:28:22 motivo volumio[12129]: [Metrics] WebUI: 8s 409.54ms Apr 22 22:28:22 motivo volumio[12129]: info: CoreStateMachine::resetVolumioState Apr 22 22:28:22 motivo volumio[12129]: info: CoreStateMachine::getcurrentVolume Apr 22 22:28:22 motivo volumio[12129]: info: CoreCommandRouter::volumioRetrievevolume Apr 22 22:28:22 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 22:28:22 motivo volumio[12129]: info: Cannot read play queue from file Apr 22 22:28:22 motivo volumio[12129]: info: Motivo Hardware found Apr 22 22:28:22 motivo volumio[12129]: info: MRS: Removed streaming files Apr 22 22:28:22 motivo volumio[12129]: info: MRS: volumioStreaming STOPPED Apr 22 22:28:22 motivo volumio[12129]: info: MRS: SNAPSERVER STOPPED Apr 22 22:28:22 motivo volumio[12129]: info: MRS: SNAPCLIENT STOPPED Apr 22 22:28:22 motivo volumio[12129]: verbose: New Socket.io Connection to 192.168.1.164 from 192.168.1.34 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 1 Apr 22 22:28:22 motivo volumio[12129]: verbose: New Socket.io Connection to 192.168.1.164 from 192.168.1.34 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 2 Apr 22 22:28:22 motivo volumio[12129]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-memorysave-touch Total Clients: 3 Apr 22 22:28:22 motivo volumio[12129]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-memorysave-touch Total Clients: 4 Apr 22 22:28:22 motivo volumio[12129]: verbose: New Socket.io Connection to 192.168.1.164 from 192.168.1.34 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 5 Apr 22 22:28:22 motivo volumio-remote-updater[567]: [2024-04-22 22:28:22] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1713824898 101 Apr 22 22:28:22 motivo volumio[12129]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 6 Apr 22 22:28:22 motivo volumio[12129]: verbose: New Socket.io Connection to 192.168.1.164 from 192.168.1.34 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 7 Apr 22 22:28:22 motivo volumio[12129]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-memorysave-touch Total Clients: 8 Apr 22 22:28:22 motivo volumio[12129]: verbose: New Socket.io Connection to 192.168.1.164:3000 from 192.168.1.66 UA: node-XMLHttpRequest Total Clients: 9 Apr 22 22:28:22 motivo volumio[12129]: info: Setting Device type: Raspberry PI Apr 22 22:28:22 motivo volumio[12129]: info: CoreStateMachine::setRepeat null single undefined Apr 22 22:28:22 motivo volumio[12129]: info: CoreStateMachine::pushState Apr 22 22:28:22 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:22 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 22:28:22 motivo volumio[12129]: info: CoreCommandRouter::volumioPushState Apr 22 22:28:22 motivo volumio[12129]: info: CoreStateMachine::setRandom null Apr 22 22:28:22 motivo volumio[12129]: info: CoreStateMachine::pushState Apr 22 22:28:22 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:22 motivo volumio[12129]: info: CoreCommandRouter::volumioPushState Apr 22 22:28:22 motivo volumio[12129]: info: Completed loading Core Plugins Apr 22 22:28:22 motivo volumio[12129]: info: Preparing to generate the ALSA configuration file Apr 22 22:28:22 motivo volumio[12129]: info: VolumeController:: Volume=46 Mute =false Apr 22 22:28:22 motivo volumio[12129]: info: CoreStateMachine::pushState Apr 22 22:28:22 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:22 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 22:28:22 motivo volumio[12129]: info: CoreCommandRouter::volumioPushState Apr 22 22:28:22 motivo volumio[12129]: info: CoreStateMachine::updateTrackBlock Apr 22 22:28:22 motivo volumio[12129]: info: CorePlayQueue::getTrackBlock Apr 22 22:28:22 motivo volumio[12129]: info: CoreCommandRouter::volumioRetrievevolume Apr 22 22:28:23 motivo volumio[12129]: info: Discovery: adding c719d579-661a-4a58-b12a-d4b86c78aed0 Apr 22 22:28:23 motivo volumio[12129]: info: Discovery: Found device Integro Apr 22 22:28:23 motivo volumio[12129]: info: Discovery: Connecting to remote: 192.168.1.66 Apr 22 22:28:23 motivo volumio[12129]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Apr 22 22:28:23 motivo volumio[12129]: info: Reading ALSA contributions from plugins. Apr 22 22:28:23 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Apr 22 22:28:23 motivo volumio[12129]: info: CoreCommandRouter::volumioGetState Apr 22 22:28:23 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:23 motivo volumio[12129]: info: VolumeController:: Volume=46 Mute =false Apr 22 22:28:23 motivo volumio[12129]: info: CoreStateMachine::pushState Apr 22 22:28:23 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:23 motivo volumio[12129]: info: CoreCommandRouter::volumioPushState Apr 22 22:28:23 motivo volumio[12129]: info: Asound.conf file unchanged, so no further update is needed Apr 22 22:28:23 motivo volumio[12129]: info: Output device has changed, restarting MPD Apr 22 22:28:23 motivo sudo[12317]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 22 22:28:23 motivo sudo[12317]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:28:23 motivo sudo[12317]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:23 motivo volumio[12129]: info: Output device has changed, restarting Shairport Sync Apr 22 22:28:23 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:23 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 22:28:23 motivo sudo[12320]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 22 22:28:23 motivo sudo[12320]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:28:23 motivo systemd[1]: Stopping Music Player Daemon... Apr 22 22:28:23 motivo systemd[1]: mpd.service: Succeeded. Apr 22 22:28:23 motivo systemd[1]: Stopped Music Player Daemon. Apr 22 22:28:23 motivo volumio[12129]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 22 22:28:23 motivo volumio[12129]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 22 22:28:23 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:23 motivo systemd[1]: Starting Music Player Daemon... Apr 22 22:28:23 motivo volumio[12129]: info: ___________ START PLUGINS ___________ Apr 22 22:28:23 motivo volumio[12129]: info: ControllerMpd::onStart: Initializing MPD Apr 22 22:28:23 motivo volumio[12129]: info: Creating MPD Configuration file Apr 22 22:28:23 motivo sudo[12329]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 22 22:28:23 motivo sudo[12329]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:28:23 motivo sudo[12329]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:23 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 22 22:28:23 motivo volumio[12129]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 22 22:28:23 motivo volumio[12129]: info: [1713824903349] CoreMusicLibrary::Adding element Server multimediali Apr 22 22:28:23 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 22:28:23 motivo sudo[12332]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 22 22:28:23 motivo sudo[12332]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:28:23 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 22 22:28:23 motivo systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 22 22:28:23 motivo systemd[1]: mpd.service: Succeeded. Apr 22 22:28:23 motivo systemd[1]: Stopped Music Player Daemon. Apr 22 22:28:23 motivo volumio[12129]: info: Adding Manifest REST API Endpoints Apr 22 22:28:23 motivo volumio[12129]: info: Adding manifestui REST Endpoint for plugin: miscellanea/manifestui Apr 22 22:28:23 motivo volumio[12129]: info: Adding METAVOLUMIO REST API Endpoints Apr 22 22:28:23 motivo volumio[12129]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Apr 22 22:28:23 motivo volumio[12129]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Apr 22 22:28:23 motivo volumio[12129]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Apr 22 22:28:23 motivo volumio[12129]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Apr 22 22:28:23 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:23 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 22:28:23 motivo systemd[1]: Starting Music Player Daemon... Apr 22 22:28:23 motivo sudo[12335]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Motivo Apr 22 22:28:23 motivo sudo[12335]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:28:23 motivo sudo[12335]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:23 motivo volumio[12129]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 22 22:28:23 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:23 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 22:28:23 motivo volumio[12129]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 22 22:28:23 motivo volumio[12129]: info: Preparing CD Folders Apr 22 22:28:23 motivo volumio[12129]: info: Adding CD REST API Endpoints Apr 22 22:28:23 motivo volumio[12129]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Apr 22 22:28:23 motivo volumio[12129]: info: Starting UDEV Watcher for CD Apr 22 22:28:23 motivo volumio[12129]: info: Detecting CD presence with UDEV Apr 22 22:28:23 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Apr 22 22:28:23 motivo volumio[12129]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 22 22:28:23 motivo volumio[12129]: info: [1713824903570] CoreMusicLibrary::Adding element Last_100 Apr 22 22:28:23 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 22:28:23 motivo volumio[12129]: info: Starting RAAT Plugin Apr 22 22:28:23 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Apr 22 22:28:23 motivo volumio[12129]: info: Additional UI Settings Added for plugin music_service/raat Apr 22 22:28:23 motivo volumio[12129]: info: Registering DSP Elements listener and retrieving current ones Apr 22 22:28:23 motivo volumio[12129]: info: Additional DSP elements updated Apr 22 22:28:23 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:23 motivo volumio[12129]: info: Updating RAAT Signal Path Apr 22 22:28:23 motivo volumio[12129]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Apr 22 22:28:23 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:23 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:23 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:23 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:23 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:23 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 22 22:28:23 motivo volumio[12129]: info: Not Reporting Auto name since its the default one Apr 22 22:28:23 motivo volumio[12129]: info: Streaming services startup Apr 22 22:28:23 motivo volumio[12129]: info: Starting Streaming Daemon Apr 22 22:28:23 motivo sudo[12349]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 22 22:28:23 motivo sudo[12349]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:28:23 motivo sudo[12349]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:23 motivo volumio[12129]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 22 22:28:23 motivo volumio[12129]: info: [1713824903768] CoreMusicLibrary::Adding element Webradio Apr 22 22:28:23 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 22:28:23 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 22 22:28:23 motivo sudo[12356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 22 22:28:23 motivo sudo[12356]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:28:23 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Apr 22 22:28:23 motivo systemd[1]: Stopping Volumio Tidal Connect Service... Apr 22 22:28:23 motivo systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Apr 22 22:28:23 motivo systemd[1]: vtcs.service: Succeeded. Apr 22 22:28:23 motivo systemd[1]: Stopped Volumio Tidal Connect Service. Apr 22 22:28:23 motivo sudo[12356]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:23 motivo volumio[12129]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 22 22:28:23 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:23 motivo volumio[12129]: error: Hi Res Audio Failed Login: Missing Login Data Apr 22 22:28:23 motivo volumio[12129]: info: Adding HIGHRESAUDIO REST API Endpoints Apr 22 22:28:23 motivo volumio[12129]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Apr 22 22:28:23 motivo volumio[12129]: info: Initializing Serial Communication on port /dev/ttyAMA1 Apr 22 22:28:23 motivo volumio[12129]: info: Touch Event Listener Process Starting Apr 22 22:28:23 motivo volumio[12129]: info: Refreshing QOBUZ token Apr 22 22:28:23 motivo sudo[12363]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xinput --test-xi2 --root Apr 22 22:28:23 motivo sudo[12363]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:28:23 motivo volumio[12129]: info: Adding inputs REST Endpoints Apr 22 22:28:23 motivo volumio[12129]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Apr 22 22:28:23 motivo volumio[12129]: info: Scanning Audio Inputs Apr 22 22:28:23 motivo volumio[12129]: info: Checking against Known Cards name Apr 22 22:28:23 motivo volumio[12129]: info: Checking against Known Cards name Apr 22 22:28:23 motivo volumio[12129]: info: Adding Server instance for streaming Apr 22 22:28:24 motivo volumio[12129]: info: Refreshing TIDAL token Apr 22 22:28:24 motivo volumio[12129]: info: Volumio Calling Home Apr 22 22:28:24 motivo volumio[12129]: (node:12129) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. Apr 22 22:28:24 motivo volumio[12129]: (Use `node --trace-deprecation ...` to show where the warning was created) Apr 22 22:28:24 motivo volumio[12129]: info: Discovery: adding 82dac078-ee73-4109-b56a-13c84023851f Apr 22 22:28:24 motivo volumio[12129]: info: Discovery: Found device Motivo Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::volumioGetState Apr 22 22:28:24 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:24 motivo volumio[12129]: info: MRS: Pushing multiroomSync output for this device Apr 22 22:28:24 motivo volumio[12129]: info: MRS: Pushing multiroomSync output Apr 22 22:28:24 motivo volumio[12129]: info: Adding audio output: Apr 22 22:28:24 motivo volumio[12129]: info: Adding audio output: Apr 22 22:28:24 motivo volumio[12129]: info: Serial port opened successfully Apr 22 22:28:24 motivo volumio[12129]: info: Sending serial start messages Apr 22 22:28:24 motivo volumio[12129]: info: Display with brightness control is connected, setting display brightness Apr 22 22:28:24 motivo volumio[12129]: info: Setting Display Brightness to 12 Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:24 motivo mpd[12336]: Apr 22 22:28 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 22 22:28:24 motivo volumio[12129]: error: Cannot start Volumio Streaming Daemon Apr 22 22:28:24 motivo volumio[12129]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 22 22:28:24 motivo volumio[12129]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 22 22:28:24 motivo systemd[1]: Started Music Player Daemon. Apr 22 22:28:24 motivo volumio[12129]: info: Bluetooth name changed to Motivo Apr 22 22:28:24 motivo volumio[12129]: info: MPD Permissions set Apr 22 22:28:24 motivo volumio[12129]: info: MPD Permissions set Apr 22 22:28:24 motivo sudo[12320]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:24 motivo sudo[12332]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride Apr 22 22:28:24 motivo volumio[12129]: info: Setting Device Volume Override Apr 22 22:28:24 motivo volumio[12129]: info: Applying Volume Override Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 22 22:28:24 motivo volumio[12129]: info: Updating Volume Controller Parameters: Device: 5 Name: Analog + I2S + Headphones Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 22 22:28:24 motivo volumio[12129]: info: Enabling external Volume Control Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: inputs , updateVolumeSettings Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: inputs , retrievevolume Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:24 motivo volumio[12129]: info: CoreStateMachine::pushState Apr 22 22:28:24 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::volumioPushState Apr 22 22:28:24 motivo volumio[12129]: info: MRS: Pushing multiroomSync output update for this device Apr 22 22:28:24 motivo volumio[12129]: info: MRS: Pushing multiroomSync output Apr 22 22:28:24 motivo volumio[12129]: info: CoreStateMachine::pushState Apr 22 22:28:24 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::volumioPushState Apr 22 22:28:24 motivo volumio[12129]: info: MRS: Pushing multiroomSync output update for this device Apr 22 22:28:24 motivo volumio[12129]: info: MRS: Pushing multiroomSync output Apr 22 22:28:24 motivo volumio[12129]: info: CoreStateMachine::pushState Apr 22 22:28:24 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::volumioPushState Apr 22 22:28:24 motivo volumio[12129]: info: MRS: Pushing multiroomSync output update for this device Apr 22 22:28:24 motivo volumio[12129]: info: MRS: Pushing multiroomSync output Apr 22 22:28:24 motivo volumio[12129]: info: MRS: Pushing audio output on request Apr 22 22:28:24 motivo volumio[12129]: info: MRS: Pushing multiroomSync output Apr 22 22:28:24 motivo volumio[12129]: info: Discovery: Connected to remote: 192.168.1.66 Apr 22 22:28:24 motivo volumio[12129]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-memorysave-touch Total Clients: 10 Apr 22 22:28:24 motivo volumio[12129]: info: Volumio called home Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Apr 22 22:28:24 motivo volumio[12129]: info: Setting Additional System Software info: Hardware Revision: 2.0 Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Apr 22 22:28:24 motivo volumio[12129]: info: Setting HW Firmware info: undefined Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Apr 22 22:28:24 motivo volumio[12129]: info: Setting HW Version info: 2.0 Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Apr 22 22:28:24 motivo volumio[12129]: info: Setting Additional System Software info: Hardware Revision: 2.0, Firmware Version: 0.1.0 Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Apr 22 22:28:24 motivo volumio[12129]: info: Setting HW Firmware info: 0.1.0 Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Apr 22 22:28:24 motivo volumio[12129]: info: Setting HW Version info: 2.0 Apr 22 22:28:24 motivo volumio[12129]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Apr 22 22:28:24 motivo volumio[12129]: info: MCU Signalled Headphone Mode Disabled Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:24 motivo volumio[12129]: info: Updating RAAT Signal Path Apr 22 22:28:24 motivo volumio[12129]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Apr 22 22:28:24 motivo volumio[12129]: info: MCU Signalled Sleep Mode Disabled Apr 22 22:28:24 motivo volumio[12129]: info: Enabling Advanced system settings configuration Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , addAdditionalUISections Apr 22 22:28:24 motivo volumio[12129]: info: Additional UI Settings Added for plugin music_service/inputs Apr 22 22:28:24 motivo volumio[12129]: info: MCU Signalled Auto Boot Mode On Power Disabled Apr 22 22:28:24 motivo volumio[12129]: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA Apr 22 22:28:24 motivo volumio[12129]: 11111110000000000000000000000000 Apr 22 22:28:24 motivo volumio[12129]: 11111110000000000000000000000000 Apr 22 22:28:24 motivo sudo[12379]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms force on Apr 22 22:28:24 motivo sudo[12379]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:28:24 motivo volumio[12129]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 11 Apr 22 22:28:24 motivo sudo[12379]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Apr 22 22:28:24 motivo sudo[12394]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Apr 22 22:28:24 motivo sudo[12394]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:28:24 motivo sudo[12394]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:24 motivo sudo[12396]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Apr 22 22:28:24 motivo sudo[12396]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:28:24 motivo systemd[1]: Stopping RAAT DAEMON... Apr 22 22:28:24 motivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Apr 22 22:28:24 motivo systemd[1]: raat-daemon.service: Succeeded. Apr 22 22:28:24 motivo systemd[1]: Stopped RAAT DAEMON. Apr 22 22:28:24 motivo volumio[12129]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 12 Apr 22 22:28:24 motivo systemd[1]: Started RAAT DAEMON. Apr 22 22:28:24 motivo sudo[12396]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:24 motivo sudo[12404]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms 0 0 0 Apr 22 22:28:24 motivo sudo[12404]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:28:24 motivo sudo[12404]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:24 motivo volumio[12129]: info: Access Token successfully retrieved Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 22 22:28:24 motivo volumio[12129]: info: [1713824904858] CoreMusicLibrary::Adding element QOBUZ Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 22:28:24 motivo volumio[12129]: Cannot find translation for source QOBUZ Apr 22 22:28:24 motivo volumio[12129]: info: Stopping AccessToken refresher cron for QOBUZ Apr 22 22:28:24 motivo volumio[12129]: info: AccessToken refresher cron started for QOBUZ Apr 22 22:28:24 motivo volumio[12129]: info: Adding QOBUZ REST API Endpoints Apr 22 22:28:24 motivo volumio[12129]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Apr 22 22:28:24 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 22 22:28:24 motivo volumio[12129]: error: MPD error: The expression evaluated to a falsy value: Apr 22 22:28:24 motivo volumio[12129]: assert.ok(self.idling) Apr 22 22:28:24 motivo volumio[12129]: error: The expression evaluated to a falsy value: Apr 22 22:28:24 motivo volumio[12129]: assert.ok(self.idling) Apr 22 22:28:25 motivo volumio[12129]: info: Raat Daemon started successfully Apr 22 22:28:25 motivo volumio[12129]: info: MPD running with PID12336 Apr 22 22:28:25 motivo volumio[12129]: ,establishing connection Apr 22 22:28:25 motivo volumio[12129]: info: MRS: Found cast device: S801B-ff0ab9b74701e208d26a65bc56f88ce3 Apr 22 22:28:25 motivo volumio[12129]: info: Adding audio output: Apr 22 22:28:25 motivo volumio[12129]: error: Serial API: Failed to decode command: MAXVOL, message: 100 Apr 22 22:28:25 motivo volumio[12129]: error: Serial API: Failed to decode command: MAXVOL, message: 100 Apr 22 22:28:25 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 22 22:28:25 motivo volumio[12129]: info: CoreCommandRouter::volumioGetVisibleSources Apr 22 22:28:25 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 22:28:25 motivo volumio[12129]: info: CoreCommandRouter::volumioGetState Apr 22 22:28:25 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:25 motivo volumio[12129]: info: CoreCommandRouter::volumioGetState Apr 22 22:28:25 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:25 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 22 22:28:25 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 22 22:28:25 motivo volumio[12129]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Apr 22 22:28:25 motivo volumio[12129]: info: Received Get System Info Apr 22 22:28:25 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 22 22:28:25 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 22 22:28:25 motivo volumio[12129]: info: Discovery: Getting this device information Apr 22 22:28:25 motivo volumio[12129]: info: CoreCommandRouter::volumioGetState Apr 22 22:28:25 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:25 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 22 22:28:25 motivo volumio[12129]: info: CoreCommandRouter::volumioGetState Apr 22 22:28:25 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:25 motivo volumio[12129]: info: Listing playlists Apr 22 22:28:25 motivo volumio[12129]: info: CoreCommandRouter::volumioGetQueue Apr 22 22:28:25 motivo volumio[12129]: info: CoreStateMachine::getQueue Apr 22 22:28:25 motivo volumio[12129]: info: CorePlayQueue::getQueue Apr 22 22:28:25 motivo volumio[12129]: error: updateQueue error: null Apr 22 22:28:25 motivo volumio[12129]: info: Access Token successfully retrieved Apr 22 22:28:25 motivo volumio[12129]: info: Starting Shairport Sync Apr 22 22:28:25 motivo volumio[12129]: info: Starting Shairport Sync Apr 22 22:28:25 motivo sudo[12412]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 22 22:28:25 motivo sudo[12412]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:28:25 motivo volumio[12129]: info: Starting Shairport Sync Apr 22 22:28:25 motivo sudo[12414]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 22 22:28:25 motivo sudo[12414]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:28:25 motivo volumio[12129]: info: Adding Inputs via Serial API Apr 22 22:28:25 motivo volumio[12129]: info: Adding HDMI I2S MODES via Serial API Apr 22 22:28:25 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Apr 22 22:28:25 motivo volumio[12129]: info: Additional UI Settings Added for plugin music_service/inputs Apr 22 22:28:25 motivo volumio[12129]: EEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEE Apr 22 22:28:25 motivo volumio[12129]: 11111110000000000000000000000000 Apr 22 22:28:25 motivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 22 22:28:25 motivo systemd[1]: shairport-sync.service: Succeeded. Apr 22 22:28:25 motivo sudo[12418]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 22 22:28:25 motivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 22 22:28:25 motivo volumio[12129]: [ Apr 22 22:28:25 motivo volumio[12129]: { id: '1', name: 'Linear phase fast roll-off' }, Apr 22 22:28:25 motivo volumio[12129]: { id: '2', name: 'Linear phase slow roll-off' }, Apr 22 22:28:25 motivo volumio[12129]: { id: '3', name: 'Minimum phase fast roll-off' }, Apr 22 22:28:25 motivo volumio[12129]: { id: '4', name: 'Minimum phase slow roll-off' }, Apr 22 22:28:25 motivo volumio[12129]: { id: '5', name: 'Apodizing fast roll-off' }, Apr 22 22:28:25 motivo volumio[12129]: { id: '6', name: 'Corrected minimum phase fast roll-off' }, Apr 22 22:28:25 motivo volumio[12129]: { id: '7', name: 'Brick wall' }, Apr 22 22:28:25 motivo volumio[12129]: { id: '8', name: 'Reserved for future use' }, Apr 22 22:28:25 motivo volumio[12129]: { id: '9', name: 'Reserved for future use' }, Apr 22 22:28:25 motivo volumio[12129]: { id: '10', name: 'Reserved for future use' }, Apr 22 22:28:25 motivo volumio[12129]: { id: '11', name: 'Reserved for future use' }, Apr 22 22:28:25 motivo volumio[12129]: { id: '12', name: 'Reserved for future use' }, Apr 22 22:28:25 motivo volumio[12129]: { id: '13', name: 'Reserved for future use' }, Apr 22 22:28:25 motivo volumio[12129]: { id: '14', name: 'Reserved for future use' }, Apr 22 22:28:25 motivo volumio[12129]: { id: '15', name: 'Reserved for future use' }, Apr 22 22:28:25 motivo volumio[12129]: { id: '16', name: 'Reserved for future use' }, Apr 22 22:28:25 motivo volumio[12129]: { id: '17', name: 'Reserved for future use' }, Apr 22 22:28:25 motivo volumio[12129]: { id: '18', name: 'Reserved for future use' }, Apr 22 22:28:25 motivo volumio[12129]: { id: '19', name: 'Reserved for future use' }, Apr 22 22:28:25 motivo volumio[12129]: { id: '20', name: 'Reserved for future use' }, Apr 22 22:28:25 motivo volumio[12129]: { id: '21', name: 'Reserved for future use' }, Apr 22 22:28:25 motivo volumio[12129]: { id: '22', name: 'Reserved for future use' }, Apr 22 22:28:25 motivo volumio[12129]: { id: '23', name: '23' }, Apr 22 22:28:25 motivo volumio[12129]: { id: '24', name: '24' }, Apr 22 22:28:25 motivo volumio[12129]: { id: '25', name: '25' }, Apr 22 22:28:25 motivo volumio[12129]: { id: '26', name: '26' }, Apr 22 22:28:25 motivo volumio[12129]: { id: '27', name: '27' }, Apr 22 22:28:25 motivo volumio[12129]: { id: '28', name: '28' }, Apr 22 22:28:25 motivo volumio[12129]: { id: '29', name: '29' }, Apr 22 22:28:25 motivo volumio[12129]: { id: '30', name: '30' }, Apr 22 22:28:25 motivo volumio[12129]: { id: '31', name: '31' }, Apr 22 22:28:25 motivo volumio[12129]: { id: '32', name: '32' } Apr 22 22:28:25 motivo volumio[12129]: ] Apr 22 22:28:25 motivo volumio[12129]: [] Apr 22 22:28:25 motivo sudo[12418]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:28:25 motivo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 22 22:28:25 motivo sudo[12414]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:25 motivo sudo[12412]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:25 motivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 22 22:28:25 motivo systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Apr 22 22:28:25 motivo systemd[1]: shairport-sync.service: Succeeded. Apr 22 22:28:25 motivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 22 22:28:25 motivo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 22 22:28:25 motivo sudo[12418]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:25 motivo volumio[12129]: info: Executing endpoint restartRAATSocket Apr 22 22:28:25 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Apr 22 22:28:25 motivo volumio[12129]: error: updateQueue error: null Apr 22 22:28:25 motivo volumio[12129]: info: Shairport-Sync Started Apr 22 22:28:25 motivo volumio[12129]: Error adding Membership: Error: addMembership EINVAL Apr 22 22:28:25 motivo volumio[12129]: info: Shairport-Sync Started Apr 22 22:28:25 motivo volumio[12129]: info: Shairport-Sync Started Apr 22 22:28:25 motivo volumio[12129]: info: CoreStateMachine::pushState Apr 22 22:28:25 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:25 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 22:28:25 motivo volumio[12129]: info: CoreCommandRouter::volumioPushState Apr 22 22:28:25 motivo volumio[12129]: info: MRS: Pushing multiroomSync output update for this device Apr 22 22:28:25 motivo volumio[12129]: info: MRS: Pushing multiroomSync output Apr 22 22:28:25 motivo volumio[12129]: info: CoreStateMachine::pushState Apr 22 22:28:25 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:25 motivo volumio[12129]: info: CoreCommandRouter::volumioPushState Apr 22 22:28:25 motivo volumio[12129]: info: MRS: Pushing multiroomSync output update for this device Apr 22 22:28:25 motivo volumio[12129]: info: MRS: Pushing multiroomSync output Apr 22 22:28:25 motivo volumio[12129]: info: CoreCommandRouter::servicePushState Apr 22 22:28:25 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:25 motivo volumio[12129]: verbose: STATE SERVICE {"status":"play","service":"inputs","title":"","artist":"","album":"","albumart":"/albumart","uri":"","trackType":"","seek":0,"duration":0,"samplerate":"","bitdepth":"","stream":true,"disableUiControls":true,"channels":2} Apr 22 22:28:25 motivo volumio[12129]: verbose: CURRENT POSITION 0 Apr 22 22:28:25 motivo volumio[12129]: info: CoreStateMachine::syncState stateService play Apr 22 22:28:25 motivo volumio[12129]: info: CoreStateMachine::syncState currentStatus stop Apr 22 22:28:25 motivo volumio[12129]: info: CoreCommandRouter::volumiosetSourceActiveno-source Apr 22 22:28:25 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 22:28:25 motivo volumio[12129]: Cannot find translation for source QOBUZ Apr 22 22:28:25 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:25 motivo volumio[12129]: info: MRS: Adding multiroomSync output Apr 22 22:28:25 motivo volumio[12129]: info: Adding audio output: Apr 22 22:28:25 motivo volumio[12129]: info: MRS: Pushing multiroomSync output Apr 22 22:28:25 motivo volumio[12129]: info: CoreCommandRouter::volumioGetState Apr 22 22:28:25 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:25 motivo volumio[12129]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 13 Apr 22 22:28:25 motivo volumio[12129]: info: CoreCommandRouter::volumioGetState Apr 22 22:28:25 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:25 motivo volumio[12129]: info: Successfully retrieved User Session From TIDAL Apr 22 22:28:25 motivo volumio[12129]: info: MCU Signalled Playback Inactive Apr 22 22:28:25 motivo volumio[12129]: info: Successfully retrieved User Subscription From TIDAL Apr 22 22:28:25 motivo volumio[12129]: info: Adding TIDAL to Browse Sources Apr 22 22:28:25 motivo volumio[12129]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 22 22:28:25 motivo volumio[12129]: info: [1713824905843] CoreMusicLibrary::Adding element TIDAL Apr 22 22:28:25 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 22:28:25 motivo volumio[12129]: Cannot find translation for source QOBUZ Apr 22 22:28:25 motivo volumio[12129]: Cannot find translation for source TIDAL Apr 22 22:28:25 motivo volumio[12129]: info: Stopping AccessToken refresher cron Apr 22 22:28:25 motivo volumio[12129]: info: AccessToken refresher cron started Apr 22 22:28:25 motivo volumio[12129]: info: Adding TIDAL REST API Endpoints Apr 22 22:28:25 motivo volumio[12129]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Apr 22 22:28:25 motivo sudo[12426]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 22 22:28:25 motivo sudo[12426]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:28:25 motivo sudo[12426]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:25 motivo sudo[12432]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 22 22:28:25 motivo sudo[12432]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:28:25 motivo sudo[12432]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:26 motivo sudo[12435]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 22 22:28:26 motivo sudo[12435]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:28:26 motivo sudo[12435]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:26 motivo volumio[12129]: info: Upmpdcli Daemon Started Apr 22 22:28:26 motivo sudo[12439]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Apr 22 22:28:26 motivo sudo[12439]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:28:26 motivo sudo[12439]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:26 motivo volumio[12129]: info: Volumio BT Module successfully started Apr 22 22:28:26 motivo volumio[12129]: info: TidalConnect service stoped! Apr 22 22:28:26 motivo volumio[12129]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Apr 22 22:28:26 motivo volumio[12129]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Apr 22 22:28:26 motivo sudo[12451]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Apr 22 22:28:26 motivo sudo[12451]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:28:27 motivo volumio[12129]: info: Initializing I2S Bus Apr 22 22:28:27 motivo systemd[1]: Started Volumio Tidal Connect Service. Apr 22 22:28:27 motivo sudo[12451]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:27 motivo volumio[12129]: info: Executing endpoint tc_getconfig Apr 22 22:28:27 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Apr 22 22:28:27 motivo vtcs[12453]: STARTING TidalConnect services, version: 1.4.0.34 Apr 22 22:28:27 motivo vtcs[12453]: STARTED TidalConnect services. Apr 22 22:28:27 motivo volumio[12129]: info: Executing endpoint tc_connect Apr 22 22:28:27 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Apr 22 22:28:27 motivo volumio[12129]: info: Connecting to TidalConnect Apr 22 22:28:27 motivo volumio[12129]: info: CoreCommandRouter::servicePushState Apr 22 22:28:27 motivo volumio[12129]: info: CoreStateMachine::pushState Apr 22 22:28:27 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:27 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 22:28:27 motivo volumio[12129]: info: CoreCommandRouter::volumioPushState Apr 22 22:28:27 motivo volumio[12129]: info: MRS: Pushing multiroomSync output update for this device Apr 22 22:28:27 motivo volumio[12129]: info: MRS: Pushing multiroomSync output Apr 22 22:28:27 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:27 motivo volumio[12129]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Apr 22 22:28:27 motivo volumio[12129]: verbose: CURRENT POSITION 0 Apr 22 22:28:27 motivo volumio[12129]: info: CoreStateMachine::syncState stateService stop Apr 22 22:28:27 motivo volumio[12129]: info: CoreStateMachine::syncState currentStatus play Apr 22 22:28:27 motivo volumio[12129]: info: CoreCommandRouter::volumioPushState Apr 22 22:28:27 motivo volumio[12129]: info: MRS: Pushing multiroomSync output update for this device Apr 22 22:28:27 motivo volumio[12129]: info: MRS: Pushing multiroomSync output Apr 22 22:28:27 motivo volumio[12129]: info: CoreStateMachine::stPlaybackTimer Apr 22 22:28:27 motivo volumio[12129]: info: CoreCommandRouter::servicePushState Apr 22 22:28:27 motivo volumio[12129]: info: CoreStateMachine::pushState Apr 22 22:28:27 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:27 motivo volumio[12129]: info: CoreCommandRouter::volumioPushState Apr 22 22:28:27 motivo volumio[12129]: info: MRS: Pushing multiroomSync output update for this device Apr 22 22:28:27 motivo volumio[12129]: info: MRS: Pushing multiroomSync output Apr 22 22:28:27 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:27 motivo volumio[12129]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Apr 22 22:28:27 motivo volumio[12129]: verbose: CURRENT POSITION 0 Apr 22 22:28:27 motivo volumio[12129]: info: CoreStateMachine::syncState stateService stop Apr 22 22:28:27 motivo volumio[12129]: info: CoreStateMachine::syncState currentStatus stop Apr 22 22:28:27 motivo volumio[12129]: info: CoreStateMachine::pushState Apr 22 22:28:27 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:27 motivo volumio[12129]: info: CoreCommandRouter::volumioPushState Apr 22 22:28:27 motivo volumio[12129]: info: MRS: Pushing multiroomSync output update for this device Apr 22 22:28:27 motivo volumio[12129]: info: MRS: Pushing multiroomSync output Apr 22 22:28:27 motivo volumio[12129]: info: No code Apr 22 22:28:27 motivo volumio[12129]: info: CoreStateMachine::pushState Apr 22 22:28:27 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:27 motivo volumio[12129]: info: CoreCommandRouter::volumioPushState Apr 22 22:28:27 motivo volumio[12129]: info: MRS: Pushing multiroomSync output update for this device Apr 22 22:28:27 motivo volumio[12129]: info: MRS: Pushing multiroomSync output Apr 22 22:28:27 motivo volumio[12129]: info: Updating RAAT Signal Path Apr 22 22:28:27 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:27 motivo volumio[12129]: info: Updating RAAT Signal Path Apr 22 22:28:27 motivo volumio[12129]: info: Updating RAAT Signal Path Apr 22 22:28:27 motivo volumio[12129]: info: Updating RAAT Signal Path Apr 22 22:28:27 motivo volumio[12129]: info: Updating RAAT Signal Path Apr 22 22:28:28 motivo volumio[12129]: info: Successfully initialized Motivo I2S Bus Apr 22 22:28:28 motivo sudo[12120]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:28 motivo volumio[12129]: info: MRS: Getting audio outputs on start Apr 22 22:28:28 motivo volumio[12129]: info: MRS: Requesting all other devices output Apr 22 22:28:29 motivo volumio[12129]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Apr 22 22:28:30 motivo volumio[12129]: info: TidalConnect service started! Apr 22 22:28:30 motivo volumio[12129]: info: Completed starting Core Plugins Apr 22 22:28:30 motivo volumio[12129]: info: ------------------------------------------- Apr 22 22:28:30 motivo volumio[12129]: info: ----- MyVolumio plugins startup ---- Apr 22 22:28:30 motivo volumio[12129]: info: ------------------------------------------- Apr 22 22:28:30 motivo volumio[12129]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 22 22:28:34 motivo volumio[12129]: info: Checking for updated MCU Firmware Apr 22 22:28:34 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 22 22:28:34 motivo volumio[12129]: info: Firware on device is on latest version, no need to update Apr 22 22:28:38 motivo volumio[12129]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Apr 22 22:28:38 motivo volumio[12129]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Apr 22 22:28:38 motivo volumio[12129]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Apr 22 22:28:38 motivo volumio[12129]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Apr 22 22:28:38 motivo volumio[12129]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Apr 22 22:28:38 motivo volumio[12129]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Apr 22 22:28:38 motivo volumio[12129]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Apr 22 22:28:38 motivo volumio[12129]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Apr 22 22:28:38 motivo volumio[12129]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Apr 22 22:28:38 motivo volumio[12129]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Apr 22 22:28:38 motivo volumio[12129]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Apr 22 22:28:38 motivo volumio[12129]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Apr 22 22:28:38 motivo volumio[12129]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Apr 22 22:28:38 motivo volumio[12129]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Apr 22 22:28:38 motivo volumio[12129]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Apr 22 22:28:38 motivo volumio[12129]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Apr 22 22:28:38 motivo volumio[12129]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Apr 22 22:28:38 motivo volumio[12129]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Apr 22 22:28:38 motivo volumio[12129]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Apr 22 22:28:38 motivo volumio[12129]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Apr 22 22:28:38 motivo volumio[12129]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Apr 22 22:28:38 motivo volumio[12129]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Apr 22 22:28:38 motivo volumio[12129]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Apr 22 22:28:38 motivo volumio[12129]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Apr 22 22:28:38 motivo volumio[12129]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Apr 22 22:28:38 motivo volumio[12129]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Apr 22 22:28:38 motivo volumio[12129]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Apr 22 22:28:39 motivo volumio[12129]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Apr 22 22:28:39 motivo volumio[12129]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Apr 22 22:28:39 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 22:28:39 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 22:28:39 motivo volumio[12129]: info: Starting MyVolumio Remote Streaming Endpoints Apr 22 22:28:39 motivo volumio[12129]: info: MyVolumio login type: Token Apr 22 22:28:39 motivo volumio[12129]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Apr 22 22:28:39 motivo volumio[12129]: error: [MyVolumio PluginManager] Could not read package.json file: Error: /myvolumio/plugins/music_service/streaming_services//package.json: ENOENT: no such file or directory, open '/myvolumio/plugins/music_service/streaming_services//package.json' Apr 22 22:28:39 motivo volumio[12129]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Apr 22 22:28:40 motivo volumio[12129]: info: MyVolumio token set successfully Apr 22 22:28:40 motivo volumio[12129]: info: MYVOLUMIO: Adding device Apr 22 22:28:40 motivo volumio[12129]: info: MYVOLUMIO: Evaluating Server Apr 22 22:28:41 motivo volumio[12129]: info: MyVolumio Plan changed: superstar Apr 22 22:28:41 motivo volumio[12129]: info: [MyVolumio PluginManager] Subscribed plan changed to superstar Apr 22 22:28:41 motivo volumio[12129]: info: Adding audio output: Apr 22 22:28:41 motivo volumio[12129]: info: MYVOLUMIO: Adding device Apr 22 22:28:41 motivo volumio[12129]: info: MYVOLUMIO: Evaluating Server Apr 22 22:28:41 motivo volumio[12129]: info: Remote config written successfully Apr 22 22:28:41 motivo volumio[12129]: info: Starting Tunnel 1 Apr 22 22:28:41 motivo volumio[12129]: info: Starting Tunnel Connection Checker Apr 22 22:28:41 motivo volumio[12129]: info: MYVolumio Device enabled Apr 22 22:28:41 motivo volumio[12129]: info: MyVolumio status changed Apr 22 22:28:41 motivo volumio[12129]: info: Streaming services startup Apr 22 22:28:41 motivo volumio[12129]: info: Starting Streaming Daemon Apr 22 22:28:41 motivo volumio[12129]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Apr 22 22:28:41 motivo sudo[12509]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 22 22:28:41 motivo sudo[12509]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:28:41 motivo volumio[12129]: info: Setting Geolocation for MyVolumio to eu4 Apr 22 22:28:41 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 22:28:41 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 22:28:41 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 22:28:41 motivo sudo[12509]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:41 motivo volumio[12129]: error: Cannot start Volumio Streaming Daemon Apr 22 22:28:41 motivo volumio[12129]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 22 22:28:41 motivo volumio[12129]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 22 22:28:41 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Apr 22 22:28:41 motivo volumio[12129]: info: [MyVolumio PluginManager] Plugin audio_interface/bluetooth is enabled for this plan, but could not be found on the local filesystem! Apr 22 22:28:41 motivo volumio[12129]: info: [MyVolumio PluginManager] Plugin audio_interface/multiroom is enabled for this plan, but could not be found on the local filesystem! Apr 22 22:28:41 motivo volumio[12129]: info: [MyVolumio PluginManager] Plugin miscellanea/metavolumio is enabled for this plan, but could not be found on the local filesystem! Apr 22 22:28:41 motivo volumio[12129]: info: [MyVolumio PluginManager] Plugin miscellanea/manifestui is enabled for this plan, but could not be found on the local filesystem! Apr 22 22:28:41 motivo volumio[12129]: info: [MyVolumio PluginManager] Plugin music_service/cd_controller is enabled for this plan, but could not be found on the local filesystem! Apr 22 22:28:41 motivo volumio[12129]: info: [MyVolumio PluginManager] Plugin music_service/smart_inputs is enabled for this plan, but could not be found on the local filesystem! Apr 22 22:28:41 motivo volumio[12129]: info: [MyVolumio PluginManager] Plugin music_service/hi_res_audio is enabled for this plan, but could not be found on the local filesystem! Apr 22 22:28:41 motivo volumio[12129]: info: [MyVolumio PluginManager] Plugin music_service/tidal is enabled for this plan, but could not be found on the local filesystem! Apr 22 22:28:41 motivo volumio[12129]: info: [MyVolumio PluginManager] Plugin music_service/qobuz is enabled for this plan, but could not be found on the local filesystem! Apr 22 22:28:41 motivo volumio[12129]: info: [MyVolumio PluginManager] Plugin music_service/tidalconnect is enabled for this plan, but could not be found on the local filesystem! Apr 22 22:28:42 motivo volumio[12129]: info: Setting Geolocation for MyVolumio to eu4 Apr 22 22:28:42 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 22:28:42 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 22:28:42 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 22:28:42 motivo volumio[12129]: info: Successfully Added MyVolumio device Apr 22 22:28:42 motivo volumio[12129]: info: Successfully Added MyVolumio device Apr 22 22:28:42 motivo volumio[12129]: info: Updating MyVolumio device info Apr 22 22:28:42 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 22:28:42 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 22:28:42 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 22:28:43 motivo volumio[12129]: info: Updating MyVolumio device info Apr 22 22:28:43 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 22:28:43 motivo volumio[12129]: info: Successfully Updated MyVolumio device Apr 22 22:28:43 motivo volumio[12129]: info: Successfully Updated MyVolumio device Apr 22 22:28:46 motivo sudo[12517]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Apr 22 22:28:46 motivo sudo[12517]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:28:46 motivo autossh[12100]: received signal to exit (15) Apr 22 22:28:46 motivo systemd[1]: Stopping MyVolumio SSH Tunnel... Apr 22 22:28:46 motivo systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM Apr 22 22:28:46 motivo systemd[1]: sshtunnel.service: Succeeded. Apr 22 22:28:46 motivo systemd[1]: Stopped MyVolumio SSH Tunnel. Apr 22 22:28:46 motivo volumio[12129]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 22 22:28:46 motivo systemd[1]: Started MyVolumio SSH Tunnel. Apr 22 22:28:46 motivo volumio[12129]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 22 22:28:46 motivo sudo[12517]: pam_unix(sudo:session): session closed for user root Apr 22 22:28:46 motivo volumio[12129]: info: Remote SSH Started Apr 22 22:28:46 motivo autossh[12520]: port set to 0, monitoring disabled Apr 22 22:28:46 motivo autossh[12520]: starting ssh (count 1) Apr 22 22:28:46 motivo autossh[12520]: ssh child pid is 12523 Apr 22 22:28:46 motivo volumio[12129]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 14 Apr 22 22:28:46 motivo volumio[12129]: info: CoreCommandRouter::volumioGetState Apr 22 22:28:46 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:46 motivo volumiossh-tunnel[12519]: Warning: Permanently added '[eu4.myvolumio.org]:2222,[167.172.103.77]:2222' (RSA) to the list of known hosts. Apr 22 22:28:50 motivo volumio[12129]: error: MyVolumio Plugin failed to start in a timely fashion Apr 22 22:28:50 motivo volumio[12129]: info: BOOT COMPLETED Apr 22 22:28:50 motivo volumio[12129]: [Metrics] CommandRouter: 35s 577.76ms Apr 22 22:28:50 motivo volumio[12129]: info: CoreCommandRouter::volumiosetStartupVolume Apr 22 22:28:50 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:50 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 22:28:50 motivo volumio[12129]: info: CoreCommandRouter::Close All Modals sent Apr 22 22:28:50 motivo volumio[12129]: info: CoreCommandRouter::Close All Modals sent Apr 22 22:28:51 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Apr 22 22:28:51 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 22 22:28:51 motivo volumio[12129]: No protocol specified Apr 22 22:28:51 motivo volumio[12129]: xcb_connection_has_error() returned true Apr 22 22:28:51 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Apr 22 22:28:54 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 22 22:28:54 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 22:28:54 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 22 22:28:54 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 22 22:28:54 motivo volumio[12129]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 15 Apr 22 22:28:54 motivo volumio[12129]: info: CoreCommandRouter::volumioGetState Apr 22 22:28:54 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:28:54 motivo volumio-remote-updater[567]: Test mode enabled Apr 22 22:28:54 motivo volumio-remote-updater[567]: No alpha test mode Apr 22 22:28:54 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Apr 22 22:28:54 motivo volumio[12129]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Apr 22 22:28:54 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Apr 22 22:28:59 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:59 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:28:59 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Apr 22 22:28:59 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 22 22:28:59 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Apr 22 22:28:59 motivo volumio[12129]: info: CoreCommandRouter::volumioGetBrowseSources Apr 22 22:28:59 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 22 22:29:06 motivo volumio[12129]: verbose: New Socket.io Connection to 192.168.1.164 from 192.168.1.34 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 16 Apr 22 22:29:06 motivo volumio[12129]: verbose: New Socket.io Connection to 192.168.1.164 from 192.168.1.34 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 17 Apr 22 22:29:06 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 22 22:29:06 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 22 22:29:06 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 22 22:29:06 motivo volumio[12129]: info: CoreCommandRouter::volumioGetVisibleSources Apr 22 22:29:06 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 22:29:06 motivo volumio[12129]: info: CoreCommandRouter::volumioGetState Apr 22 22:29:06 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:29:06 motivo volumio[12129]: info: CoreCommandRouter::volumioGetState Apr 22 22:29:06 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:29:06 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 22 22:29:06 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 22 22:29:06 motivo volumio[12129]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Apr 22 22:29:06 motivo volumio[12129]: info: Received Get System Info Apr 22 22:29:06 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 22 22:29:06 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 22 22:29:06 motivo volumio[12129]: info: Discovery: Getting this device information Apr 22 22:29:06 motivo volumio[12129]: info: CoreCommandRouter::volumioGetState Apr 22 22:29:06 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:29:06 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 22 22:29:06 motivo volumio[12129]: info: CoreCommandRouter::volumioGetState Apr 22 22:29:06 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:29:06 motivo volumio[12129]: info: Listing playlists Apr 22 22:29:06 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 22 22:29:06 motivo volumio[12129]: info: CoreCommandRouter::volumioGetVisibleSources Apr 22 22:29:06 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 22:29:06 motivo volumio[12129]: info: CoreCommandRouter::volumioGetState Apr 22 22:29:06 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:29:06 motivo volumio[12129]: info: CoreCommandRouter::volumioGetState Apr 22 22:29:06 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:29:06 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 22 22:29:06 motivo volumio[12129]: info: CoreCommandRouter::volumioGetQueue Apr 22 22:29:06 motivo volumio[12129]: info: CoreStateMachine::getQueue Apr 22 22:29:06 motivo volumio[12129]: info: CorePlayQueue::getQueue Apr 22 22:29:06 motivo volumio[12129]: info: Listing playlists Apr 22 22:29:06 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 22 22:29:06 motivo volumio[12129]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Apr 22 22:29:06 motivo volumio[12129]: info: Received Get System Info Apr 22 22:29:06 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 22 22:29:06 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 22 22:29:06 motivo volumio[12129]: info: Discovery: Getting this device information Apr 22 22:29:06 motivo volumio[12129]: info: CoreCommandRouter::volumioGetState Apr 22 22:29:06 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:29:06 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 22 22:29:06 motivo volumio[12129]: info: CoreCommandRouter::volumioGetState Apr 22 22:29:06 motivo volumio[12129]: info: CorePlayQueue::getTrack 0 Apr 22 22:29:06 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 22 22:29:06 motivo volumio[12129]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 22 22:29:40 motivo sudo[12575]: volumio : TTY=pts/0 ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/cp -rp volumio-serial-plugin/README.md volumio-serial-plugin/UIConfigAudio.json volumio-serial-plugin/UIConfigSystem.json volumio-serial-plugin/config.json volumio-serial-plugin/dacFiltersMapFile.json volumio-serial-plugin/deploy.sh volumio-serial-plugin/i18n volumio-serial-plugin/i2sHdmiMapFile.json volumio-serial-plugin/icons volumio-serial-plugin/index.js volumio-serial-plugin/inputMapFile.json volumio-serial-plugin/inputs.json volumio-serial-plugin/install.sh volumio-serial-plugin/package.json volumio-serial-plugin/requiredConf.json volumio-serial-plugin/serialTest.js volumio-serial-plugin/touchevents.sh /volumio/app/plugins/music_service/inputs/ Apr 22 22:29:40 motivo sudo[12575]: pam_unix(sudo:session): session opened for user root by volumio(uid=0) Apr 22 22:29:40 motivo sudo[12575]: pam_unix(sudo:session): session closed for user root Apr 22 22:29:40 motivo sudo[12578]: volumio : TTY=pts/0 ; PWD=/home/volumio ; USER=root ; COMMAND=/usr/bin/killall node Apr 22 22:29:40 motivo sudo[12578]: pam_unix(sudo:session): session opened for user root by volumio(uid=0) Apr 22 22:29:40 motivo sudo[12578]: pam_unix(sudo:session): session closed for user root Apr 22 22:29:40 motivo sudo[12581]: volumio : TTY=pts/0 ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/journalctl -f Apr 22 22:29:40 motivo sudo[12581]: pam_unix(sudo:session): session opened for user root by volumio(uid=0) Apr 22 22:29:40 motivo volumio-remote-updater[567]: [2024-04-22 22:29:40] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Apr 22 22:29:40 motivo volumio-remote-updater[567]: [2024-04-22 22:29:40] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Apr 22 22:29:40 motivo vtcs[12453]: [2024-04-22 22:29:40.773] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Apr 22 22:29:40 motivo systemd[1]: volumio.service: Main process exited, code=killed, status=15/TERM Apr 22 22:29:40 motivo sudo[12363]: pam_unix(sudo:session): session closed for user root Apr 22 22:29:40 motivo systemd[1]: volumio.service: Succeeded. Apr 22 22:29:40 motivo systemd[1]: Started dynamicswap service. Apr 22 22:29:40 motivo systemd[1]: dynamicswap.service: Succeeded. Apr 22 22:29:41 motivo systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Apr 22 22:29:41 motivo systemd[1]: volumio.service: Scheduled restart job, restart counter is at 12. Apr 22 22:29:41 motivo systemd[1]: Started dynamicswap service. Apr 22 22:29:41 motivo systemd[1]: Stopped Volumio Backend Module. Apr 22 22:29:41 motivo systemd[1]: Started Volumio Backend Module. Apr 22 22:29:41 motivo systemd[1]: dynamicswap.service: Succeeded. Apr 22 22:29:42 motivo volumio[12591]: info: ------------------------------------------- Apr 22 22:29:42 motivo volumio[12591]: info: ----- Volumio3 ---- Apr 22 22:29:42 motivo volumio[12591]: info: ------------------------------------------- Apr 22 22:29:42 motivo volumio[12591]: info: ----- System startup ---- Apr 22 22:29:42 motivo volumio[12591]: info: ------------------------------------------- Apr 22 22:29:42 motivo volumio[12591]: info: MYVOLUMIO Environment detected Apr 22 22:29:42 motivo volumio[12591]: info: Plugin folders cleanup Apr 22 22:29:42 motivo volumio[12591]: info: Scanning into folder /volumio/app/plugins/ Apr 22 22:29:42 motivo volumio[12591]: info: Scanning category audio_interface Apr 22 22:29:42 motivo volumio[12591]: info: Scanning category miscellanea Apr 22 22:29:42 motivo volumio[12591]: info: Scanning category music_service Apr 22 22:29:42 motivo volumio[12591]: info: Scanning category plugins.json Apr 22 22:29:42 motivo volumio[12591]: info: Scanning category system_controller Apr 22 22:29:42 motivo volumio[12591]: info: Scanning category user_interface Apr 22 22:29:42 motivo volumio[12591]: info: Scanning into folder /data/plugins/ Apr 22 22:29:42 motivo volumio[12591]: info: Plugin folders cleanup completed Apr 22 22:29:42 motivo volumio[12591]: info: ------------------------------------------- Apr 22 22:29:42 motivo volumio[12591]: info: ----- Core plugins startup ---- Apr 22 22:29:42 motivo volumio[12591]: info: ------------------------------------------- Apr 22 22:29:42 motivo volumio[12591]: info: Loading plugins from folder /volumio/app/plugins/ Apr 22 22:29:42 motivo volumio[12591]: info: Adding plugin bluetooth to MyMusic Plugins Apr 22 22:29:42 motivo volumio[12591]: info: Adding plugin multiroom to MyMusic Plugins Apr 22 22:29:42 motivo volumio[12591]: info: Adding plugin upnp to MyMusic Plugins Apr 22 22:29:42 motivo volumio[12591]: info: Adding plugin metavolumio to MyMusic Plugins Apr 22 22:29:42 motivo volumio[12591]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 22 22:29:42 motivo volumio[12591]: info: Adding plugin cd_controller to MyMusic Plugins Apr 22 22:29:42 motivo volumio[12591]: info: Adding plugin raat to MyMusic Plugins Apr 22 22:29:42 motivo volumio[12591]: info: Adding plugin smart_inputs to MyMusic Plugins Apr 22 22:29:42 motivo volumio[12591]: info: Adding plugin tidalconnect to MyMusic Plugins Apr 22 22:29:42 motivo volumio[12591]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 22 22:29:42 motivo volumio[12591]: info: Loading plugins from folder /data/plugins/ Apr 22 22:29:42 motivo volumio[12591]: info: Loading plugin "system"... Apr 22 22:29:42 motivo volumio[12591]: info: Loading plugin "appearance"... Apr 22 22:29:43 motivo volumio[12591]: info: Loading plugin "network"... Apr 22 22:29:43 motivo volumio[12591]: info: Refreshing Cached IP Addresses Apr 22 22:29:43 motivo sudo[12617]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 22 22:29:43 motivo sudo[12617]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:29:43 motivo sudo[12617]: pam_unix(sudo:session): session closed for user root Apr 22 22:29:43 motivo volumio[12591]: info: Loading plugin "services"... Apr 22 22:29:43 motivo sudo[12619]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 22 22:29:43 motivo sudo[12619]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:29:43 motivo volumio[12591]: info: Loading plugin "alsa_controller"... Apr 22 22:29:43 motivo sudo[12619]: pam_unix(sudo:session): session closed for user root Apr 22 22:29:43 motivo sudo[12622]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 22 22:29:43 motivo sudo[12622]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:29:43 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 22 22:29:43 motivo volumio[12591]: info: Loading plugin "wizard"... Apr 22 22:29:43 motivo volumio[12591]: info: Loading plugin "networkfs"... Apr 22 22:29:43 motivo volumio[12591]: info: Starting Udev Watcher for removable devices Apr 22 22:29:43 motivo volumio[12591]: info: Ignoring mount for partition: boot Apr 22 22:29:43 motivo volumio[12591]: info: Ignoring mount for partition: volumio Apr 22 22:29:43 motivo volumio[12591]: info: Ignoring mount for partition: volumio_data Apr 22 22:29:43 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 22 22:29:43 motivo volumio[12591]: info: Loading plugin "volumio_command_line_client"... Apr 22 22:29:43 motivo volumio[12591]: info: Loading plugin "upnp"... Apr 22 22:29:43 motivo volumio[12591]: info: [1713824983672] Starting Upmpd Daemon Apr 22 22:29:43 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 22 22:29:43 motivo volumio[12591]: info: Loading plugin "my_music"... Apr 22 22:29:43 motivo volumio[12591]: info: Loading plugin "mpd"... Apr 22 22:29:43 motivo volumio[12591]: info: Loading plugin "upnp_browser"... Apr 22 22:29:44 motivo volumio[12591]: info: Loading plugin "bluetooth"... Apr 22 22:29:44 motivo volumio[12591]: info: [1713824984221] Starting BluetoothController Apr 22 22:29:44 motivo volumio[12591]: info: Loading plugin "alarm-clock"... Apr 22 22:29:44 motivo volumio[12591]: info: Loading plugin "manifestui"... Apr 22 22:29:44 motivo volumio[12591]: info: Loading plugin "metavolumio"... Apr 22 22:29:45 motivo volumio[12591]: info: Loading plugin "airplay_emulation"... Apr 22 22:29:45 motivo volumio[12591]: info: Starting Shairport Sync Apr 22 22:29:45 motivo volumio[12591]: info: Loading plugin "cd_controller"... Apr 22 22:29:45 motivo volumio[12591]: info: Loading plugin "last_100"... Apr 22 22:29:45 motivo volumio[12591]: info: Loading plugin "raat"... Apr 22 22:29:45 motivo volumio[12591]: info: RAAT Plugin loaded Apr 22 22:29:45 motivo volumio[12591]: info: Adding restartRAATSocket REST API Endpoint Apr 22 22:29:45 motivo volumio[12591]: info: Adding restartRAATSocket REST Endpoint for plugin: music_service/raat Apr 22 22:29:45 motivo volumio[12591]: info: Loading plugin "streaming_services"... Apr 22 22:29:45 motivo volumio-remote-updater[567]: [2024-04-22 22:29:45] [connect] Successful connection Apr 22 22:29:45 motivo volumio[12591]: info: Starting Streaming Service Transparent Proxy Apr 22 22:29:45 motivo volumio[12591]: info: Loading plugin "tidalconnect"... Apr 22 22:29:46 motivo volumio[12591]: info: Loading plugin "webradio"... Apr 22 22:29:46 motivo volumio[12591]: info: Loading plugin "i2s_dacs"... Apr 22 22:29:46 motivo volumio[12591]: info: I2S DAC not set, start Auto-detection Apr 22 22:29:46 motivo volumio[12591]: info: Loading plugin "volumiodiscovery"... Apr 22 22:29:46 motivo volumio[12591]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 22 22:29:46 motivo volumio[12591]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 22 22:29:46 motivo volumio[12591]: *** WARNING *** For more information see Apr 22 22:29:46 motivo volumio[12591]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 22 22:29:46 motivo node[12591]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 22 22:29:46 motivo volumio[12591]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 22 22:29:46 motivo volumio[12591]: *** WARNING *** For more information see Apr 22 22:29:46 motivo node[12591]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 22 22:29:46 motivo node[12591]: *** WARNING *** For more information see Apr 22 22:29:46 motivo node[12591]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 22 22:29:46 motivo node[12591]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 22 22:29:46 motivo node[12591]: *** WARNING *** For more information see Apr 22 22:29:46 motivo volumio[12591]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 22 22:29:46 motivo volumio[12591]: info: Discovery: Started advertising with name: Motivo Apr 22 22:29:46 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 22 22:29:46 motivo volumio[12591]: info: Loading plugin "multiroom"... Apr 22 22:29:46 motivo volumio[12591]: STREAMING PROXY: Starting server on port 3245 Apr 22 22:29:46 motivo volumio[12591]: Node JS runtime: 14 Apr 22 22:29:47 motivo volumio[12591]: info: Applying required configuration parameters for plugin multiroom Apr 22 22:29:47 motivo sudo[12640]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Apr 22 22:29:47 motivo sudo[12640]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:29:47 motivo sudo[12640]: pam_unix(sudo:session): session closed for user root Apr 22 22:29:47 motivo volumio[12591]: /bin/mkdir: cannot create directory ‘/tmp/hls’: File exists Apr 22 22:29:47 motivo volumio[12591]: info: MRS: MultiRoom plugin initialized Apr 22 22:29:47 motivo volumio[12591]: info: MRS: STOPPING SNAPCLIENT Apr 22 22:29:47 motivo volumio[12591]: info: MRS: Snap server stop Apr 22 22:29:47 motivo sudo[12656]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Apr 22 22:29:47 motivo sudo[12656]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:29:47 motivo volumio[12591]: info: MRS: STOPPING volumioStreaming Apr 22 22:29:47 motivo sudo[12659]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Apr 22 22:29:47 motivo sudo[12659]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:29:47 motivo sudo[12656]: pam_unix(sudo:session): session closed for user root Apr 22 22:29:47 motivo sudo[12659]: pam_unix(sudo:session): session closed for user root Apr 22 22:29:47 motivo sudo[12662]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Apr 22 22:29:47 motivo sudo[12662]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:29:47 motivo volumio[12591]: info: Loading plugin "outputs"... Apr 22 22:29:47 motivo volumio[12591]: info: Loading plugin "albumart"... Apr 22 22:29:47 motivo sudo[12662]: pam_unix(sudo:session): session closed for user root Apr 22 22:29:47 motivo volumio[12591]: info: Plugin example_plugin is not enabled Apr 22 22:29:47 motivo volumio[12591]: info: Loading plugin "hi_res_audio"... Apr 22 22:29:47 motivo sudo[12664]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Apr 22 22:29:47 motivo sudo[12664]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:29:47 motivo sudo[12664]: pam_unix(sudo:session): session closed for user root Apr 22 22:29:47 motivo sudo[12622]: pam_unix(sudo:session): session closed for user root Apr 22 22:29:47 motivo volumio[12591]: Forking 3 albumart workers Apr 22 22:29:48 motivo volumio[12591]: info: Applying required configuration parameters for plugin hi_res_audio Apr 22 22:29:48 motivo volumio[12591]: info: Loading plugin "inputs"... Apr 22 22:29:48 motivo volumio[12591]: Starting albumart workers Apr 22 22:29:48 motivo volumio[12591]: Starting albumart workers Apr 22 22:29:48 motivo volumio[12591]: Starting albumart workers Apr 22 22:29:48 motivo volumio[12591]: info: Loading plugin "qobuz"... Apr 22 22:29:49 motivo volumio[12591]: info: Loading plugin "smart_inputs"... Apr 22 22:29:49 motivo volumio[12591]: info: Loading plugin "tidal"... Apr 22 22:29:49 motivo volumio[12591]: info: Loading plugin "motivocontrol"... Apr 22 22:29:49 motivo volumio[12591]: info: Adding this device properties Apr 22 22:29:49 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Apr 22 22:29:49 motivo volumio[12591]: info: Setting Additional Device Volumio Properties: [object Object] Apr 22 22:29:49 motivo volumio[12591]: info: Checking For Motivo Hardware Apr 22 22:29:50 motivo volumio[12591]: info: Loading plugin "updater_comm"... Apr 22 22:29:50 motivo volumio[12591]: info: Plugin mpdemulation is not enabled Apr 22 22:29:50 motivo volumio[12591]: info: Loading plugin "rest_api"... Apr 22 22:29:50 motivo volumio[12591]: info: Loading plugin "websocket"... Apr 22 22:29:50 motivo volumio[12591]: info: Loading i18n strings for locale it Apr 22 22:29:50 motivo volumio[12591]: Updating browse sources language Apr 22 22:29:50 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 22:29:50 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 22 22:29:50 motivo volumio[12591]: info: CoreCommandRouter::initPlayerControls Apr 22 22:29:50 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:50 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:50 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:50 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:50 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:50 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:50 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:50 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:50 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 22 22:29:50 motivo volumio[12591]: Express server listening on port 3000 Apr 22 22:29:50 motivo volumio[12591]: [Metrics] WebUI: 8s 345.70ms Apr 22 22:29:50 motivo volumio[12591]: info: CoreStateMachine::resetVolumioState Apr 22 22:29:50 motivo volumio[12591]: info: CoreStateMachine::getcurrentVolume Apr 22 22:29:50 motivo volumio[12591]: info: CoreCommandRouter::volumioRetrievevolume Apr 22 22:29:50 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 22:29:50 motivo volumio[12591]: info: Cannot read play queue from file Apr 22 22:29:50 motivo volumio[12591]: info: Motivo Hardware found Apr 22 22:29:50 motivo volumio[12591]: info: MRS: Removed streaming files Apr 22 22:29:50 motivo volumio[12591]: info: MRS: volumioStreaming STOPPED Apr 22 22:29:50 motivo volumio[12591]: info: MRS: SNAPSERVER STOPPED Apr 22 22:29:50 motivo volumio[12591]: info: MRS: SNAPCLIENT STOPPED Apr 22 22:29:50 motivo volumio[12591]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-memorysave-touch Total Clients: 1 Apr 22 22:29:50 motivo volumio[12591]: verbose: New Socket.io Connection to 192.168.1.164 from 192.168.1.34 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 2 Apr 22 22:29:50 motivo volumio[12591]: verbose: New Socket.io Connection to 192.168.1.164 from 192.168.1.34 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 3 Apr 22 22:29:50 motivo volumio[12591]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-memorysave-touch Total Clients: 4 Apr 22 22:29:50 motivo volumio[12591]: verbose: New Socket.io Connection to 192.168.1.164 from 192.168.1.34 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 5 Apr 22 22:29:50 motivo volumio-remote-updater[567]: [2024-04-22 22:29:50] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1713824985 101 Apr 22 22:29:50 motivo volumio[12591]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 6 Apr 22 22:29:50 motivo volumio[12591]: verbose: New Socket.io Connection to 192.168.1.164 from 192.168.1.34 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 7 Apr 22 22:29:50 motivo volumio[12591]: verbose: New Socket.io Connection to 192.168.1.164:3000 from 192.168.1.66 UA: node-XMLHttpRequest Total Clients: 8 Apr 22 22:29:50 motivo volumio[12591]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-memorysave-touch Total Clients: 9 Apr 22 22:29:50 motivo volumio[12591]: info: VolumeController:: Volume=46 Mute =false Apr 22 22:29:50 motivo volumio[12591]: info: CoreStateMachine::pushState Apr 22 22:29:50 motivo volumio[12591]: info: CorePlayQueue::getTrack 0 Apr 22 22:29:50 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 22:29:50 motivo volumio[12591]: info: CoreCommandRouter::volumioPushState Apr 22 22:29:50 motivo volumio[12591]: info: CoreStateMachine::updateTrackBlock Apr 22 22:29:50 motivo volumio[12591]: info: CorePlayQueue::getTrackBlock Apr 22 22:29:50 motivo volumio[12591]: info: CoreCommandRouter::volumioRetrievevolume Apr 22 22:29:50 motivo volumio[12591]: info: CoreStateMachine::setRepeat null single undefined Apr 22 22:29:50 motivo volumio[12591]: info: CoreStateMachine::pushState Apr 22 22:29:50 motivo volumio[12591]: info: CorePlayQueue::getTrack 0 Apr 22 22:29:50 motivo volumio[12591]: info: CoreCommandRouter::volumioPushState Apr 22 22:29:50 motivo volumio[12591]: info: CoreStateMachine::setRandom null Apr 22 22:29:50 motivo volumio[12591]: info: CoreStateMachine::pushState Apr 22 22:29:50 motivo volumio[12591]: info: CorePlayQueue::getTrack 0 Apr 22 22:29:50 motivo volumio[12591]: info: CoreCommandRouter::volumioPushState Apr 22 22:29:50 motivo volumio[12591]: info: Setting Device type: Raspberry PI Apr 22 22:29:50 motivo volumio[12591]: info: Completed loading Core Plugins Apr 22 22:29:50 motivo volumio[12591]: info: Preparing to generate the ALSA configuration file Apr 22 22:29:50 motivo volumio[12591]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Apr 22 22:29:50 motivo volumio[12591]: info: Reading ALSA contributions from plugins. Apr 22 22:29:50 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Apr 22 22:29:50 motivo volumio[12591]: info: Discovery: adding c719d579-661a-4a58-b12a-d4b86c78aed0 Apr 22 22:29:50 motivo volumio[12591]: info: Discovery: Found device Integro Apr 22 22:29:50 motivo volumio[12591]: info: Discovery: Connecting to remote: 192.168.1.66 Apr 22 22:29:50 motivo volumio[12591]: info: CoreCommandRouter::volumioGetState Apr 22 22:29:50 motivo volumio[12591]: info: CorePlayQueue::getTrack 0 Apr 22 22:29:50 motivo volumio[12591]: info: VolumeController:: Volume=46 Mute =false Apr 22 22:29:50 motivo volumio[12591]: info: CoreStateMachine::pushState Apr 22 22:29:50 motivo volumio[12591]: info: CorePlayQueue::getTrack 0 Apr 22 22:29:50 motivo volumio[12591]: info: CoreCommandRouter::volumioPushState Apr 22 22:29:50 motivo volumio[12591]: info: Discovery: adding 82dac078-ee73-4109-b56a-13c84023851f Apr 22 22:29:50 motivo volumio[12591]: info: Discovery: Found device Motivo Apr 22 22:29:50 motivo volumio[12591]: info: CoreCommandRouter::volumioGetState Apr 22 22:29:50 motivo volumio[12591]: info: CorePlayQueue::getTrack 0 Apr 22 22:29:50 motivo volumio[12591]: info: MRS: Pushing multiroomSync output for this device Apr 22 22:29:50 motivo volumio[12591]: info: MRS: Pushing multiroomSync output Apr 22 22:29:50 motivo volumio[12591]: info: Adding audio output: Apr 22 22:29:50 motivo volumio[12591]: info: Adding audio output: Apr 22 22:29:50 motivo volumio[12591]: info: Asound.conf file unchanged, so no further update is needed Apr 22 22:29:50 motivo volumio[12591]: info: Output device has changed, restarting MPD Apr 22 22:29:50 motivo sudo[12738]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 22 22:29:50 motivo sudo[12738]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:29:50 motivo sudo[12738]: pam_unix(sudo:session): session closed for user root Apr 22 22:29:50 motivo volumio[12591]: info: Output device has changed, restarting Shairport Sync Apr 22 22:29:50 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:50 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 22:29:50 motivo sudo[12741]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 22 22:29:50 motivo sudo[12741]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:29:50 motivo systemd[1]: Stopping Music Player Daemon... Apr 22 22:29:50 motivo systemd[1]: mpd.service: Succeeded. Apr 22 22:29:51 motivo systemd[1]: Stopped Music Player Daemon. Apr 22 22:29:51 motivo volumio[12591]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 22 22:29:51 motivo volumio[12591]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 22 22:29:51 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:51 motivo systemd[1]: Starting Music Player Daemon... Apr 22 22:29:51 motivo volumio[12591]: info: ___________ START PLUGINS ___________ Apr 22 22:29:51 motivo volumio[12591]: info: ControllerMpd::onStart: Initializing MPD Apr 22 22:29:51 motivo volumio[12591]: info: Creating MPD Configuration file Apr 22 22:29:51 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 22 22:29:51 motivo volumio[12591]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 22 22:29:51 motivo volumio[12591]: info: [1713824991095] CoreMusicLibrary::Adding element Server multimediali Apr 22 22:29:51 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 22:29:51 motivo sudo[12751]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 22 22:29:51 motivo sudo[12751]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:29:51 motivo sudo[12752]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 22 22:29:51 motivo sudo[12752]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:29:51 motivo sudo[12751]: pam_unix(sudo:session): session closed for user root Apr 22 22:29:51 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 22 22:29:51 motivo systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 22 22:29:51 motivo systemd[1]: mpd.service: Succeeded. Apr 22 22:29:51 motivo systemd[1]: Stopped Music Player Daemon. Apr 22 22:29:51 motivo volumio[12591]: info: Adding Manifest REST API Endpoints Apr 22 22:29:51 motivo volumio[12591]: info: Adding manifestui REST Endpoint for plugin: miscellanea/manifestui Apr 22 22:29:51 motivo systemd[1]: Starting Music Player Daemon... Apr 22 22:29:51 motivo volumio[12591]: info: Adding METAVOLUMIO REST API Endpoints Apr 22 22:29:51 motivo volumio[12591]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Apr 22 22:29:51 motivo volumio[12591]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Apr 22 22:29:51 motivo volumio[12591]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Apr 22 22:29:51 motivo volumio[12591]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Apr 22 22:29:51 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:51 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 22:29:51 motivo sudo[12757]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Motivo Apr 22 22:29:51 motivo sudo[12757]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:29:51 motivo sudo[12757]: pam_unix(sudo:session): session closed for user root Apr 22 22:29:51 motivo volumio[12591]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 22 22:29:51 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:51 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 22:29:51 motivo volumio[12591]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 22 22:29:51 motivo volumio[12591]: info: Preparing CD Folders Apr 22 22:29:51 motivo volumio[12591]: info: Adding CD REST API Endpoints Apr 22 22:29:51 motivo volumio[12591]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Apr 22 22:29:51 motivo volumio[12591]: info: Starting UDEV Watcher for CD Apr 22 22:29:51 motivo volumio[12591]: info: Detecting CD presence with UDEV Apr 22 22:29:51 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Apr 22 22:29:51 motivo volumio[12591]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 22 22:29:51 motivo volumio[12591]: info: [1713824991320] CoreMusicLibrary::Adding element Last_100 Apr 22 22:29:51 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 22:29:51 motivo volumio[12591]: info: Starting RAAT Plugin Apr 22 22:29:51 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Apr 22 22:29:51 motivo volumio[12591]: info: Additional UI Settings Added for plugin music_service/raat Apr 22 22:29:51 motivo volumio[12591]: info: Registering DSP Elements listener and retrieving current ones Apr 22 22:29:51 motivo volumio[12591]: info: Additional DSP elements updated Apr 22 22:29:51 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:51 motivo volumio[12591]: info: Updating RAAT Signal Path Apr 22 22:29:51 motivo volumio[12591]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Apr 22 22:29:51 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:51 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:51 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:51 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:51 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:51 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 22 22:29:51 motivo volumio[12591]: info: Not Reporting Auto name since its the default one Apr 22 22:29:51 motivo volumio[12591]: info: Streaming services startup Apr 22 22:29:51 motivo volumio[12591]: info: Starting Streaming Daemon Apr 22 22:29:51 motivo sudo[12771]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 22 22:29:51 motivo sudo[12771]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:29:51 motivo sudo[12771]: pam_unix(sudo:session): session closed for user root Apr 22 22:29:51 motivo volumio[12591]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 22 22:29:51 motivo volumio[12591]: info: [1713824991500] CoreMusicLibrary::Adding element Webradio Apr 22 22:29:51 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 22:29:51 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 22 22:29:51 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Apr 22 22:29:51 motivo sudo[12778]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 22 22:29:51 motivo sudo[12778]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:29:51 motivo volumio[12591]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 22 22:29:51 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:51 motivo systemd[1]: Stopping Volumio Tidal Connect Service... Apr 22 22:29:51 motivo systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Apr 22 22:29:51 motivo systemd[1]: vtcs.service: Succeeded. Apr 22 22:29:51 motivo systemd[1]: Stopped Volumio Tidal Connect Service. Apr 22 22:29:51 motivo volumio[12591]: error: Hi Res Audio Failed Login: Missing Login Data Apr 22 22:29:51 motivo volumio[12591]: info: Adding HIGHRESAUDIO REST API Endpoints Apr 22 22:29:51 motivo volumio[12591]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Apr 22 22:29:51 motivo volumio[12591]: info: Initializing Serial Communication on port /dev/ttyAMA1 Apr 22 22:29:51 motivo sudo[12778]: pam_unix(sudo:session): session closed for user root Apr 22 22:29:51 motivo volumio[12591]: info: Touch Event Listener Process Starting Apr 22 22:29:51 motivo volumio[12591]: info: Refreshing QOBUZ token Apr 22 22:29:51 motivo volumio[12591]: info: Adding inputs REST Endpoints Apr 22 22:29:51 motivo volumio[12591]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Apr 22 22:29:51 motivo volumio[12591]: info: Scanning Audio Inputs Apr 22 22:29:51 motivo sudo[12785]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xinput --test-xi2 --root Apr 22 22:29:51 motivo sudo[12785]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:29:51 motivo volumio[12591]: info: Checking against Known Cards name Apr 22 22:29:51 motivo volumio[12591]: info: Checking against Known Cards name Apr 22 22:29:51 motivo volumio[12591]: info: Adding Server instance for streaming Apr 22 22:29:51 motivo volumio[12591]: info: Refreshing TIDAL token Apr 22 22:29:51 motivo volumio[12591]: info: Volumio Calling Home Apr 22 22:29:51 motivo volumio[12591]: (node:12591) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. Apr 22 22:29:51 motivo volumio[12591]: (Use `node --trace-deprecation ...` to show where the warning was created) Apr 22 22:29:51 motivo volumio[12591]: info: Serial port opened successfully Apr 22 22:29:51 motivo volumio[12591]: info: Sending serial start messages Apr 22 22:29:51 motivo volumio[12591]: info: Display with brightness control is connected, setting display brightness Apr 22 22:29:51 motivo volumio[12591]: info: Setting Display Brightness to 12 Apr 22 22:29:51 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:51 motivo volumio[12591]: info: MRS: Pushing audio output on request Apr 22 22:29:51 motivo volumio[12591]: info: MRS: Pushing multiroomSync output Apr 22 22:29:52 motivo volumio[12591]: info: Discovery: Connected to remote: 192.168.1.66 Apr 22 22:29:52 motivo volumio[12591]: info: MRS: Adding multiroomSync output Apr 22 22:29:52 motivo volumio[12591]: info: Adding audio output: Apr 22 22:29:52 motivo volumio[12591]: info: MRS: Pushing multiroomSync output Apr 22 22:29:52 motivo volumio[12591]: error: Cannot start Volumio Streaming Daemon Apr 22 22:29:52 motivo volumio[12591]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 22 22:29:52 motivo volumio[12591]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 22 22:29:52 motivo volumio[12591]: info: Bluetooth name changed to Motivo Apr 22 22:29:52 motivo volumio[12591]: info: MPD Permissions set Apr 22 22:29:52 motivo volumio[12591]: info: MPD Permissions set Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride Apr 22 22:29:52 motivo volumio[12591]: info: Setting Device Volume Override Apr 22 22:29:52 motivo mpd[12756]: Apr 22 22:29 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 22 22:29:52 motivo systemd[1]: Started Music Player Daemon. Apr 22 22:29:52 motivo sudo[12741]: pam_unix(sudo:session): session closed for user root Apr 22 22:29:52 motivo sudo[12752]: pam_unix(sudo:session): session closed for user root Apr 22 22:29:52 motivo volumio[12591]: info: Applying Volume Override Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 22 22:29:52 motivo volumio[12591]: info: Updating Volume Controller Parameters: Device: 5 Name: Analog + I2S + Headphones Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 22 22:29:52 motivo volumio[12591]: info: Enabling external Volume Control Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: inputs , updateVolumeSettings Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: inputs , retrievevolume Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:52 motivo volumio[12591]: info: CoreStateMachine::pushState Apr 22 22:29:52 motivo volumio[12591]: info: CorePlayQueue::getTrack 0 Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::volumioPushState Apr 22 22:29:52 motivo volumio[12591]: info: MRS: Pushing multiroomSync output update for this device Apr 22 22:29:52 motivo volumio[12591]: info: MRS: Pushing multiroomSync output Apr 22 22:29:52 motivo volumio[12591]: info: CoreStateMachine::pushState Apr 22 22:29:52 motivo volumio[12591]: info: CorePlayQueue::getTrack 0 Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::volumioPushState Apr 22 22:29:52 motivo volumio[12591]: info: MRS: Pushing multiroomSync output update for this device Apr 22 22:29:52 motivo volumio[12591]: info: MRS: Pushing multiroomSync output Apr 22 22:29:52 motivo volumio[12591]: info: CoreStateMachine::pushState Apr 22 22:29:52 motivo volumio[12591]: info: CorePlayQueue::getTrack 0 Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::volumioPushState Apr 22 22:29:52 motivo volumio[12591]: info: MRS: Pushing multiroomSync output update for this device Apr 22 22:29:52 motivo volumio[12591]: info: MRS: Pushing multiroomSync output Apr 22 22:29:52 motivo volumio[12591]: info: Volumio called home Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Apr 22 22:29:52 motivo volumio[12591]: info: Setting Additional System Software info: Hardware Revision: 2.0 Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Apr 22 22:29:52 motivo volumio[12591]: info: Setting HW Firmware info: undefined Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Apr 22 22:29:52 motivo volumio[12591]: info: Setting HW Version info: 2.0 Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Apr 22 22:29:52 motivo volumio[12591]: info: Setting Additional System Software info: Hardware Revision: 2.0, Firmware Version: 0.1.0 Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Apr 22 22:29:52 motivo volumio[12591]: info: Setting HW Firmware info: 0.1.0 Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Apr 22 22:29:52 motivo volumio[12591]: info: Setting HW Version info: 2.0 Apr 22 22:29:52 motivo volumio[12591]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Apr 22 22:29:52 motivo volumio[12591]: info: MCU Signalled Headphone Mode Disabled Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:52 motivo volumio[12591]: info: Updating RAAT Signal Path Apr 22 22:29:52 motivo volumio[12591]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Apr 22 22:29:52 motivo volumio[12591]: info: MCU Signalled Sleep Mode Disabled Apr 22 22:29:52 motivo volumio[12591]: info: Enabling Advanced system settings configuration Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: system , addAdditionalUISections Apr 22 22:29:52 motivo volumio[12591]: info: Additional UI Settings Added for plugin music_service/inputs Apr 22 22:29:52 motivo volumio[12591]: info: MCU Signalled Auto Boot Mode On Power Disabled Apr 22 22:29:52 motivo volumio[12591]: AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA Apr 22 22:29:52 motivo volumio[12591]: 11111110000000000000000000000000 Apr 22 22:29:52 motivo volumio[12591]: 11111110000000000000000000000000 Apr 22 22:29:52 motivo sudo[12800]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms force on Apr 22 22:29:52 motivo sudo[12800]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:29:52 motivo volumio[12591]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 10 Apr 22 22:29:52 motivo sudo[12800]: pam_unix(sudo:session): session closed for user root Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Apr 22 22:29:52 motivo volumio[12591]: error: Serial API: Failed to decode command: MAXVOL, message: 100 Apr 22 22:29:52 motivo sudo[12816]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Apr 22 22:29:52 motivo sudo[12816]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:29:52 motivo sudo[12816]: pam_unix(sudo:session): session closed for user root Apr 22 22:29:52 motivo sudo[12818]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Apr 22 22:29:52 motivo sudo[12818]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:29:52 motivo volumio[12591]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 11 Apr 22 22:29:52 motivo systemd[1]: Stopping RAAT DAEMON... Apr 22 22:29:52 motivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Apr 22 22:29:52 motivo systemd[1]: raat-daemon.service: Succeeded. Apr 22 22:29:52 motivo systemd[1]: Stopped RAAT DAEMON. Apr 22 22:29:52 motivo systemd[1]: Started RAAT DAEMON. Apr 22 22:29:52 motivo sudo[12818]: pam_unix(sudo:session): session closed for user root Apr 22 22:29:52 motivo volumio[12591]: error: Serial API: Failed to decode command: MAXVOL, message: 100 Apr 22 22:29:52 motivo sudo[12822]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms 0 0 0 Apr 22 22:29:52 motivo sudo[12822]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:29:52 motivo sudo[12822]: pam_unix(sudo:session): session closed for user root Apr 22 22:29:52 motivo volumio[12591]: info: Access Token successfully retrieved Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 22 22:29:52 motivo volumio[12591]: info: [1713824992525] CoreMusicLibrary::Adding element QOBUZ Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 22 22:29:52 motivo volumio[12591]: Cannot find translation for source QOBUZ Apr 22 22:29:52 motivo volumio[12591]: info: Stopping AccessToken refresher cron for QOBUZ Apr 22 22:29:52 motivo volumio[12591]: info: AccessToken refresher cron started for QOBUZ Apr 22 22:29:52 motivo volumio[12591]: info: Adding QOBUZ REST API Endpoints Apr 22 22:29:52 motivo volumio[12591]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Apr 22 22:29:52 motivo volumio[12591]: error: MPD error: The expression evaluated to a falsy value: Apr 22 22:29:52 motivo volumio[12591]: assert.ok(self.idling) Apr 22 22:29:52 motivo volumio[12591]: error: The expression evaluated to a falsy value: Apr 22 22:29:52 motivo volumio[12591]: assert.ok(self.idling) Apr 22 22:29:52 motivo volumio[12591]: info: Raat Daemon started successfully Apr 22 22:29:52 motivo volumio[12591]: info: MPD running with PID12756 Apr 22 22:29:52 motivo volumio[12591]: ,establishing connection Apr 22 22:29:52 motivo volumio[12591]: info: MRS: Found cast device: S801B-ff0ab9b74701e208d26a65bc56f88ce3 Apr 22 22:29:52 motivo volumio[12591]: info: Adding audio output: Apr 22 22:29:52 motivo volumio[12591]: error: updateQueue error: null Apr 22 22:29:52 motivo volumio[12591]: info: Access Token successfully retrieved Apr 22 22:29:52 motivo volumio[12591]: info: Starting Shairport Sync Apr 22 22:29:52 motivo volumio[12591]: info: Starting Shairport Sync Apr 22 22:29:52 motivo sudo[12834]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 22 22:29:52 motivo sudo[12834]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:29:52 motivo volumio[12591]: info: Starting Shairport Sync Apr 22 22:29:52 motivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 22 22:29:52 motivo sudo[12837]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 22 22:29:52 motivo sudo[12837]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:29:52 motivo systemd[1]: shairport-sync.service: Succeeded. Apr 22 22:29:52 motivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 22 22:29:52 motivo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 22 22:29:52 motivo sudo[12834]: pam_unix(sudo:session): session closed for user root Apr 22 22:29:52 motivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 22 22:29:52 motivo systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Apr 22 22:29:52 motivo systemd[1]: shairport-sync.service: Succeeded. Apr 22 22:29:52 motivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 22 22:29:52 motivo volumio[12591]: info: Adding Inputs via Serial API Apr 22 22:29:52 motivo volumio[12591]: info: Adding HDMI I2S MODES via Serial API Apr 22 22:29:52 motivo volumio[12591]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Apr 22 22:29:52 motivo volumio[12591]: info: Additional UI Settings Added for plugin music_service/inputs Apr 22 22:29:52 motivo volumio[12591]: EEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEEE Apr 22 22:29:52 motivo volumio[12591]: 11111110000000000000000000000000 Apr 22 22:29:52 motivo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 22 22:29:52 motivo sudo[12837]: pam_unix(sudo:session): session closed for user root Apr 22 22:29:52 motivo sudo[12841]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 22 22:29:52 motivo sudo[12841]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 22:29:52 motivo volumio[12591]: [ Apr 22 22:29:52 motivo volumio[12591]: { id: '1', name: 'Linear phase fast roll-off' }, Apr 22 22:29:52 motivo volumio[12591]: { id: '2', name: 'Linear phase slow roll-off' }, Apr 22 22:29:52 motivo volumio[12591]: { id: '3', name: 'Minimum phase fast roll-off' }, Apr 22 22:29:52 motivo volumio[12591]: { id: '4', name: 'Minimum phase slow roll-off' }, Apr 22 22:29:52 motivo volumio[12591]: { id: '5', name: 'Apodizing fast roll-off' }, Apr 22 22:29:52 motivo volumio[12591]: { id: '6', name: 'Corrected minimum phase fast roll-off' }, Apr 22 22:29:52 motivo volumio[12591]: { id: '7', name: 'Brick wall' }, Apr 22 22:29:52 motivo volumio[12591]: { id: '8', name: 'Reserved for future use' }, Apr 22 22:29:52 motivo volumio[12591]: { id: '9', name: 'Reserved for future use' }, Apr 22 22:29:52 motivo volumio[12591]: { id: '10', name: 'Reserved for future use' }, Apr 22 22:29:52 motivo volumio[12591]: { id: '11', name: 'Reserved for future use' }, Apr 22 22:29:52 motivo volumio[12591]: { id: '12', name: 'Reserved for future use' }, Apr 22 22:29:52 motivo volumio[12591]: { id: '13', name: 'Reserved for future use' }, Apr 22 22:29:52 motivo volumio[12591]: { id: '14', name: 'Reserved for future use' }, Apr 22 22:29:52 motivo volumio[12591]: { id: '15', name: 'Reserved for future use' }, Apr 22 22:29:52 motivo volumio[12591]: { id: '16', name: 'Reserved for future use' }, Apr 22 22:29:52 motivo volumio[12591]: { id: '17', name: 'Reserved for future use' }, Apr 22 22:29:52 motivo volumio[12591]: { id: '18', name: 'Reserved for future use' }, Apr 22 22:29:52 motivo volumio[12591]: { id: '19', name: 'Reserved for future use' }, Apr 22 22:29:52 motivo volumio[12591]: { id: '20', name: 'Reserved for future use' }, Apr 22 22:29:52 motivo volumio[12591]: { id: '21', name: 'Reserved for future use' }, Apr 22 22:29:52 motivo volumio[12591]: { id: '22', name: 'Reserved for future use' }, Apr 22 22:29:52 motivo volumio[12591]: { id: '23', name: '23' }, Apr 22 22:29:52 motivo volumio[12591]: { id: '24', name: '24' }, Apr 22 22:29:52 motivo volumio[12591]: { id: '25', name: '25' }, Apr 22 22:29:52 motivo volumio[12591]: { id: '26', name: '26' }, Apr 22 22:29:52 motivo volumio[12591]: { id: '27', name: '27' }, Apr 22 22:29:52 motivo volumio[12591]: { id: '28', name: '28' }, Apr 22 22:29:52 motivo volumio[12591]: { id: '29', name: '29' }, Apr 22 22:29:52 motivo volumio[12591]: { id: '30', name: '30' }, Apr 22 22:29:52 motivo volumio[12591]: { id: '31', name: '31' }, Apr 22 22:29:52 motivo volumio[12591]: { id: '32', name: '32' } Apr 22 22:29:52 motivo volumio[12591]: ] Apr 22 22:29:52 motivo volumio[12591]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 22 22:29:52 motivo volumio[12591]: ReferenceError: availableDacFilters is not defined Apr 22 22:29:52 motivo volumio[12591]: at serialInputs.populateDACAvailableFiltersModesList (/volumio/app/plugins/music_service/inputs/index.js:2029:25) Apr 22 22:29:52 motivo volumio[12591]: at /volumio/app/plugins/music_service/inputs/index.js:2021:18 Apr 22 22:29:52 motivo volumio[12591]: at /volumio/app/plugins/music_service/inputs/node_modules/jsonfile/index.js:46:5 Apr 22 22:29:52 motivo volumio[12591]: at /volumio/app/plugins/music_service/inputs/node_modules/graceful-fs/graceful-fs.js:123:16 Apr 22 22:29:52 motivo volumio[12591]: at FSReqCallback.readFileAfterClose [as oncomplete] (internal/fs/read_file_context.js:63:3) Apr 22 22:29:52 motivo volumio[12591]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 22 22:29:52 motivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 22 22:29:52 motivo systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Apr 22 22:29:52 motivo systemd[1]: shairport-sync.service: Succeeded. Apr 22 22:29:52 motivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 22 22:29:52 motivo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 22 22:29:52 motivo sudo[12841]: pam_unix(sudo:session): session closed for user root Apr 22 22:29:53 motivo sudo[12856]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-22 22:28 Apr 22 22:29:53 motivo sudo[12856]: 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="b51559ff3f3719e35ff52cb9ccf2ff401b5ecb06" VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee" VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623" VOLUMIO_BE_VERSION="f61678c696e00921b9f86a2ceee67cca65b9d5c8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="motivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Apr 2024 08:42:15 PM CEST" VOLUMIO_VERSION="3.655" VOLUMIO_HARDWARE="cm4" VOLUMIO_DEVICENAME="CM4" VOLUMIO_VENDOR_MODEL="Volumio Motivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Motivo" VOLUMIO_HASH="b361d83dddb9ed6e6c52e935657ebf5a"