-- Logs begin at Thu 2019-02-14 04:11:58 CST, end at Thu 2025-07-03 08:07:28 CDT. --
Jul 03 08:06:01 volumio volumio[847]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 03 08:06:01 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Jul 03 08:06:01 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Jul 03 08:06:01 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs
Jul 03 08:06:01 volumio volumio[847]: info: Received Get System Version
Jul 03 08:06:01 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 03 08:06:01 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: appearance , getBackgrounds
Jul 03 08:06:04 volumio nmbd[722]: [2025/07/03 08:06:04.241709, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Jul 03 08:06:04 volumio nmbd[722]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.146 for name WORKGROUP<1d>.
Jul 03 08:06:04 volumio nmbd[722]: This response was from IP 192.168.1.137, reporting an IP address of 192.168.1.137.
Jul 03 08:06:05 volumio volumio[847]: info: Volumio Network Manager: Network status updated: 1
Jul 03 08:06:06 volumio sudo[25454]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jul 03 08:06:06 volumio sudo[25454]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 03 08:06:06 volumio sudo[25454]: pam_unix(sudo:session): session closed for user root
Jul 03 08:06:06 volumio sudo[25457]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jul 03 08:06:06 volumio sudo[25457]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 03 08:06:06 volumio sudo[25457]: pam_unix(sudo:session): session closed for user root
Jul 03 08:06:06 volumio sudo[25460]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Jul 03 08:06:06 volumio sudo[25460]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 03 08:06:06 volumio sudo[25460]: pam_unix(sudo:session): session closed for user root
Jul 03 08:06:06 volumio volumio[847]: info: Upmpdcli Daemon Started
Jul 03 08:06:06 volumio sudo[25463]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jul 03 08:06:06 volumio sudo[25463]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 03 08:06:06 volumio sudo[25463]: pam_unix(sudo:session): session closed for user root
Jul 03 08:06:06 volumio sudo[25466]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jul 03 08:06:06 volumio sudo[25466]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 03 08:06:06 volumio sudo[25466]: pam_unix(sudo:session): session closed for user root
Jul 03 08:06:06 volumio sudo[25469]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Jul 03 08:06:06 volumio sudo[25469]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 03 08:06:06 volumio sudo[25469]: pam_unix(sudo:session): session closed for user root
Jul 03 08:06:06 volumio volumio[847]: info: Upmpdcli Daemon Started
Jul 03 08:06:08 volumio ntpd[743]: Soliciting pool server 2604:4500:6:7c9::186
Jul 03 08:06:08 volumio ntpd[743]: Soliciting pool server 144.202.41.38
Jul 03 08:06:10 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: wizard , openWizard
Jul 03 08:06:10 volumio volumio[847]: info: CoreCommandRouter::Reload Ui
Jul 03 08:06:10 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps
Jul 03 08:06:10 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode
Jul 03 08:06:10 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages
Jul 03 08:06:10 volumio sudo[25475]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jul 03 08:06:10 volumio sudo[25475]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 03 08:06:10 volumio sudo[25475]: pam_unix(sudo:session): session closed for user root
Jul 03 08:06:11 volumio sudo[25478]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jul 03 08:06:11 volumio sudo[25478]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 03 08:06:11 volumio sudo[25478]: pam_unix(sudo:session): session closed for user root
Jul 03 08:06:11 volumio volumio[847]: verbose: New Socket.io Connection to 192.168.1.204 from 192.168.1.195 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5
Jul 03 08:06:11 volumio volumio[847]: info: CoreCommandRouter::volumioGetVisibleSources
Jul 03 08:06:11 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 03 08:06:11 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps
Jul 03 08:06:11 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode
Jul 03 08:06:11 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages
Jul 03 08:06:11 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones
Jul 03 08:06:11 volumio volumio[847]: info: Received Get System Info
Jul 03 08:06:11 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 03 08:06:11 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 03 08:06:11 volumio volumio[847]: info: Discovery: Getting this device information
Jul 03 08:06:11 volumio volumio[847]: info: CoreCommandRouter::volumioGetState
Jul 03 08:06:11 volumio volumio[847]: info: CorePlayQueue::getTrack 0
Jul 03 08:06:11 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 03 08:06:11 volumio volumio-remote-updater[618]: No test mode
Jul 03 08:06:11 volumio volumio-remote-updater[618]: No alpha test mode
Jul 03 08:06:11 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Jul 03 08:06:11 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jul 03 08:06:11 volumio volumio[847]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 03 08:06:11 volumio volumio[847]: info: Retrieving Cloud Streaming UI
Jul 03 08:06:11 volumio volumio[847]: info: Getting Tidal Cloud Configuration
Jul 03 08:06:11 volumio volumio[847]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 03 08:06:11 volumio volumio[847]: info: Getting Qobuz Cloud Configuration
Jul 03 08:06:11 volumio volumio[847]: info: Asking plugin for UI Config
Jul 03 08:06:11 volumio volumio[847]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 03 08:06:11 volumio volumio[847]: info: Getting Spotify Cloud Configuration
Jul 03 08:06:11 volumio volumio[847]: info: Asking plugin for UI Config
Jul 03 08:06:11 volumio volumio[847]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 03 08:06:11 volumio volumio[847]: info: Saving Spotify Acccount
Jul 03 08:06:11 volumio volumio[847]: info: Got Tidal Cloud Configuration
Jul 03 08:06:11 volumio volumio[847]: info: Got it
Jul 03 08:06:11 volumio volumio[847]: info: Got it
Jul 03 08:06:11 volumio volumio[847]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Jul 03 08:06:11 volumio volumio[847]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 03 08:06:11 volumio volumio[847]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
Jul 03 08:06:11 volumio volumio[847]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
\n\n- Disable UI controls during DLNA playback
\n- Fix for Cast functionality halting due to memory filling up
\n- Fix for XML parsing on web-radio search
\n
\nNEW ADDITIONS
\n\n- Add link for downloading CORRD in the side-menu
\n
\n","title":"Update v3.819","updateavailable":true}
Jul 03 08:06:11 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Jul 03 08:06:12 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage
Jul 03 08:06:12 volumio volumio[847]: info: Loading i18n strings for locale en
Jul 03 08:06:12 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone
Jul 03 08:06:12 volumio volumio[847]: info: Setting timezone to America/Chicago
Jul 03 08:06:12 volumio sudo[25488]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime
Jul 03 08:06:12 volumio sudo[25488]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 03 08:06:12 volumio sudo[25488]: pam_unix(sudo:session): session closed for user root
Jul 03 08:06:12 volumio sudo[25492]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/America/Chicago /etc/localtime
Jul 03 08:06:12 volumio sudo[25492]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 03 08:06:12 volumio sudo[25492]: pam_unix(sudo:session): session closed for user root
Jul 03 08:06:12 volumio systemd[1]: Starting Daily apt download activities...
Jul 03 08:06:12 volumio sudo[25495]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime
Jul 03 08:06:12 volumio sudo[25495]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 03 08:06:12 volumio sudo[25495]: pam_unix(sudo:session): session closed for user root
Jul 03 08:06:12 volumio sudo[25498]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone America/Chicago
Jul 03 08:06:12 volumio sudo[25498]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 03 08:06:12 volumio dbus-daemon[624]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.39' (uid=0 pid=25500 comm="/usr/bin/timedatectl set-timezone America/Chicago ")
Jul 03 08:06:12 volumio systemd[1]: Starting Time & Date Service...
Jul 03 08:06:12 volumio systemd[1]: apt-daily.service: Succeeded.
Jul 03 08:06:12 volumio systemd[1]: Started Daily apt download activities.
Jul 03 08:06:37 volumio dbus-daemon[624]: [system] Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms)
Jul 03 08:06:37 volumio sudo[25498]: pam_unix(sudo:session): session closed for user root
Jul 03 08:06:37 volumio volumio[847]: Failed to set time zone: Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms)
Jul 03 08:06:37 volumio volumio[847]: info: Could not set timezone, retrying
Jul 03 08:06:37 volumio volumio[847]: info: Fetching Streaming Services browse cache
Jul 03 08:06:37 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jul 03 08:06:37 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Jul 03 08:06:37 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage
Jul 03 08:06:37 volumio volumio[847]: info: Loading i18n strings for locale en
Jul 03 08:06:37 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone
Jul 03 08:06:37 volumio volumio[847]: info: Setting timezone to America/Chicago
Jul 03 08:06:37 volumio sudo[25596]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime
Jul 03 08:06:37 volumio sudo[25596]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 03 08:06:37 volumio sudo[25596]: pam_unix(sudo:session): session closed for user root
Jul 03 08:06:37 volumio sudo[25599]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/America/Chicago /etc/localtime
Jul 03 08:06:37 volumio sudo[25599]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 03 08:06:37 volumio sudo[25599]: pam_unix(sudo:session): session closed for user root
Jul 03 08:06:37 volumio sudo[25602]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime
Jul 03 08:06:37 volumio sudo[25602]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 03 08:06:37 volumio sudo[25602]: pam_unix(sudo:session): session closed for user root
Jul 03 08:06:37 volumio sudo[25605]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone America/Chicago
Jul 03 08:06:37 volumio sudo[25605]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 03 08:06:37 volumio dbus-daemon[624]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.40' (uid=0 pid=25606 comm="/usr/bin/timedatectl set-timezone America/Chicago ")
Jul 03 08:06:37 volumio volumio-remote-updater[618]: [2025-07-03 13:06:37] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006]
Jul 03 08:06:42 volumio volumio-remote-updater[618]: [2025-07-03 13:06:42] [connect] Successful connection
Jul 03 08:06:55 volumio volumio-remote-updater[618]: [2025-07-03 13:06:55] [connect] Successful connection
Jul 03 08:07:02 volumio dbus-daemon[624]: [system] Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms)
Jul 03 08:07:02 volumio sudo[25605]: pam_unix(sudo:session): session closed for user root
Jul 03 08:07:02 volumio volumio[847]: Failed to set time zone: Connection timed out
Jul 03 08:07:02 volumio volumio[847]: info: Could not set timezone, retrying
Jul 03 08:07:02 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
Jul 03 08:07:02 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
Jul 03 08:07:02 volumio volumio[847]: info: Update: [object Object]
Jul 03 08:07:02 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: updater_comm , checkSystemIntegrity
Jul 03 08:07:02 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 03 08:07:02 volumio volumio[847]: info: Update: [object Object]
Jul 03 08:07:02 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: updater_comm , checkSystemIntegrity
Jul 03 08:07:02 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 03 08:07:02 volumio volumio[847]: info: Update: [object Object]
Jul 03 08:07:02 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: updater_comm , checkSystemIntegrity
Jul 03 08:07:02 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 03 08:07:02 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jul 03 08:07:02 volumio volumio[847]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Jul 03 08:07:02 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Jul 03 08:07:02 volumio volumio[847]: info: Received Get System Version
Jul 03 08:07:02 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 03 08:07:02 volumio volumio[847]: info: Received Get System Info
Jul 03 08:07:02 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jul 03 08:07:02 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jul 03 08:07:02 volumio volumio[847]: info: Discovery: Getting this device information
Jul 03 08:07:02 volumio volumio[847]: info: CoreCommandRouter::volumioGetState
Jul 03 08:07:02 volumio volumio[847]: info: CorePlayQueue::getTrack 0
Jul 03 08:07:02 volumio volumio[847]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jul 03 08:07:02 volumio volumio[847]: info: Fetching Streaming Services browse cache
Jul 03 08:07:02 volumio sudo[25708]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone America/Chicago
Jul 03 08:07:02 volumio sudo[25708]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 03 08:07:02 volumio dbus-daemon[624]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.41' (uid=0 pid=25709 comm="/usr/bin/timedatectl set-timezone America/Chicago ")
Jul 03 08:07:10 volumio volumio-remote-updater[618]: [2025-07-03 13:07:10] [connect] Successful connection
Jul 03 08:07:25 volumio volumio-remote-updater[618]: [2025-07-03 13:07:25] [connect] Successful connection
Jul 03 08:07:27 volumio dbus-daemon[624]: [system] Failed to activate service 'org.freedesktop.timedate1': timed out (service_start_timeout=25000ms)
Jul 03 08:07:27 volumio sudo[25708]: pam_unix(sudo:session): session closed for user root
Jul 03 08:07:27 volumio volumio[847]: Failed to set time zone: Connection timed out
Jul 03 08:07:27 volumio volumio[847]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 03 08:07:27 volumio volumio[847]: Error: Command failed: /usr/bin/sudo /usr/bin/timedatectl set-timezone 'America/Chicago'
Jul 03 08:07:27 volumio volumio[847]: Failed to set time zone: Connection timed out
Jul 03 08:07:27 volumio volumio[847]: at checkExecSyncError (child_process.js:616:11)
Jul 03 08:07:27 volumio volumio[847]: at execSync (child_process.js:652:15)
Jul 03 08:07:27 volumio volumio[847]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/system/index.js:1680:9)
Jul 03 08:07:27 volumio volumio[847]: at listOnTimeout (internal/timers.js:554:17)
Jul 03 08:07:27 volumio volumio[847]: at processTimers (internal/timers.js:497:7) {
Jul 03 08:07:27 volumio volumio[847]: status: 1,
Jul 03 08:07:27 volumio volumio[847]: signal: null,
Jul 03 08:07:27 volumio volumio[847]: output: [ null, '', 'Failed to set time zone: Connection timed out\n' ],
Jul 03 08:07:27 volumio volumio[847]: pid: 25707,
Jul 03 08:07:27 volumio volumio[847]: stdout: '',
Jul 03 08:07:27 volumio volumio[847]: stderr: 'Failed to set time zone: Connection timed out\n'
Jul 03 08:07:27 volumio volumio[847]: }
Jul 03 08:07:27 volumio volumio[847]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 03 08:07:28 volumio sudo[25766]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-03 08:06
Jul 03 08:07:28 volumio sudo[25766]: 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="04c18c158cc4bac70764c3360b25fcce0c69266a"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 04:52:53 PM CEST"
VOLUMIO_VERSION="3.816"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="a72866a0de4045751d03a035de6290e1"