-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Mon 2024-10-21 23:30:16 UTC. --
Oct 21 23:29:41 volumio volumio[900]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Total Clients: 6
Oct 21 23:29:41 volumio volumio[900]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Total Clients: 7
Oct 21 23:29:42 volumio volumio[900]: info: CoreCommandRouter::volumioGetState
Oct 21 23:29:42 volumio volumio[900]: info: CorePlayQueue::getTrack 37
Oct 21 23:29:42 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Oct 21 23:29:42 volumio volumio[900]: info: Listing playlists
Oct 21 23:29:42 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Oct 21 23:29:42 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Oct 21 23:29:42 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Oct 21 23:29:42 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 21 23:29:43 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 21 23:29:43 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Oct 21 23:29:47 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 21 23:29:49 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 21 23:29:50 volumio volumio[900]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 21 23:29:50 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Oct 21 23:29:50 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Oct 21 23:29:50 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Oct 21 23:29:50 volumio volumio[900]: info: Received Get System Version
Oct 21 23:29:50 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 21 23:30:00 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 21 23:30:00 volumio volumio[900]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Oct 21 23:30:00 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Oct 21 23:30:00 volumio volumio[900]: info: Received Get System Version
Oct 21 23:30:00 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 21 23:30:00 volumio volumio[900]: info: Received Get System Info
Oct 21 23:30:00 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 21 23:30:00 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 21 23:30:00 volumio volumio[900]: info: Discovery: Getting this device information
Oct 21 23:30:00 volumio volumio[900]: info: CoreCommandRouter::volumioGetState
Oct 21 23:30:00 volumio volumio[900]: info: CorePlayQueue::getTrack 37
Oct 21 23:30:00 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 21 23:30:07 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: wizard , openWizard
Oct 21 23:30:07 volumio volumio[900]: info: CoreCommandRouter::Reload Ui
Oct 21 23:30:07 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps
Oct 21 23:30:07 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode
Oct 21 23:30:08 volumio volumio[900]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Total Clients: 7
Oct 21 23:30:08 volumio volumio[900]: info: CoreCommandRouter::volumioGetVisibleSources
Oct 21 23:30:08 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 21 23:30:08 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps
Oct 21 23:30:08 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode
Oct 21 23:30:08 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages
Oct 21 23:30:08 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones
Oct 21 23:30:08 volumio volumio[900]: info: Received Get System Info
Oct 21 23:30:08 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 21 23:30:08 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 21 23:30:08 volumio volumio[900]: info: Discovery: Getting this device information
Oct 21 23:30:08 volumio volumio[900]: info: CoreCommandRouter::volumioGetState
Oct 21 23:30:08 volumio volumio[900]: info: CorePlayQueue::getTrack 37
Oct 21 23:30:08 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 21 23:30:08 volumio volumio-remote-updater[469]: No test mode
Oct 21 23:30:08 volumio volumio-remote-updater[469]: No alpha test mode
Oct 21 23:30:08 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Oct 21 23:30:08 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 21 23:30:09 volumio volumio[900]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
- Improved translations
- Fix for Wizard not showing on second start
- Fix for Playback Queue not advancing
NEW ADDITIONS
- Add DSD Quirk for Marantz SA-12 on Rivo and Primo v2
","title":"Update v3.757","updateavailable":true}
Oct 21 23:30:09 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Oct 21 23:30:10 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 21 23:30:11 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 21 23:30:13 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage
Oct 21 23:30:13 volumio volumio[900]: info: Loading i18n strings for locale en
Oct 21 23:30:13 volumio volumio[900]: Updating browse sources language
Oct 21 23:30:13 volumio volumio[900]: Cannot find translation for source Mother Earth Radio
Oct 21 23:30:13 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 21 23:30:13 volumio volumio[900]: Cannot find translation for source Mother Earth Radio
Oct 21 23:30:13 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone
Oct 21 23:30:13 volumio volumio[900]: info: Setting timezone to Etc/Unknown
Oct 21 23:30:13 volumio sudo[2810]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime
Oct 21 23:30:13 volumio sudo[2810]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 21 23:30:13 volumio sudo[2810]: pam_unix(sudo:session): session closed for user root
Oct 21 23:30:13 volumio systemd[1]: Starting Daily apt download activities...
Oct 21 23:30:13 volumio sudo[2814]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Etc/Unknown /etc/localtime
Oct 21 23:30:13 volumio sudo[2814]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 21 23:30:13 volumio sudo[2814]: pam_unix(sudo:session): session closed for user root
Oct 21 23:30:13 volumio sudo[2817]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime
Oct 21 23:30:13 volumio sudo[2817]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 21 23:30:13 volumio sudo[2817]: pam_unix(sudo:session): session closed for user root
Oct 21 23:30:13 volumio volumio[900]: /bin/chmod: cannot operate on dangling symlink '/etc/localtime'
Oct 21 23:30:13 volumio volumio[900]: error: Could not set timezone: Error: Command failed: /usr/bin/sudo /bin/chmod 777 /etc/localtime
Oct 21 23:30:13 volumio volumio[900]: /bin/chmod: cannot operate on dangling symlink '/etc/localtime'
Oct 21 23:30:13 volumio sudo[2821]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Etc/Unknown
Oct 21 23:30:13 volumio sudo[2821]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 21 23:30:13 volumio dbus-daemon[504]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.21' (uid=0 pid=2823 comm="/usr/bin/timedatectl set-timezone Etc/Unknown ")
Oct 21 23:30:13 volumio systemd[1]: Starting Time & Date Service...
Oct 21 23:30:15 volumio systemd-timedated[2827]: /etc/localtime should be a symbolic link to a time zone data file in /usr/share/zoneinfo/.
Oct 21 23:30:15 volumio dbus-daemon[504]: [system] Successfully activated service 'org.freedesktop.timedate1'
Oct 21 23:30:15 volumio systemd[1]: Started Time & Date Service.
Oct 21 23:30:15 volumio sudo[2821]: pam_unix(sudo:session): session closed for user root
Oct 21 23:30:15 volumio volumio[900]: Failed to set time zone: Invalid time zone 'Etc/Unknown'
Oct 21 23:30:15 volumio volumio[900]: info: Could not set timezone, retrying
Oct 21 23:30:15 volumio volumio[900]: info: Fetching Streaming Services browse cache
Oct 21 23:30:15 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
Oct 21 23:30:15 volumio volumio[900]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
Oct 21 23:30:15 volumio sudo[2850]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Oct 21 23:30:15 volumio sudo[2850]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 21 23:30:15 volumio systemd[1]: apt-daily.service: Succeeded.
Oct 21 23:30:15 volumio systemd[1]: Started Daily apt download activities.
Oct 21 23:30:16 volumio sudo[2879]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Etc/Unknown
Oct 21 23:30:16 volumio sudo[2879]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 21 23:30:16 volumio sudo[2879]: pam_unix(sudo:session): session closed for user root
Oct 21 23:30:16 volumio volumio[900]: Failed to set time zone: Invalid time zone 'Etc/Unknown'
Oct 21 23:30:16 volumio volumio[900]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 21 23:30:16 volumio volumio[900]: Error: Command failed: /usr/bin/sudo /usr/bin/timedatectl set-timezone 'Etc/Unknown'
Oct 21 23:30:16 volumio volumio[900]: Failed to set time zone: Invalid time zone 'Etc/Unknown'
Oct 21 23:30:16 volumio volumio[900]: at checkExecSyncError (child_process.js:616:11)
Oct 21 23:30:16 volumio volumio[900]: at execSync (child_process.js:652:15)
Oct 21 23:30:16 volumio volumio[900]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/system/index.js:1448:9)
Oct 21 23:30:16 volumio volumio[900]: at listOnTimeout (internal/timers.js:554:17)
Oct 21 23:30:16 volumio volumio[900]: at processTimers (internal/timers.js:497:7) {
Oct 21 23:30:16 volumio volumio[900]: status: 1,
Oct 21 23:30:16 volumio volumio[900]: signal: null,
Oct 21 23:30:16 volumio volumio[900]: output: [
Oct 21 23:30:16 volumio volumio[900]: null,
Oct 21 23:30:16 volumio volumio[900]: '',
Oct 21 23:30:16 volumio volumio[900]: "Failed to set time zone: Invalid time zone 'Etc/Unknown'\n"
Oct 21 23:30:16 volumio volumio[900]: ],
Oct 21 23:30:16 volumio volumio[900]: pid: 2878,
Oct 21 23:30:16 volumio volumio[900]: stdout: '',
Oct 21 23:30:16 volumio volumio[900]: stderr: "Failed to set time zone: Invalid time zone 'Etc/Unknown'\n"
Oct 21 23:30:16 volumio volumio[900]: }
Oct 21 23:30:16 volumio volumio[900]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 21 23:30:16 volumio sudo[2890]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-21 23:29
Oct 21 23:30:16 volumio sudo[2890]: 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="cd8cf34b47ce852e70b71e6f7b6e0265f7fdb695"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="8f88153f9a18f312d56050e6613b45a852ac819a"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 27 Sep 2023 11:35:49 AM CEST"
VOLUMIO_VERSION="3.546"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="6823c0d83061ff736b7e0dd4481bc496"