-- 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"