-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Sat 2024-04-13 18:56:48 CEST. --
Apr 13 18:55:51 volumio ntpd[794]: receive: Unexpected origin timestamp 0xe979dc66.45642300 does not match aorg 0000000000.00000000 from server@185.19.184.35 xmt 0xe9c53797.77b48c89
Apr 13 18:55:51 volumio ntpd[794]: receive: Unexpected origin timestamp 0xe979dc66.4562cf27 does not match aorg 0000000000.00000000 from server@162.159.200.123 xmt 0xe9c53797.787f1a8a
Apr 13 18:55:51 volumio ntpd[794]: receive: Unexpected origin timestamp 0xe979dc66.455f7a1f does not match aorg 0000000000.00000000 from server@31.14.133.122 xmt 0xe9c53797.77e193b9
Apr 13 18:55:51 volumio ntpd[794]: receive: Unexpected origin timestamp 0xe979dc66.4565f8d1 does not match aorg 0000000000.00000000 from server@185.208.47.14 xmt 0xe9c53797.78ba431c
Apr 13 18:55:51 volumio ntpd[794]: receive: Unexpected origin timestamp 0xe979dc66.4561640a does not match aorg 0000000000.00000000 from server@93.94.88.50 xmt 0xe9c53797.7a07a393
Apr 13 18:55:51 volumio systemd[1]: Starting Daily apt download activities...
Apr 13 18:55:51 volumio volumio[901]: info: Discovery: A device disappeared from network
Apr 13 18:55:51 volumio volumio[901]: info: Discovery: Device volumio disappeared from network
Apr 13 18:55:51 volumio volumio[901]: info: Discovery: A device disappeared from network
Apr 13 18:55:51 volumio ntpd[794]: Soliciting pool server 195.32.69.63
Apr 13 18:55:51 volumio volumio[901]: info: Discovery: adding undefined
Apr 13 18:55:51 volumio volumio[901]: info: Discovery: Found device Volumio
Apr 13 18:55:51 volumio volumio[901]: info: CoreCommandRouter::volumioGetState
Apr 13 18:55:51 volumio volumio[901]: info: CorePlayQueue::getTrack 0
Apr 13 18:55:51 volumio volumio[901]: info: Discovery: this is already registered,  undefined
Apr 13 18:55:51 volumio volumio[901]: info: Discovery: Found device Volumio
Apr 13 18:55:51 volumio volumio[901]: info: CoreCommandRouter::volumioGetState
Apr 13 18:55:51 volumio volumio[901]: info: CorePlayQueue::getTrack 0
Apr 13 18:55:51 volumio systemd[1]: apt-daily.service: Succeeded.
Apr 13 18:55:51 volumio systemd[1]: Started Daily apt download activities.
Apr 13 18:55:51 volumio systemd[1]: Starting Daily apt upgrade and clean activities...
Apr 13 18:55:52 volumio systemd[1]: apt-daily-upgrade.service: Succeeded.
Apr 13 18:55:52 volumio systemd[1]: Started Daily apt upgrade and clean activities.
Apr 13 18:55:52 volumio sudo[1710]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 13 18:55:52 volumio sudo[1710]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:55:52 volumio sudo[1710]: pam_unix(sudo:session): session closed for user root
Apr 13 18:55:52 volumio sudo[1712]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 13 18:55:52 volumio sudo[1712]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:55:52 volumio sudo[1712]: pam_unix(sudo:session): session closed for user root
Apr 13 18:55:52 volumio volumio[901]: verbose: New Socket.io Connection to 192.168.1.218 from 192.168.1.106 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:124.0) Gecko/20100101 Firefox/124.0 Total Clients: 3
Apr 13 18:55:53 volumio volumio[901]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 13 18:55:53 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 13 18:55:53 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps
Apr 13 18:55:53 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode
Apr 13 18:55:53 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages
Apr 13 18:55:53 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones
Apr 13 18:55:53 volumio volumio[901]: info: Received Get System Info
Apr 13 18:55:53 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 13 18:55:53 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 13 18:55:53 volumio volumio[901]: info: Discovery: Getting this device information
Apr 13 18:55:53 volumio volumio[901]: info: CoreCommandRouter::volumioGetState
Apr 13 18:55:53 volumio volumio[901]: info: CorePlayQueue::getTrack 0
Apr 13 18:55:53 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 13 18:55:53 volumio volumio-remote-updater[653]: No test mode
Apr 13 18:55:53 volumio volumio-remote-updater[653]: No alpha test mode
Apr 13 18:55:53 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Apr 13 18:55:53 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Apr 13 18:55:53 volumio volumio[901]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
\n\nFix for USB drive not mounted in some cases
\nFix albumart alignment on Manifest UI
\nRestored gpu settings in config.txt on pi
\nFix for wrong size of NAS and CIFS drives
\n
\nNEW ADDITIONS
\n\nPatched driver for Waveshare DSI displays on Pi
\nBump MPD to 0.23.15
\nUNSTABLE ALPHA BUILD - DO NOT INSTALL
\n\n","title":"Update v3.632","updateavailable":true}
Apr 13 18:55:53 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Apr 13 18:55:54 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 13 18:55:58 volumio volumio[901]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Apr 13 18:55:58 volumio volumio[901]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Apr 13 18:55:58 volumio volumio[901]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Apr 13 18:55:58 volumio volumio[901]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Apr 13 18:55:58 volumio volumio[901]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Apr 13 18:55:58 volumio volumio[901]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Apr 13 18:55:58 volumio volumio[901]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Apr 13 18:55:58 volumio volumio[901]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Apr 13 18:55:58 volumio volumio[901]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Apr 13 18:55:58 volumio volumio[901]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Apr 13 18:55:58 volumio volumio[901]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Apr 13 18:55:58 volumio volumio[901]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Apr 13 18:55:58 volumio volumio[901]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Apr 13 18:55:58 volumio volumio[901]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Apr 13 18:55:58 volumio volumio[901]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Apr 13 18:55:58 volumio volumio[901]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Apr 13 18:55:58 volumio volumio[901]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Apr 13 18:55:58 volumio volumio[901]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Apr 13 18:55:58 volumio volumio[901]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Apr 13 18:55:58 volumio volumio[901]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Apr 13 18:55:58 volumio volumio[901]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Apr 13 18:55:58 volumio volumio[901]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Apr 13 18:55:58 volumio volumio[901]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Apr 13 18:55:58 volumio volumio[901]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Apr 13 18:55:58 volumio volumio[901]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Apr 13 18:55:58 volumio volumio[901]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Apr 13 18:55:58 volumio volumio[901]: info: Adding plugin bluetooth to MyMusic Plugins
Apr 13 18:55:58 volumio volumio[901]: info: Adding plugin multiroom to MyMusic Plugins
Apr 13 18:55:58 volumio volumio[901]: info: Adding plugin metavolumio to MyMusic Plugins
Apr 13 18:55:58 volumio volumio[901]: info: Adding plugin cd_controller to MyMusic Plugins
Apr 13 18:55:58 volumio volumio[901]: info: Adding plugin smart_inputs to MyMusic Plugins
Apr 13 18:55:58 volumio volumio[901]: info: Adding plugin tidalconnect to MyMusic Plugins
Apr 13 18:55:58 volumio volumio[901]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Apr 13 18:55:58 volumio volumio[901]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Apr 13 18:55:58 volumio volumio[901]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Apr 13 18:55:58 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 13 18:55:58 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 13 18:55:58 volumio volumio[901]: info: Starting MyVolumio Remote Streaming Endpoints
Apr 13 18:55:58 volumio volumio[901]: info: MyVolumio not started
Apr 13 18:55:58 volumio volumio[901]: info: Initializing device activation check
Apr 13 18:55:58 volumio volumio[901]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Apr 13 18:55:58 volumio volumio[901]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Apr 13 18:55:59 volumio volumio[901]: info: Starting Streaming Service Transparent Proxy
Apr 13 18:55:59 volumio volumio[901]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Apr 13 18:55:59 volumio volumio[901]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Apr 13 18:55:59 volumio volumio[901]: info: Streaming services startup
Apr 13 18:55:59 volumio volumio[901]: info: Starting Streaming Daemon
Apr 13 18:55:59 volumio sudo[1726]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Apr 13 18:55:59 volumio sudo[1726]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:55:59 volumio sudo[1726]: pam_unix(sudo:session): session closed for user root
Apr 13 18:55:59 volumio volumio[901]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Apr 13 18:55:59 volumio volumio[901]: error: Cannot start Volumio Streaming Daemon
Apr 13 18:55:59 volumio volumio[901]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Apr 13 18:55:59 volumio volumio[901]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Apr 13 18:55:59 volumio volumio[901]: STREAMING PROXY: Starting server on port 3245
Apr 13 18:55:59 volumio volumio[901]: Node JS runtime: 14
Apr 13 18:56:02 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage
Apr 13 18:56:02 volumio volumio[901]: info: Loading i18n strings for locale it
Apr 13 18:56:02 volumio volumio[901]: Updating browse sources language
Apr 13 18:56:02 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 13 18:56:02 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone
Apr 13 18:56:02 volumio volumio[901]: info: Setting timezone to Europe/Rome
Apr 13 18:56:02 volumio sudo[1734]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime
Apr 13 18:56:02 volumio sudo[1734]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:02 volumio sudo[1734]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:02 volumio sudo[1737]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Rome /etc/localtime
Apr 13 18:56:02 volumio sudo[1737]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:02 volumio sudo[1737]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:02 volumio sudo[1740]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime
Apr 13 18:56:02 volumio sudo[1740]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:02 volumio sudo[1740]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:02 volumio sudo[1743]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Rome
Apr 13 18:56:02 volumio sudo[1743]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:03 volumio dbus-daemon[650]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.19' (uid=0 pid=1744 comm="/usr/bin/timedatectl set-timezone Europe/Rome ")
Apr 13 18:56:03 volumio systemd[1]: Starting Time & Date Service...
Apr 13 18:56:03 volumio dbus-daemon[650]: [system] Successfully activated service 'org.freedesktop.timedate1'
Apr 13 18:56:03 volumio systemd[1]: Started Time & Date Service.
Apr 13 18:56:03 volumio sudo[1743]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:03 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
Apr 13 18:56:03 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
Apr 13 18:56:03 volumio sudo[1747]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Apr 13 18:56:03 volumio sudo[1747]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:03 volumio volumio[901]: info: Fetching Streaming Services browse cache
Apr 13 18:56:06 volumio sudo[1747]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:09 volumio sudo[1750]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 13 18:56:09 volumio sudo[1750]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:09 volumio sudo[1750]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:09 volumio sudo[1752]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 13 18:56:09 volumio sudo[1752]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:09 volumio sudo[1752]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:09 volumio volumio[901]: verbose: New Socket.io Connection to 192.168.1.218 from 192.168.1.106 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:124.0) Gecko/20100101 Firefox/124.0 Total Clients: 4
Apr 13 18:56:09 volumio volumio[901]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 13 18:56:09 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 13 18:56:11 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Apr 13 18:56:11 volumio volumio[901]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Apr 13 18:56:11 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Apr 13 18:56:11 volumio volumio[901]: info: Received Get System Version
Apr 13 18:56:11 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 13 18:56:11 volumio volumio[901]: info: Received Get System Info
Apr 13 18:56:11 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 13 18:56:11 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 13 18:56:11 volumio volumio[901]: info: Discovery: Getting this device information
Apr 13 18:56:11 volumio volumio[901]: info: CoreCommandRouter::volumioGetState
Apr 13 18:56:11 volumio volumio[901]: info: CorePlayQueue::getTrack 0
Apr 13 18:56:11 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 13 18:56:13 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Apr 13 18:56:13 volumio sudo[1756]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 13 18:56:13 volumio sudo[1756]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:13 volumio volumio[901]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 4
Apr 13 18:56:13 volumio sudo[1756]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:13 volumio sudo[1758]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 13 18:56:13 volumio sudo[1758]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:13 volumio sudo[1758]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:13 volumio volumio[901]: info: CoreCommandRouter::volumioGetState
Apr 13 18:56:13 volumio volumio[901]: info: CorePlayQueue::getTrack 0
Apr 13 18:56:13 volumio volumio[901]: verbose: New Socket.io Connection to 192.168.1.218 from 192.168.1.106 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:124.0) Gecko/20100101 Firefox/124.0 Total Clients: 5
Apr 13 18:56:13 volumio volumio[901]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 13 18:56:13 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 13 18:56:13 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps
Apr 13 18:56:13 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode
Apr 13 18:56:13 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages
Apr 13 18:56:13 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones
Apr 13 18:56:13 volumio volumio[901]: info: Received Get System Info
Apr 13 18:56:13 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 13 18:56:13 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 13 18:56:13 volumio volumio[901]: info: Discovery: Getting this device information
Apr 13 18:56:13 volumio volumio[901]: info: CoreCommandRouter::volumioGetState
Apr 13 18:56:13 volumio volumio[901]: info: CorePlayQueue::getTrack 0
Apr 13 18:56:13 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 13 18:56:13 volumio volumio-remote-updater[653]: No test mode
Apr 13 18:56:13 volumio volumio-remote-updater[653]: No alpha test mode
Apr 13 18:56:13 volumio volumio[901]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
\n\nFix for USB drive not mounted in some cases
\nFix albumart alignment on Manifest UI
\nRestored gpu settings in config.txt on pi
\nFix for wrong size of NAS and CIFS drives
\n
\nNEW ADDITIONS
\n\nPatched driver for Waveshare DSI displays on Pi
\nBump MPD to 0.23.15
\nUNSTABLE ALPHA BUILD - DO NOT INSTALL
\n\n","title":"Update v3.632","updateavailable":true}
Apr 13 18:56:13 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Apr 13 18:56:16 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
Apr 13 18:56:16 volumio volumio[901]: info: MyVolumio login type: Token
Apr 13 18:56:16 volumio volumio[901]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Apr 13 18:56:17 volumio volumio[901]: info: MyVolumio token set successfully
Apr 13 18:56:17 volumio volumio[901]: info: MYVOLUMIO: Adding device
Apr 13 18:56:17 volumio volumio[901]: info: MYVOLUMIO: Evaluating Server
Apr 13 18:56:17 volumio volumio[901]: info: MyVolumio Plan changed: premium
Apr 13 18:56:17 volumio volumio[901]: info: [MyVolumio PluginManager] Subscribed plan changed to premium
Apr 13 18:56:17 volumio volumio[901]: info: Removing browser output: myVolumio user plan is not superstar
Apr 13 18:56:17 volumio volumio[901]: info: Removing audio output:
Apr 13 18:56:17 volumio volumio[901]: info: MYVOLUMIO: Adding device
Apr 13 18:56:17 volumio volumio[901]: info: MYVOLUMIO: Evaluating Server
Apr 13 18:56:17 volumio volumio[901]: info: Remote config written successfully
Apr 13 18:56:17 volumio volumio[901]: info: Starting Tunnel 1
Apr 13 18:56:17 volumio volumio[901]: info: Starting Tunnel Connection Checker
Apr 13 18:56:17 volumio volumio[901]: info: MYVolumio Device enabled
Apr 13 18:56:17 volumio volumio[901]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins...
Apr 13 18:56:17 volumio volumio[901]: info: MyVolumio status changed
Apr 13 18:56:17 volumio volumio[901]: info: Streaming services startup
Apr 13 18:56:17 volumio volumio[901]: info: Starting Streaming Daemon
Apr 13 18:56:17 volumio sudo[1798]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Apr 13 18:56:17 volumio sudo[1798]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:17 volumio volumio[901]: error: [MyVolumio PluginManager] Could not read cache file: ENOENT: no such file or directory, open '/data/myvolumio/cache.data'
Apr 13 18:56:17 volumio sudo[1798]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:17 volumio volumio[901]: error: Cannot start Volumio Streaming Daemon
Apr 13 18:56:17 volumio volumio[901]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Apr 13 18:56:17 volumio volumio[901]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Apr 13 18:56:17 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings
Apr 13 18:56:17 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices
Apr 13 18:56:17 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Apr 13 18:56:17 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 13 18:56:17 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 13 18:56:18 volumio volumio[901]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"...
Apr 13 18:56:18 volumio volumio[901]: info: [1713027378080] Starting BluetoothController
Apr 13 18:56:18 volumio volumio[901]: info: [MyVolumio PluginManager] Loading plugin "multiroom"...
Apr 13 18:56:18 volumio sudo[1803]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom
Apr 13 18:56:18 volumio sudo[1803]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:18 volumio sudo[1803]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:18 volumio volumio[901]: info: MRS: MultiRoom plugin initialized
Apr 13 18:56:18 volumio volumio[901]: info: MRS: STOPPING SNAPCLIENT
Apr 13 18:56:18 volumio volumio[901]: info: MRS: Snap server stop
Apr 13 18:56:18 volumio sudo[1819]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient
Apr 13 18:56:18 volumio sudo[1819]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:18 volumio volumio[901]: info: MRS: STOPPING volumioStreaming
Apr 13 18:56:18 volumio sudo[1822]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver
Apr 13 18:56:18 volumio sudo[1822]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:18 volumio sudo[1824]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming
Apr 13 18:56:18 volumio sudo[1824]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:18 volumio volumio[901]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"...
Apr 13 18:56:18 volumio sudo[1819]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:18 volumio sudo[1828]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/*
Apr 13 18:56:18 volumio sudo[1828]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:18 volumio sudo[1828]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:18 volumio volumio[901]: info: [MyVolumio PluginManager] Loading plugin "manifestui"...
Apr 13 18:56:18 volumio sudo[1822]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:18 volumio volumio[901]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"...
Apr 13 18:56:18 volumio sudo[1824]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:18 volumio volumio[901]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"...
Apr 13 18:56:18 volumio volumio[901]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"...
Apr 13 18:56:18 volumio volumio[901]: info: [MyVolumio PluginManager] Loading plugin "tidal"...
Apr 13 18:56:18 volumio volumio[901]: info: [MyVolumio PluginManager] Loading plugin "qobuz"...
Apr 13 18:56:18 volumio volumio[901]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"...
Apr 13 18:56:18 volumio volumio[901]: info: Preparing to generate the ALSA configuration file
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid
Apr 13 18:56:18 volumio volumio[901]: info: MRS: Removed streaming files
Apr 13 18:56:18 volumio volumio[901]: info: MRS: volumioStreaming STOPPED
Apr 13 18:56:18 volumio volumio[901]: info: MRS: SNAPSERVER STOPPED
Apr 13 18:56:18 volumio volumio[901]: info: MRS: SNAPCLIENT STOPPED
Apr 13 18:56:18 volumio volumio[901]: info: Asound.conf file unchanged, so no further update is needed
Apr 13 18:56:18 volumio volumio[901]: info: Output device has changed, restarting MPD
Apr 13 18:56:18 volumio sudo[1831]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 13 18:56:18 volumio sudo[1831]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:18 volumio volumio[901]: info: Output device has changed, restarting Shairport Sync
Apr 13 18:56:18 volumio sudo[1831]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 13 18:56:18 volumio sudo[1833]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 13 18:56:18 volumio sudo[1833]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:18 volumio systemd[1]: Stopping Music Player Daemon...
Apr 13 18:56:18 volumio volumio[901]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 13 18:56:18 volumio volumio[901]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 13 18:56:18 volumio volumio[901]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus
Apr 13 18:56:18 volumio volumio[901]: info: MRS: Pushing multiroomSync output for this device
Apr 13 18:56:18 volumio sudo[1842]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Volumio
Apr 13 18:56:18 volumio sudo[1842]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:18 volumio sudo[1842]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:18 volumio systemd[1]: mpd.service: Succeeded.
Apr 13 18:56:18 volumio volumio[901]: info: MRS: Pushing multiroomSync output
Apr 13 18:56:18 volumio systemd[1]: Stopped Music Player Daemon.
Apr 13 18:56:18 volumio volumio[901]: info: Adding audio output:
Apr 13 18:56:18 volumio volumio[901]: info: Adding audio output:
Apr 13 18:56:18 volumio volumio[901]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio
Apr 13 18:56:18 volumio volumio[901]: info: Adding METAVOLUMIO REST API Endpoints
Apr 13 18:56:18 volumio volumio[901]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio
Apr 13 18:56:18 volumio volumio[901]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio
Apr 13 18:56:18 volumio volumio[901]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio
Apr 13 18:56:18 volumio volumio[901]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio
Apr 13 18:56:18 volumio volumio[901]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui
Apr 13 18:56:18 volumio volumio[901]: info: Adding Manifest REST API Endpoints
Apr 13 18:56:18 volumio volumio[901]: info: Adding manifestui REST Endpoint for plugin: miscellanea/manifestui
Apr 13 18:56:18 volumio systemd[1]: Starting Music Player Daemon...
Apr 13 18:56:18 volumio volumio[901]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller
Apr 13 18:56:18 volumio volumio[901]: info: Preparing CD Folders
Apr 13 18:56:18 volumio volumio[901]: info: Adding CD REST API Endpoints
Apr 13 18:56:18 volumio volumio[901]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller
Apr 13 18:56:18 volumio volumio[901]: info: Starting UDEV Watcher for CD
Apr 13 18:56:18 volumio volumio[901]: info: Detecting CD presence with UDEV
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices
Apr 13 18:56:18 volumio volumio[901]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs
Apr 13 18:56:18 volumio volumio[901]: info: Adding inputs REST Endpoints
Apr 13 18:56:18 volumio volumio[901]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs
Apr 13 18:56:18 volumio volumio[901]: info: Scanning Audio Inputs
Apr 13 18:56:18 volumio sudo[1844]:     root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Apr 13 18:56:18 volumio sudo[1844]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:18 volumio sudo[1844]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:18 volumio volumio[901]: info: Checking against Known Cards name
Apr 13 18:56:18 volumio volumio[901]: info: Adding Server instance for streaming
Apr 13 18:56:18 volumio volumio[901]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio
Apr 13 18:56:18 volumio volumio[901]: error: Hi Res Audio Failed Login: Missing Login Data
Apr 13 18:56:18 volumio volumio[901]: info: Adding HIGHRESAUDIO REST API Endpoints
Apr 13 18:56:18 volumio volumio[901]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio
Apr 13 18:56:18 volumio volumio[901]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal
Apr 13 18:56:18 volumio volumio[901]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz
Apr 13 18:56:18 volumio volumio[901]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect
Apr 13 18:56:18 volumio volumio[901]: info: Stopping AccessToken refresher cron
Apr 13 18:56:18 volumio sudo[1855]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Apr 13 18:56:18 volumio sudo[1855]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:18 volumio volumio[901]: info: AccessToken refresher cron started
Apr 13 18:56:18 volumio volumio[901]: info: Stopping AccessToken refresher cron for QOBUZ
Apr 13 18:56:18 volumio volumio[901]: info: AccessToken refresher cron started for QOBUZ
Apr 13 18:56:18 volumio volumio[901]: info: Adding TIDAL REST API Endpoints
Apr 13 18:56:18 volumio volumio[901]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal
Apr 13 18:56:18 volumio sudo[1855]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:18 volumio volumio[901]: info: Adding QOBUZ REST API Endpoints
Apr 13 18:56:18 volumio volumio[901]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 13 18:56:18 volumio volumio[901]: info: Setting Geolocation for MyVolumio to eu10
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined
Apr 13 18:56:18 volumio volumio[901]: info: Bluetooth name changed to Volumio
Apr 13 18:56:18 volumio volumio[901]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined
Apr 13 18:56:18 volumio volumio[901]: info: MPD Permissions set
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: Starting Shairport Sync
Apr 13 18:56:18 volumio volumio[901]: info: Preparing to generate the ALSA configuration file
Apr 13 18:56:18 volumio sudo[1863]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 13 18:56:18 volumio sudo[1863]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:18 volumio volumio[901]: info: Asound.conf file unchanged, so no further update is needed
Apr 13 18:56:18 volumio volumio[901]: info: Output device has changed, restarting MPD
Apr 13 18:56:18 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 13 18:56:18 volumio volumio[901]: info: Output device has changed, restarting Shairport Sync
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 13 18:56:18 volumio systemd[1]: shairport-sync.service: Succeeded.
Apr 13 18:56:18 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Apr 13 18:56:18 volumio sudo[1866]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 13 18:56:18 volumio sudo[1866]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:18 volumio volumio[901]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 13 18:56:18 volumio volumio[901]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: Preparing to generate the ALSA configuration file
Apr 13 18:56:18 volumio sudo[1866]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:18 volumio sudo[1868]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 13 18:56:18 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 13 18:56:18 volumio sudo[1868]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:18 volumio volumio[901]: info: MPD Permissions set
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio sudo[1863]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:18 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Apr 13 18:56:18 volumio systemd[1]: mpd.service: Succeeded.
Apr 13 18:56:18 volumio systemd[1]: Stopped Music Player Daemon.
Apr 13 18:56:18 volumio systemd[1]: Starting Music Player Daemon...
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: Asound.conf file unchanged, so no further update is needed
Apr 13 18:56:18 volumio volumio[901]: info: Output device has changed, restarting MPD
Apr 13 18:56:18 volumio sudo[1885]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 13 18:56:18 volumio volumio[901]: info: Output device has changed, restarting Shairport Sync
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 13 18:56:18 volumio sudo[1885]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:18 volumio sudo[1885]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:18 volumio sudo[1887]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 13 18:56:18 volumio sudo[1887]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:18 volumio sudo[1881]:     root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Apr 13 18:56:18 volumio sudo[1881]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:18 volumio sudo[1881]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:18 volumio volumio[901]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 13 18:56:18 volumio volumio[901]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: MPD Permissions set
Apr 13 18:56:18 volumio volumio[901]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined
Apr 13 18:56:18 volumio volumio[901]: info: Shairport-Sync Started
Apr 13 18:56:18 volumio volumio[901]: info: Starting Shairport Sync
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio sudo[1898]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 13 18:56:18 volumio sudo[1898]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined
Apr 13 18:56:18 volumio volumio[901]: info: Starting Shairport Sync
Apr 13 18:56:18 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Apr 13 18:56:18 volumio systemd[1]: mpd.service: Succeeded.
Apr 13 18:56:18 volumio systemd[1]: Stopped Music Player Daemon.
Apr 13 18:56:18 volumio volumio[901]: info: Setting Geolocation for MyVolumio to eu10
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 13 18:56:18 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 13 18:56:18 volumio systemd[1]: Starting Music Player Daemon...
Apr 13 18:56:18 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 13 18:56:18 volumio sudo[1905]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 13 18:56:18 volumio systemd[1]: shairport-sync.service: Succeeded.
Apr 13 18:56:18 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Apr 13 18:56:18 volumio sudo[1905]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:18 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 13 18:56:19 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 13 18:56:19 volumio sudo[1898]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:19 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Apr 13 18:56:19 volumio systemd[1]: shairport-sync.service: Succeeded.
Apr 13 18:56:19 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Apr 13 18:56:19 volumio volumio[901]: info: Shairport-Sync Started
Apr 13 18:56:19 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 13 18:56:19 volumio sudo[1905]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:19 volumio volumio[901]: info: Shairport-Sync Started
Apr 13 18:56:19 volumio sudo[1906]:     root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Apr 13 18:56:19 volumio sudo[1906]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:19 volumio sudo[1906]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:19 volumio mpd[1912]: Apr 13 18:56 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Apr 13 18:56:19 volumio systemd[1]: Started Music Player Daemon.
Apr 13 18:56:19 volumio sudo[1868]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:19 volumio sudo[1887]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:19 volumio sudo[1833]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:19 volumio volumio[901]: error: MPD error: The expression evaluated to a falsy value:
Apr 13 18:56:19 volumio volumio[901]:   assert.ok(self.idling)
Apr 13 18:56:19 volumio volumio[901]: error: The expression evaluated to a falsy value:
Apr 13 18:56:19 volumio volumio[901]:   assert.ok(self.idling)
Apr 13 18:56:19 volumio volumio[901]: error: MPD error: The expression evaluated to a falsy value:
Apr 13 18:56:19 volumio volumio[901]:   assert.ok(self.idling)
Apr 13 18:56:19 volumio volumio[901]: error: The expression evaluated to a falsy value:
Apr 13 18:56:19 volumio volumio[901]:   assert.ok(self.idling)
Apr 13 18:56:19 volumio volumio[901]: error: updateQueue error: null
Apr 13 18:56:19 volumio volumio[901]: info: Successfully Added MyVolumio device
Apr 13 18:56:19 volumio volumio[901]: info: Updating MyVolumio device info
Apr 13 18:56:19 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 13 18:56:19 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 13 18:56:19 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 13 18:56:19 volumio volumio[901]: info: Updating MyVolumio device info
Apr 13 18:56:19 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 13 18:56:19 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 13 18:56:19 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 13 18:56:20 volumio volumio[901]: info: Found match in Cards Database: setting mixer  for card HDMI 0 Out
Apr 13 18:56:20 volumio volumio[901]: info: Device 0 does not have any Mixer Control Available
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Apr 13 18:56:20 volumio volumio[901]: info: Updating Volume Controller Parameters: Device: 0 Name: HDMI 0 Out Mixer:  Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Apr 13 18:56:20 volumio volumio[901]: info: Disabling external Volume Control
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 13 18:56:20 volumio volumio[901]: info: CoreStateMachine::pushState
Apr 13 18:56:20 volumio volumio[901]: info: CorePlayQueue::getTrack 0
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::volumioPushState
Apr 13 18:56:20 volumio volumio[901]: info: MRS: Pushing multiroomSync output update for this device
Apr 13 18:56:20 volumio volumio[901]: info: MRS: Pushing multiroomSync output
Apr 13 18:56:20 volumio volumio[901]: info: Preparing to generate the ALSA configuration file
Apr 13 18:56:20 volumio volumio[901]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Apr 13 18:56:20 volumio volumio[901]: info: Reading ALSA contributions from plugins.
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
Apr 13 18:56:20 volumio sudo[1925]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Apr 13 18:56:20 volumio sudo[1925]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
Apr 13 18:56:20 volumio sudo[1932]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Apr 13 18:56:20 volumio sudo[1932]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:20 volumio volumio[901]: info: Asound.conf file written
Apr 13 18:56:20 volumio sudo[1932]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:20 volumio sudo[1935]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Apr 13 18:56:20 volumio sudo[1935]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:20 volumio sudo[1935]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:20 volumio volumio[901]: No state is present for card vc4hdmi0
Apr 13 18:56:20 volumio volumio[901]: Found hardware: "vc4-hdmi" "" "" "" ""
Apr 13 18:56:20 volumio volumio[901]: Hardware is initialized using a generic method
Apr 13 18:56:20 volumio volumio[901]: No state is present for card vc4hdmi0
Apr 13 18:56:20 volumio volumio[901]: No state is present for card vc4hdmi1
Apr 13 18:56:20 volumio volumio[901]: Found hardware: "vc4-hdmi" "" "" "" ""
Apr 13 18:56:20 volumio volumio[901]: Hardware is initialized using a generic method
Apr 13 18:56:20 volumio volumio[901]: No state is present for card vc4hdmi1
Apr 13 18:56:20 volumio volumio[901]: info: Output device has changed, restarting MPD
Apr 13 18:56:20 volumio sudo[1940]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 13 18:56:20 volumio sudo[1940]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:20 volumio volumio[901]: info: Output device has changed, restarting Shairport Sync
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 13 18:56:20 volumio sudo[1940]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:20 volumio sudo[1942]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 13 18:56:20 volumio sudo[1942]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:20 volumio systemd[1]: Stopping Music Player Daemon...
Apr 13 18:56:20 volumio volumio[901]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 13 18:56:20 volumio systemd[1]: mpd.service: Succeeded.
Apr 13 18:56:20 volumio volumio[901]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:20 volumio systemd[1]: Stopped Music Player Daemon.
Apr 13 18:56:20 volumio volumio[901]: info: Output device has changed, restarting MPD
Apr 13 18:56:20 volumio sudo[1952]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 13 18:56:20 volumio sudo[1952]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:20 volumio systemd[1]: Starting Music Player Daemon...
Apr 13 18:56:20 volumio volumio[901]: info: Output device has changed, restarting Shairport Sync
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 13 18:56:20 volumio sudo[1952]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:20 volumio sudo[1955]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 13 18:56:20 volumio sudo[1955]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:20 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Apr 13 18:56:20 volumio systemd[1]: mpd.service: Succeeded.
Apr 13 18:56:20 volumio systemd[1]: Stopped Music Player Daemon.
Apr 13 18:56:20 volumio systemd[1]: Starting Music Player Daemon...
Apr 13 18:56:20 volumio volumio[901]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 13 18:56:20 volumio volumio[901]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:20 volumio volumio[901]: info: Successfully Added MyVolumio device
Apr 13 18:56:20 volumio volumio[901]: info: MPD Permissions set
Apr 13 18:56:20 volumio volumio[901]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined
Apr 13 18:56:20 volumio volumio[901]: info: MPD Permissions set
Apr 13 18:56:20 volumio volumio[901]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan
Apr 13 18:56:20 volumio volumio[901]: wlan0     Interface doesn't support scanning : Device or resource busy
Apr 13 18:56:20 volumio volumio[901]: info: Cannot use regular scanning, forcing with ap-force
Apr 13 18:56:20 volumio sudo[1960]:     root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Apr 13 18:56:20 volumio sudo[1960]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:20 volumio sudo[1964]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force
Apr 13 18:56:20 volumio sudo[1964]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:20 volumio sudo[1960]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:20 volumio sudo[1964]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:20 volumio volumio[901]: command failed: Device or resource busy (-16)
Apr 13 18:56:20 volumio volumio[901]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force
Apr 13 18:56:20 volumio volumio[901]: command failed: Device or resource busy (-16)
Apr 13 18:56:20 volumio volumio[901]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 13 18:56:20 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:20 volumio volumio[901]: info: Starting Shairport Sync
Apr 13 18:56:20 volumio volumio[901]: info: Starting Shairport Sync
Apr 13 18:56:20 volumio sudo[1977]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 13 18:56:20 volumio sudo[1977]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:20 volumio sudo[1979]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 13 18:56:20 volumio sudo[1979]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:20 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 13 18:56:20 volumio systemd[1]: shairport-sync.service: Succeeded.
Apr 13 18:56:20 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Apr 13 18:56:20 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 13 18:56:20 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 13 18:56:20 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Apr 13 18:56:20 volumio systemd[1]: shairport-sync.service: Succeeded.
Apr 13 18:56:20 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Apr 13 18:56:20 volumio sudo[1977]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:20 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 13 18:56:20 volumio sudo[1979]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:20 volumio volumio[901]: info: Shairport-Sync Started
Apr 13 18:56:20 volumio volumio[901]: info: Shairport-Sync Started
Apr 13 18:56:20 volumio volumio[901]: info: Successfully Updated MyVolumio device
Apr 13 18:56:20 volumio mpd[1967]: Apr 13 18:56 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Apr 13 18:56:20 volumio systemd[1]: Started Music Player Daemon.
Apr 13 18:56:20 volumio sudo[1942]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:20 volumio sudo[1955]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:20 volumio volumio[901]: error: updateQueue error: null
Apr 13 18:56:20 volumio volumio[901]: error: updateQueue error: null
Apr 13 18:56:21 volumio volumio[901]: info: Successfully Updated MyVolumio device
Apr 13 18:56:21 volumio sudo[1990]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service
Apr 13 18:56:21 volumio sudo[1990]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:21 volumio systemd[1]: Started Volumio Bluetooth Module.
Apr 13 18:56:21 volumio sudo[1990]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:21 volumio volumio[901]: info: Volumio BT Module successfully started
Apr 13 18:56:21 volumio sudo[1993]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/*
Apr 13 18:56:21 volumio sudo[1993]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:21 volumio volumiobt[1992]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory
Apr 13 18:56:21 volumio sudo[1993]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:21 volumio volumio[901]: info: TidalConnect service stoped!
Apr 13 18:56:21 volumio volumio[901]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Apr 13 18:56:21 volumio volumio[901]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect
Apr 13 18:56:21 volumio sudo[2005]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Apr 13 18:56:21 volumio sudo[2005]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:21 volumio systemd[1]: Started Volumio Tidal Connect Service.
Apr 13 18:56:21 volumio sudo[2005]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:21 volumio volumio[901]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 13 18:56:21 volumio volumio[901]: info: Retrieving Cloud Streaming UI
Apr 13 18:56:21 volumio volumio[901]: info: Getting Tidal Cloud Configuration
Apr 13 18:56:21 volumio volumio[901]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 13 18:56:21 volumio volumio[901]: info: Getting Qobuz Cloud Configuration
Apr 13 18:56:21 volumio volumio[901]: info: Asking plugin for UI Config
Apr 13 18:56:21 volumio volumio[901]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 13 18:56:21 volumio volumio[901]: info: Getting Spotify Cloud Configuration
Apr 13 18:56:21 volumio volumio[901]: info: Asking plugin for UI Config
Apr 13 18:56:21 volumio volumio[901]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 13 18:56:21 volumio volumio[901]: info: Saving Spotify Acccount
Apr 13 18:56:21 volumio volumio[901]: info: Got it
Apr 13 18:56:21 volumio volumio[901]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Apr 13 18:56:21 volumio volumio[901]: info: Got Tidal Cloud Configuration
Apr 13 18:56:21 volumio volumio[901]: info: Got it
Apr 13 18:56:21 volumio volumio[901]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 13 18:56:22 volumio volumio[901]: info: Executing endpoint tc_getconfig
Apr 13 18:56:22 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig
Apr 13 18:56:22 volumio vtcs[2007]: STARTING TidalConnect services, version: 1.3.0.19
Apr 13 18:56:22 volumio vtcs[2007]: STARTED TidalConnect services.
Apr 13 18:56:22 volumio volumio[901]: info: Executing endpoint tc_connect
Apr 13 18:56:22 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect
Apr 13 18:56:22 volumio volumio[901]: info: Connecting to TidalConnect
Apr 13 18:56:22 volumio volumio[901]: info: CoreCommandRouter::servicePushState
Apr 13 18:56:22 volumio volumio[901]: info: CoreStateMachine::pushState
Apr 13 18:56:22 volumio volumio[901]: info: CorePlayQueue::getTrack 0
Apr 13 18:56:22 volumio volumio[901]: info: CoreCommandRouter::volumioPushState
Apr 13 18:56:22 volumio volumio[901]: info: MRS: Pushing multiroomSync output update for this device
Apr 13 18:56:22 volumio volumio[901]: info: MRS: Pushing multiroomSync output
Apr 13 18:56:22 volumio volumio[901]: info: CorePlayQueue::getTrack 0
Apr 13 18:56:22 volumio volumio[901]: 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 13 18:56:22 volumio volumio[901]: verbose: CURRENT POSITION 0
Apr 13 18:56:22 volumio volumio[901]: info: CoreStateMachine::syncState   stateService stop
Apr 13 18:56:22 volumio volumio[901]: info: CoreStateMachine::syncState   currentStatus stop
Apr 13 18:56:22 volumio volumio[901]: info: CoreStateMachine::pushState
Apr 13 18:56:22 volumio volumio[901]: info: CorePlayQueue::getTrack 0
Apr 13 18:56:22 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 13 18:56:22 volumio volumio[901]: info: CoreCommandRouter::volumioPushState
Apr 13 18:56:22 volumio volumio[901]: info: MRS: Pushing multiroomSync output update for this device
Apr 13 18:56:22 volumio volumio[901]: info: MRS: Pushing multiroomSync output
Apr 13 18:56:22 volumio volumio[901]: info: No code
Apr 13 18:56:22 volumio volumio[901]: info: CoreStateMachine::pushState
Apr 13 18:56:22 volumio volumio[901]: info: CorePlayQueue::getTrack 0
Apr 13 18:56:22 volumio volumio[901]: info: CoreCommandRouter::volumioPushState
Apr 13 18:56:22 volumio volumio[901]: info: MRS: Pushing multiroomSync output update for this device
Apr 13 18:56:22 volumio volumio[901]: info: MRS: Pushing multiroomSync output
Apr 13 18:56:22 volumio volumio[901]: info: CoreCommandRouter::servicePushState
Apr 13 18:56:22 volumio volumio[901]: info: CoreStateMachine::pushState
Apr 13 18:56:22 volumio volumio[901]: info: CorePlayQueue::getTrack 0
Apr 13 18:56:22 volumio volumio[901]: info: CoreCommandRouter::volumioPushState
Apr 13 18:56:22 volumio volumio[901]: info: MRS: Pushing multiroomSync output update for this device
Apr 13 18:56:22 volumio volumio[901]: info: MRS: Pushing multiroomSync output
Apr 13 18:56:22 volumio volumio[901]: info: CorePlayQueue::getTrack 0
Apr 13 18:56:22 volumio volumio[901]: 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 13 18:56:22 volumio volumio[901]: verbose: CURRENT POSITION 0
Apr 13 18:56:22 volumio volumio[901]: info: CoreStateMachine::syncState   stateService stop
Apr 13 18:56:22 volumio volumio[901]: info: CoreStateMachine::syncState   currentStatus stop
Apr 13 18:56:22 volumio volumio[901]: info: CoreStateMachine::pushState
Apr 13 18:56:22 volumio volumio[901]: info: CorePlayQueue::getTrack 0
Apr 13 18:56:22 volumio volumio[901]: info: CoreCommandRouter::volumioPushState
Apr 13 18:56:22 volumio volumio[901]: info: MRS: Pushing multiroomSync output update for this device
Apr 13 18:56:22 volumio volumio[901]: info: MRS: Pushing multiroomSync output
Apr 13 18:56:22 volumio volumio[901]: info: No code
Apr 13 18:56:22 volumio volumio[901]: info: CoreStateMachine::pushState
Apr 13 18:56:22 volumio volumio[901]: info: CorePlayQueue::getTrack 0
Apr 13 18:56:22 volumio volumio[901]: info: CoreCommandRouter::volumioPushState
Apr 13 18:56:22 volumio volumio[901]: info: MRS: Pushing multiroomSync output update for this device
Apr 13 18:56:22 volumio volumio[901]: info: MRS: Pushing multiroomSync output
Apr 13 18:56:22 volumio sudo[2030]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service
Apr 13 18:56:22 volumio sudo[2030]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:22 volumio systemd[1]: Started MyVolumio SSH Tunnel.
Apr 13 18:56:22 volumio sudo[2030]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:22 volumio volumio[901]: info: Remote SSH Started
Apr 13 18:56:22 volumio autossh[2033]: port set to 0, monitoring disabled
Apr 13 18:56:22 volumio autossh[2033]: starting ssh (count 1)
Apr 13 18:56:22 volumio autossh[2033]: ssh child pid is 2036
Apr 13 18:56:22 volumio volumio[901]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 5
Apr 13 18:56:22 volumio volumio[901]: info: CoreCommandRouter::volumioGetState
Apr 13 18:56:22 volumio volumio[901]: info: CorePlayQueue::getTrack 0
Apr 13 18:56:22 volumio volumiossh-tunnel[2032]: Warning: Permanently added '[eu10.myvolumio.org]:2222,[46.101.141.203]:2222' (RSA) to the list of known hosts.
Apr 13 18:56:22 volumio sudo[2037]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio
Apr 13 18:56:22 volumio sudo[2037]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:22 volumio volumiobt[1992]: pulseaudio: no process found
Apr 13 18:56:22 volumio sudo[2037]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:22 volumio dbus-daemon[650]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.28' (uid=1000 pid=2041 comm="/usr/bin/pulseaudio --high-priority=true ")
Apr 13 18:56:22 volumio systemd[1]: Starting RealtimeKit Scheduling Policy Service...
Apr 13 18:56:22 volumio volumio[901]: ------------------------------------ BT MESSAGE: BT STATUS: running
Apr 13 18:56:22 volumio dbus-daemon[650]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1'
Apr 13 18:56:22 volumio systemd[1]: Started RealtimeKit Scheduling Policy Service.
Apr 13 18:56:22 volumio rtkit-daemon[2042]: Successfully called chroot.
Apr 13 18:56:22 volumio rtkit-daemon[2042]: Successfully dropped privileges.
Apr 13 18:56:22 volumio rtkit-daemon[2042]: Successfully limited resources.
Apr 13 18:56:22 volumio rtkit-daemon[2042]: Running.
Apr 13 18:56:22 volumio rtkit-daemon[2042]: Watchdog thread running.
Apr 13 18:56:22 volumio rtkit-daemon[2042]: Canary thread running.
Apr 13 18:56:22 volumio dbus-daemon[650]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.29' (uid=0 pid=2042 comm="/usr/lib/rtkit/rtkit-daemon ")
Apr 13 18:56:22 volumio systemd[1]: Starting Authorization Manager...
Apr 13 18:56:22 volumio volumio[901]: ------------------------------------ BT MESSAGE: BT STATUS: running
Apr 13 18:56:22 volumio polkitd[2045]: started daemon version 0.105 using authority implementation `local' version `0.105'
Apr 13 18:56:22 volumio dbus-daemon[650]: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
Apr 13 18:56:22 volumio systemd[1]: Started Authorization Manager.
Apr 13 18:56:22 volumio pulseaudio[2041]: Failed to open cookie file '/home/volumio/.config/pulse/cookie': No such file or directory
Apr 13 18:56:22 volumio pulseaudio[2041]: Failed to load authentication key '/home/volumio/.config/pulse/cookie': No such file or directory
Apr 13 18:56:22 volumio pulseaudio[2041]: Failed to open cookie file '/home/volumio/.pulse-cookie': No such file or directory
Apr 13 18:56:22 volumio pulseaudio[2041]: Failed to load authentication key '/home/volumio/.pulse-cookie': No such file or directory
Apr 13 18:56:22 volumio pulseaudio[2041]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
Apr 13 18:56:22 volumio pulseaudio[2041]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
Apr 13 18:56:22 volumio volumiobt[1992]: Applying permissions
Apr 13 18:56:22 volumio volumiobt[1992]: Setting BT discoverable and pairable
Apr 13 18:56:22 volumio bluetoothd[735]: Endpoint registered: sender=:1.49 path=/MediaEndpoint/A2DPSource
Apr 13 18:56:22 volumio bluetoothd[735]: Endpoint registered: sender=:1.49 path=/MediaEndpoint/A2DPSink
Apr 13 18:56:22 volumio pulseaudio[2041]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files
Apr 13 18:56:22 volumio kernel: Bluetooth: RFCOMM TTY layer initialized
Apr 13 18:56:22 volumio kernel: Bluetooth: RFCOMM socket layer initialized
Apr 13 18:56:22 volumio kernel: Bluetooth: RFCOMM ver 1.11
Apr 13 18:56:22 volumio volumiobt[1992]: [CHG] Controller D8:3A:DD:ED:EE:8D Class: 0x000c041c
Apr 13 18:56:22 volumio volumiobt[1992]: [55B blob data]
Apr 13 18:56:22 volumio volumiobt[1992]: [117B blob data]
Apr 13 18:56:22 volumio volumiobt[1992]: [117B blob data]
Apr 13 18:56:22 volumio volumiobt[1992]: [117B blob data]
Apr 13 18:56:22 volumio volumiobt[1992]: [117B blob data]
Apr 13 18:56:22 volumio volumiobt[1992]: [117B blob data]
Apr 13 18:56:22 volumio volumiobt[1992]: [117B blob data]
Apr 13 18:56:22 volumio volumiobt[1992]: [117B blob data]
Apr 13 18:56:22 volumio volumiobt[1992]: [117B blob data]
Apr 13 18:56:22 volumio volumiobt[1992]: [117B blob data]
Apr 13 18:56:22 volumio volumiobt[1992]: [bluetooth]# -e power on
Apr 13 18:56:22 volumio volumiobt[1992]: Invalid command in menu main: -e
Apr 13 18:56:22 volumio volumiobt[1992]: 
Apr 13 18:56:22 volumio volumiobt[1992]: Use "help" for a list of available commands in a menu.
Apr 13 18:56:22 volumio volumiobt[1992]: Use "menu " if you want to enter any submenu.
Apr 13 18:56:22 volumio volumiobt[1992]: Use "back" if you want to return to menu main.
Apr 13 18:56:22 volumio volumiobt[1992]: [bluetooth]# agent on
Apr 13 18:56:22 volumio volumiobt[1992]: Agent is already registered
Apr 13 18:56:22 volumio volumiobt[1992]: [bluetooth]# discoverable on
Apr 13 18:56:22 volumio volumiobt[1992]: [bluetooth]# pairable on
Apr 13 18:56:22 volumio volumiobt[1992]: [bluetooth]# agent NoInputNoOutput
Apr 13 18:56:22 volumio volumiobt[1992]: Agent is already registered
Apr 13 18:56:22 volumio volumiobt[1992]: [bluetooth]# default-agent
Apr 13 18:56:22 volumio volumiobt[1992]: [bluetooth]# quit
Apr 13 18:56:23 volumio volumiobt[1992]: [59B blob data]
Apr 13 18:56:23 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation
Apr 13 18:56:23 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware
Apr 13 18:56:23 volumio volumio[901]: xcb_connection_has_error() returned true
Apr 13 18:56:23 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray
Apr 13 18:56:23 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage
Apr 13 18:56:23 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware
Apr 13 18:56:23 volumio volumio[901]: xcb_connection_has_error() returned true
Apr 13 18:56:23 volumio volumio[901]: info: MRS: Getting audio outputs on start
Apr 13 18:56:23 volumio volumio[901]: info: MRS: Requesting all other devices output
Apr 13 18:56:24 volumio sudo[1925]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:24 volumio volumio[901]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Apr 13 18:56:24 volumio volumio[901]: info: CoreStateMachine::getcurrentVolume
Apr 13 18:56:24 volumio volumio[901]: info: CoreCommandRouter::volumioRetrievevolume
Apr 13 18:56:24 volumio volumio[901]: info: CoreStateMachine::pushState
Apr 13 18:56:24 volumio volumio[901]: info: CorePlayQueue::getTrack 0
Apr 13 18:56:24 volumio volumio[901]: info: CoreCommandRouter::volumioPushState
Apr 13 18:56:24 volumio volumio[901]: info: MRS: Pushing multiroomSync output update for this device
Apr 13 18:56:24 volumio volumio[901]: info: MRS: Pushing multiroomSync output
Apr 13 18:56:24 volumio volumio[901]: info: TidalConnect service started!
Apr 13 18:56:26 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction
Apr 13 18:56:26 volumio volumio[901]: info: CoreCommandRouter::Reload Ui
Apr 13 18:56:26 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , setShowWizard
Apr 13 18:56:26 volumio volumio[901]: info: Wizard terminated Successfully
Apr 13 18:56:26 volumio volumio[901]: info: CoreCommandRouter::volumiosetStartupVolume
Apr 13 18:56:26 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 13 18:56:27 volumio volumio[901]: verbose: New Socket.io Connection to 192.168.1.218 from 192.168.1.106 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:124.0) Gecko/20100101 Firefox/124.0 Total Clients: 5
Apr 13 18:56:27 volumio volumio[901]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 13 18:56:27 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 13 18:56:27 volumio volumio[901]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 13 18:56:27 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 13 18:56:27 volumio volumio[901]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 13 18:56:27 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 13 18:56:32 volumio sudo[2066]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 13 18:56:32 volumio sudo[2066]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:32 volumio sudo[2066]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:32 volumio sudo[2068]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 13 18:56:32 volumio sudo[2068]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:32 volumio sudo[2068]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:32 volumio volumio[901]: verbose: New Socket.io Connection to 192.168.1.218 from 192.168.1.106 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:124.0) Gecko/20100101 Firefox/124.0 Total Clients: 5
Apr 13 18:56:33 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule
Apr 13 18:56:33 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 13 18:56:33 volumio systemd[1]: systemd-timedated.service: Succeeded.
Apr 13 18:56:33 volumio volumio-remote-updater[653]: No test mode
Apr 13 18:56:33 volumio volumio-remote-updater[653]: No alpha test mode
Apr 13 18:56:33 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Apr 13 18:56:33 volumio volumio[901]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
\n\nFix for USB drive not mounted in some cases
\nFix albumart alignment on Manifest UI
\nRestored gpu settings in config.txt on pi
\nFix for wrong size of NAS and CIFS drives
\n
\nNEW ADDITIONS
\n\nPatched driver for Waveshare DSI displays on Pi
\nBump MPD to 0.23.15
\nUNSTABLE ALPHA BUILD - DO NOT INSTALL
\n\n","title":"Update v3.632","updateavailable":true}
Apr 13 18:56:33 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Apr 13 18:56:33 volumio sudo[2075]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 13 18:56:33 volumio sudo[2075]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:33 volumio sudo[2075]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:33 volumio sudo[2077]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 13 18:56:33 volumio sudo[2077]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 13 18:56:33 volumio sudo[2077]: pam_unix(sudo:session): session closed for user root
Apr 13 18:56:33 volumio volumio[901]: verbose: New Socket.io Connection to 192.168.1.218 from 192.168.1.106 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:124.0) Gecko/20100101 Firefox/124.0 Total Clients: 6
Apr 13 18:56:33 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 13 18:56:33 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 13 18:56:33 volumio volumio[901]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 13 18:56:33 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 13 18:56:33 volumio volumio[901]: info: CoreCommandRouter::volumioGetState
Apr 13 18:56:33 volumio volumio[901]: info: CorePlayQueue::getTrack 0
Apr 13 18:56:33 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Apr 13 18:56:33 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 13 18:56:33 volumio volumio[901]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Apr 13 18:56:33 volumio volumio[901]: info: Received Get System Info
Apr 13 18:56:33 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 13 18:56:33 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 13 18:56:33 volumio volumio[901]: info: Discovery: Getting this device information
Apr 13 18:56:33 volumio volumio[901]: info: CoreCommandRouter::volumioGetState
Apr 13 18:56:33 volumio volumio[901]: info: CorePlayQueue::getTrack 0
Apr 13 18:56:33 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 13 18:56:33 volumio volumio[901]: info: CoreCommandRouter::volumioGetState
Apr 13 18:56:33 volumio volumio[901]: info: CorePlayQueue::getTrack 0
Apr 13 18:56:33 volumio volumio[901]: info: Listing playlists
Apr 13 18:56:33 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Apr 13 18:56:33 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Apr 13 18:56:33 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Apr 13 18:56:34 volumio volumio[901]: info: CoreCommandRouter::volumioGetState
Apr 13 18:56:34 volumio volumio[901]: info: CorePlayQueue::getTrack 0
Apr 13 18:56:35 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 13 18:56:35 volumio volumio[901]: info: Received Get System Info
Apr 13 18:56:35 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 13 18:56:35 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 13 18:56:35 volumio volumio[901]: info: Discovery: Getting this device information
Apr 13 18:56:35 volumio volumio[901]: info: CoreCommandRouter::volumioGetState
Apr 13 18:56:35 volumio volumio[901]: info: CorePlayQueue::getTrack 0
Apr 13 18:56:35 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 13 18:56:36 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 13 18:56:36 volumio volumio[901]: info: Received Get System Info
Apr 13 18:56:36 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 13 18:56:36 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 13 18:56:36 volumio volumio[901]: info: Discovery: Getting this device information
Apr 13 18:56:36 volumio volumio[901]: info: CoreCommandRouter::volumioGetState
Apr 13 18:56:36 volumio volumio[901]: info: CorePlayQueue::getTrack 0
Apr 13 18:56:36 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 13 18:56:36 volumio volumio[901]: info: CoreCommandRouter::Close All Modals sent
Apr 13 18:56:36 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: appearance , setTOSAccepted
Apr 13 18:56:40 volumio volumio[901]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 13 18:56:40 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Apr 13 18:56:40 volumio volumio[901]: Disk list :  [ { device: 'nvme0n1', name: 'NVMe', size: '119.2G' } ]
Apr 13 18:56:40 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Apr 13 18:56:40 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Apr 13 18:56:40 volumio volumio[901]: info: Received Get System Version
Apr 13 18:56:40 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 13 18:56:48 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: system , installToDisk
Apr 13 18:56:48 volumio volumio[901]: info: CoreCommandRouter::executeOnPlugin: networkfs , disableDeviceActions
Apr 13 18:56:48 volumio volumio[901]: info: Mount handler: device actions disabled
Apr 13 18:56:48 volumio volumio[901]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 13 18:56:48 volumio volumio[901]: Error: ENOENT: no such file or directory, open '/boot/partconfig.json'
Apr 13 18:56:48 volumio volumio[901]:     at Object.openSync (fs.js:476:3)
Apr 13 18:56:48 volumio volumio[901]:     at Object.readFileSync (fs.js:377:35)
Apr 13 18:56:48 volumio volumio[901]:     at ControllerSystem.installToDisk (/volumio/app/plugins/system_controller/system/index.js:1089:22)
Apr 13 18:56:48 volumio volumio[901]:     at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1077:32)
Apr 13 18:56:48 volumio volumio[901]:     at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1747:44)
Apr 13 18:56:48 volumio volumio[901]:     at Socket.emit (events.js:315:20)
Apr 13 18:56:48 volumio volumio[901]:     at /volumio/node_modules/socket.io/lib/socket.js:503:12
Apr 13 18:56:48 volumio volumio[901]:     at processTicksAndRejections (internal/process/task_queues.js:75:11) {
Apr 13 18:56:48 volumio volumio[901]:   errno: -2,
Apr 13 18:56:48 volumio volumio[901]:   syscall: 'open',
Apr 13 18:56:48 volumio volumio[901]:   code: 'ENOENT',
Apr 13 18:56:48 volumio volumio[901]:   path: '/boot/partconfig.json'
Apr 13 18:56:48 volumio volumio[901]: }
Apr 13 18:56:48 volumio volumio[901]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 13 18:56:48 volumio sudo[2147]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-13 18:55
Apr 13 18:56:48 volumio sudo[2147]: 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="7c673b07907238212a131b497e21110246a68320"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="e831866afe2db61aee9333a8f5ba9d9fd36609c7"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 16 Feb 2024 02:00:11 PM CET"
VOLUMIO_VERSION="3.623"
VOLUMIO_HARDWARE="pi-uuid"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="594dd6d1d48ac435d55f868a032abffe"