-- Logs begin at Tue 2025-02-25 21:36:01 IST, end at Tue 2025-02-25 21:38:29 IST. --
Feb 25 21:37:00 volumio-sh volumio[1028]: verbose: New Socket.io Connection to 192.168.1.5 from 192.168.1.2 UA: Mozilla/5.0 (Linux; Android 12; moto e32 Build/STCS32.60-74-8; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.166 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9
Feb 25 21:37:00 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Feb 25 21:37:00 volumio-sh volumio[1028]: info: CoreCommandRouter::volumioGetVisibleSources
Feb 25 21:37:00 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 25 21:37:00 volumio-sh volumio[1028]: info: CoreCommandRouter::volumioGetState
Feb 25 21:37:00 volumio-sh volumio[1028]: info: CorePlayQueue::getTrack 0
Feb 25 21:37:00 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Feb 25 21:37:00 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Feb 25 21:37:00 volumio-sh volumio[1028]: info: Received Get System Info
Feb 25 21:37:00 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 25 21:37:00 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 25 21:37:00 volumio-sh volumio[1028]: info: Discovery: Getting this device information
Feb 25 21:37:00 volumio-sh volumio[1028]: info: CoreCommandRouter::volumioGetState
Feb 25 21:37:00 volumio-sh volumio[1028]: info: CorePlayQueue::getTrack 0
Feb 25 21:37:00 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 25 21:37:00 volumio-sh volumio[1028]: info: CoreCommandRouter::volumioGetState
Feb 25 21:37:00 volumio-sh volumio[1028]: info: CorePlayQueue::getTrack 0
Feb 25 21:37:00 volumio-sh volumio[1028]: info: Listing playlists
Feb 25 21:37:00 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Feb 25 21:37:00 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Feb 25 21:37:00 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Feb 25 21:37:01 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 25 21:37:01 volumio-sh volumio[1028]: info: Received Get System Info
Feb 25 21:37:01 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 25 21:37:01 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 25 21:37:01 volumio-sh volumio[1028]: info: Discovery: Getting this device information
Feb 25 21:37:01 volumio-sh volumio[1028]: info: CoreCommandRouter::volumioGetState
Feb 25 21:37:01 volumio-sh volumio[1028]: info: CorePlayQueue::getTrack 0
Feb 25 21:37:01 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 25 21:37:01 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Feb 25 21:37:02 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Feb 25 21:37:02 volumio-sh volumiologrotate[818]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory
Feb 25 21:37:02 volumio-sh volumiologrotate[818]: ls: cannot access 'SH': No such file or directory
Feb 25 21:37:03 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 25 21:37:03 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 25 21:37:03 volumio-sh volumio[1028]: info: Discovery: Getting this device information
Feb 25 21:37:03 volumio-sh volumio[1028]: info: CoreCommandRouter::volumioGetState
Feb 25 21:37:03 volumio-sh volumio[1028]: info: CorePlayQueue::getTrack 0
Feb 25 21:37:03 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 25 21:37:03 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 25 21:37:03 volumio-sh volumio[1028]: info: Received Get System Info
Feb 25 21:37:03 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 25 21:37:03 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 25 21:37:03 volumio-sh volumio[1028]: info: Discovery: Getting this device information
Feb 25 21:37:03 volumio-sh volumio[1028]: info: CoreCommandRouter::volumioGetState
Feb 25 21:37:03 volumio-sh volumio[1028]: info: CorePlayQueue::getTrack 0
Feb 25 21:37:03 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 25 21:37:05 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 25 21:37:05 volumio-sh volumio[1028]: info: Received Get System Info
Feb 25 21:37:05 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 25 21:37:05 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 25 21:37:05 volumio-sh volumio[1028]: info: Discovery: Getting this device information
Feb 25 21:37:05 volumio-sh volumio[1028]: info: CoreCommandRouter::volumioGetState
Feb 25 21:37:05 volumio-sh volumio[1028]: info: CorePlayQueue::getTrack 0
Feb 25 21:37:05 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 25 21:37:05 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 25 21:37:05 volumio-sh volumio[1028]: info: Received Get System Info
Feb 25 21:37:05 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 25 21:37:05 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 25 21:37:05 volumio-sh volumio[1028]: info: Discovery: Getting this device information
Feb 25 21:37:05 volumio-sh volumio[1028]: info: CoreCommandRouter::volumioGetState
Feb 25 21:37:05 volumio-sh volumio[1028]: info: CorePlayQueue::getTrack 0
Feb 25 21:37:05 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 25 21:37:07 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 25 21:37:08 volumio-sh volumio[1028]: info: Received Get System Info
Feb 25 21:37:08 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 25 21:37:08 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 25 21:37:08 volumio-sh volumio[1028]: info: Discovery: Getting this device information
Feb 25 21:37:08 volumio-sh volumio[1028]: info: CoreCommandRouter::volumioGetState
Feb 25 21:37:08 volumio-sh volumio[1028]: info: CorePlayQueue::getTrack 0
Feb 25 21:37:08 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 25 21:37:10 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Feb 25 21:37:10 volumio-sh ntpd[919]: Soliciting pool server 192.46.211.253
Feb 25 21:37:11 volumio-sh ntpd[919]: Soliciting pool server 160.250.111.68
Feb 25 21:37:11 volumio-sh ntpd[919]: Soliciting pool server 139.84.142.141
Feb 25 21:37:12 volumio-sh ntpd[919]: Soliciting pool server 95.216.144.226
Feb 25 21:37:12 volumio-sh ntpd[919]: Soliciting pool server 172.232.97.196
Feb 25 21:37:12 volumio-sh ntpd[919]: Soliciting pool server 162.159.200.123
Feb 25 21:37:12 volumio-sh ntpd[919]: Soliciting pool server 192.46.215.60
Feb 25 21:37:12 volumio-sh volumio[1028]: info: CoreCommandRouter::volumioGetQueue
Feb 25 21:37:12 volumio-sh volumio[1028]: info: CoreStateMachine::getQueue
Feb 25 21:37:12 volumio-sh volumio[1028]: info: CorePlayQueue::getQueue
Feb 25 21:37:13 volumio-sh ntpd[919]: Soliciting pool server 3.111.45.100
Feb 25 21:37:13 volumio-sh ntpd[919]: Soliciting pool server 162.159.200.1
Feb 25 21:37:13 volumio-sh ntpd[919]: Soliciting pool server 13.126.27.131
Feb 25 21:37:14 volumio-sh ntpd[919]: Soliciting pool server 14.139.60.103
Feb 25 21:37:14 volumio-sh ntpd[919]: Soliciting pool server 139.84.150.88
Feb 25 21:37:15 volumio-sh ntpd[919]: Soliciting pool server 2606:4700:f1::123
Feb 25 21:37:15 volumio-sh ntpd[919]: Soliciting pool server 17.253.18.131
Feb 25 21:37:18 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Feb 25 21:37:18 volumio-sh volumio[1028]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Feb 25 21:37:18 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Feb 25 21:37:18 volumio-sh volumio[1028]: info: Received Get System Version
Feb 25 21:37:18 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 25 21:37:18 volumio-sh volumio[1028]: info: Received Get System Info
Feb 25 21:37:18 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 25 21:37:18 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 25 21:37:18 volumio-sh volumio[1028]: info: Discovery: Getting this device information
Feb 25 21:37:18 volumio-sh volumio[1028]: info: CoreCommandRouter::volumioGetState
Feb 25 21:37:18 volumio-sh volumio[1028]: info: CorePlayQueue::getTrack 0
Feb 25 21:37:18 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 25 21:37:19 volumio-sh ntpd[919]: receive: Unexpected origin timestamp 0xeb686937.54774e3b does not match aorg 0000000000.00000000 from server@160.250.111.68 xmt 0xeb686937.f86f22e0
Feb 25 21:37:19 volumio-sh ntpd[919]: receive: Unexpected origin timestamp 0xeb686937.54746f0c does not match aorg 0000000000.00000000 from server@13.126.27.131 xmt 0xeb686937.f805eac2
Feb 25 21:37:19 volumio-sh ntpd[919]: receive: Unexpected origin timestamp 0xeb686937.5477e88d does not match aorg 0000000000.00000000 from server@192.46.211.253 xmt 0xeb686937.f0991002
Feb 25 21:37:20 volumio-sh ntpd[919]: receive: Unexpected origin timestamp 0xeb686937.54760134 does not match aorg 0000000000.00000000 from server@192.46.215.60 xmt 0xeb686937.ef2dc172
Feb 25 21:37:20 volumio-sh ntpd[919]: receive: Unexpected origin timestamp 0xeb686937.547518f4 does not match aorg 0000000000.00000000 from server@95.216.144.226 xmt 0xeb686938.0ed03f82
Feb 25 21:37:34 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 25 21:37:34 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 25 21:37:34 volumio-sh volumio[1028]: info: Discovery: Getting this device information
Feb 25 21:37:34 volumio-sh volumio[1028]: info: CoreCommandRouter::volumioGetState
Feb 25 21:37:34 volumio-sh volumio[1028]: info: CorePlayQueue::getTrack 0
Feb 25 21:37:34 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 25 21:37:42 volumio-sh volumio[1028]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 25 21:37:42 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Feb 25 21:37:42 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 25 21:37:42 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 25 21:37:42 volumio-sh volumio[1028]: info: Getting Alsa Cards List without I2S DAC
Feb 25 21:37:42 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber
Feb 25 21:37:42 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 25 21:37:42 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 25 21:37:42 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 25 21:37:42 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 25 21:37:42 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 25 21:37:42 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 25 21:37:42 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 25 21:37:42 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 25 21:37:42 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Feb 25 21:37:42 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Feb 25 21:37:58 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 25 21:37:58 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Feb 25 21:38:03 volumio-sh volumiologrotate[818]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory
Feb 25 21:38:03 volumio-sh volumiologrotate[818]: ls: cannot access 'SH': No such file or directory
Feb 25 21:38:04 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 25 21:38:04 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 25 21:38:04 volumio-sh volumio[1028]: info: Discovery: Getting this device information
Feb 25 21:38:04 volumio-sh volumio[1028]: info: CoreCommandRouter::volumioGetState
Feb 25 21:38:04 volumio-sh volumio[1028]: info: CorePlayQueue::getTrack 0
Feb 25 21:38:04 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 25 21:38:07 volumio-sh volumio[1028]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 25 21:38:24 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 25 21:38:24 volumio-sh volumio[1028]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Feb 25 21:38:29 volumio-sh volumio[1028]: info: Starting Uninstall of plugin user_interface - touch_display
Feb 25 21:38:29 volumio-sh volumio[1028]: info: Uninstalling plugin touch_display
Feb 25 21:38:29 volumio-sh sudo[1834]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf
Feb 25 21:38:29 volumio-sh sudo[1834]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 21:38:29 volumio-sh sudo[1834]: pam_unix(sudo:session): session closed for user root
Feb 25 21:38:29 volumio-sh sudo[1836]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start getty@tty1.service
Feb 25 21:38:29 volumio-sh sudo[1836]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 21:38:29 volumio-sh sudo[1839]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable getty@tty1.service
Feb 25 21:38:29 volumio-sh volumio[1028]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set.
Feb 25 21:38:29 volumio-sh volumio[1028]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 25 21:38:29 volumio-sh sudo[1839]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 21:38:29 volumio-sh systemd[1]: Created slice system-getty.slice.
Feb 25 21:38:29 volumio-sh volumio[1028]: TypeError: Cannot read property 'split' of undefined
Feb 25 21:38:29 volumio-sh volumio[1028]: at /data/plugins/user_interface/touch_display/index.js:1258:37
Feb 25 21:38:29 volumio-sh volumio[1028]: at ChildProcess.exithandler (child_process.js:299:7)
Feb 25 21:38:29 volumio-sh volumio[1028]: at ChildProcess.emit (events.js:315:20)
Feb 25 21:38:29 volumio-sh volumio[1028]: at maybeClose (internal/child_process.js:1048:16)
Feb 25 21:38:29 volumio-sh volumio[1028]: at Socket. (internal/child_process.js:439:11)
Feb 25 21:38:29 volumio-sh volumio[1028]: at Socket.emit (events.js:315:20)
Feb 25 21:38:29 volumio-sh volumio[1028]: at Pipe. (net.js:673:12)
Feb 25 21:38:29 volumio-sh volumio[1028]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 25 21:38:29 volumio-sh sudo[1842]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumio-kiosk.service
Feb 25 21:38:29 volumio-sh systemd[1]: Started Getty on tty1.
Feb 25 21:38:29 volumio-sh sudo[1842]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 25 21:38:29 volumio-sh sudo[1836]: pam_unix(sudo:session): session closed for user root
Feb 25 21:38:29 volumio-sh systemd[1]: Reloading.
Feb 25 21:38:29 volumio-sh systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly.
Feb 25 21:38:29 volumio-sh sudo[1868]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-25 21:37
Feb 25 21:38:29 volumio-sh sudo[1868]: 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"