-- Logs begin at Thu 2019-02-14 17:11:58 +07, end at Fri 2025-05-02 21:24:08 +07. -- May 02 21:23:06 volumio volumio-remote-updater[611]: No test mode May 02 21:23:06 volumio volumio-remote-updater[611]: No alpha test mode May 02 21:23:06 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled May 02 21:23:06 volumio volumio[856]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} May 02 21:23:06 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache May 02 21:23:07 volumio volumio[856]: info: Volumio Network Manager: Network status updated: 1 May 02 21:23:09 volumio volumio[1220]: ........................................................................................................................................................................................................................................................................................................................................................................................................++++ May 02 21:23:09 volumio volumio[1220]: e is 65537 (0x010001) May 02 21:23:09 volumio volumio[1220]: writing RSA key May 02 21:23:16 volumio ntpd[804]: Soliciting pool server 202.80.227.130 May 02 21:23:17 volumio ntpd[804]: Soliciting pool server 122.155.180.231 May 02 21:23:18 volumio ntpd[804]: Soliciting pool server 147.50.17.138 May 02 21:23:19 volumio ntpd[804]: Soliciting pool server 202.29.58.130 May 02 21:23:21 volumio ntpd[804]: Soliciting pool server 202.28.116.236 May 02 21:23:22 volumio ntpd[804]: Soliciting pool server 2401:5700:100:508::135:5 May 02 21:23:34 volumio volumio[856]: verbose: New Socket.io Connection to 192.168.1.123 from 192.168.1.107 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_1_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.1.1 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 4 May 02 21:23:34 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 02 21:23:34 volumio volumio[856]: info: CoreCommandRouter::volumioGetVisibleSources May 02 21:23:34 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 02 21:23:34 volumio volumio[856]: info: CoreCommandRouter::volumioGetState May 02 21:23:34 volumio volumio[856]: info: CorePlayQueue::getTrack 0 May 02 21:23:34 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 02 21:23:34 volumio volumio[856]: info: CoreCommandRouter::volumioGetQueue May 02 21:23:34 volumio volumio[856]: info: CoreStateMachine::getQueue May 02 21:23:34 volumio volumio[856]: info: CorePlayQueue::getQueue May 02 21:23:34 volumio volumio[856]: info: Listing playlists May 02 21:23:34 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 02 21:23:34 volumio volumio[856]: info: Received Get System Info May 02 21:23:34 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 02 21:23:34 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 02 21:23:34 volumio volumio[856]: info: Discovery: Getting this device information May 02 21:23:34 volumio volumio[856]: info: CoreCommandRouter::volumioGetState May 02 21:23:34 volumio volumio[856]: info: CorePlayQueue::getTrack 0 May 02 21:23:34 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 02 21:23:34 volumio volumio[856]: info: CoreCommandRouter::volumioGetState May 02 21:23:34 volumio volumio[856]: info: CorePlayQueue::getTrack 0 May 02 21:23:34 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 02 21:23:34 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 02 21:23:34 volumio volumio[856]: An internal error occurred while serving an albumart. Details: NotFoundError: Not Found May 02 21:23:34 volumio volumio[856]: at SendStream.error (/volumio/node_modules/send/index.js:270:31) May 02 21:23:34 volumio volumio[856]: at SendStream.pipe (/volumio/node_modules/send/index.js:584:14) May 02 21:23:34 volumio volumio[856]: at sendfile (/volumio/node_modules/express/lib/response.js:1103:8) May 02 21:23:34 volumio volumio[856]: at ServerResponse.sendFile (/volumio/node_modules/express/lib/response.js:433:3) May 02 21:23:34 volumio volumio[856]: at Promise._successFn (/volumio/app/plugins/miscellanea/albumart/albumart.js:444:9) May 02 21:23:34 volumio volumio[856]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) May 02 21:23:34 volumio volumio[856]: at processTicksAndRejections (internal/process/task_queues.js:75:11) May 02 21:23:34 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 02 21:23:36 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 02 21:23:36 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 02 21:23:36 volumio volumio[856]: info: Received Get System Info May 02 21:23:36 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 02 21:23:36 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 02 21:23:36 volumio volumio[856]: info: Discovery: Getting this device information May 02 21:23:36 volumio volumio[856]: info: CoreCommandRouter::volumioGetState May 02 21:23:36 volumio volumio[856]: info: CorePlayQueue::getTrack 0 May 02 21:23:36 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 02 21:23:36 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 02 21:23:38 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 02 21:23:38 volumio volumio[856]: info: Received Get System Info May 02 21:23:38 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 02 21:23:38 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 02 21:23:38 volumio volumio[856]: info: Discovery: Getting this device information May 02 21:23:38 volumio volumio[856]: info: CoreCommandRouter::volumioGetState May 02 21:23:38 volumio volumio[856]: info: CorePlayQueue::getTrack 0 May 02 21:23:38 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 02 21:23:39 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 02 21:23:39 volumio volumio[856]: info: Received Get System Info May 02 21:23:39 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 02 21:23:39 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 02 21:23:39 volumio volumio[856]: info: Discovery: Getting this device information May 02 21:23:39 volumio volumio[856]: info: CoreCommandRouter::volumioGetState May 02 21:23:39 volumio volumio[856]: info: CorePlayQueue::getTrack 0 May 02 21:23:39 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 02 21:23:40 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 02 21:23:40 volumio volumio[856]: info: Received Get System Info May 02 21:23:40 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 02 21:23:40 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 02 21:23:40 volumio volumio[856]: info: Discovery: Getting this device information May 02 21:23:40 volumio volumio[856]: info: CoreCommandRouter::volumioGetState May 02 21:23:40 volumio volumio[856]: info: CorePlayQueue::getTrack 0 May 02 21:23:40 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 02 21:23:44 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 02 21:23:46 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 02 21:23:46 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 02 21:23:53 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 02 21:23:53 volumio volumio[856]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 02 21:23:53 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 02 21:23:53 volumio volumio[856]: info: Received Get System Version May 02 21:23:53 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 02 21:23:53 volumio volumio[856]: info: Received Get System Info May 02 21:23:53 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 02 21:23:53 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 02 21:23:53 volumio volumio[856]: info: Discovery: Getting this device information May 02 21:23:53 volumio volumio[856]: info: CoreCommandRouter::volumioGetState May 02 21:23:53 volumio volumio[856]: info: CorePlayQueue::getTrack 0 May 02 21:23:53 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 02 21:23:55 volumio volumio[856]: info: Enabling plugin music_services_shield May 02 21:23:55 volumio volumio[856]: info: Loading plugin "music_services_shield"... May 02 21:23:55 volumio volumio[856]: info: Applying required configuration parameters for plugin music_services_shield May 02 21:23:55 volumio volumio[856]: info: PLUGIN START: music_services_shield May 02 21:23:56 volumio sudo[1571]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/moveallprocesses.sh May 02 21:23:56 volumio sudo[1571]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 21:23:56 volumio kernel: new mount options do not match the existing superblock, will be ignored May 02 21:23:56 volumio sudo[1571]: pam_unix(sudo:session): session closed for user root May 02 21:23:56 volumio volumio[856]: info: Done. May 02 21:23:56 volumio sudo[1597]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/addservice.sh May 02 21:23:56 volumio sudo[1597]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 21:23:56 volumio systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... May 02 21:23:57 volumio volumio[1601]: cset: --> shielding system active with May 02 21:23:57 volumio volumio[1601]: cset: "system" cpuset of CPUSPEC(1-3) with 118 tasks running May 02 21:23:57 volumio volumio[1601]: cset: "user" cpuset of CPUSPEC(0) with 3 tasks running May 02 21:23:57 volumio systemd[1]: Started Shield Volumio Music Services in the User CPU Set. May 02 21:23:57 volumio systemd[1]: Reloading. May 02 21:23:57 volumio 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. May 02 21:23:57 volumio systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed. May 02 21:23:57 volumio sudo[1597]: pam_unix(sudo:session): session closed for user root May 02 21:23:57 volumio volumio[856]: info: succeeded May 02 21:24:01 volumio volumio[856]: info: Enabling plugin now_playing May 02 21:24:01 volumio volumio[856]: info: Loading plugin "now_playing"... May 02 21:24:02 volumio volumio[856]: info: PLUGIN START: now_playing May 02 21:24:02 volumio volumio[856]: info: [now-playing] ConfigUpdater: config is up to date. May 02 21:24:02 volumio volumio[856]: info: [now-playing] Fetching API key... May 02 21:24:02 volumio volumio[856]: info: [now-playing] App is listening on port 4004. May 02 21:24:02 volumio volumio[856]: info: [now-playing] Backing up /opt/volumiokiosk.sh to /home/volumio/.now_playing/volumiokiosk.sh.bak May 02 21:24:02 volumio sudo[1656]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sed -i s/localhost:3000/localhost:4004/g /opt/volumiokiosk.sh May 02 21:24:02 volumio sudo[1656]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 21:24:02 volumio sudo[1656]: pam_unix(sudo:session): session closed for user root May 02 21:24:02 volumio volumio[856]: [sudo] password for volumio: info: [now-playing] Executing /usr/bin/sudo /bin/systemctl status volumio-kiosk May 02 21:24:02 volumio sudo[1659]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status volumio-kiosk May 02 21:24:02 volumio sudo[1659]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 21:24:02 volumio sudo[1659]: pam_unix(sudo:session): session closed for user root May 02 21:24:02 volumio volumio[856]: error: [now-playing] Failed to execute systemctl command status on volumio-kiosk: Error: Command failed: /usr/bin/sudo /bin/systemctl status volumio-kiosk May 02 21:24:02 volumio volumio[856]: at ChildProcess.exithandler (child_process.js:308:12) May 02 21:24:02 volumio volumio[856]: at ChildProcess.emit (events.js:315:20) May 02 21:24:02 volumio volumio[856]: at maybeClose (internal/child_process.js:1048:16) May 02 21:24:02 volumio volumio[856]: at Process.ChildProcess._handle.onexit (internal/child_process.js:288:5) May 02 21:24:02 volumio volumio[856]: info: Error: Error: Command failed: /usr/bin/sudo /bin/systemctl status volumio-kiosk May 02 21:24:03 volumio volumio[856]: info: Enabling plugin peppy_screensaver May 02 21:24:03 volumio volumio[856]: info: Loading plugin "peppy_screensaver"... May 02 21:24:03 volumio volumio[856]: info: Applying required configuration parameters for plugin peppy_screensaver May 02 21:24:03 volumio volumio[856]: info: Preparing to generate the ALSA configuration file May 02 21:24:03 volumio volumio[856]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf May 02 21:24:03 volumio volumio[856]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf May 02 21:24:03 volumio volumio[856]: info: Reading ALSA contributions from plugins. May 02 21:24:03 volumio volumio[856]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 May 02 21:24:03 volumio volumio[856]: info: Asound.conf file written May 02 21:24:03 volumio sudo[1662]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf May 02 21:24:03 volumio sudo[1662]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 21:24:03 volumio sudo[1662]: pam_unix(sudo:session): session closed for user root May 02 21:24:03 volumio volumio[856]: info: Output device has changed, restarting MPD May 02 21:24:03 volumio sudo[1667]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 02 21:24:03 volumio sudo[1667]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 21:24:03 volumio volumio[856]: info: Output device has changed, restarting Shairport Sync May 02 21:24:03 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 21:24:03 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 02 21:24:03 volumio sudo[1667]: pam_unix(sudo:session): session closed for user root May 02 21:24:03 volumio sudo[1670]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 02 21:24:03 volumio sudo[1670]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 21:24:04 volumio systemd[1]: musicservicesshield.service: Succeeded. May 02 21:24:04 volumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. May 02 21:24:04 volumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... May 02 21:24:04 volumio systemd[1]: Stopping Music Player Daemon... May 02 21:24:04 volumio volumio[856]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 02 21:24:04 volumio volumio[856]: info: PLUGIN START: peppy_screensaver May 02 21:24:04 volumio volumio[856]: info: Loading i18n strings for locale en May 02 21:24:04 volumio systemd[1]: mpd.service: Succeeded. May 02 21:24:04 volumio systemd[1]: Stopped Music Player Daemon. May 02 21:24:04 volumio volumio[856]: info: /tmp/myfifo created May 02 21:24:04 volumio volumio[856]: info: /tmp/myfifosa created May 02 21:24:04 volumio sudo[1681]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-dummy index=7 pcm_substreams=1 fake_buffer=0 May 02 21:24:04 volumio sudo[1681]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 21:24:04 volumio systemd[1]: Starting Music Player Daemon... May 02 21:24:04 volumio sudo[1681]: pam_unix(sudo:session): session closed for user root May 02 21:24:04 volumio volumio[856]: info: snd-dummy loaded May 02 21:24:04 volumio sudo[1676]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 02 21:24:04 volumio sudo[1676]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 21:24:04 volumio sudo[1676]: pam_unix(sudo:session): session closed for user root May 02 21:24:04 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 02 21:24:04 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 21:24:04 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startShairportSync May 02 21:24:04 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 21:24:04 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 02 21:24:04 volumio sudo[1704]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount --bind /tmp/shairport-sync.conf.tmpl /volumio/app/plugins/music_service/airplay_emulation/shairport-sync.conf.tmpl May 02 21:24:04 volumio sudo[1704]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 21:24:04 volumio sudo[1704]: pam_unix(sudo:session): session closed for user root May 02 21:24:04 volumio volumio[856]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 02 21:24:04 volumio volumio[856]: info: Done. May 02 21:24:04 volumio volumio[856]: info: MPD Permissions set May 02 21:24:04 volumio volumio[856]: info: CoreCommandRouter::volumioGetState May 02 21:24:04 volumio volumio[856]: info: CorePlayQueue::getTrack 0 May 02 21:24:04 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 21:24:04 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 21:24:04 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 21:24:04 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 21:24:04 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 21:24:04 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 21:24:04 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 21:24:04 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 21:24:04 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 02 21:24:04 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 21:24:04 volumio volumio[856]: info: Enabling plugin touch_display May 02 21:24:04 volumio volumio[856]: info: Loading plugin "touch_display"... May 02 21:24:04 volumio volumio[856]: info: Applying required configuration parameters for plugin touch_display May 02 21:24:04 volumio volumio[856]: info: PLUGIN START: touch_display May 02 21:24:04 volumio volumio[856]: info: Loading i18n strings for locale en May 02 21:24:04 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 02 21:24:05 volumio mpd[1691]: May 02 21:24 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 02 21:24:05 volumio sudo[1715]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service May 02 21:24:05 volumio sudo[1715]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 21:24:05 volumio sudo[1717]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload May 02 21:24:05 volumio sudo[1713]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service May 02 21:24:05 volumio sudo[1717]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 21:24:05 volumio sudo[1713]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 21:24:05 volumio volumio[856]: error: touch_display: Error detecting backlight interface: Error: ENOENT: no such file or directory, scandir '/sys/class/backlight/' May 02 21:24:05 volumio volumio[856]: info: Starting Shairport Sync May 02 21:24:05 volumio systemd[1]: Reloading. May 02 21:24:05 volumio sudo[1724]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount --bind /tmp/mpd.conf.tmpl /volumio/app/plugins/music_service/mpd/mpd.conf.tmpl May 02 21:24:05 volumio sudo[1724]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 21:24:05 volumio sudo[1724]: pam_unix(sudo:session): session closed for user root May 02 21:24:05 volumio volumio[856]: info: Starting Shairport Sync May 02 21:24:05 volumio sudo[1728]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 02 21:24:05 volumio sudo[1728]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 21:24:05 volumio volumio[856]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 May 02 21:24:05 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , createMPDFile May 02 21:24:05 volumio sudo[1739]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 02 21:24:05 volumio sudo[1739]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 21:24:05 volumio sudo[1746]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 02 21:24:05 volumio sudo[1746]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 21:24:05 volumio sudo[1746]: pam_unix(sudo:session): session closed for user root May 02 21:24:05 volumio volumio[856]: info: touch_display: No Raspberry Pi Foundation touch screen detected. May 02 21:24:05 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 21:24:05 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 21:24:05 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 21:24:05 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 21:24:05 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 21:24:05 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 21:24:05 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 21:24:05 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 21:24:05 volumio sudo[1752]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf May 02 21:24:05 volumio sudo[1752]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 21:24:05 volumio sudo[1752]: pam_unix(sudo:session): session closed for user root May 02 21:24:05 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 02 21:24:05 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 21:24:05 volumio volumio[856]: info: MPD Permissions set May 02 21:24:05 volumio volumio[856]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. May 02 21:24:05 volumio 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. May 02 21:24:05 volumio volumio[856]: info: Enabling plugin touch_display May 02 21:24:05 volumio volumio[856]: info: Loading plugin "touch_display"... May 02 21:24:05 volumio volumio[856]: info: Applying required configuration parameters for plugin touch_display May 02 21:24:05 volumio volumio[856]: info: PLUGIN START: touch_display May 02 21:24:05 volumio volumio[856]: info: Loading i18n strings for locale en May 02 21:24:05 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 02 21:24:05 volumio sudo[1759]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service May 02 21:24:05 volumio sudo[1759]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 21:24:05 volumio volumio[856]: error: touch_display: Error detecting backlight interface: Error: ENOENT: no such file or directory, scandir '/sys/class/backlight/' May 02 21:24:05 volumio sudo[1762]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service May 02 21:24:05 volumio sudo[1762]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 21:24:05 volumio sudo[1765]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload May 02 21:24:05 volumio sudo[1765]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 21:24:05 volumio volumio[856]: info: touch_display: No Raspberry Pi Foundation touch screen detected. May 02 21:24:05 volumio volumio[856]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd May 02 21:24:05 volumio sudo[1768]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf May 02 21:24:05 volumio sudo[1768]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 21:24:05 volumio sudo[1768]: pam_unix(sudo:session): session closed for user root May 02 21:24:05 volumio volumio[856]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. May 02 21:24:05 volumio sudo[1771]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 02 21:24:05 volumio sudo[1771]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 21:24:05 volumio systemd[1]: Started Music Player Daemon. May 02 21:24:05 volumio sudo[1670]: pam_unix(sudo:session): session closed for user root May 02 21:24:05 volumio sudo[1715]: pam_unix(sudo:session): session closed for user root May 02 21:24:05 volumio volumio[856]: info: touch_display: systemctl disable getty@tty1.service succeeded. May 02 21:24:05 volumio volumio[856]: error: updateQueue error: null May 02 21:24:05 volumio systemd[1]: Reloading. May 02 21:24:06 volumio 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. May 02 21:24:06 volumio sudo[1717]: pam_unix(sudo:session): session closed for user root May 02 21:24:06 volumio volumio[856]: info: touch_display: systemctl daemon-reload succeeded. May 02 21:24:06 volumio sudo[1787]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service May 02 21:24:06 volumio sudo[1787]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 21:24:06 volumio systemd[1]: Reloading. May 02 21:24:06 volumio volumio[856]: info: [now-playing] OpenWeatherMap API key obtained. May 02 21:24:06 volumio 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. May 02 21:24:06 volumio systemd[1]: Reloading. May 02 21:24:06 volumio sudo[1762]: pam_unix(sudo:session): session closed for user root May 02 21:24:06 volumio volumio[856]: info: touch_display: systemctl disable getty@tty1.service succeeded. May 02 21:24:07 volumio 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. May 02 21:24:07 volumio volumio[856]: error: [now-playing] Error fetching https://openweathermap.org/data/2.5/weather?appid=5796abbde9106b7da4febfae8c44c232&lat=13.92369&lon=100.58877: Error: Response error: 401 - Unauthorized May 02 21:24:07 volumio volumio[856]: at fetchPage (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:29:15) May 02 21:24:07 volumio volumio[856]: at runMicrotasks () May 02 21:24:07 volumio volumio[856]: at processTicksAndRejections (internal/process/task_queues.js:93:5) May 02 21:24:07 volumio volumio[856]: at async Promise.all (index 1) May 02 21:24:07 volumio volumio[856]: at async fetchData (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:84:24) May 02 21:24:07 volumio volumio[856]: at async OpenWeatherMapAPI.getWeather (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:97:45) May 02 21:24:07 volumio volumio[856]: at async /data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:297:25 May 02 21:24:07 volumio volumio[856]: info: [now-playing] Fetching API key... May 02 21:24:07 volumio volumio[856]: error: [now-playing] Error fetching https://openweathermap.org/data/2.5/onecall?appid=5796abbde9106b7da4febfae8c44c232&lat=13.92369&lon=100.58877: Error: Response error: 401 - Unauthorized May 02 21:24:07 volumio volumio[856]: at fetchPage (/data/plugins/user_interface/now_playing/dist/lib/api/openweathermap/index.js:29:15) May 02 21:24:07 volumio volumio[856]: at runMicrotasks () May 02 21:24:07 volumio volumio[856]: at processTicksAndRejections (internal/process/task_queues.js:93:5) May 02 21:24:07 volumio volumio[856]: at async Promise.all (index 0) May 02 21:24:07 volumio sudo[1765]: pam_unix(sudo:session): session closed for user root May 02 21:24:07 volumio volumio[856]: info: touch_display: systemctl daemon-reload succeeded. May 02 21:24:07 volumio systemd[1]: Started Volumio Kiosk. May 02 21:24:07 volumio systemd[1]: Stopping Music Player Daemon... May 02 21:24:07 volumio sudo[1787]: pam_unix(sudo:session): session closed for user root May 02 21:24:07 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 02 21:24:07 volumio systemd[1]: Stopping Getty on tty1... May 02 21:24:07 volumio systemd[1]: shairport-sync.service: Succeeded. May 02 21:24:07 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 02 21:24:07 volumio volumio[856]: info: touch_display: systemctl start volumio-kiosk.service succeeded. May 02 21:24:07 volumio volumio[856]: info: touch_display: Volumio Kiosk started. May 02 21:24:07 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 02 21:24:07 volumio sudo[1728]: pam_unix(sudo:session): session closed for user root May 02 21:24:07 volumio sudo[1816]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service May 02 21:24:07 volumio sudo[1739]: pam_unix(sudo:session): session closed for user root May 02 21:24:07 volumio systemd[1]: getty@tty1.service: Main process exited, code=killed, status=15/TERM May 02 21:24:07 volumio systemd[1]: getty@tty1.service: Succeeded. May 02 21:24:07 volumio systemd[1]: Stopped Getty on tty1. May 02 21:24:07 volumio sudo[1816]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 21:24:07 volumio systemd[1]: mpd.service: Succeeded. May 02 21:24:07 volumio systemd[1]: Stopped Music Player Daemon. May 02 21:24:07 volumio volumio[856]: info: CoreCommandRouter::volumioGetState May 02 21:24:07 volumio volumio[856]: info: CorePlayQueue::getTrack 0 May 02 21:24:07 volumio volumio[856]: info: Done. May 02 21:24:07 volumio sudo[1713]: pam_unix(sudo:session): session closed for user root May 02 21:24:07 volumio volumio[856]: info: CoreCommandRouter::volumioGetState May 02 21:24:07 volumio volumio[856]: info: CorePlayQueue::getTrack 0 May 02 21:24:07 volumio volumio[856]: info: Shairport-Sync Started May 02 21:24:07 volumio volumio[856]: info: Shairport-Sync Started May 02 21:24:07 volumio volumio[856]: info: touch_display: systemctl stop getty@tty1.service succeeded. May 02 21:24:07 volumio sudo[1759]: pam_unix(sudo:session): session closed for user root May 02 21:24:07 volumio volumio[856]: info: touch_display: systemctl stop getty@tty1.service succeeded. May 02 21:24:07 volumio systemd[1]: Starting Music Player Daemon... May 02 21:24:07 volumio sudo[1816]: pam_unix(sudo:session): session closed for user root May 02 21:24:07 volumio volumio[856]: info: touch_display: X display number found: May 02 21:24:07 volumio volumio[856]: info: touch_display: systemctl start volumio-kiosk.service succeeded. May 02 21:24:07 volumio volumio[856]: info: touch_display: Volumio Kiosk started. May 02 21:24:07 volumio volumio[856]: info: CoreCommandRouter::volumioGetState May 02 21:24:07 volumio volumio[856]: info: CorePlayQueue::getTrack 0 May 02 21:24:07 volumio volumio[856]: info: Done. May 02 21:24:07 volumio volumio[856]: info: CoreCommandRouter::volumioGetState May 02 21:24:07 volumio volumio[856]: info: CorePlayQueue::getTrack 0 May 02 21:24:07 volumio volumio[856]: info: touch_display: X display number found: 0 May 02 21:24:07 volumio sudo[1839]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 02 21:24:07 volumio sudo[1839]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 21:24:07 volumio sudo[1839]: pam_unix(sudo:session): session closed for user root May 02 21:24:07 volumio startx[1817]: X.Org X Server 1.20.4 May 02 21:24:07 volumio startx[1817]: X Protocol Version 11, Revision 0 May 02 21:24:07 volumio startx[1817]: Build Operating System: Linux 5.4.0-109-generic armv8l Raspbian May 02 21:24:07 volumio startx[1817]: Current Operating System: Linux volumio 6.6.62-v7l+ #1816 SMP Mon Nov 18 15:33:33 GMT 2024 armv7l May 02 21:24:07 volumio startx[1817]: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_headphones=0 cgroup_disable=memory numa_policy=interleave snd_bcm2835.enable_headphones=1 snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=1280 bcm2708_fb.fbheight=400 bcm2708_fb.fbswap=1 smsc95xx.macaddr=D8:3A:DD:1A:D6:AD vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyS0,115200 console=tty1 imgpart=UUID=826680f7-a407-4ab9-8bd5-1855bda526fd imgfile=/volumio_current.sqsh bootpart=UUID=FD90-ED9E datapart=UUID=fecb0823-2e5b-4bba-9498-dd37b5084148 uuidconfig=cmdline.txt pcie_aspm=off pci=pcie_bus_safe rootwait bootdelay=7 logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa= snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 nodebug use_kmsg=no May 02 21:24:07 volumio startx[1817]: Build Date: 04 April 2023 07:50:56AM May 02 21:24:07 volumio startx[1817]: xorg-server 2:1.20.4-1+rpt4+deb10u9 (https://www.debian.org/support) May 02 21:24:07 volumio startx[1817]: Current version of pixman: 0.36.0 May 02 21:24:07 volumio startx[1817]: Before reporting problems, check http://wiki.x.org May 02 21:24:07 volumio startx[1817]: to make sure that you have the latest version. May 02 21:24:07 volumio startx[1817]: Markers: (--) probed, (**) from config file, (==) default setting, May 02 21:24:07 volumio startx[1817]: (++) from command line, (!!) notice, (II) informational, May 02 21:24:07 volumio startx[1817]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. May 02 21:24:07 volumio startx[1817]: (==) Log file: "/var/log/Xorg.0.log", Time: Fri May 2 21:24:07 2025 May 02 21:24:07 volumio startx[1817]: (==) Using config directory: "/etc/X11/xorg.conf.d" May 02 21:24:07 volumio startx[1817]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" May 02 21:24:07 volumio volumio[856]: info: touch_display: X display number found: 0 May 02 21:24:07 volumio volumio[856]: info: touch_display: X display number found: 0 May 02 21:24:07 volumio volumio[856]: info: touch_display: X display number found: 0 May 02 21:24:07 volumio volumio[856]: info: touch_display: X display number found: 0 May 02 21:24:07 volumio volumio[856]: info: touch_display: X display number found: 0 May 02 21:24:07 volumio volumio[856]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 May 02 21:24:07 volumio volumio[856]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 May 02 21:24:08 volumio volumio[856]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 02 21:24:08 volumio volumio[856]: Error: connect EISCONN /tmp/.X11-unix/X0 May 02 21:24:08 volumio volumio[856]: at PipeConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { May 02 21:24:08 volumio volumio[856]: errno: -106, May 02 21:24:08 volumio volumio[856]: code: 'EISCONN', May 02 21:24:08 volumio volumio[856]: syscall: 'connect', May 02 21:24:08 volumio volumio[856]: address: '/tmp/.X11-unix/X0' May 02 21:24:08 volumio volumio[856]: } May 02 21:24:08 volumio volumio[856]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 02 21:24:08 volumio sudo[1882]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-02 21:23 May 02 21:24:08 volumio sudo[1882]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 24 Apr 2025 09:33:57 AM CEST" VOLUMIO_VERSION="3.804" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="354f95cf0a6c2cbcd57b1aca3179c81c"