-- Logs begin at Thu 2019-02-14 10:11:59 WET, end at Thu 2025-07-17 20:09:29 WEST. -- Jul 17 20:08:07 volumio volumio-remote-updater[651]: No test mode Jul 17 20:08:07 volumio volumio-remote-updater[651]: No alpha test mode Jul 17 20:08:07 volumio volumio[1013]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jul 17 20:08:07 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jul 17 20:08:09 volumio volumio[1013]: info: CoreCommandRouter::Close All Modals sent Jul 17 20:08:22 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 17 20:08:22 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 17 20:08:22 volumio volumio[1013]: info: Discovery: Getting this device information Jul 17 20:08:22 volumio volumio[1013]: info: CoreCommandRouter::volumioGetState Jul 17 20:08:22 volumio volumio[1013]: info: CorePlayQueue::getTrack 7 Jul 17 20:08:22 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 17 20:08:26 volumio volumio[1013]: info: CALLMETHOD: system_controller system saveUpdateSettings [object Object] Jul 17 20:08:26 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: system , saveUpdateSettings Jul 17 20:08:26 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Jul 17 20:08:26 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 17 20:08:26 volumio volumio-remote-updater[651]: No test mode Jul 17 20:08:26 volumio volumio-remote-updater[651]: No alpha test mode Jul 17 20:08:26 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jul 17 20:08:26 volumio volumio[1013]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jul 17 20:08:26 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jul 17 20:08:27 volumio volumio[1013]: info: CALLMETHOD: system_controller system saveUpdateSettings [object Object] Jul 17 20:08:27 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: system , saveUpdateSettings Jul 17 20:08:27 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Jul 17 20:08:27 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 17 20:08:27 volumio volumio-remote-updater[651]: No test mode Jul 17 20:08:27 volumio volumio-remote-updater[651]: No alpha test mode Jul 17 20:08:27 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jul 17 20:08:27 volumio volumio[1013]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jul 17 20:08:27 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jul 17 20:08:27 volumio volumio[1013]: info: CALLMETHOD: system_controller system saveUpdateSettings [object Object] Jul 17 20:08:27 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: system , saveUpdateSettings Jul 17 20:08:27 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Jul 17 20:08:27 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 17 20:08:27 volumio volumio-remote-updater[651]: No test mode Jul 17 20:08:27 volumio volumio-remote-updater[651]: No alpha test mode Jul 17 20:08:27 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jul 17 20:08:28 volumio volumio[1013]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jul 17 20:08:28 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jul 17 20:08:33 volumio volumio[1013]: info: CALLMETHOD: system_controller system savePrivacySettings [object Object] Jul 17 20:08:33 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: system , savePrivacySettings Jul 17 20:08:33 volumio volumio[1013]: info: CoreCommandRouter::Reload Ui Jul 17 20:08:34 volumio sudo[14551]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 17 20:08:34 volumio sudo[14551]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:08:34 volumio sudo[14553]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 17 20:08:34 volumio sudo[14553]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:08:34 volumio sudo[14551]: pam_unix(sudo:session): session closed for user root Jul 17 20:08:34 volumio sudo[14553]: pam_unix(sudo:session): session closed for user root Jul 17 20:08:34 volumio volumio[1013]: verbose: New Socket.io Connection to 192.168.1.81 from 192.168.1.71 UA: Mozilla/5.0 (Linux; Android 14; SM-A346B Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/138.0.7204.67 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Jul 17 20:08:34 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 17 20:08:34 volumio volumio[1013]: info: CoreCommandRouter::volumioGetVisibleSources Jul 17 20:08:34 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 17 20:08:34 volumio volumio[1013]: info: CoreCommandRouter::volumioGetState Jul 17 20:08:34 volumio volumio[1013]: info: CorePlayQueue::getTrack 7 Jul 17 20:08:34 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 17 20:08:34 volumio volumio[1013]: info: CoreCommandRouter::volumioGetQueue Jul 17 20:08:34 volumio volumio[1013]: info: CoreStateMachine::getQueue Jul 17 20:08:34 volumio volumio[1013]: info: CorePlayQueue::getQueue Jul 17 20:08:34 volumio volumio[1013]: info: Listing playlists Jul 17 20:08:34 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 17 20:08:34 volumio volumio[1013]: info: Received Get System Info Jul 17 20:08:34 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 17 20:08:34 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 17 20:08:34 volumio volumio[1013]: info: Discovery: Getting this device information Jul 17 20:08:34 volumio volumio[1013]: info: CoreCommandRouter::volumioGetState Jul 17 20:08:34 volumio volumio[1013]: info: CorePlayQueue::getTrack 7 Jul 17 20:08:34 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 17 20:08:34 volumio volumio[1013]: info: CoreCommandRouter::volumioGetState Jul 17 20:08:34 volumio volumio[1013]: info: CorePlayQueue::getTrack 7 Jul 17 20:08:34 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 17 20:08:34 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 17 20:08:34 volumio sudo[14557]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 17 20:08:34 volumio sudo[14557]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:08:34 volumio sudo[14557]: pam_unix(sudo:session): session closed for user root Jul 17 20:08:34 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 17 20:08:34 volumio sudo[14560]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 17 20:08:34 volumio sudo[14560]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:08:34 volumio sudo[14560]: pam_unix(sudo:session): session closed for user root Jul 17 20:08:35 volumio volumio[1013]: verbose: New Socket.io Connection to 192.168.1.81 from 192.168.1.71 UA: Mozilla/5.0 (Linux; Android 14; SM-A346B Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/138.0.7204.67 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Jul 17 20:08:35 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 17 20:08:35 volumio volumio[1013]: info: CoreCommandRouter::volumioGetVisibleSources Jul 17 20:08:35 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 17 20:08:35 volumio volumio[1013]: info: CoreCommandRouter::volumioGetState Jul 17 20:08:35 volumio volumio[1013]: info: CorePlayQueue::getTrack 7 Jul 17 20:08:35 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 17 20:08:35 volumio volumio[1013]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 17 20:08:35 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 17 20:08:35 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 17 20:08:35 volumio volumio[1013]: info: Received Get System Info Jul 17 20:08:35 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 17 20:08:35 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 17 20:08:35 volumio volumio[1013]: info: Discovery: Getting this device information Jul 17 20:08:35 volumio volumio[1013]: info: CoreCommandRouter::volumioGetState Jul 17 20:08:35 volumio volumio[1013]: info: CorePlayQueue::getTrack 7 Jul 17 20:08:35 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 17 20:08:35 volumio volumio[1013]: info: CoreCommandRouter::volumioGetState Jul 17 20:08:35 volumio volumio[1013]: info: CorePlayQueue::getTrack 7 Jul 17 20:08:35 volumio volumio[1013]: info: Listing playlists Jul 17 20:08:35 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 17 20:08:35 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 17 20:08:35 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 17 20:08:35 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 17 20:08:35 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 17 20:08:35 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Jul 17 20:08:35 volumio volumio[1013]: info: Received Get System Version Jul 17 20:08:35 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 17 20:08:36 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jul 17 20:08:36 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 17 20:08:36 volumio volumio[1013]: info: Received Get System Info Jul 17 20:08:36 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 17 20:08:36 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 17 20:08:36 volumio volumio[1013]: info: Discovery: Getting this device information Jul 17 20:08:36 volumio volumio[1013]: info: CoreCommandRouter::volumioGetState Jul 17 20:08:36 volumio volumio[1013]: info: CorePlayQueue::getTrack 7 Jul 17 20:08:36 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 17 20:08:37 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jul 17 20:08:37 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 17 20:08:37 volumio volumio[1013]: info: Received Get System Info Jul 17 20:08:37 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 17 20:08:37 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 17 20:08:37 volumio volumio[1013]: info: Discovery: Getting this device information Jul 17 20:08:37 volumio volumio[1013]: info: CoreCommandRouter::volumioGetState Jul 17 20:08:37 volumio volumio[1013]: info: CorePlayQueue::getTrack 7 Jul 17 20:08:37 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 17 20:08:37 volumio volumio[1013]: info: CALLMETHOD: system_controller system setLanguageTimezone [object Object] Jul 17 20:08:37 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: system , setLanguageTimezone Jul 17 20:08:37 volumio volumio[1013]: info: Setting timezone to Europe/Lisbon Jul 17 20:08:37 volumio sudo[14577]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Jul 17 20:08:37 volumio sudo[14577]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:08:37 volumio sudo[14577]: pam_unix(sudo:session): session closed for user root Jul 17 20:08:37 volumio sudo[14581]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Lisbon /etc/localtime Jul 17 20:08:37 volumio sudo[14581]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:08:37 volumio sudo[14581]: pam_unix(sudo:session): session closed for user root Jul 17 20:08:37 volumio systemd[1]: Starting Daily apt upgrade and clean activities... Jul 17 20:08:37 volumio sudo[14584]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Jul 17 20:08:37 volumio sudo[14584]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:08:37 volumio sudo[14584]: pam_unix(sudo:session): session closed for user root Jul 17 20:08:37 volumio sudo[14589]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Lisbon Jul 17 20:08:37 volumio sudo[14589]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:08:37 volumio dbus-daemon[690]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.15' (uid=0 pid=14591 comm="/usr/bin/timedatectl set-timezone Europe/Lisbon ") Jul 17 20:08:37 volumio systemd[1]: Starting Time & Date Service... Jul 17 20:08:37 volumio kernel: dwc_otg 3f980000.usb: dev 1.4 ep1in scatterlist error -121/-121 Jul 17 20:08:39 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. Jul 17 20:08:39 volumio systemd[1]: Started Daily apt upgrade and clean activities. Jul 17 20:08:43 volumio volumio-remote-updater[651]: [2025-07-17 20:08:43] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] Jul 17 20:08:48 volumio volumio-remote-updater[651]: [2025-07-17 20:08:48] [connect] Successful connection Jul 17 20:09:00 volumio volumio-remote-updater[651]: [2025-07-17 20:09:00] [connect] Successful connection Jul 17 20:09:02 volumio dbus-daemon[690]: [system] Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms) Jul 17 20:09:02 volumio sudo[14589]: pam_unix(sudo:session): session closed for user root Jul 17 20:09:02 volumio volumio[1013]: Failed to set time zone: Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms) Jul 17 20:09:02 volumio volumio[1013]: info: Could not set timezone, retrying Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Jul 17 20:09:02 volumio volumio[1013]: info: Loading i18n strings for locale pt Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 17 20:09:02 volumio volumio[1013]: info: Received Get System Info Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 17 20:09:02 volumio volumio[1013]: info: Discovery: Getting this device information Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::volumioGetState Jul 17 20:09:02 volumio volumio[1013]: info: CorePlayQueue::getTrack 7 Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 17 20:09:02 volumio volumio[1013]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jul 17 20:09:02 volumio volumio[1013]: info: Received Get System Version Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 17 20:09:02 volumio volumio[1013]: info: Received Get System Info Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 17 20:09:02 volumio volumio[1013]: info: Discovery: Getting this device information Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::volumioGetState Jul 17 20:09:02 volumio volumio[1013]: info: CorePlayQueue::getTrack 7 Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 17 20:09:02 volumio volumio[1013]: info: CALLMETHOD: miscellanea appearance setVolumio3UI [object Object] Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: appearance , setVolumio3UI Jul 17 20:09:02 volumio volumio[1013]: info: Setting active UI to: {"uiPrettyName":"Contemporary","uiName":"contemporary","uiPath":"/volumio/http/www3"} Jul 17 20:09:02 volumio volumio[1013]: info: CALLMETHOD: miscellanea appearance setVolumio3UI [object Object] Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: appearance , setVolumio3UI Jul 17 20:09:02 volumio volumio[1013]: info: Setting active UI to: {"uiPrettyName":"Manifest","uiName":"manifest","uiPath":"/volumio/http/www4"} Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::volumioPlay Jul 17 20:09:02 volumio volumio[1013]: info: CoreStateMachine::play index undefined Jul 17 20:09:02 volumio volumio[1013]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 17 20:09:02 volumio volumio[1013]: info: CorePlayQueue::getTrack 7 Jul 17 20:09:02 volumio volumio[1013]: info: CoreStateMachine::startPlaybackTimer Jul 17 20:09:02 volumio volumio[1013]: info: CorePlayQueue::getTrack 7 Jul 17 20:09:02 volumio volumio[1013]: verbose: ControllerMpd::clearAddPlayTracks USB/ROCK/01.Rock/Dire Straits - Brothers In Arms 1986/08 - One World.flac Jul 17 20:09:02 volumio volumio[1013]: verbose: ControllerMpd::sendMpdCommand stop Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 17 20:09:02 volumio volumio[1013]: info: Received Get System Info Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 17 20:09:02 volumio volumio[1013]: info: Discovery: Getting this device information Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::volumioGetState Jul 17 20:09:02 volumio volumio[1013]: info: CorePlayQueue::getTrack 7 Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 17 20:09:02 volumio volumio[1013]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jul 17 20:09:02 volumio volumio[1013]: info: Received Get System Version Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 17 20:09:02 volumio volumio[1013]: info: Received Get System Info Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 17 20:09:02 volumio volumio[1013]: info: Discovery: Getting this device information Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::volumioGetState Jul 17 20:09:02 volumio volumio[1013]: info: CorePlayQueue::getTrack 7 Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::volumioGetState Jul 17 20:09:02 volumio volumio[1013]: info: CorePlayQueue::getTrack 7 Jul 17 20:09:02 volumio sudo[14726]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /data/active_volumio_ui Jul 17 20:09:02 volumio sudo[14726]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:09:02 volumio sudo[14726]: pam_unix(sudo:session): session closed for user root Jul 17 20:09:02 volumio sudo[14729]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /data/active_volumio_ui Jul 17 20:09:02 volumio sudo[14729]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:09:02 volumio sudo[14729]: pam_unix(sudo:session): session closed for user root Jul 17 20:09:02 volumio volumio[1013]: info: sendMpdCommand stop took 140 milliseconds Jul 17 20:09:02 volumio volumio[1013]: verbose: ControllerMpd::sendMpdCommand clear Jul 17 20:09:02 volumio volumio-remote-updater[651]: [2025-07-17 20:09:02] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1752779340 101 Jul 17 20:09:02 volumio volumio[1013]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 5 Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 17 20:09:02 volumio volumio[1013]: info: Discovery: Getting this device information Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::volumioGetState Jul 17 20:09:02 volumio volumio[1013]: info: CorePlayQueue::getTrack 7 Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 17 20:09:02 volumio volumio[1013]: info: Discovery: Getting this device information Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::volumioGetState Jul 17 20:09:02 volumio volumio[1013]: info: CorePlayQueue::getTrack 7 Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 17 20:09:02 volumio volumio[1013]: info: Jul 17 20:09:02 volumio volumio[1013]: ---------------------------- MPD announces system playlist update Jul 17 20:09:02 volumio volumio[1013]: info: Ignoring MPD Status Update Jul 17 20:09:02 volumio volumio[1013]: info: sendMpdCommand clear took 32 milliseconds Jul 17 20:09:02 volumio volumio[1013]: verbose: ControllerMpd::sendMpdCommand add "USB/ROCK/01.Rock/Dire Straits - Brothers In Arms 1986/08 - One World.flac" Jul 17 20:09:02 volumio volumio[1013]: info: Jul 17 20:09:02 volumio volumio[1013]: ---------------------------- MPD announces system playlist update Jul 17 20:09:02 volumio volumio[1013]: info: Ignoring MPD Status Update Jul 17 20:09:02 volumio volumio[1013]: info: Jul 17 20:09:02 volumio volumio[1013]: ---------------------------- MPD announces system playlist update Jul 17 20:09:02 volumio volumio[1013]: info: Ignoring MPD Status Update Jul 17 20:09:02 volumio volumio[1013]: Updating browse sources language Jul 17 20:09:02 volumio volumio[1013]: Cannot find translation for source YouTube2 Jul 17 20:09:02 volumio volumio[1013]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 17 20:09:02 volumio volumio[1013]: Cannot find translation for source YouTube2 Jul 17 20:09:02 volumio volumio[1013]: error: updateQueue error: null Jul 17 20:09:02 volumio volumio[1013]: info: Jul 17 20:09:02 volumio volumio[1013]: ---------------------------- MPD announces system playlist update Jul 17 20:09:02 volumio volumio[1013]: info: Ignoring MPD Status Update Jul 17 20:09:02 volumio volumio[1013]: info: ------------------------------ 41ms Jul 17 20:09:02 volumio volumio[1013]: info: sendMpdCommand add "USB/ROCK/01.Rock/Dire Straits - Brothers In Arms 1986/08 - One World.flac" took 40 milliseconds Jul 17 20:09:02 volumio volumio[1013]: info: ------------------------------ 37ms Jul 17 20:09:02 volumio volumio[1013]: info: ------------------------------ 37ms Jul 17 20:09:02 volumio volumio[1013]: verbose: ControllerMpd::sendMpdCommand play Jul 17 20:09:02 volumio volumio[1013]: info: Jul 17 20:09:02 volumio volumio[1013]: ---------------------------- MPD announces system playlist update Jul 17 20:09:02 volumio volumio[1013]: info: Ignoring MPD Status Update Jul 17 20:09:02 volumio volumio[1013]: info: Jul 17 20:09:02 volumio volumio[1013]: ---------------------------- MPD announces system playlist update Jul 17 20:09:02 volumio volumio[1013]: info: Ignoring MPD Status Update Jul 17 20:09:02 volumio volumio[1013]: info: ------------------------------ 8ms Jul 17 20:09:02 volumio volumio[1013]: info: sendMpdCommand play took 5 milliseconds Jul 17 20:09:02 volumio volumio[1013]: info: ------------------------------ 5ms Jul 17 20:09:02 volumio volumio[1013]: info: ------------------------------ 4ms Jul 17 20:09:03 volumio volumio[1013]: info: Fetching Streaming Services browse cache Jul 17 20:09:03 volumio sudo[14732]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 17 20:09:03 volumio sudo[14732]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:09:03 volumio sudo[14732]: pam_unix(sudo:session): session closed for user root Jul 17 20:09:03 volumio sudo[14735]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 17 20:09:03 volumio sudo[14735]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:09:03 volumio sudo[14735]: pam_unix(sudo:session): session closed for user root Jul 17 20:09:03 volumio volumio[1013]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jul 17 20:09:03 volumio sudo[14738]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Lisbon Jul 17 20:09:03 volumio sudo[14738]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 17 20:09:03 volumio dbus-daemon[690]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.16' (uid=0 pid=14739 comm="/usr/bin/timedatectl set-timezone Europe/Lisbon ") Jul 17 20:09:08 volumio kernel: usb 1-1.4: reset high-speed USB device number 5 using dwc_otg Jul 17 20:09:08 volumio kernel: sd 1:0:0:0: [sdb] Unaligned partial completion (resid=65519, sector_sz=512) Jul 17 20:09:08 volumio kernel: sd 1:0:0:0: [sdb] tag#0 CDB: opcode=0x28 28 00 00 00 00 41 00 00 80 00 Jul 17 20:09:08 volumio kernel: scsi_io_completion_action: 6 callbacks suppressed Jul 17 20:09:08 volumio kernel: sd 1:0:0:0: [sdb] tag#0 UNKNOWN(0x2003) Result: hostbyte=0x03 driverbyte=DRIVER_OK cmd_age=30s Jul 17 20:09:08 volumio kernel: sd 1:0:0:0: [sdb] tag#0 CDB: opcode=0x28 28 00 00 00 00 41 00 00 80 00 Jul 17 20:09:08 volumio kernel: blk_print_req_error: 6 callbacks suppressed Jul 17 20:09:08 volumio kernel: I/O error, dev sdb, sector 65 op 0x0:(READ) flags 0x84700 phys_seg 128 prio class 2 Jul 17 20:09:09 volumio kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Jul 17 20:09:28 volumio dbus-daemon[690]: [system] Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms) Jul 17 20:09:28 volumio sudo[14738]: pam_unix(sudo:session): session closed for user root Jul 17 20:09:28 volumio volumio[1013]: Failed to set time zone: Connection timed out Jul 17 20:09:28 volumio volumio[1013]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 17 20:09:28 volumio volumio[1013]: Error: Command failed: /usr/bin/sudo /usr/bin/timedatectl set-timezone 'Europe/Lisbon' Jul 17 20:09:28 volumio volumio[1013]: Failed to set time zone: Connection timed out Jul 17 20:09:28 volumio volumio[1013]: at checkExecSyncError (child_process.js:616:11) Jul 17 20:09:28 volumio volumio[1013]: at execSync (child_process.js:652:15) Jul 17 20:09:28 volumio volumio[1013]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/system/index.js:1680:9) Jul 17 20:09:28 volumio volumio[1013]: at listOnTimeout (internal/timers.js:554:17) Jul 17 20:09:28 volumio volumio[1013]: at processTimers (internal/timers.js:497:7) { Jul 17 20:09:28 volumio volumio[1013]: status: 1, Jul 17 20:09:28 volumio volumio[1013]: signal: null, Jul 17 20:09:28 volumio volumio[1013]: output: [ null, '', 'Failed to set time zone: Connection timed out\n' ], Jul 17 20:09:28 volumio volumio[1013]: pid: 14737, Jul 17 20:09:28 volumio volumio[1013]: stdout: '', Jul 17 20:09:28 volumio volumio[1013]: stderr: 'Failed to set time zone: Connection timed out\n' Jul 17 20:09:28 volumio volumio[1013]: } Jul 17 20:09:28 volumio volumio[1013]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 17 20:09:29 volumio sudo[14797]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-17 20:08 Jul 17 20:09:29 volumio sudo[14797]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="811ff8312d42f9da0260be1d353081a805678820" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 02 Jul 2025 04:07:25 PM CEST" VOLUMIO_VERSION="3.819" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3b9115b1943141a9d7186aa434f8f3c2"