-- Logs begin at Thu 2019-02-14 12:11:59 EET, end at Tue 2024-10-08 18:28:51 EEST. --
Oct 08 18:27:02 volumio-n sudo[904]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //10.0.0.80/zamba /mnt/NAS/Zamba
Oct 08 18:27:02 volumio-n sudo[904]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 08 18:27:02 volumio-n kernel: CIFS: Attempting to mount \\10.0.0.80\zamba
Oct 08 18:27:02 volumio-n kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Oct 08 18:27:02 volumio-n kernel: CIFS: VFS: cifs_mount failed w/return code = -113
Oct 08 18:27:02 volumio-n sudo[904]: pam_unix(sudo:session): session closed for user root
Oct 08 18:27:02 volumio-n volumio[683]: info: Cannot mount NAS Zamba at system boot, trial number 4 ,retrying in 5 seconds
Oct 08 18:27:03 volumio-n volumio[683]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600
Oct 08 18:27:04 volumio-n systemd[1]: systemd-fsckd.service: Succeeded.
Oct 08 18:27:07 volumio-n sudo[909]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //10.0.0.80/zamba /mnt/NAS/Zamba
Oct 08 18:27:07 volumio-n sudo[909]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 08 18:27:07 volumio-n sudo[909]: pam_unix(sudo:session): session closed for user root
Oct 08 18:27:07 volumio-n kernel: CIFS: Attempting to mount \\10.0.0.80\zamba
Oct 08 18:27:07 volumio-n kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Oct 08 18:27:07 volumio-n kernel: CIFS: VFS: cifs_mount failed w/return code = -113
Oct 08 18:27:07 volumio-n volumio[683]: info: Cannot mount NAS at system boot, trial number 4 ,stopping
Oct 08 18:27:08 volumio-n systemd[1]: systemd-hostnamed.service: Succeeded.
Oct 08 18:27:13 volumio-n volumio[683]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600
Oct 08 18:27:15 volumio-n volumio[683]: error: Plugin system_controller system failed to complete 'onVolumioStart' in a timely fashion
Oct 08 18:27:15 volumio-n volumio[683]: info: Preparing to generate the ALSA configuration file
Oct 08 18:27:15 volumio-n volumio[683]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf
Oct 08 18:27:15 volumio-n volumio[683]: info: Reading ALSA contributions from plugins.
Oct 08 18:27:15 volumio-n volumio[683]: info: Asound.conf file unchanged, so no further update is needed
Oct 08 18:27:15 volumio-n volumio[683]: info: Output device has changed, restarting MPD
Oct 08 18:27:15 volumio-n volumio[683]: info: Output device has changed, restarting Shairport Sync
Oct 08 18:27:15 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:15 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 08 18:27:15 volumio-n sudo[916]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Oct 08 18:27:15 volumio-n sudo[916]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 08 18:27:15 volumio-n sudo[916]: pam_unix(sudo:session): session closed for user root
Oct 08 18:27:15 volumio-n sudo[918]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Oct 08 18:27:15 volumio-n sudo[918]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 08 18:27:15 volumio-n volumio[683]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Oct 08 18:27:15 volumio-n volumio[683]: info: ___________ START PLUGINS ___________
Oct 08 18:27:15 volumio-n volumio[683]: info: ControllerMpd::onStart: Initializing MPD
Oct 08 18:27:15 volumio-n volumio[683]: info: Creating MPD Configuration file
Oct 08 18:27:15 volumio-n systemd[1]: Listening on mpd.socket.
Oct 08 18:27:15 volumio-n systemd[1]: Starting Music Player Daemon...
Oct 08 18:27:15 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 08 18:27:15 volumio-n volumio[683]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Oct 08 18:27:15 volumio-n volumio[683]: info: [1728401235992] CoreMusicLibrary::Adding element Media Servers
Oct 08 18:27:15 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 08 18:27:15 volumio-n sudo[926]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Oct 08 18:27:15 volumio-n sudo[926]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 08 18:27:16 volumio-n sudo[926]: pam_unix(sudo:session): session closed for user root
Oct 08 18:27:16 volumio-n sudo[929]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Oct 08 18:27:16 volumio-n sudo[929]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 08 18:27:16 volumio-n systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Oct 08 18:27:16 volumio-n systemd[1]: mpd.service: Succeeded.
Oct 08 18:27:16 volumio-n systemd[1]: Stopped Music Player Daemon.
Oct 08 18:27:16 volumio-n systemd[1]: Starting Music Player Daemon...
Oct 08 18:27:16 volumio-n volumio[683]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 08 18:27:16 volumio-n volumio[683]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Oct 08 18:27:16 volumio-n volumio[683]: info: [1728401236130] CoreMusicLibrary::Adding element Last_100
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Oct 08 18:27:16 volumio-n volumio[683]: info: [1728401236133] CoreMusicLibrary::Adding element Webradio
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 08 18:27:16 volumio-n volumio[683]: info: Loading i18n strings for locale en
Oct 08 18:27:16 volumio-n volumio[683]: info: /tmp/myfifo created
Oct 08 18:27:16 volumio-n volumio[683]: info: /tmp/myfifosa created
Oct 08 18:27:16 volumio-n sudo[944]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-dummy index=7 pcm_substreams=1 fake_buffer=0
Oct 08 18:27:16 volumio-n sudo[944]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 08 18:27:16 volumio-n sudo[944]: pam_unix(sudo:session): session closed for user root
Oct 08 18:27:16 volumio-n volumio[683]: info: snd-dummy loaded
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startShairportSync
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 08 18:27:16 volumio-n volumio[683]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Oct 08 18:27:16 volumio-n volumio[683]: info: Loading i18n strings for locale en
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 08 18:27:16 volumio-n volumio[683]: info: Volumio Calling Home
Oct 08 18:27:16 volumio-n sudo[958]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service
Oct 08 18:27:16 volumio-n sudo[958]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 08 18:27:16 volumio-n sudo[961]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service
Oct 08 18:27:16 volumio-n sudo[961]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 08 18:27:16 volumio-n sudo[963]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload
Oct 08 18:27:16 volumio-n sudo[963]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 08 18:27:16 volumio-n volumio[683]: error: touch_display: Error detecting backlight interface: Error: ENOENT: no such file or directory, scandir '/sys/class/backlight/'
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::volumioGetState
Oct 08 18:27:16 volumio-n volumio[683]: info: CorePlayQueue::getTrack 0
Oct 08 18:27:16 volumio-n volumio[683]: info: MPD Permissions set
Oct 08 18:27:16 volumio-n volumio[683]: info: MPD Permissions set
Oct 08 18:27:16 volumio-n volumio[683]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 7
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 08 18:27:16 volumio-n systemd[1]: Reloading.
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:16 volumio-n volumio[683]: info: touch_display: No Raspberry Pi Foundation touch screen detected.
Oct 08 18:27:16 volumio-n sudo[992]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount --bind /tmp/mpd.conf.tmpl /volumio/app/plugins/music_service/mpd/mpd.conf.tmpl
Oct 08 18:27:16 volumio-n sudo[992]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 08 18:27:16 volumio-n sudo[994]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf
Oct 08 18:27:16 volumio-n sudo[994]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 08 18:27:16 volumio-n sudo[992]: pam_unix(sudo:session): session closed for user root
Oct 08 18:27:16 volumio-n sudo[994]: pam_unix(sudo:session): session closed for user root
Oct 08 18:27:16 volumio-n volumio[683]: info: Volumio called home
Oct 08 18:27:16 volumio-n volumio[683]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set.
Oct 08 18:27:16 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: mpd , createMPDFile
Oct 08 18:27:16 volumio-n volumio[683]: info: Starting Shairport Sync
Oct 08 18:27:16 volumio-n volumio[683]: info: Starting Shairport Sync
Oct 08 18:27:16 volumio-n sudo[998]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Oct 08 18:27:16 volumio-n sudo[998]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 08 18:27:16 volumio-n sudo[998]: pam_unix(sudo:session): session closed for user root
Oct 08 18:27:16 volumio-n sudo[1000]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Oct 08 18:27:16 volumio-n sudo[1000]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 08 18:27:16 volumio-n volumio[683]: info: Starting Shairport Sync
Oct 08 18:27:16 volumio-n volumio[683]: info: Starting Shairport Sync
Oct 08 18:27:16 volumio-n sudo[1003]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Oct 08 18:27:16 volumio-n sudo[1003]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 08 18:27:16 volumio-n sudo[1009]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Oct 08 18:27:16 volumio-n sudo[1009]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 08 18:27:16 volumio-n sudo[1008]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Oct 08 18:27:17 volumio-n sudo[1008]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 08 18:27:17 volumio-n volumio[683]: info: MPD Permissions set
Oct 08 18:27:17 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:17 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:17 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:17 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:17 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:17 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:17 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:17 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:17 volumio-n 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.
Oct 08 18:27:17 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 08 18:27:17 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:17 volumio-n volumio[683]: info: CoreCommandRouter::volumioGetState
Oct 08 18:27:17 volumio-n volumio[683]: info: CorePlayQueue::getTrack 0
Oct 08 18:27:17 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd
Oct 08 18:27:17 volumio-n sudo[1017]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Oct 08 18:27:17 volumio-n sudo[1017]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 08 18:27:17 volumio-n sudo[963]: pam_unix(sudo:session): session closed for user root
Oct 08 18:27:17 volumio-n volumio[683]: info: touch_display: systemctl daemon-reload succeeded.
Oct 08 18:27:17 volumio-n sudo[1020]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service
Oct 08 18:27:17 volumio-n sudo[1020]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 08 18:27:17 volumio-n systemd[1]: Reloading.
Oct 08 18:27:17 volumio-n 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.
Oct 08 18:27:17 volumio-n mpd[935]: Oct 08 18:27 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Oct 08 18:27:18 volumio-n systemd[1]: Started Music Player Daemon.
Oct 08 18:27:18 volumio-n sudo[961]: pam_unix(sudo:session): session closed for user root
Oct 08 18:27:18 volumio-n sudo[918]: pam_unix(sudo:session): session closed for user root
Oct 08 18:27:18 volumio-n sudo[929]: pam_unix(sudo:session): session closed for user root
Oct 08 18:27:18 volumio-n volumio[683]: info: touch_display: systemctl disable getty@tty1.service succeeded.
Oct 08 18:27:18 volumio-n volumio[683]: error: MPD error: The expression evaluated to a falsy value:
Oct 08 18:27:18 volumio-n volumio[683]: assert.ok(self.idling)
Oct 08 18:27:18 volumio-n volumio[683]: error: The expression evaluated to a falsy value:
Oct 08 18:27:18 volumio-n volumio[683]: assert.ok(self.idling)
Oct 08 18:27:18 volumio-n volumio[683]: error: updateQueue error: null
Oct 08 18:27:18 volumio-n volumio[683]: info: MPD running with PID935
Oct 08 18:27:18 volumio-n volumio[683]: ,establishing connection
Oct 08 18:27:18 volumio-n volumio[683]: error: updateQueue error: null
Oct 08 18:27:18 volumio-n systemd[1]: Started Volumio Kiosk.
Oct 08 18:27:18 volumio-n sudo[1020]: pam_unix(sudo:session): session closed for user root
Oct 08 18:27:18 volumio-n systemd[1]: Stopping Music Player Daemon...
Oct 08 18:27:18 volumio-n systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Oct 08 18:27:18 volumio-n volumio[683]: info: touch_display: systemctl start volumio-kiosk.service succeeded.
Oct 08 18:27:18 volumio-n volumio[683]: info: touch_display: Volumio Kiosk started.
Oct 08 18:27:18 volumio-n systemd[1]: shairport-sync.service: Succeeded.
Oct 08 18:27:18 volumio-n systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Oct 08 18:27:18 volumio-n volumio[683]: info: CoreCommandRouter::volumioGetState
Oct 08 18:27:18 volumio-n volumio[683]: info: CorePlayQueue::getTrack 0
Oct 08 18:27:18 volumio-n volumio[683]: info: Completed starting Core Plugins
Oct 08 18:27:18 volumio-n volumio[683]: info: -------------------------------------------
Oct 08 18:27:18 volumio-n volumio[683]: info: ----- MyVolumio plugins startup ----
Oct 08 18:27:18 volumio-n volumio[683]: info: -------------------------------------------
Oct 08 18:27:18 volumio-n volumio[683]: info: [MyVolumio PluginManager] Fetching plans data....
Oct 08 18:27:18 volumio-n sudo[958]: pam_unix(sudo:session): session closed for user root
Oct 08 18:27:18 volumio-n volumio[683]: info: CoreCommandRouter::volumioGetState
Oct 08 18:27:18 volumio-n volumio[683]: info: CorePlayQueue::getTrack 0
Oct 08 18:27:18 volumio-n volumio[683]: info: touch_display: systemctl stop getty@tty1.service succeeded.
Oct 08 18:27:18 volumio-n systemd[1]: mpd.service: Succeeded.
Oct 08 18:27:18 volumio-n systemd[1]: Stopped Music Player Daemon.
Oct 08 18:27:18 volumio-n systemd[1]: Starting Music Player Daemon...
Oct 08 18:27:18 volumio-n systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Oct 08 18:27:18 volumio-n sudo[1008]: pam_unix(sudo:session): session closed for user root
Oct 08 18:27:18 volumio-n sudo[1000]: pam_unix(sudo:session): session closed for user root
Oct 08 18:27:18 volumio-n sudo[1003]: pam_unix(sudo:session): session closed for user root
Oct 08 18:27:18 volumio-n sudo[1009]: pam_unix(sudo:session): session closed for user root
Oct 08 18:27:18 volumio-n volumio[683]: info: Shairport-Sync Started
Oct 08 18:27:18 volumio-n volumio[683]: Error adding Membership: Error: addMembership EINVAL
Oct 08 18:27:18 volumio-n volumio[683]: info: Shairport-Sync Started
Oct 08 18:27:18 volumio-n volumio[683]: info: Shairport-Sync Started
Oct 08 18:27:18 volumio-n volumio[683]: info: Shairport-Sync Started
Oct 08 18:27:18 volumio-n volumio[683]: info: touch_display: X display number found: 0
Oct 08 18:27:18 volumio-n volumio[683]: info: touch_display: X display number found: 0
Oct 08 18:27:18 volumio-n startx[1039]: X.Org X Server 1.20.4
Oct 08 18:27:18 volumio-n startx[1039]: X Protocol Version 11, Revision 0
Oct 08 18:27:18 volumio-n startx[1039]: Build Operating System: Linux 5.4.0-109-generic armv8l Raspbian
Oct 08 18:27:18 volumio-n startx[1039]: Current Operating System: Linux volumio-n 6.1.69-v7l+ #1710 SMP Thu Dec 21 13:17:38 GMT 2023 armv7l
Oct 08 18:27:18 volumio-n startx[1039]: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_headphones=0 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=1280 bcm2708_fb.fbheight=400 bcm2708_fb.fbswap=1 smsc95xx.macaddr=E4:5F:01:BA:AF:9F 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=/dev/mmcblk0p2 imgfile=/volumio_current.sqsh rootwait bootdelay=5 elevator=noop 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
Oct 08 18:27:18 volumio-n startx[1039]: Build Date: 04 April 2023 07:50:56AM
Oct 08 18:27:18 volumio-n startx[1039]: xorg-server 2:1.20.4-1+rpt4+deb10u9 (https://www.debian.org/support)
Oct 08 18:27:18 volumio-n startx[1039]: Current version of pixman: 0.36.0
Oct 08 18:27:18 volumio-n startx[1039]: Before reporting problems, check http://wiki.x.org
Oct 08 18:27:18 volumio-n startx[1039]: to make sure that you have the latest version.
Oct 08 18:27:18 volumio-n startx[1039]: Markers: (--) probed, (**) from config file, (==) default setting,
Oct 08 18:27:18 volumio-n startx[1039]: (++) from command line, (!!) notice, (II) informational,
Oct 08 18:27:18 volumio-n startx[1039]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown.
Oct 08 18:27:18 volumio-n startx[1039]: (==) Log file: "/var/log/Xorg.0.log", Time: Tue Oct 8 18:27:18 2024
Oct 08 18:27:18 volumio-n startx[1039]: (==) Using config directory: "/etc/X11/xorg.conf.d"
Oct 08 18:27:18 volumio-n startx[1039]: (==) Using system config directory "/usr/share/X11/xorg.conf.d"
Oct 08 18:27:18 volumio-n volumio[683]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0
Oct 08 18:27:18 volumio-n volumio[683]: info: touch_display: X display number found: 0
Oct 08 18:27:19 volumio-n mpd[1057]: Oct 08 18:27 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Oct 08 18:27:19 volumio-n systemd[1]: Started Music Player Daemon.
Oct 08 18:27:19 volumio-n sudo[1017]: pam_unix(sudo:session): session closed for user root
Oct 08 18:27:19 volumio-n volumio[683]: error: updateQueue error: null
Oct 08 18:27:19 volumio-n volumio[683]: info: touch_display: Setting screensaver timeout to 120 seconds.
Oct 08 18:27:26 volumio-n volumio[683]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Oct 08 18:27:26 volumio-n volumio[683]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Oct 08 18:27:26 volumio-n volumio[683]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Oct 08 18:27:26 volumio-n volumio[683]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Oct 08 18:27:26 volumio-n volumio[683]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Oct 08 18:27:26 volumio-n volumio[683]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Oct 08 18:27:26 volumio-n volumio[683]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Oct 08 18:27:26 volumio-n volumio[683]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Oct 08 18:27:26 volumio-n volumio[683]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Oct 08 18:27:26 volumio-n volumio[683]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Oct 08 18:27:26 volumio-n volumio[683]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Oct 08 18:27:26 volumio-n volumio[683]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Oct 08 18:27:26 volumio-n volumio[683]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Oct 08 18:27:26 volumio-n volumio[683]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Oct 08 18:27:26 volumio-n volumio[683]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Oct 08 18:27:26 volumio-n volumio[683]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Oct 08 18:27:26 volumio-n volumio[683]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Oct 08 18:27:26 volumio-n volumio[683]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Oct 08 18:27:26 volumio-n volumio[683]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Oct 08 18:27:26 volumio-n volumio[683]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Oct 08 18:27:26 volumio-n volumio[683]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Oct 08 18:27:26 volumio-n volumio[683]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Oct 08 18:27:26 volumio-n volumio[683]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Oct 08 18:27:26 volumio-n volumio[683]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Oct 08 18:27:26 volumio-n volumio[683]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Oct 08 18:27:26 volumio-n volumio[683]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Oct 08 18:27:26 volumio-n volumio[683]: info: Adding plugin bluetooth to MyMusic Plugins
Oct 08 18:27:26 volumio-n volumio[683]: info: Adding plugin multiroom to MyMusic Plugins
Oct 08 18:27:26 volumio-n volumio[683]: info: Adding plugin metavolumio to MyMusic Plugins
Oct 08 18:27:26 volumio-n volumio[683]: info: Adding plugin cd_controller to MyMusic Plugins
Oct 08 18:27:26 volumio-n volumio[683]: info: Adding plugin smart_inputs to MyMusic Plugins
Oct 08 18:27:26 volumio-n volumio[683]: info: Adding plugin tidalconnect to MyMusic Plugins
Oct 08 18:27:26 volumio-n volumio[683]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Oct 08 18:27:27 volumio-n volumio[683]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Oct 08 18:27:27 volumio-n volumio[683]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Oct 08 18:27:27 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 08 18:27:27 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 08 18:27:27 volumio-n volumio[683]: info: Starting MyVolumio Remote Streaming Endpoints
Oct 08 18:27:27 volumio-n volumio[683]: info: MyVolumio not started
Oct 08 18:27:27 volumio-n volumio[683]: info: Initializing device activation check
Oct 08 18:27:27 volumio-n volumio[683]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Oct 08 18:27:27 volumio-n volumio[683]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Oct 08 18:27:28 volumio-n volumio[683]: info: Starting Streaming Service Transparent Proxy
Oct 08 18:27:28 volumio-n volumio[683]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Oct 08 18:27:28 volumio-n volumio[683]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Oct 08 18:27:28 volumio-n volumio[683]: info: Streaming services startup
Oct 08 18:27:28 volumio-n volumio[683]: info: Starting Streaming Daemon
Oct 08 18:27:28 volumio-n sudo[1265]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Oct 08 18:27:28 volumio-n sudo[1265]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 08 18:27:29 volumio-n sudo[1265]: pam_unix(sudo:session): session closed for user root
Oct 08 18:27:29 volumio-n volumio[683]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Oct 08 18:27:29 volumio-n volumio[683]: error: Cannot start Volumio Streaming Daemon
Oct 08 18:27:29 volumio-n volumio[683]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Oct 08 18:27:29 volumio-n volumio[683]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Oct 08 18:27:29 volumio-n volumio[683]: STREAMING PROXY: Starting server on port 3245
Oct 08 18:27:29 volumio-n volumio[683]: Node JS runtime: 14
Oct 08 18:27:31 volumio-n volumio[683]: 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: 8
Oct 08 18:27:31 volumio-n volumio[897]: Generating RSA private key, 4096 bit long modulus (2 primes)
Oct 08 18:27:32 volumio-n volumio[683]: 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: 9
Oct 08 18:27:33 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Oct 08 18:27:34 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Oct 08 18:27:34 volumio-n volumio[683]: info: CoreCommandRouter::volumioGetVisibleSources
Oct 08 18:27:34 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 08 18:27:34 volumio-n volumio[683]: info: CoreCommandRouter::volumioGetState
Oct 08 18:27:34 volumio-n volumio[683]: info: CorePlayQueue::getTrack 0
Oct 08 18:27:34 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Oct 08 18:27:34 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Oct 08 18:27:34 volumio-n volumio[683]: info: Received Get System Info
Oct 08 18:27:34 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 08 18:27:34 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 08 18:27:34 volumio-n volumio[683]: info: Discovery: Getting this device information
Oct 08 18:27:34 volumio-n volumio[683]: info: CoreCommandRouter::volumioGetState
Oct 08 18:27:34 volumio-n volumio[683]: info: CorePlayQueue::getTrack 0
Oct 08 18:27:34 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 08 18:27:34 volumio-n volumio[683]: info: CoreCommandRouter::volumioGetState
Oct 08 18:27:34 volumio-n volumio[683]: info: CorePlayQueue::getTrack 0
Oct 08 18:27:34 volumio-n volumio[683]: info: Listing playlists
Oct 08 18:27:34 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Oct 08 18:27:34 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 08 18:27:34 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 08 18:27:34 volumio-n volumio[683]: info: Received Get System Info
Oct 08 18:27:34 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 08 18:27:34 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 08 18:27:34 volumio-n volumio[683]: info: Discovery: Getting this device information
Oct 08 18:27:34 volumio-n volumio[683]: info: CoreCommandRouter::volumioGetState
Oct 08 18:27:34 volumio-n volumio[683]: info: CorePlayQueue::getTrack 0
Oct 08 18:27:34 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 08 18:27:34 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Oct 08 18:27:42 volumio-n volumio[683]: info: CoreCommandRouter::volumioGetState
Oct 08 18:27:42 volumio-n volumio[683]: info: CorePlayQueue::getTrack 0
Oct 08 18:27:42 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 08 18:27:42 volumio-n volumio[683]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 10
Oct 08 18:27:42 volumio-n volumio[683]: info: CoreCommandRouter::volumioGetState
Oct 08 18:27:42 volumio-n volumio[683]: info: CorePlayQueue::getTrack 0
Oct 08 18:27:44 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 08 18:27:46 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 08 18:27:46 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 08 18:27:46 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Oct 08 18:27:46 volumio-n volumio-remote-updater[448]: No test mode
Oct 08 18:27:46 volumio-n volumio-remote-updater[448]: No alpha test mode
Oct 08 18:27:46 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Oct 08 18:27:46 volumio-n ntpd[670]: Soliciting pool server 212.7.1.131
Oct 08 18:27:46 volumio-n volumio[683]: 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 08 18:27:46 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Oct 08 18:27:46 volumio-n ntpd[670]: Soliciting pool server 193.40.133.134
Oct 08 18:27:46 volumio-n volumio[683]: info: CoreCommandRouter::Close All Modals sent
Oct 08 18:27:47 volumio-n ntpd[670]: Soliciting pool server 185.194.53.27
Oct 08 18:27:47 volumio-n ntpd[670]: Soliciting pool server 193.40.134.137
Oct 08 18:27:47 volumio-n ntpd[670]: Soliciting pool server 212.7.1.132
Oct 08 18:27:47 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:47 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:47 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Oct 08 18:27:47 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Oct 08 18:27:47 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Oct 08 18:27:47 volumio-n volumio[683]: info: CoreCommandRouter::volumioGetBrowseSources
Oct 08 18:27:47 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 08 18:27:48 volumio-n volumio[897]: .....................................................................................................................................................................................++++
Oct 08 18:27:48 volumio-n ntpd[670]: Soliciting pool server 193.40.0.5
Oct 08 18:27:48 volumio-n ntpd[670]: Soliciting pool server 193.40.0.5
Oct 08 18:27:48 volumio-n ntpd[670]: Soliciting pool server 91.206.16.3
Oct 08 18:27:49 volumio-n volumio[683]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Oct 08 18:27:49 volumio-n volumio[683]: info: Completed starting MyVolumio Plugin
Oct 08 18:27:49 volumio-n volumio[683]: info: BOOT COMPLETED
Oct 08 18:27:49 volumio-n volumio[683]: [Metrics] CommandRouter: 68s 26.33ms
Oct 08 18:27:49 volumio-n volumio[683]: info: CoreCommandRouter::volumiosetStartupVolume
Oct 08 18:27:49 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 08 18:27:49 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 08 18:27:49 volumio-n volumio[683]: info: CoreCommandRouter::Close All Modals sent
Oct 08 18:27:49 volumio-n volumio[683]: info: CoreCommandRouter::Close All Modals sent
Oct 08 18:27:49 volumio-n ntpd[670]: Soliciting pool server 91.209.94.10
Oct 08 18:27:50 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Oct 08 18:27:50 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 08 18:27:50 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Oct 08 18:27:50 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 08 18:27:50 volumio-n volumio[683]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Oct 08 18:27:50 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Oct 08 18:27:50 volumio-n volumio[683]: info: Received Get System Version
Oct 08 18:27:50 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 08 18:27:50 volumio-n volumio[683]: info: Received Get System Info
Oct 08 18:27:50 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 08 18:27:50 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 08 18:27:50 volumio-n volumio[683]: info: Discovery: Getting this device information
Oct 08 18:27:50 volumio-n volumio[683]: info: CoreCommandRouter::volumioGetState
Oct 08 18:27:50 volumio-n volumio[683]: info: CorePlayQueue::getTrack 0
Oct 08 18:27:50 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 08 18:27:50 volumio-n ntpd[670]: Soliciting pool server 91.207.136.55
Oct 08 18:27:51 volumio-n ntpd[670]: Soliciting pool server 193.192.36.3
Oct 08 18:27:52 volumio-n ntpd[670]: Soliciting pool server 2001:1b28:1:5::132
Oct 08 18:28:14 volumio-n ntpd[670]: receive: Unexpected origin timestamp 0xeaafcdf9.9846280f does not match aorg 0000000000.00000000 from server@193.40.133.134 xmt 0xeaafce0e.d3517a14
Oct 08 18:28:14 volumio-n ntpd[670]: receive: Unexpected origin timestamp 0xeaafcdf9.982d36c3 does not match aorg 0000000000.00000000 from server@91.209.94.10 xmt 0xeaafce0e.d4835e3c
Oct 08 18:28:14 volumio-n volumio[683]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 08 18:28:14 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 08 18:28:25 volumio-n volumio[897]: ...................................................................................................................................................................................++++
Oct 08 18:28:25 volumio-n volumio[897]: e is 65537 (0x010001)
Oct 08 18:28:25 volumio-n volumio[897]: writing RSA key
Oct 08 18:28:33 volumio-n volumio[683]: info: CALLMETHOD: user_interface peppy_screensaver savePeppyMeterConf [object Object]
Oct 08 18:28:33 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , savePeppyMeterConf
Oct 08 18:28:33 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 08 18:28:33 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 08 18:28:33 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 08 18:28:33 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 08 18:28:40 volumio-n volumio[683]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 08 18:28:42 volumio-n volumio[683]: info: CoreCommandRouter::Close All Modals sent
Oct 08 18:28:46 volumio-n volumio[683]: info: CoreCommandRouter::volumioGetState
Oct 08 18:28:46 volumio-n volumio[683]: info: CorePlayQueue::getTrack 0
Oct 08 18:28:50 volumio-n volumio[683]: info: Preload queue cleared
Oct 08 18:28:50 volumio-n volumio[683]: info: CoreCommandRouter::volumioReplaceandPlayItems
Oct 08 18:28:50 volumio-n volumio[683]: info: CoreStateMachine::ClearQueue
Oct 08 18:28:50 volumio-n volumio[683]: info: CoreStateMachine::stop
Oct 08 18:28:50 volumio-n volumio[683]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 08 18:28:50 volumio-n volumio[683]: info: CorePlayQueue::clearPlayQueue
Oct 08 18:28:50 volumio-n volumio[683]: info: CorePlayQueue::saveQueue
Oct 08 18:28:50 volumio-n volumio[683]: info: CoreCommandRouter::volumioPushQueue
Oct 08 18:28:50 volumio-n volumio[683]: info: CoreStateMachine::addQueueItems
Oct 08 18:28:50 volumio-n volumio[683]: info: CorePlayQueue::addQueueItems
Oct 08 18:28:50 volumio-n volumio[683]: info: Preload queue cleared
Oct 08 18:28:50 volumio-n volumio[683]: info: Adding Item to queue: music-library/USB/Samsung_USB/[192kHz-24bit]
Oct 08 18:28:50 volumio-n volumio[683]: info: Exploding uri music-library/USB/Samsung_USB/[192kHz-24bit] in service mpd
Oct 08 18:28:50 volumio-n volumio[683]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists/Audiophile%20Speaker%20Set-Up/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%5B192kHz-24bit%5D%2F01-Audiophile%20Speakers%20Test%20Presentation.flac&metadata=false
Oct 08 18:28:50 volumio-n volumio[683]: info: URI /mnt/USB/Samsung_USB/[192kHz-24bit]/01-Audiophile Speakers Test Presentation.flac
Oct 08 18:28:50 volumio-n volumio[683]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists/Audiophile%20Speaker%20Set-Up/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%5B192kHz-24bit%5D%2F02-The%20Pink%20Panther.flac&metadata=false
Oct 08 18:28:50 volumio-n volumio[683]: info: URI /mnt/USB/Samsung_USB/[192kHz-24bit]/02-The Pink Panther.flac
Oct 08 18:28:50 volumio-n volumio[683]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists/Audiophile%20Speaker%20Set-Up/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%5B192kHz-24bit%5D%2F03-Everybody%20Loves%20Somebody.flac&metadata=false
Oct 08 18:28:50 volumio-n volumio[683]: info: URI /mnt/USB/Samsung_USB/[192kHz-24bit]/03-Everybody Loves Somebody.flac
Oct 08 18:28:50 volumio-n volumio[683]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists/Audiophile%20Speaker%20Set-Up/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%5B192kHz-24bit%5D%2F04-Story.flac&metadata=false
Oct 08 18:28:50 volumio-n volumio[683]: info: URI /mnt/USB/Samsung_USB/[192kHz-24bit]/04-Story.flac
Oct 08 18:28:50 volumio-n volumio[683]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists/Audiophile%20Speaker%20Set-Up/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%5B192kHz-24bit%5D%2F05-Very%20Early.flac&metadata=false
Oct 08 18:28:50 volumio-n volumio[683]: info: URI /mnt/USB/Samsung_USB/[192kHz-24bit]/05-Very Early.flac
Oct 08 18:28:50 volumio-n volumio[683]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists/Audiophile%20Speaker%20Set-Up/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%5B192kHz-24bit%5D%2F06-Good%20Morning%20Heartache.flac&metadata=false
Oct 08 18:28:50 volumio-n volumio[683]: info: URI /mnt/USB/Samsung_USB/[192kHz-24bit]/06-Good Morning Heartache.flac
Oct 08 18:28:50 volumio-n volumio[683]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists/Audiophile%20Speaker%20Set-Up/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%5B192kHz-24bit%5D%2F07-Jazz%20Session.flac&metadata=false
Oct 08 18:28:50 volumio-n volumio[683]: info: URI /mnt/USB/Samsung_USB/[192kHz-24bit]/07-Jazz Session.flac
Oct 08 18:28:50 volumio-n volumio[683]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists/Audiophile%20Speaker%20Set-Up/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%5B192kHz-24bit%5D%2F08-Greek%20Tycoon_%20Bouzouki%20Music.flac&metadata=false
Oct 08 18:28:50 volumio-n volumio[683]: info: URI /mnt/USB/Samsung_USB/[192kHz-24bit]/08-Greek Tycoon_ Bouzouki Music.flac
Oct 08 18:28:50 volumio-n volumio[683]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists/Audiophile%20Speaker%20Set-Up/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%5B192kHz-24bit%5D%2F09-Cello%20Suite%20(excerpt).flac&metadata=false
Oct 08 18:28:50 volumio-n volumio[683]: info: URI /mnt/USB/Samsung_USB/[192kHz-24bit]/09-Cello Suite (excerpt).flac
Oct 08 18:28:50 volumio-n volumio[683]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists/Audiophile%20Speaker%20Set-Up/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%5B192kHz-24bit%5D%2F10-String%20Quartet%20in%20G%20Minor%20(excerpt).flac&metadata=false
Oct 08 18:28:50 volumio-n volumio[683]: info: URI /mnt/USB/Samsung_USB/[192kHz-24bit]/10-String Quartet in G Minor (excerpt).flac
Oct 08 18:28:50 volumio-n volumio[683]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists/Audiophile%20Speaker%20Set-Up/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%5B192kHz-24bit%5D%2F11-Concert%20Piano.flac&metadata=false
Oct 08 18:28:50 volumio-n volumio[683]: info: URI /mnt/USB/Samsung_USB/[192kHz-24bit]/11-Concert Piano.flac
Oct 08 18:28:50 volumio-n volumio[683]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists/Audiophile%20Speaker%20Set-Up/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%5B192kHz-24bit%5D%2F12-J'entend%20la%20chanson%20des%20filles.flac&metadata=false
Oct 08 18:28:50 volumio-n volumio[683]: info: URI /mnt/USB/Samsung_USB/[192kHz-24bit]/12-J'entend la chanson des filles.flac
Oct 08 18:28:50 volumio-n volumio[683]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists/Audiophile%20Speaker%20Set-Up/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%5B192kHz-24bit%5D%2F13-Brandenburg%20Concerto%20No.%201%20in%20F%20Major%2C%20BWV%201046%20(excerpt).flac&metadata=false
Oct 08 18:28:50 volumio-n volumio[683]: info: URI /mnt/USB/Samsung_USB/[192kHz-24bit]/13-Brandenburg Concerto No. 1 in F Major, BWV 1046 (excerpt).flac
Oct 08 18:28:50 volumio-n volumio[683]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists/Audiophile%20Speaker%20Set-Up/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%5B192kHz-24bit%5D%2F14-Trumpet%20Solo.flac&metadata=false
Oct 08 18:28:50 volumio-n volumio[683]: info: URI /mnt/USB/Samsung_USB/[192kHz-24bit]/14-Trumpet Solo.flac
Oct 08 18:28:50 volumio-n volumio[683]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists/Audiophile%20Speaker%20Set-Up/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%5B192kHz-24bit%5D%2F15-Lieder%20Recital.flac&metadata=false
Oct 08 18:28:50 volumio-n volumio[683]: info: URI /mnt/USB/Samsung_USB/[192kHz-24bit]/15-Lieder Recital.flac
Oct 08 18:28:50 volumio-n volumio[683]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists/Audiophile%20Speaker%20Set-Up/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%5B192kHz-24bit%5D%2F16-Harp.flac&metadata=false
Oct 08 18:28:50 volumio-n volumio[683]: info: URI /mnt/USB/Samsung_USB/[192kHz-24bit]/16-Harp.flac
Oct 08 18:28:50 volumio-n volumio[683]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists/Audiophile%20Speaker%20Set-Up/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%5B192kHz-24bit%5D%2F17-Cello%20Sonata%2C%20Op.%2025%2C%20No.%203%20(excerpt).flac&metadata=false
Oct 08 18:28:50 volumio-n volumio[683]: info: URI /mnt/USB/Samsung_USB/[192kHz-24bit]/17-Cello Sonata, Op. 25, No. 3 (excerpt).flac
Oct 08 18:28:50 volumio-n volumio[683]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists/Audiophile%20Speaker%20Set-Up/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%5B192kHz-24bit%5D%2F18-Guitar.flac&metadata=false
Oct 08 18:28:50 volumio-n volumio[683]: info: URI /mnt/USB/Samsung_USB/[192kHz-24bit]/18-Guitar.flac
Oct 08 18:28:50 volumio-n volumio[683]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists/Audiophile%20Speaker%20Set-Up/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%5B192kHz-24bit%5D%2F19-Bassoon_%20Bassoon%201.flac&metadata=false
Oct 08 18:28:50 volumio-n volumio[683]: info: URI /mnt/USB/Samsung_USB/[192kHz-24bit]/19-Bassoon_ Bassoon 1.flac
Oct 08 18:28:50 volumio-n volumio[683]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists/Audiophile%20Speaker%20Set-Up/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%5B192kHz-24bit%5D%2F20-Bassoon_%20Bassoon%202.flac&metadata=false
Oct 08 18:28:50 volumio-n volumio[683]: info: URI /mnt/USB/Samsung_USB/[192kHz-24bit]/20-Bassoon_ Bassoon 2.flac
Oct 08 18:28:50 volumio-n volumio[683]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists/Audiophile%20Speaker%20Set-Up/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%5B192kHz-24bit%5D%2F21-Violin.flac&metadata=false
Oct 08 18:28:50 volumio-n volumio[683]: info: URI /mnt/USB/Samsung_USB/[192kHz-24bit]/21-Violin.flac
Oct 08 18:28:50 volumio-n volumio[683]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists/Audiophile%20Speaker%20Set-Up/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%5B192kHz-24bit%5D%2F22-Duduk.flac&metadata=false
Oct 08 18:28:50 volumio-n volumio[683]: info: URI /mnt/USB/Samsung_USB/[192kHz-24bit]/22-Duduk.flac
Oct 08 18:28:50 volumio-n volumio[683]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists/Audiophile%20Speaker%20Set-Up/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%5B192kHz-24bit%5D%2F23-Bawu.flac&metadata=false
Oct 08 18:28:50 volumio-n volumio[683]: info: URI /mnt/USB/Samsung_USB/[192kHz-24bit]/23-Bawu.flac
Oct 08 18:28:50 volumio-n volumio[683]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists/Audiophile%20Speaker%20Set-Up/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%5B192kHz-24bit%5D%2F24-Trumpet.flac&metadata=false
Oct 08 18:28:50 volumio-n volumio[683]: info: URI /mnt/USB/Samsung_USB/[192kHz-24bit]/24-Trumpet.flac
Oct 08 18:28:50 volumio-n volumio[683]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists/Audiophile%20Speaker%20Set-Up/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%5B192kHz-24bit%5D%2F25-Flugelhorn.flac&metadata=false
Oct 08 18:28:50 volumio-n volumio[683]: info: URI /mnt/USB/Samsung_USB/[192kHz-24bit]/25-Flugelhorn.flac
Oct 08 18:28:50 volumio-n volumio[683]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists/Audiophile%20Speaker%20Set-Up/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%5B192kHz-24bit%5D%2F26-Violin%20Concerto%20(excerpt).flac&metadata=false
Oct 08 18:28:50 volumio-n volumio[683]: info: URI /mnt/USB/Samsung_USB/[192kHz-24bit]/26-Violin Concerto (excerpt).flac
Oct 08 18:28:50 volumio-n volumio[683]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists/Audiophile%20Speaker%20Set-Up/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%5B192kHz-24bit%5D%2F27-Romeo%20and%20Juliet%20Suite%20No.%201%2C%20Op.%2064bis_%20Dance%20of%20the%20Knights.flac&metadata=false
Oct 08 18:28:50 volumio-n volumio[683]: info: URI /mnt/USB/Samsung_USB/[192kHz-24bit]/27-Romeo and Juliet Suite No. 1, Op. 64bis_ Dance of the Knights.flac
Oct 08 18:28:50 volumio-n volumio[683]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists/Audiophile%20Speaker%20Set-Up/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%5B192kHz-24bit%5D%2F28-Orchestra%20Excerpt.flac&metadata=false
Oct 08 18:28:50 volumio-n volumio[683]: info: URI /mnt/USB/Samsung_USB/[192kHz-24bit]/28-Orchestra Excerpt.flac
Oct 08 18:28:50 volumio-n volumio[683]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists/Audiophile%20Speaker%20Set-Up/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%5B192kHz-24bit%5D%2F29-Pictures%20at%20an%20Exhibition%20(arr.%20for%20orchestra)_%20Pictures%20at%20an%20Exibition%20(excerpt).flac&metadata=false
Oct 08 18:28:50 volumio-n volumio[683]: info: URI /mnt/USB/Samsung_USB/[192kHz-24bit]/29-Pictures at an Exhibition (arr. for orchestra)_ Pictures at an Exibition (excerpt).flac
Oct 08 18:28:50 volumio-n volumio[683]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists/2xHD%20-%20Audiophile%20Speaker%20Set-Up/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%5B192kHz-24bit%5D%2F2xHD%20Audiophile%20Speaker%20Set-Up.cue&metadata=false
Oct 08 18:28:50 volumio-n volumio[683]: info: URI /mnt/USB/Samsung_USB/[192kHz-24bit]/2xHD Audiophile Speaker Set-Up.cue
Oct 08 18:28:50 volumio-n volumio[683]: info: ALBUMART /albumart?cacheid=106&web=Various%20Artists/2xHD%20-%20Audiophile%20Speaker%20Set-Up/extralarge&path=%2Fmnt%2FUSB%2FSamsung_USB%2F%5B192kHz-24bit%5D%2F2xHD%20Audiophile%20Speaker%20Set-Up.cue&metadata=false
Oct 08 18:28:50 volumio-n volumio[683]: info: URI /mnt/USB/Samsung_USB/[192kHz-24bit]/2xHD Audiophile Speaker Set-Up.cue
Oct 08 18:28:50 volumio-n volumio[683]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 08 18:28:50 volumio-n volumio[683]: Error: Unable to resolve or reject the same promise twice
Oct 08 18:28:50 volumio-n volumio[683]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43)
Oct 08 18:28:50 volumio-n volumio[683]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21
Oct 08 18:28:50 volumio-n volumio[683]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3)
Oct 08 18:28:50 volumio-n volumio[683]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12)
Oct 08 18:28:50 volumio-n volumio[683]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12)
Oct 08 18:28:50 volumio-n volumio[683]: at Socket.emit (events.js:315:20)
Oct 08 18:28:50 volumio-n volumio[683]: at addChunk (internal/streams/readable.js:309:12)
Oct 08 18:28:50 volumio-n volumio[683]: at readableAddChunk (internal/streams/readable.js:280:11)
Oct 08 18:28:50 volumio-n volumio[683]: at Socket.Readable.push (internal/streams/readable.js:223:10)
Oct 08 18:28:50 volumio-n volumio[683]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23)
Oct 08 18:28:50 volumio-n volumio[683]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 08 18:28:51 volumio-n sudo[1555]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-08 18:27
Oct 08 18:28:51 volumio-n sudo[1555]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET"
VOLUMIO_VERSION="3.631"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"