-- Logs begin at Thu 2019-02-14 08:11:58 -02, end at Mon 2025-03-03 18:15:25 -03. -- Mar 03 18:14:02 volumio volumio-remote-updater[610]: No test mode Mar 03 18:14:02 volumio volumio-remote-updater[610]: No alpha test mode Mar 03 18:14:03 volumio volumio[906]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 03 18:14:03 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 03 18:14:05 volumio volumio[906]: info: CoreCommandRouter::Close All Modals sent Mar 03 18:14:08 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: wizard , openWizard Mar 03 18:14:08 volumio volumio[906]: info: CoreCommandRouter::Reload Ui Mar 03 18:14:08 volumio sudo[4466]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 03 18:14:08 volumio sudo[4466]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 18:14:08 volumio sudo[4464]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 03 18:14:08 volumio sudo[4464]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 18:14:08 volumio sudo[4466]: pam_unix(sudo:session): session closed for user root Mar 03 18:14:08 volumio sudo[4464]: pam_unix(sudo:session): session closed for user root Mar 03 18:14:08 volumio volumio[906]: verbose: New Socket.io Connection to 192.168.1.13 from 192.168.1.9 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_4 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 4 Mar 03 18:14:08 volumio volumio[906]: info: CoreCommandRouter::volumioGetVisibleSources Mar 03 18:14:08 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 03 18:14:08 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Mar 03 18:14:08 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Mar 03 18:14:08 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Mar 03 18:14:08 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Mar 03 18:14:08 volumio volumio[906]: info: Received Get System Info Mar 03 18:14:08 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 03 18:14:08 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 03 18:14:08 volumio volumio[906]: info: Discovery: Getting this device information Mar 03 18:14:08 volumio volumio[906]: info: CoreCommandRouter::volumioGetState Mar 03 18:14:08 volumio volumio[906]: info: CorePlayQueue::getTrack 0 Mar 03 18:14:08 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 03 18:14:08 volumio volumio-remote-updater[610]: No test mode Mar 03 18:14:08 volumio volumio-remote-updater[610]: No alpha test mode Mar 03 18:14:08 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 03 18:14:08 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 03 18:14:08 volumio volumio[906]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 03 18:14:08 volumio volumio[906]: info: Retrieving Cloud Streaming UI Mar 03 18:14:08 volumio volumio[906]: info: Getting Tidal Cloud Configuration Mar 03 18:14:08 volumio volumio[906]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 03 18:14:08 volumio volumio[906]: info: Getting Qobuz Cloud Configuration Mar 03 18:14:08 volumio volumio[906]: info: Asking plugin for UI Config Mar 03 18:14:08 volumio volumio[906]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 03 18:14:08 volumio volumio[906]: info: Getting Spotify Cloud Configuration Mar 03 18:14:08 volumio volumio[906]: info: Asking plugin for UI Config Mar 03 18:14:08 volumio volumio[906]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 03 18:14:08 volumio volumio[906]: info: Saving Spotify Acccount Mar 03 18:14:08 volumio volumio[906]: info: Got Tidal Cloud Configuration Mar 03 18:14:08 volumio volumio[906]: info: Got it Mar 03 18:14:08 volumio volumio[906]: info: Got it Mar 03 18:14:08 volumio volumio[906]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 03 18:14:08 volumio volumio[906]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 03 18:14:08 volumio volumio[906]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Mar 03 18:14:09 volumio volumio[906]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 03 18:14:09 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 03 18:14:09 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Mar 03 18:14:09 volumio volumio[906]: info: Loading i18n strings for locale it Mar 03 18:14:09 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Mar 03 18:14:09 volumio volumio[906]: info: Setting timezone to America/Sao_Paulo Mar 03 18:14:09 volumio sudo[4478]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Mar 03 18:14:09 volumio sudo[4478]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 18:14:09 volumio sudo[4478]: pam_unix(sudo:session): session closed for user root Mar 03 18:14:09 volumio sudo[4481]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/America/Sao_Paulo /etc/localtime Mar 03 18:14:09 volumio sudo[4481]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 18:14:09 volumio sudo[4481]: pam_unix(sudo:session): session closed for user root Mar 03 18:14:09 volumio sudo[4484]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Mar 03 18:14:09 volumio sudo[4484]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 18:14:09 volumio sudo[4484]: pam_unix(sudo:session): session closed for user root Mar 03 18:14:09 volumio sudo[4487]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone America/Sao_Paulo Mar 03 18:14:09 volumio sudo[4487]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 18:14:09 volumio dbus-daemon[609]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.34' (uid=0 pid=4488 comm="/usr/bin/timedatectl set-timezone America/Sao_Paul") Mar 03 18:14:10 volumio systemd[1]: Starting Time & Date Service... Mar 03 18:14:23 volumio volumio-remote-updater[610]: [2025-03-03 21:14:23] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] Mar 03 18:14:28 volumio volumio-remote-updater[610]: [2025-03-03 21:14:28] [connect] Successful connection Mar 03 18:14:35 volumio dbus-daemon[609]: [system] Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms) Mar 03 18:14:35 volumio sudo[4487]: pam_unix(sudo:session): session closed for user root Mar 03 18:14:35 volumio volumio[906]: Failed to set time zone: Connection timed out Mar 03 18:14:35 volumio volumio[906]: info: Could not set timezone, retrying Mar 03 18:14:35 volumio volumio[906]: info: Fetching Streaming Services browse cache Mar 03 18:14:35 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 03 18:14:35 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Mar 03 18:14:35 volumio volumio[906]: info: Loading i18n strings for locale it Mar 03 18:14:35 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Mar 03 18:14:35 volumio volumio[906]: info: Setting timezone to America/Sao_Paulo Mar 03 18:14:35 volumio sudo[4568]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Mar 03 18:14:35 volumio sudo[4568]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 18:14:35 volumio sudo[4568]: pam_unix(sudo:session): session closed for user root Mar 03 18:14:35 volumio sudo[4571]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/America/Sao_Paulo /etc/localtime Mar 03 18:14:35 volumio sudo[4571]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 18:14:35 volumio sudo[4571]: pam_unix(sudo:session): session closed for user root Mar 03 18:14:35 volumio sudo[4574]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Mar 03 18:14:35 volumio sudo[4574]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 18:14:35 volumio sudo[4574]: pam_unix(sudo:session): session closed for user root Mar 03 18:14:35 volumio sudo[4577]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone America/Sao_Paulo Mar 03 18:14:35 volumio sudo[4577]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 18:14:35 volumio dbus-daemon[609]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.35' (uid=0 pid=4578 comm="/usr/bin/timedatectl set-timezone America/Sao_Paul") Mar 03 18:14:40 volumio volumio-remote-updater[610]: [2025-03-03 21:14:40] [connect] Successful connection Mar 03 18:14:55 volumio volumio-remote-updater[610]: [2025-03-03 21:14:55] [connect] Successful connection Mar 03 18:15:00 volumio dbus-daemon[609]: [system] Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms) Mar 03 18:15:00 volumio sudo[4577]: pam_unix(sudo:session): session closed for user root Mar 03 18:15:00 volumio volumio[906]: Failed to set time zone: Connection timed out Mar 03 18:15:00 volumio volumio[906]: info: Could not set timezone, retrying Mar 03 18:15:00 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Mar 03 18:15:00 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Mar 03 18:15:00 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 03 18:15:00 volumio volumio[906]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 03 18:15:00 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 03 18:15:00 volumio volumio[906]: info: Received Get System Version Mar 03 18:15:00 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 03 18:15:00 volumio volumio[906]: info: Received Get System Info Mar 03 18:15:00 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 03 18:15:00 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 03 18:15:00 volumio volumio[906]: info: Discovery: Getting this device information Mar 03 18:15:00 volumio volumio[906]: info: CoreCommandRouter::volumioGetState Mar 03 18:15:00 volumio volumio[906]: info: CorePlayQueue::getTrack 0 Mar 03 18:15:00 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 03 18:15:00 volumio sudo[4632]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 03 18:15:00 volumio sudo[4632]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 18:15:00 volumio volumio[906]: info: Fetching Streaming Services browse cache Mar 03 18:15:00 volumio sudo[4635]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone America/Sao_Paulo Mar 03 18:15:00 volumio sudo[4635]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 03 18:15:00 volumio dbus-daemon[609]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.36' (uid=0 pid=4636 comm="/usr/bin/timedatectl set-timezone America/Sao_Paul") Mar 03 18:15:04 volumio sudo[4632]: pam_unix(sudo:session): session closed for user root Mar 03 18:15:10 volumio volumio-remote-updater[610]: [2025-03-03 21:15:10] [connect] Successful connection Mar 03 18:15:25 volumio dbus-daemon[609]: [system] Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms) Mar 03 18:15:25 volumio sudo[4635]: pam_unix(sudo:session): session closed for user root Mar 03 18:15:25 volumio volumio[906]: Failed to set time zone: Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms) Mar 03 18:15:25 volumio volumio[906]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 03 18:15:25 volumio volumio[906]: Error: Command failed: /usr/bin/sudo /usr/bin/timedatectl set-timezone 'America/Sao_Paulo' Mar 03 18:15:25 volumio volumio[906]: Failed to set time zone: Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms) Mar 03 18:15:25 volumio volumio[906]: at checkExecSyncError (child_process.js:616:11) Mar 03 18:15:25 volumio volumio[906]: at execSync (child_process.js:652:15) Mar 03 18:15:25 volumio volumio[906]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/system/index.js:1575:9) Mar 03 18:15:25 volumio volumio[906]: at listOnTimeout (internal/timers.js:554:17) Mar 03 18:15:25 volumio volumio[906]: at processTimers (internal/timers.js:497:7) { Mar 03 18:15:25 volumio volumio[906]: status: 1, Mar 03 18:15:25 volumio volumio[906]: signal: null, Mar 03 18:15:25 volumio volumio[906]: output: [ Mar 03 18:15:25 volumio volumio[906]: null, Mar 03 18:15:25 volumio volumio[906]: '', Mar 03 18:15:25 volumio volumio[906]: "Failed to set time zone: Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms)\n" Mar 03 18:15:25 volumio volumio[906]: ], Mar 03 18:15:25 volumio volumio[906]: pid: 4634, Mar 03 18:15:25 volumio volumio[906]: stdout: '', Mar 03 18:15:25 volumio volumio[906]: stderr: "Failed to set time zone: Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms)\n" Mar 03 18:15:25 volumio volumio[906]: } Mar 03 18:15:25 volumio volumio[906]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 03 18:15:25 volumio sudo[4722]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-03 18:14 Mar 03 18:15:25 volumio sudo[4722]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"