-- Logs begin at Thu 2024-10-17 12:06:49 CST, end at Thu 2024-10-17 12:14:41 CST. -- Oct 17 12:13:07 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioGetState Oct 17 12:13:07 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:13:11 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 17 12:13:11 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 17 12:13:14 volumio-x86 volumio[841]: info: CoreStateMachine::stop Oct 17 12:13:14 volumio-x86 volumio[841]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 12:13:14 volumio-x86 volumio[841]: info: Disabling plugin peppy_screensaver Oct 17 12:13:14 volumio-x86 volumio[841]: info: Preparing to generate the ALSA configuration file Oct 17 12:13:14 volumio-x86 sudo[2495]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /volumio/app/plugins/music_service/mpd/mpd.conf.tmpl Oct 17 12:13:14 volumio-x86 sudo[2495]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:14 volumio-x86 volumio[841]: info: Asound.conf file written Oct 17 12:13:14 volumio-x86 systemd[1106]: volumio-app-plugins-music_service-mpd-mpd.conf.tmpl.mount: Succeeded. Oct 17 12:13:14 volumio-x86 systemd[1]: volumio-app-plugins-music_service-mpd-mpd.conf.tmpl.mount: Succeeded. Oct 17 12:13:14 volumio-x86 sudo[2495]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:14 volumio-x86 sudo[2498]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 17 12:13:14 volumio-x86 sudo[2498]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:14 volumio-x86 sudo[2498]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:15 volumio-x86 volumio[841]: info: Output device has changed, restarting MPD Oct 17 12:13:15 volumio-x86 sudo[2504]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 17 12:13:15 volumio-x86 volumio[841]: info: Output device has changed, restarting Shairport Sync Oct 17 12:13:15 volumio-x86 sudo[2504]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:15 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:15 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:15 volumio-x86 sudo[2504]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:15 volumio-x86 sudo[2506]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 17 12:13:15 volumio-x86 sudo[2506]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:15 volumio-x86 systemd[1]: Stopping Music Player Daemon... Oct 17 12:13:15 volumio-x86 volumio[841]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 12:13:15 volumio-x86 volumio[841]: info: Done. Oct 17 12:13:15 volumio-x86 systemd[1]: mpd.service: Succeeded. Oct 17 12:13:15 volumio-x86 systemd[1]: Stopped Music Player Daemon. Oct 17 12:13:15 volumio-x86 volumio[841]: info: MPD Permissions set Oct 17 12:13:15 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:15 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:15 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:15 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:15 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:15 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:15 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:15 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:15 volumio-x86 systemd[1]: Starting Music Player Daemon... Oct 17 12:13:15 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:15 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 17 12:13:15 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:15 volumio-x86 volumio[841]: info: Starting Shairport Sync Oct 17 12:13:15 volumio-x86 sudo[2521]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 17 12:13:15 volumio-x86 sudo[2521]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:15 volumio-x86 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 17 12:13:15 volumio-x86 systemd[1]: shairport-sync.service: Succeeded. Oct 17 12:13:15 volumio-x86 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 17 12:13:15 volumio-x86 sudo[2512]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 17 12:13:15 volumio-x86 sudo[2512]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:15 volumio-x86 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 17 12:13:15 volumio-x86 sudo[2512]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:15 volumio-x86 sudo[2521]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:15 volumio-x86 volumio[841]: info: Shairport-Sync Started Oct 17 12:13:15 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:16 volumio-x86 volumio[841]: info: Enabling plugin peppy_screensaver Oct 17 12:13:16 volumio-x86 volumio[841]: info: Loading plugin "peppy_screensaver"... Oct 17 12:13:16 volumio-x86 volumio[841]: info: Applying required configuration parameters for plugin peppy_screensaver Oct 17 12:13:16 volumio-x86 volumio[841]: info: Preparing to generate the ALSA configuration file Oct 17 12:13:16 volumio-x86 volumio[841]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Oct 17 12:13:16 volumio-x86 volumio[841]: info: Reading ALSA contributions from plugins. Oct 17 12:13:16 volumio-x86 volumio[841]: info: Asound.conf file written Oct 17 12:13:16 volumio-x86 sudo[2529]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 17 12:13:16 volumio-x86 sudo[2529]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:16 volumio-x86 sudo[2529]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:16 volumio-x86 volumio[841]: info: Output device has changed, restarting MPD Oct 17 12:13:16 volumio-x86 sudo[2534]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 17 12:13:16 volumio-x86 volumio[841]: info: Output device has changed, restarting Shairport Sync Oct 17 12:13:16 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:16 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:16 volumio-x86 sudo[2534]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:16 volumio-x86 sudo[2534]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:16 volumio-x86 sudo[2536]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 17 12:13:16 volumio-x86 sudo[2536]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:16 volumio-x86 volumio[841]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 12:13:16 volumio-x86 volumio[841]: info: PLUGIN START: peppy_screensaver Oct 17 12:13:16 volumio-x86 volumio[841]: info: Loading i18n strings for locale zh_TW Oct 17 12:13:16 volumio-x86 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 17 12:13:16 volumio-x86 systemd[1]: mpd.service: Succeeded. Oct 17 12:13:16 volumio-x86 systemd[1]: Stopped Music Player Daemon. Oct 17 12:13:16 volumio-x86 volumio[841]: info: /tmp/myfifo created Oct 17 12:13:16 volumio-x86 systemd[1]: Starting Music Player Daemon... Oct 17 12:13:16 volumio-x86 volumio[841]: info: /tmp/myfifosa created Oct 17 12:13:16 volumio-x86 sudo[2549]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-dummy index=7 pcm_substreams=1 fake_buffer=0 Oct 17 12:13:16 volumio-x86 sudo[2549]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:16 volumio-x86 sudo[2549]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:16 volumio-x86 volumio[841]: info: snd-dummy loaded Oct 17 12:13:16 volumio-x86 sudo[2542]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 17 12:13:16 volumio-x86 sudo[2542]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:17 volumio-x86 sudo[2542]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startShairportSync Oct 17 12:13:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:17 volumio-x86 volumio[841]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 12:13:17 volumio-x86 volumio[841]: info: Done. Oct 17 12:13:17 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioGetState Oct 17 12:13:17 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:13:17 volumio-x86 volumio[841]: info: MPD Permissions set Oct 17 12:13:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 17 12:13:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:17 volumio-x86 volumio[841]: info: Starting Shairport Sync Oct 17 12:13:17 volumio-x86 volumio[841]: info: Starting Shairport Sync Oct 17 12:13:17 volumio-x86 sudo[2576]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount --bind /tmp/mpd.conf.tmpl /volumio/app/plugins/music_service/mpd/mpd.conf.tmpl Oct 17 12:13:17 volumio-x86 sudo[2576]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:17 volumio-x86 sudo[2576]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: mpd , createMPDFile Oct 17 12:13:17 volumio-x86 sudo[2578]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 17 12:13:17 volumio-x86 sudo[2578]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:17 volumio-x86 sudo[2581]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 17 12:13:17 volumio-x86 sudo[2581]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:17 volumio-x86 sudo[2584]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 17 12:13:17 volumio-x86 sudo[2584]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:17 volumio-x86 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 17 12:13:17 volumio-x86 systemd[1]: shairport-sync.service: Succeeded. Oct 17 12:13:17 volumio-x86 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 17 12:13:17 volumio-x86 sudo[2584]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:17 volumio-x86 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 17 12:13:17 volumio-x86 sudo[2578]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:17 volumio-x86 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 17 12:13:17 volumio-x86 systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Oct 17 12:13:17 volumio-x86 systemd[1]: shairport-sync.service: Succeeded. Oct 17 12:13:17 volumio-x86 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 17 12:13:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 17 12:13:17 volumio-x86 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 17 12:13:17 volumio-x86 sudo[2581]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:17 volumio-x86 volumio[841]: info: Shairport-Sync Started Oct 17 12:13:17 volumio-x86 volumio[841]: info: MPD Permissions set Oct 17 12:13:17 volumio-x86 volumio[841]: info: Shairport-Sync Started Oct 17 12:13:18 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Oct 17 12:13:18 volumio-x86 sudo[2599]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 17 12:13:18 volumio-x86 sudo[2599]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:18 volumio-x86 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 17 12:13:18 volumio-x86 systemd[1]: mpd.service: Succeeded. Oct 17 12:13:18 volumio-x86 systemd[1]: Stopped Music Player Daemon. Oct 17 12:13:18 volumio-x86 systemd[1]: Starting Music Player Daemon... Oct 17 12:13:18 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioGetState Oct 17 12:13:18 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:13:18 volumio-x86 sudo[2605]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 17 12:13:18 volumio-x86 sudo[2605]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:18 volumio-x86 sudo[2605]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:19 volumio-x86 mpd[2610]: Oct 17 12:13 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 17 12:13:19 volumio-x86 systemd[1]: Started Music Player Daemon. Oct 17 12:13:19 volumio-x86 sudo[2599]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:19 volumio-x86 sudo[2506]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:19 volumio-x86 sudo[2536]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:19 volumio-x86 volumio[841]: error: MPD error: The expression evaluated to a falsy value: Oct 17 12:13:19 volumio-x86 volumio[841]: assert.ok(self.idling) Oct 17 12:13:19 volumio-x86 volumio[841]: error: The expression evaluated to a falsy value: Oct 17 12:13:19 volumio-x86 volumio[841]: assert.ok(self.idling) Oct 17 12:13:19 volumio-x86 volumio[841]: error: MPD error: The expression evaluated to a falsy value: Oct 17 12:13:19 volumio-x86 volumio[841]: assert.ok(self.idling) Oct 17 12:13:19 volumio-x86 volumio[841]: error: The expression evaluated to a falsy value: Oct 17 12:13:19 volumio-x86 volumio[841]: assert.ok(self.idling) Oct 17 12:13:19 volumio-x86 volumio[841]: error: updateQueue error: null Oct 17 12:13:19 volumio-x86 volumio[841]: info: CoreStateMachine::stop Oct 17 12:13:19 volumio-x86 volumio[841]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 12:13:19 volumio-x86 volumio[841]: info: Disabling plugin peppy_screensaver Oct 17 12:13:19 volumio-x86 volumio[841]: info: Preparing to generate the ALSA configuration file Oct 17 12:13:19 volumio-x86 volumio[841]: info: Asound.conf file written Oct 17 12:13:19 volumio-x86 sudo[2618]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /volumio/app/plugins/music_service/mpd/mpd.conf.tmpl Oct 17 12:13:19 volumio-x86 sudo[2618]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:19 volumio-x86 sudo[2618]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:19 volumio-x86 systemd[1106]: volumio-app-plugins-music_service-mpd-mpd.conf.tmpl.mount: Succeeded. Oct 17 12:13:19 volumio-x86 systemd[1]: volumio-app-plugins-music_service-mpd-mpd.conf.tmpl.mount: Succeeded. Oct 17 12:13:19 volumio-x86 sudo[2621]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 17 12:13:19 volumio-x86 sudo[2621]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:19 volumio-x86 sudo[2621]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:19 volumio-x86 volumio[841]: info: Output device has changed, restarting MPD Oct 17 12:13:19 volumio-x86 volumio[841]: info: Output device has changed, restarting Shairport Sync Oct 17 12:13:19 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:19 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:19 volumio-x86 sudo[2628]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 17 12:13:19 volumio-x86 sudo[2628]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:19 volumio-x86 sudo[2626]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 17 12:13:20 volumio-x86 sudo[2626]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:20 volumio-x86 sudo[2626]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:20 volumio-x86 systemd[1]: Stopping Music Player Daemon... Oct 17 12:13:20 volumio-x86 volumio[841]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 12:13:20 volumio-x86 volumio[841]: info: Done. Oct 17 12:13:20 volumio-x86 volumio[841]: info: MPD Permissions set Oct 17 12:13:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:20 volumio-x86 systemd[1]: mpd.service: Succeeded. Oct 17 12:13:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:20 volumio-x86 systemd[1]: Stopped Music Player Daemon. Oct 17 12:13:20 volumio-x86 systemd[1]: Starting Music Player Daemon... Oct 17 12:13:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 17 12:13:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:20 volumio-x86 volumio[841]: info: Starting Shairport Sync Oct 17 12:13:20 volumio-x86 sudo[2642]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 17 12:13:20 volumio-x86 sudo[2642]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:20 volumio-x86 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 17 12:13:20 volumio-x86 systemd[1]: shairport-sync.service: Succeeded. Oct 17 12:13:20 volumio-x86 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 17 12:13:20 volumio-x86 sudo[2634]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 17 12:13:20 volumio-x86 sudo[2634]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:20 volumio-x86 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 17 12:13:20 volumio-x86 sudo[2642]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:20 volumio-x86 volumio[841]: info: Shairport-Sync Started Oct 17 12:13:20 volumio-x86 sudo[2634]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:23 volumio-x86 mpd[2647]: Oct 17 12:13 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 17 12:13:23 volumio-x86 systemd[1]: Started Music Player Daemon. Oct 17 12:13:23 volumio-x86 sudo[2628]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:23 volumio-x86 volumio[841]: error: updateQueue error: null Oct 17 12:13:23 volumio-x86 volumio[841]: info: Enabling plugin peppy_screensaver Oct 17 12:13:23 volumio-x86 volumio[841]: info: Loading plugin "peppy_screensaver"... Oct 17 12:13:23 volumio-x86 volumio[841]: info: Applying required configuration parameters for plugin peppy_screensaver Oct 17 12:13:23 volumio-x86 volumio[841]: info: Preparing to generate the ALSA configuration file Oct 17 12:13:23 volumio-x86 volumio[841]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Oct 17 12:13:23 volumio-x86 volumio[841]: info: Reading ALSA contributions from plugins. Oct 17 12:13:23 volumio-x86 volumio[841]: info: Asound.conf file written Oct 17 12:13:23 volumio-x86 sudo[2653]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 17 12:13:23 volumio-x86 sudo[2653]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:23 volumio-x86 sudo[2653]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:23 volumio-x86 volumio[841]: info: Output device has changed, restarting MPD Oct 17 12:13:23 volumio-x86 sudo[2658]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 17 12:13:23 volumio-x86 sudo[2658]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:23 volumio-x86 volumio[841]: info: Output device has changed, restarting Shairport Sync Oct 17 12:13:23 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:23 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:23 volumio-x86 sudo[2658]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:23 volumio-x86 sudo[2661]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 17 12:13:23 volumio-x86 sudo[2661]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:23 volumio-x86 systemd[1]: Stopping Music Player Daemon... Oct 17 12:13:23 volumio-x86 volumio[841]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 12:13:23 volumio-x86 volumio[841]: info: PLUGIN START: peppy_screensaver Oct 17 12:13:23 volumio-x86 volumio[841]: info: Loading i18n strings for locale zh_TW Oct 17 12:13:23 volumio-x86 systemd[1]: mpd.service: Succeeded. Oct 17 12:13:23 volumio-x86 systemd[1]: Stopped Music Player Daemon. Oct 17 12:13:23 volumio-x86 volumio[841]: info: /tmp/myfifo created Oct 17 12:13:23 volumio-x86 systemd[1]: Starting Music Player Daemon... Oct 17 12:13:23 volumio-x86 volumio[841]: info: /tmp/myfifosa created Oct 17 12:13:23 volumio-x86 sudo[2672]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-dummy index=7 pcm_substreams=1 fake_buffer=0 Oct 17 12:13:23 volumio-x86 sudo[2672]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:23 volumio-x86 sudo[2672]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:23 volumio-x86 volumio[841]: info: snd-dummy loaded Oct 17 12:13:24 volumio-x86 sudo[2666]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 17 12:13:24 volumio-x86 sudo[2666]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:24 volumio-x86 sudo[2666]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:24 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:24 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:24 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:24 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startShairportSync Oct 17 12:13:24 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:24 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:24 volumio-x86 volumio[841]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 12:13:24 volumio-x86 volumio[841]: info: Done. Oct 17 12:13:24 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioGetState Oct 17 12:13:24 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:13:24 volumio-x86 volumio[841]: info: MPD Permissions set Oct 17 12:13:24 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:24 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:24 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:24 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:24 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:24 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:24 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:24 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:24 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 17 12:13:24 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:24 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:24 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:24 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:24 volumio-x86 volumio[841]: info: Starting Shairport Sync Oct 17 12:13:24 volumio-x86 sudo[2699]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount --bind /tmp/mpd.conf.tmpl /volumio/app/plugins/music_service/mpd/mpd.conf.tmpl Oct 17 12:13:24 volumio-x86 sudo[2699]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:24 volumio-x86 volumio[841]: info: Starting Shairport Sync Oct 17 12:13:24 volumio-x86 sudo[2699]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:24 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: mpd , createMPDFile Oct 17 12:13:24 volumio-x86 sudo[2702]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 17 12:13:24 volumio-x86 sudo[2704]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 17 12:13:24 volumio-x86 sudo[2704]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:24 volumio-x86 sudo[2702]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:24 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:24 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:24 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:24 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:24 volumio-x86 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 17 12:13:24 volumio-x86 systemd[1]: shairport-sync.service: Succeeded. Oct 17 12:13:24 volumio-x86 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 17 12:13:24 volumio-x86 sudo[2707]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 17 12:13:24 volumio-x86 sudo[2707]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:24 volumio-x86 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 17 12:13:24 volumio-x86 sudo[2704]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:24 volumio-x86 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 17 12:13:24 volumio-x86 systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Oct 17 12:13:24 volumio-x86 systemd[1]: shairport-sync.service: Succeeded. Oct 17 12:13:24 volumio-x86 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 17 12:13:24 volumio-x86 sudo[2707]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:24 volumio-x86 systemd[1]: shairport-sync.service: Start request repeated too quickly. Oct 17 12:13:24 volumio-x86 systemd[1]: shairport-sync.service: Failed with result 'start-limit-hit'. Oct 17 12:13:24 volumio-x86 systemd[1]: Failed to start Shairport Sync - AirPlay Audio Receiver. Oct 17 12:13:24 volumio-x86 sudo[2702]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:24 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:24 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 17 12:13:24 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:24 volumio-x86 volumio[841]: info: MPD Permissions set Oct 17 12:13:24 volumio-x86 volumio[841]: info: Shairport-sync error: Error: Command failed: /usr/bin/sudo /bin/systemctl restart shairport-sync Oct 17 12:13:24 volumio-x86 volumio[841]: Job for shairport-sync.service failed. Oct 17 12:13:24 volumio-x86 volumio[841]: See "systemctl status shairport-sync.service" and "journalctl -xe" for details. Oct 17 12:13:24 volumio-x86 volumio[841]: info: Shairport-Sync Started Oct 17 12:13:25 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Oct 17 12:13:25 volumio-x86 sudo[2718]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 17 12:13:25 volumio-x86 sudo[2718]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:25 volumio-x86 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 17 12:13:25 volumio-x86 systemd[1]: mpd.service: Succeeded. Oct 17 12:13:25 volumio-x86 systemd[1]: Stopped Music Player Daemon. Oct 17 12:13:25 volumio-x86 systemd[1]: Starting Music Player Daemon... Oct 17 12:13:25 volumio-x86 sudo[2720]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 17 12:13:25 volumio-x86 sudo[2720]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:25 volumio-x86 sudo[2720]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:25 volumio-x86 volumio[841]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 17 12:13:25 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:26 volumio-x86 mpd[2722]: Oct 17 12:13 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 17 12:13:26 volumio-x86 systemd[1]: Started Music Player Daemon. Oct 17 12:13:26 volumio-x86 sudo[2661]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:26 volumio-x86 sudo[2718]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:26 volumio-x86 volumio[841]: error: MPD error: The expression evaluated to a falsy value: Oct 17 12:13:26 volumio-x86 volumio[841]: assert.ok(self.idling) Oct 17 12:13:26 volumio-x86 volumio[841]: error: The expression evaluated to a falsy value: Oct 17 12:13:26 volumio-x86 volumio[841]: assert.ok(self.idling) Oct 17 12:13:26 volumio-x86 volumio[841]: error: updateQueue error: null Oct 17 12:13:29 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioGetState Oct 17 12:13:29 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:13:32 volumio-x86 volumio[841]: info: CALLMETHOD: user_interface peppy_screensaver savePeppyMeterConf [object Object] Oct 17 12:13:32 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , savePeppyMeterConf Oct 17 12:13:32 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:32 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:32 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:32 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:36 volumio-x86 volumio[841]: info: CALLMETHOD: user_interface peppy_screensaver saveVUMeterConf [object Object] Oct 17 12:13:36 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , saveVUMeterConf Oct 17 12:13:37 volumio-x86 volumio[841]: info: CALLMETHOD: user_interface peppy_screensaver saveVUMeterConf [object Object] Oct 17 12:13:37 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , saveVUMeterConf Oct 17 12:13:40 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioGetState Oct 17 12:13:40 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:13:41 volumio-x86 volumio[841]: info: CALLMETHOD: user_interface peppy_screensaver saveVUMeterConf [object Object] Oct 17 12:13:41 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , saveVUMeterConf Oct 17 12:13:41 volumio-x86 volumio[841]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 17 12:13:41 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:43 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 17 12:13:43 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 17 12:13:45 volumio-x86 volumio[841]: info: CoreStateMachine::stop Oct 17 12:13:45 volumio-x86 volumio[841]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 12:13:45 volumio-x86 volumio[841]: info: Disabling plugin peppy_screensaver Oct 17 12:13:45 volumio-x86 volumio[841]: info: Preparing to generate the ALSA configuration file Oct 17 12:13:45 volumio-x86 volumio[841]: info: Asound.conf file written Oct 17 12:13:45 volumio-x86 sudo[2745]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /volumio/app/plugins/music_service/mpd/mpd.conf.tmpl Oct 17 12:13:45 volumio-x86 sudo[2745]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:45 volumio-x86 sudo[2745]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:45 volumio-x86 systemd[1106]: volumio-app-plugins-music_service-mpd-mpd.conf.tmpl.mount: Succeeded. Oct 17 12:13:45 volumio-x86 systemd[1]: volumio-app-plugins-music_service-mpd-mpd.conf.tmpl.mount: Succeeded. Oct 17 12:13:45 volumio-x86 sudo[2748]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 17 12:13:45 volumio-x86 sudo[2748]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:45 volumio-x86 sudo[2748]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:45 volumio-x86 volumio[841]: info: Output device has changed, restarting MPD Oct 17 12:13:45 volumio-x86 sudo[2753]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 17 12:13:45 volumio-x86 volumio[841]: info: Output device has changed, restarting Shairport Sync Oct 17 12:13:45 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:45 volumio-x86 sudo[2753]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:45 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:45 volumio-x86 sudo[2753]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:45 volumio-x86 sudo[2755]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 17 12:13:45 volumio-x86 sudo[2755]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:45 volumio-x86 systemd[1]: Stopping Music Player Daemon... Oct 17 12:13:45 volumio-x86 volumio[841]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 12:13:45 volumio-x86 volumio[841]: info: Done. Oct 17 12:13:45 volumio-x86 systemd[1]: mpd.service: Succeeded. Oct 17 12:13:45 volumio-x86 systemd[1]: Stopped Music Player Daemon. Oct 17 12:13:45 volumio-x86 volumio[841]: info: MPD Permissions set Oct 17 12:13:45 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:45 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:45 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:45 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:45 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:45 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:45 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:45 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:45 volumio-x86 systemd[1]: Starting Music Player Daemon... Oct 17 12:13:45 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:45 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 17 12:13:45 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:45 volumio-x86 volumio[841]: info: Starting Shairport Sync Oct 17 12:13:45 volumio-x86 sudo[2769]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 17 12:13:45 volumio-x86 sudo[2769]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:45 volumio-x86 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 17 12:13:45 volumio-x86 sudo[2761]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 17 12:13:45 volumio-x86 sudo[2761]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:45 volumio-x86 sudo[2761]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:45 volumio-x86 sudo[2769]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:45 volumio-x86 volumio[841]: info: Shairport-Sync Started Oct 17 12:13:46 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:46 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:46 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:46 volumio-x86 mpd[2773]: Oct 17 12:13 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 17 12:13:46 volumio-x86 volumio[841]: info: Enabling plugin peppy_screensaver Oct 17 12:13:46 volumio-x86 volumio[841]: info: Loading plugin "peppy_screensaver"... Oct 17 12:13:46 volumio-x86 volumio[841]: info: Applying required configuration parameters for plugin peppy_screensaver Oct 17 12:13:46 volumio-x86 volumio[841]: info: Preparing to generate the ALSA configuration file Oct 17 12:13:46 volumio-x86 volumio[841]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Oct 17 12:13:46 volumio-x86 volumio[841]: info: Reading ALSA contributions from plugins. Oct 17 12:13:46 volumio-x86 volumio[841]: info: Asound.conf file written Oct 17 12:13:46 volumio-x86 systemd[1]: Started Music Player Daemon. Oct 17 12:13:46 volumio-x86 sudo[2755]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:46 volumio-x86 sudo[2779]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 17 12:13:46 volumio-x86 sudo[2779]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:46 volumio-x86 sudo[2779]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:47 volumio-x86 volumio[841]: info: Output device has changed, restarting MPD Oct 17 12:13:47 volumio-x86 sudo[2784]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 17 12:13:47 volumio-x86 volumio[841]: info: Output device has changed, restarting Shairport Sync Oct 17 12:13:47 volumio-x86 sudo[2784]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:47 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:47 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:47 volumio-x86 sudo[2784]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:47 volumio-x86 sudo[2786]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 17 12:13:47 volumio-x86 sudo[2786]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:47 volumio-x86 systemd[1]: Stopping Music Player Daemon... Oct 17 12:13:47 volumio-x86 volumio[841]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 12:13:47 volumio-x86 volumio[841]: info: PLUGIN START: peppy_screensaver Oct 17 12:13:47 volumio-x86 volumio[841]: info: Loading i18n strings for locale zh_TW Oct 17 12:13:47 volumio-x86 systemd[1]: mpd.service: Succeeded. Oct 17 12:13:47 volumio-x86 systemd[1]: Stopped Music Player Daemon. Oct 17 12:13:47 volumio-x86 systemd[1]: Starting Music Player Daemon... Oct 17 12:13:47 volumio-x86 volumio[841]: info: /tmp/myfifo created Oct 17 12:13:47 volumio-x86 volumio[841]: info: /tmp/myfifosa created Oct 17 12:13:47 volumio-x86 sudo[2798]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-dummy index=7 pcm_substreams=1 fake_buffer=0 Oct 17 12:13:47 volumio-x86 sudo[2798]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:47 volumio-x86 sudo[2798]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:47 volumio-x86 volumio[841]: info: snd-dummy loaded Oct 17 12:13:47 volumio-x86 sudo[2792]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 17 12:13:47 volumio-x86 sudo[2792]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:47 volumio-x86 sudo[2792]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:47 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:47 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:47 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startShairportSync Oct 17 12:13:47 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:47 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:47 volumio-x86 volumio[841]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 12:13:47 volumio-x86 volumio[841]: info: Done. Oct 17 12:13:47 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioGetState Oct 17 12:13:47 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:13:47 volumio-x86 volumio[841]: info: MPD Permissions set Oct 17 12:13:47 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:47 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:47 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:47 volumio-x86 sudo[2819]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount --bind /tmp/mpd.conf.tmpl /volumio/app/plugins/music_service/mpd/mpd.conf.tmpl Oct 17 12:13:47 volumio-x86 sudo[2819]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:48 volumio-x86 sudo[2819]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:48 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:48 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 17 12:13:48 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:48 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: mpd , createMPDFile Oct 17 12:13:48 volumio-x86 volumio[841]: info: Starting Shairport Sync Oct 17 12:13:48 volumio-x86 volumio[841]: info: Starting Shairport Sync Oct 17 12:13:48 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:48 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:48 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:48 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:48 volumio-x86 sudo[2828]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 17 12:13:48 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:48 volumio-x86 sudo[2828]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:48 volumio-x86 sudo[2830]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 17 12:13:48 volumio-x86 sudo[2830]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:48 volumio-x86 sudo[2828]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:48 volumio-x86 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 17 12:13:48 volumio-x86 systemd[1]: shairport-sync.service: Succeeded. Oct 17 12:13:48 volumio-x86 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 17 12:13:48 volumio-x86 sudo[2832]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 17 12:13:48 volumio-x86 sudo[2832]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:48 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:48 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 17 12:13:48 volumio-x86 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 17 12:13:48 volumio-x86 sudo[2830]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:48 volumio-x86 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 17 12:13:48 volumio-x86 systemd[1]: shairport-sync.service: Succeeded. Oct 17 12:13:48 volumio-x86 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 17 12:13:48 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:48 volumio-x86 volumio[841]: info: Shairport-Sync Started Oct 17 12:13:48 volumio-x86 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 17 12:13:48 volumio-x86 sudo[2832]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:48 volumio-x86 volumio[841]: (node:841) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pbeg listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Oct 17 12:13:48 volumio-x86 volumio[841]: (Use `node --trace-warnings ...` to show where the warning was created) Oct 17 12:13:48 volumio-x86 volumio[841]: (node:841) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 meta listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Oct 17 12:13:48 volumio-x86 volumio[841]: (node:841) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 prgr listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Oct 17 12:13:48 volumio-x86 volumio[841]: (node:841) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pvol listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Oct 17 12:13:48 volumio-x86 volumio[841]: (node:841) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pend listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Oct 17 12:13:48 volumio-x86 volumio[841]: info: MPD Permissions set Oct 17 12:13:48 volumio-x86 volumio[841]: info: Shairport-Sync Started Oct 17 12:13:48 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Oct 17 12:13:48 volumio-x86 sudo[2848]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 17 12:13:48 volumio-x86 sudo[2848]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:48 volumio-x86 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 17 12:13:48 volumio-x86 systemd[1]: mpd.service: Succeeded. Oct 17 12:13:48 volumio-x86 systemd[1]: Stopped Music Player Daemon. Oct 17 12:13:48 volumio-x86 systemd[1]: Starting Music Player Daemon... Oct 17 12:13:48 volumio-x86 volumio[841]: info: CoreStateMachine::stop Oct 17 12:13:48 volumio-x86 volumio[841]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 12:13:48 volumio-x86 sudo[2850]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 17 12:13:48 volumio-x86 sudo[2850]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:48 volumio-x86 sudo[2850]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:48 volumio-x86 volumio[841]: info: Disabling plugin peppy_screensaver Oct 17 12:13:48 volumio-x86 volumio[841]: info: Preparing to generate the ALSA configuration file Oct 17 12:13:49 volumio-x86 sudo[2857]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /volumio/app/plugins/music_service/mpd/mpd.conf.tmpl Oct 17 12:13:49 volumio-x86 sudo[2857]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:49 volumio-x86 systemd[1]: volumio-app-plugins-music_service-mpd-mpd.conf.tmpl.mount: Succeeded. Oct 17 12:13:49 volumio-x86 sudo[2857]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:49 volumio-x86 systemd[1106]: volumio-app-plugins-music_service-mpd-mpd.conf.tmpl.mount: Succeeded. Oct 17 12:13:49 volumio-x86 volumio[841]: info: Asound.conf file written Oct 17 12:13:49 volumio-x86 sudo[2860]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 17 12:13:49 volumio-x86 sudo[2860]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:49 volumio-x86 sudo[2860]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:49 volumio-x86 volumio[841]: info: Output device has changed, restarting MPD Oct 17 12:13:49 volumio-x86 sudo[2865]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 17 12:13:49 volumio-x86 sudo[2865]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:49 volumio-x86 sudo[2865]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:49 volumio-x86 volumio[841]: info: Output device has changed, restarting Shairport Sync Oct 17 12:13:49 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:49 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:49 volumio-x86 sudo[2868]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 17 12:13:49 volumio-x86 sudo[2868]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:49 volumio-x86 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 17 12:13:49 volumio-x86 systemd[1]: mpd.service: Succeeded. Oct 17 12:13:49 volumio-x86 systemd[1]: Stopped Music Player Daemon. Oct 17 12:13:49 volumio-x86 systemd[1]: Starting Music Player Daemon... Oct 17 12:13:49 volumio-x86 volumio[841]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 12:13:49 volumio-x86 volumio[841]: info: Done. Oct 17 12:13:49 volumio-x86 volumio[841]: info: MPD Permissions set Oct 17 12:13:49 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:49 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:49 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:49 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:49 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:49 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:49 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:49 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:49 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:49 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 17 12:13:49 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:49 volumio-x86 volumio[841]: info: Starting Shairport Sync Oct 17 12:13:49 volumio-x86 sudo[2873]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 17 12:13:49 volumio-x86 sudo[2873]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:49 volumio-x86 sudo[2873]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:49 volumio-x86 sudo[2881]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 17 12:13:49 volumio-x86 sudo[2881]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:49 volumio-x86 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 17 12:13:49 volumio-x86 systemd[1]: shairport-sync.service: Succeeded. Oct 17 12:13:49 volumio-x86 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 17 12:13:49 volumio-x86 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 17 12:13:49 volumio-x86 sudo[2881]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:49 volumio-x86 volumio[841]: info: Shairport-Sync Started Oct 17 12:13:49 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:50 volumio-x86 mpd[2883]: Oct 17 12:13 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 17 12:13:50 volumio-x86 systemd[1]: Started Music Player Daemon. Oct 17 12:13:50 volumio-x86 volumio[841]: error: updateQueue error: null Oct 17 12:13:50 volumio-x86 sudo[2868]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:50 volumio-x86 sudo[2848]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:50 volumio-x86 sudo[2786]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:50 volumio-x86 volumio[841]: error: MPD error: The expression evaluated to a falsy value: Oct 17 12:13:50 volumio-x86 volumio[841]: assert.ok(self.idling) Oct 17 12:13:50 volumio-x86 volumio[841]: error: The expression evaluated to a falsy value: Oct 17 12:13:50 volumio-x86 volumio[841]: assert.ok(self.idling) Oct 17 12:13:50 volumio-x86 volumio[841]: info: Enabling plugin peppy_screensaver Oct 17 12:13:50 volumio-x86 volumio[841]: info: Loading plugin "peppy_screensaver"... Oct 17 12:13:50 volumio-x86 volumio[841]: info: Applying required configuration parameters for plugin peppy_screensaver Oct 17 12:13:50 volumio-x86 volumio[841]: info: Preparing to generate the ALSA configuration file Oct 17 12:13:50 volumio-x86 volumio[841]: error: MPD error: The expression evaluated to a falsy value: Oct 17 12:13:50 volumio-x86 volumio[841]: assert.ok(self.idling) Oct 17 12:13:50 volumio-x86 volumio[841]: error: The expression evaluated to a falsy value: Oct 17 12:13:50 volumio-x86 volumio[841]: assert.ok(self.idling) Oct 17 12:13:50 volumio-x86 volumio[841]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Oct 17 12:13:50 volumio-x86 volumio[841]: info: Reading ALSA contributions from plugins. Oct 17 12:13:50 volumio-x86 volumio[841]: error: updateQueue error: null Oct 17 12:13:50 volumio-x86 volumio[841]: info: Asound.conf file written Oct 17 12:13:50 volumio-x86 sudo[2892]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 17 12:13:50 volumio-x86 sudo[2892]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:50 volumio-x86 sudo[2892]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:50 volumio-x86 volumio[841]: info: Output device has changed, restarting MPD Oct 17 12:13:50 volumio-x86 sudo[2897]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 17 12:13:50 volumio-x86 volumio[841]: info: Output device has changed, restarting Shairport Sync Oct 17 12:13:50 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:50 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:50 volumio-x86 sudo[2897]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:50 volumio-x86 sudo[2897]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:50 volumio-x86 sudo[2900]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 17 12:13:50 volumio-x86 sudo[2900]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:50 volumio-x86 systemd[1]: Stopping Music Player Daemon... Oct 17 12:13:50 volumio-x86 volumio[841]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 12:13:50 volumio-x86 volumio[841]: info: PLUGIN START: peppy_screensaver Oct 17 12:13:50 volumio-x86 volumio[841]: info: Loading i18n strings for locale zh_TW Oct 17 12:13:50 volumio-x86 systemd[1]: mpd.service: Succeeded. Oct 17 12:13:50 volumio-x86 systemd[1]: Stopped Music Player Daemon. Oct 17 12:13:50 volumio-x86 volumio[841]: info: /tmp/myfifo created Oct 17 12:13:50 volumio-x86 systemd[1]: Starting Music Player Daemon... Oct 17 12:13:50 volumio-x86 volumio[841]: info: /tmp/myfifosa created Oct 17 12:13:50 volumio-x86 sudo[2911]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-dummy index=7 pcm_substreams=1 fake_buffer=0 Oct 17 12:13:50 volumio-x86 sudo[2911]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:50 volumio-x86 sudo[2911]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:50 volumio-x86 volumio[841]: info: snd-dummy loaded Oct 17 12:13:50 volumio-x86 sudo[2906]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 17 12:13:50 volumio-x86 sudo[2906]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:50 volumio-x86 sudo[2906]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:51 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:51 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:51 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startShairportSync Oct 17 12:13:51 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:51 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:51 volumio-x86 volumio[841]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 12:13:51 volumio-x86 volumio[841]: info: Done. Oct 17 12:13:51 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioGetState Oct 17 12:13:51 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:13:51 volumio-x86 volumio[841]: info: MPD Permissions set Oct 17 12:13:51 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:51 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:51 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:51 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:51 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:51 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:51 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:51 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 17 12:13:51 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:51 volumio-x86 volumio[841]: info: Starting Shairport Sync Oct 17 12:13:51 volumio-x86 volumio[841]: info: Starting Shairport Sync Oct 17 12:13:51 volumio-x86 sudo[2935]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 17 12:13:51 volumio-x86 sudo[2935]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:51 volumio-x86 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 17 12:13:51 volumio-x86 sudo[2937]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 17 12:13:51 volumio-x86 systemd[1]: shairport-sync.service: Succeeded. Oct 17 12:13:51 volumio-x86 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 17 12:13:51 volumio-x86 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 17 12:13:51 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:51 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:51 volumio-x86 sudo[2937]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:51 volumio-x86 sudo[2935]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:51 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:51 volumio-x86 volumio[841]: info: Shairport-Sync Started Oct 17 12:13:51 volumio-x86 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 17 12:13:51 volumio-x86 systemd[1]: shairport-sync.service: Succeeded. Oct 17 12:13:51 volumio-x86 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 17 12:13:51 volumio-x86 systemd[1]: shairport-sync.service: Start request repeated too quickly. Oct 17 12:13:51 volumio-x86 systemd[1]: shairport-sync.service: Failed with result 'start-limit-hit'. Oct 17 12:13:51 volumio-x86 systemd[1]: Failed to start Shairport Sync - AirPlay Audio Receiver. Oct 17 12:13:51 volumio-x86 sudo[2945]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount --bind /tmp/mpd.conf.tmpl /volumio/app/plugins/music_service/mpd/mpd.conf.tmpl Oct 17 12:13:51 volumio-x86 sudo[2945]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:51 volumio-x86 sudo[2937]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:51 volumio-x86 sudo[2945]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:51 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: mpd , createMPDFile Oct 17 12:13:51 volumio-x86 volumio[841]: info: Shairport-sync error: Error: Command failed: /usr/bin/sudo /bin/systemctl restart shairport-sync Oct 17 12:13:51 volumio-x86 volumio[841]: Job for shairport-sync.service failed. Oct 17 12:13:51 volumio-x86 volumio[841]: See "systemctl status shairport-sync.service" and "journalctl -xe" for details. Oct 17 12:13:51 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:51 volumio-x86 sudo[2950]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 17 12:13:51 volumio-x86 sudo[2950]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:51 volumio-x86 sudo[2950]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:51 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:51 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 17 12:13:51 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:13:51 volumio-x86 volumio[841]: info: MPD Permissions set Oct 17 12:13:51 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioGetState Oct 17 12:13:51 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:13:51 volumio-x86 screensaver.sh[633]: 2916 Oct 17 12:13:51 volumio-x86 volumio[841]: warn: peppy_screensaver: An error occurred on pygame check Command failed: python3 -c "import pygame" Oct 17 12:13:51 volumio-x86 volumio[841]: Terminated Oct 17 12:13:51 volumio-x86 volumio[841]: {"killed":false,"code":143,"signal":null,"cmd":"python3 -c \"import pygame\"","stack":"Error: Command failed: python3 -c \"import pygame\"\nTerminated\n\n at ChildProcess.exithandler (child_process.js:383:12)\n at ChildProcess.emit (events.js:400:28)\n at maybeClose (internal/child_process.js:1088:16)\n at Socket. (internal/child_process.js:446:11)\n at Socket.emit (events.js:400:28)\n at Pipe. (net.js:686:12)"} Oct 17 12:13:52 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Oct 17 12:13:52 volumio-x86 sudo[2967]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 17 12:13:52 volumio-x86 sudo[2967]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:52 volumio-x86 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 17 12:13:52 volumio-x86 systemd[1]: mpd.service: Succeeded. Oct 17 12:13:52 volumio-x86 systemd[1]: Stopped Music Player Daemon. Oct 17 12:13:52 volumio-x86 systemd[1]: Starting Music Player Daemon... Oct 17 12:13:52 volumio-x86 sudo[2969]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 17 12:13:52 volumio-x86 sudo[2969]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:13:52 volumio-x86 sudo[2969]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:53 volumio-x86 volumio[841]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 17 12:13:53 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:13:53 volumio-x86 mpd[2971]: Oct 17 12:13 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 17 12:13:53 volumio-x86 systemd[1]: Started Music Player Daemon. Oct 17 12:13:53 volumio-x86 sudo[2967]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:53 volumio-x86 sudo[2900]: pam_unix(sudo:session): session closed for user root Oct 17 12:13:53 volumio-x86 volumio[841]: error: updateQueue error: null Oct 17 12:13:53 volumio-x86 volumio[841]: error: updateQueue error: null Oct 17 12:13:55 volumio-x86 volumiologrotate[616]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Oct 17 12:13:55 volumio-x86 volumiologrotate[616]: ls: cannot access 'X86': No such file or directory Oct 17 12:14:01 volumio-x86 volumio[841]: info: CALLMETHOD: user_interface peppy_screensaver savePeppyMeterConf [object Object] Oct 17 12:14:01 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , savePeppyMeterConf Oct 17 12:14:01 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:14:01 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:14:01 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:14:01 volumio-x86 volumio[841]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 17 12:14:01 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:14:02 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioGetState Oct 17 12:14:02 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:09 volumio-x86 volumio[841]: info: CALLMETHOD: user_interface peppy_screensaver saveVUMeterConf [object Object] Oct 17 12:14:09 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , saveVUMeterConf Oct 17 12:14:09 volumio-x86 volumio[841]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 17 12:14:09 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:14:12 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 17 12:14:12 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 17 12:14:14 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioGetState Oct 17 12:14:14 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:14 volumio-x86 volumio[841]: info: CoreStateMachine::stop Oct 17 12:14:14 volumio-x86 volumio[841]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 12:14:14 volumio-x86 volumio[841]: info: Disabling plugin peppy_screensaver Oct 17 12:14:14 volumio-x86 volumio[841]: info: Preparing to generate the ALSA configuration file Oct 17 12:14:14 volumio-x86 volumio[841]: info: Asound.conf file written Oct 17 12:14:14 volumio-x86 sudo[3040]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /volumio/app/plugins/music_service/mpd/mpd.conf.tmpl Oct 17 12:14:14 volumio-x86 sudo[3040]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:14 volumio-x86 sudo[3040]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:14 volumio-x86 systemd[1106]: volumio-app-plugins-music_service-mpd-mpd.conf.tmpl.mount: Succeeded. Oct 17 12:14:14 volumio-x86 systemd[1]: volumio-app-plugins-music_service-mpd-mpd.conf.tmpl.mount: Succeeded. Oct 17 12:14:14 volumio-x86 sudo[3043]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 17 12:14:14 volumio-x86 sudo[3043]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:14 volumio-x86 sudo[3043]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:15 volumio-x86 volumio[841]: info: Output device has changed, restarting MPD Oct 17 12:14:15 volumio-x86 sudo[3048]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 17 12:14:15 volumio-x86 sudo[3048]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:15 volumio-x86 volumio[841]: info: Output device has changed, restarting Shairport Sync Oct 17 12:14:15 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:15 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:14:15 volumio-x86 sudo[3048]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:15 volumio-x86 sudo[3050]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 17 12:14:15 volumio-x86 sudo[3050]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:15 volumio-x86 systemd[1]: Stopping Music Player Daemon... Oct 17 12:14:15 volumio-x86 volumio[841]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 12:14:15 volumio-x86 volumio[841]: info: Done. Oct 17 12:14:15 volumio-x86 volumio[841]: info: MPD Permissions set Oct 17 12:14:15 volumio-x86 systemd[1]: mpd.service: Succeeded. Oct 17 12:14:15 volumio-x86 systemd[1]: Stopped Music Player Daemon. Oct 17 12:14:15 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:15 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:15 volumio-x86 systemd[1]: Starting Music Player Daemon... Oct 17 12:14:15 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:14:15 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 17 12:14:15 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:15 volumio-x86 volumio[841]: info: Starting Shairport Sync Oct 17 12:14:15 volumio-x86 sudo[3064]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 17 12:14:15 volumio-x86 sudo[3064]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:15 volumio-x86 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 17 12:14:15 volumio-x86 sudo[3056]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 17 12:14:15 volumio-x86 sudo[3056]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:15 volumio-x86 sudo[3056]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:15 volumio-x86 sudo[3064]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:15 volumio-x86 volumio[841]: info: Shairport-Sync Started Oct 17 12:14:15 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:16 volumio-x86 volumio[841]: info: Enabling plugin peppy_screensaver Oct 17 12:14:16 volumio-x86 volumio[841]: info: Loading plugin "peppy_screensaver"... Oct 17 12:14:16 volumio-x86 volumio[841]: info: Applying required configuration parameters for plugin peppy_screensaver Oct 17 12:14:16 volumio-x86 volumio[841]: info: Preparing to generate the ALSA configuration file Oct 17 12:14:16 volumio-x86 volumio[841]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Oct 17 12:14:16 volumio-x86 volumio[841]: info: Reading ALSA contributions from plugins. Oct 17 12:14:16 volumio-x86 volumio[841]: info: Asound.conf file written Oct 17 12:14:16 volumio-x86 sudo[3072]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 17 12:14:16 volumio-x86 sudo[3072]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:16 volumio-x86 sudo[3072]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:16 volumio-x86 volumio[841]: info: Output device has changed, restarting MPD Oct 17 12:14:16 volumio-x86 sudo[3077]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 17 12:14:16 volumio-x86 sudo[3077]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:16 volumio-x86 volumio[841]: info: Output device has changed, restarting Shairport Sync Oct 17 12:14:16 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:16 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:14:16 volumio-x86 sudo[3077]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:16 volumio-x86 sudo[3080]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 17 12:14:16 volumio-x86 sudo[3080]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:16 volumio-x86 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 17 12:14:16 volumio-x86 systemd[1]: mpd.service: Succeeded. Oct 17 12:14:16 volumio-x86 systemd[1]: Stopped Music Player Daemon. Oct 17 12:14:16 volumio-x86 systemd[1]: Starting Music Player Daemon... Oct 17 12:14:16 volumio-x86 volumio[841]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 12:14:16 volumio-x86 volumio[841]: info: PLUGIN START: peppy_screensaver Oct 17 12:14:16 volumio-x86 volumio[841]: info: Loading i18n strings for locale zh_TW Oct 17 12:14:16 volumio-x86 volumio[841]: info: /tmp/myfifo created Oct 17 12:14:16 volumio-x86 volumio[841]: info: /tmp/myfifosa created Oct 17 12:14:16 volumio-x86 sudo[3091]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-dummy index=7 pcm_substreams=1 fake_buffer=0 Oct 17 12:14:16 volumio-x86 sudo[3091]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:16 volumio-x86 sudo[3085]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 17 12:14:16 volumio-x86 sudo[3091]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:16 volumio-x86 sudo[3085]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:16 volumio-x86 volumio[841]: info: snd-dummy loaded Oct 17 12:14:16 volumio-x86 sudo[3085]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:16 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:14:16 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:16 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:16 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startShairportSync Oct 17 12:14:16 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:16 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:14:16 volumio-x86 volumio[841]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 12:14:16 volumio-x86 volumio[841]: info: Done. Oct 17 12:14:16 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioGetState Oct 17 12:14:16 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:16 volumio-x86 volumio[841]: info: MPD Permissions set Oct 17 12:14:16 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:16 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:16 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:16 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:16 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:16 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:14:16 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 17 12:14:16 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:16 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:16 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:16 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:16 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:16 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:17 volumio-x86 volumio[841]: info: Starting Shairport Sync Oct 17 12:14:17 volumio-x86 volumio[841]: info: Starting Shairport Sync Oct 17 12:14:17 volumio-x86 sudo[3119]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount --bind /tmp/mpd.conf.tmpl /volumio/app/plugins/music_service/mpd/mpd.conf.tmpl Oct 17 12:14:17 volumio-x86 sudo[3119]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:17 volumio-x86 sudo[3119]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: mpd , createMPDFile Oct 17 12:14:17 volumio-x86 sudo[3120]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 17 12:14:17 volumio-x86 sudo[3120]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:17 volumio-x86 sudo[3123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 17 12:14:17 volumio-x86 sudo[3123]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:17 volumio-x86 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 17 12:14:17 volumio-x86 systemd[1]: shairport-sync.service: Succeeded. Oct 17 12:14:17 volumio-x86 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 17 12:14:17 volumio-x86 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 17 12:14:17 volumio-x86 sudo[3120]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:17 volumio-x86 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 17 12:14:17 volumio-x86 systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Oct 17 12:14:17 volumio-x86 systemd[1]: shairport-sync.service: Succeeded. Oct 17 12:14:17 volumio-x86 sudo[3127]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 17 12:14:17 volumio-x86 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 17 12:14:17 volumio-x86 sudo[3127]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:17 volumio-x86 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 17 12:14:17 volumio-x86 sudo[3123]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:17 volumio-x86 sudo[3127]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:14:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 17 12:14:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:17 volumio-x86 volumio[841]: info: MPD Permissions set Oct 17 12:14:17 volumio-x86 volumio[841]: info: Shairport-Sync Started Oct 17 12:14:17 volumio-x86 volumio[841]: info: Shairport-Sync Started Oct 17 12:14:17 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Oct 17 12:14:17 volumio-x86 sudo[3140]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 17 12:14:17 volumio-x86 sudo[3140]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:17 volumio-x86 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 17 12:14:17 volumio-x86 systemd[1]: mpd.service: Succeeded. Oct 17 12:14:17 volumio-x86 systemd[1]: Stopped Music Player Daemon. Oct 17 12:14:17 volumio-x86 systemd[1]: Starting Music Player Daemon... Oct 17 12:14:17 volumio-x86 sudo[3142]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 17 12:14:17 volumio-x86 sudo[3142]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:17 volumio-x86 sudo[3142]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:18 volumio-x86 volumio[841]: info: CoreStateMachine::stop Oct 17 12:14:18 volumio-x86 volumio[841]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 12:14:18 volumio-x86 volumio[841]: info: Disabling plugin peppy_screensaver Oct 17 12:14:18 volumio-x86 volumio[841]: info: Preparing to generate the ALSA configuration file Oct 17 12:14:18 volumio-x86 volumio[841]: info: Asound.conf file written Oct 17 12:14:18 volumio-x86 sudo[3149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /volumio/app/plugins/music_service/mpd/mpd.conf.tmpl Oct 17 12:14:18 volumio-x86 sudo[3149]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:18 volumio-x86 sudo[3152]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 17 12:14:18 volumio-x86 sudo[3152]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:18 volumio-x86 sudo[3152]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:18 volumio-x86 systemd[1106]: volumio-app-plugins-music_service-mpd-mpd.conf.tmpl.mount: Succeeded. Oct 17 12:14:18 volumio-x86 systemd[1]: volumio-app-plugins-music_service-mpd-mpd.conf.tmpl.mount: Succeeded. Oct 17 12:14:18 volumio-x86 sudo[3149]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:18 volumio-x86 volumio[841]: info: Output device has changed, restarting MPD Oct 17 12:14:18 volumio-x86 sudo[3157]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 17 12:14:18 volumio-x86 sudo[3157]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:18 volumio-x86 sudo[3157]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:18 volumio-x86 volumio[841]: info: Output device has changed, restarting Shairport Sync Oct 17 12:14:18 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:18 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:14:18 volumio-x86 sudo[3160]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 17 12:14:18 volumio-x86 sudo[3160]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:18 volumio-x86 volumio[841]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 12:14:18 volumio-x86 volumio[841]: info: Done. Oct 17 12:14:18 volumio-x86 volumio[841]: info: MPD Permissions set Oct 17 12:14:18 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:18 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:18 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:18 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:18 volumio-x86 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 17 12:14:18 volumio-x86 systemd[1]: mpd.service: Succeeded. Oct 17 12:14:18 volumio-x86 systemd[1]: Stopped Music Player Daemon. Oct 17 12:14:18 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:14:18 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 17 12:14:18 volumio-x86 systemd[1]: Starting Music Player Daemon... Oct 17 12:14:18 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:18 volumio-x86 volumio[841]: info: Starting Shairport Sync Oct 17 12:14:18 volumio-x86 sudo[3173]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 17 12:14:18 volumio-x86 sudo[3173]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:18 volumio-x86 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 17 12:14:18 volumio-x86 systemd[1]: shairport-sync.service: Succeeded. Oct 17 12:14:18 volumio-x86 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 17 12:14:18 volumio-x86 sudo[3167]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 17 12:14:18 volumio-x86 sudo[3167]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:18 volumio-x86 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 17 12:14:18 volumio-x86 sudo[3173]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:18 volumio-x86 volumio[841]: info: Shairport-Sync Started Oct 17 12:14:18 volumio-x86 sudo[3167]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:19 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:19 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:19 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:19 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:19 volumio-x86 volumio[841]: info: Enabling plugin peppy_screensaver Oct 17 12:14:19 volumio-x86 volumio[841]: info: Loading plugin "peppy_screensaver"... Oct 17 12:14:19 volumio-x86 volumio[841]: info: Applying required configuration parameters for plugin peppy_screensaver Oct 17 12:14:19 volumio-x86 volumio[841]: info: Preparing to generate the ALSA configuration file Oct 17 12:14:19 volumio-x86 volumio[841]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Oct 17 12:14:19 volumio-x86 volumio[841]: info: Reading ALSA contributions from plugins. Oct 17 12:14:19 volumio-x86 volumio[841]: info: Asound.conf file written Oct 17 12:14:19 volumio-x86 sudo[3181]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 17 12:14:19 volumio-x86 sudo[3181]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:19 volumio-x86 sudo[3181]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:19 volumio-x86 volumio[841]: info: Output device has changed, restarting MPD Oct 17 12:14:19 volumio-x86 sudo[3186]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 17 12:14:19 volumio-x86 sudo[3186]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:19 volumio-x86 volumio[841]: info: Output device has changed, restarting Shairport Sync Oct 17 12:14:19 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:19 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:14:19 volumio-x86 sudo[3186]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:19 volumio-x86 sudo[3188]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 17 12:14:19 volumio-x86 sudo[3188]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:19 volumio-x86 volumio[841]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 12:14:19 volumio-x86 volumio[841]: info: PLUGIN START: peppy_screensaver Oct 17 12:14:19 volumio-x86 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 17 12:14:19 volumio-x86 systemd[1]: mpd.service: Succeeded. Oct 17 12:14:19 volumio-x86 systemd[1]: Stopped Music Player Daemon. Oct 17 12:14:19 volumio-x86 volumio[841]: info: Loading i18n strings for locale zh_TW Oct 17 12:14:19 volumio-x86 systemd[1]: Starting Music Player Daemon... Oct 17 12:14:19 volumio-x86 volumio[841]: info: /tmp/myfifo created Oct 17 12:14:19 volumio-x86 volumio[841]: info: /tmp/myfifosa created Oct 17 12:14:19 volumio-x86 sudo[3200]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-dummy index=7 pcm_substreams=1 fake_buffer=0 Oct 17 12:14:19 volumio-x86 sudo[3200]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:19 volumio-x86 sudo[3200]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:19 volumio-x86 volumio[841]: info: snd-dummy loaded Oct 17 12:14:19 volumio-x86 sudo[3194]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 17 12:14:19 volumio-x86 sudo[3194]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:19 volumio-x86 sudo[3194]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:19 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:14:19 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:19 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startShairportSync Oct 17 12:14:19 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:19 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:14:20 volumio-x86 volumio[841]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 17 12:14:20 volumio-x86 volumio[841]: info: Done. Oct 17 12:14:20 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioGetState Oct 17 12:14:20 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:20 volumio-x86 volumio[841]: info: MPD Permissions set Oct 17 12:14:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:14:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 17 12:14:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:20 volumio-x86 volumio[841]: info: Starting Shairport Sync Oct 17 12:14:20 volumio-x86 sudo[3227]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount --bind /tmp/mpd.conf.tmpl /volumio/app/plugins/music_service/mpd/mpd.conf.tmpl Oct 17 12:14:20 volumio-x86 sudo[3227]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:20 volumio-x86 volumio[841]: info: Starting Shairport Sync Oct 17 12:14:20 volumio-x86 sudo[3227]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:20 volumio-x86 sudo[3230]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 17 12:14:20 volumio-x86 sudo[3230]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: mpd , createMPDFile Oct 17 12:14:20 volumio-x86 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 17 12:14:20 volumio-x86 systemd[1]: shairport-sync.service: Succeeded. Oct 17 12:14:20 volumio-x86 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 17 12:14:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:20 volumio-x86 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 17 12:14:20 volumio-x86 sudo[3230]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:20 volumio-x86 sudo[3233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 17 12:14:20 volumio-x86 sudo[3233]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:20 volumio-x86 sudo[3236]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 17 12:14:20 volumio-x86 sudo[3236]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:20 volumio-x86 sudo[3236]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:20 volumio-x86 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 17 12:14:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 17 12:14:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 17 12:14:20 volumio-x86 systemd[1]: shairport-sync.service: Succeeded. Oct 17 12:14:20 volumio-x86 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 17 12:14:20 volumio-x86 systemd[1]: shairport-sync.service: Start request repeated too quickly. Oct 17 12:14:20 volumio-x86 systemd[1]: shairport-sync.service: Failed with result 'start-limit-hit'. Oct 17 12:14:20 volumio-x86 systemd[1]: Failed to start Shairport Sync - AirPlay Audio Receiver. Oct 17 12:14:20 volumio-x86 sudo[3233]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:20 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 17 12:14:20 volumio-x86 volumio[841]: info: Shairport-sync error: Error: Command failed: /usr/bin/sudo /bin/systemctl restart shairport-sync Oct 17 12:14:20 volumio-x86 volumio[841]: Job for shairport-sync.service failed. Oct 17 12:14:20 volumio-x86 volumio[841]: See "systemctl status shairport-sync.service" and "journalctl -xe" for details. Oct 17 12:14:20 volumio-x86 volumio[841]: info: MPD Permissions set Oct 17 12:14:20 volumio-x86 volumio[841]: info: Shairport-Sync Started Oct 17 12:14:21 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Oct 17 12:14:21 volumio-x86 sudo[3249]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 17 12:14:21 volumio-x86 sudo[3249]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:21 volumio-x86 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 17 12:14:21 volumio-x86 systemd[1]: mpd.service: Succeeded. Oct 17 12:14:21 volumio-x86 systemd[1]: Stopped Music Player Daemon. Oct 17 12:14:21 volumio-x86 systemd[1]: Starting Music Player Daemon... Oct 17 12:14:21 volumio-x86 sudo[3251]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 17 12:14:21 volumio-x86 sudo[3251]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:21 volumio-x86 sudo[3251]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:22 volumio-x86 mpd[3253]: Oct 17 12:14 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 17 12:14:22 volumio-x86 systemd[1]: Started Music Player Daemon. Oct 17 12:14:22 volumio-x86 sudo[3050]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:22 volumio-x86 sudo[3249]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:22 volumio-x86 sudo[3140]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:22 volumio-x86 sudo[3188]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:22 volumio-x86 sudo[3080]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:22 volumio-x86 sudo[3160]: pam_unix(sudo:session): session closed for user root Oct 17 12:14:22 volumio-x86 volumio[841]: error: MPD error: The expression evaluated to a falsy value: Oct 17 12:14:22 volumio-x86 volumio[841]: assert.ok(self.idling) Oct 17 12:14:22 volumio-x86 volumio[841]: error: The expression evaluated to a falsy value: Oct 17 12:14:22 volumio-x86 volumio[841]: assert.ok(self.idling) Oct 17 12:14:22 volumio-x86 volumio[841]: error: MPD error: The expression evaluated to a falsy value: Oct 17 12:14:22 volumio-x86 volumio[841]: assert.ok(self.idling) Oct 17 12:14:22 volumio-x86 volumio[841]: error: The expression evaluated to a falsy value: Oct 17 12:14:22 volumio-x86 volumio[841]: assert.ok(self.idling) Oct 17 12:14:22 volumio-x86 volumio[841]: error: MPD error: The expression evaluated to a falsy value: Oct 17 12:14:22 volumio-x86 volumio[841]: assert.ok(self.idling) Oct 17 12:14:22 volumio-x86 volumio[841]: error: The expression evaluated to a falsy value: Oct 17 12:14:22 volumio-x86 volumio[841]: assert.ok(self.idling) Oct 17 12:14:22 volumio-x86 volumio[841]: error: MPD error: The expression evaluated to a falsy value: Oct 17 12:14:22 volumio-x86 volumio[841]: assert.ok(self.idling) Oct 17 12:14:22 volumio-x86 volumio[841]: error: The expression evaluated to a falsy value: Oct 17 12:14:22 volumio-x86 volumio[841]: assert.ok(self.idling) Oct 17 12:14:22 volumio-x86 volumio[841]: error: MPD error: The expression evaluated to a falsy value: Oct 17 12:14:22 volumio-x86 volumio[841]: assert.ok(self.idling) Oct 17 12:14:22 volumio-x86 volumio[841]: error: The expression evaluated to a falsy value: Oct 17 12:14:22 volumio-x86 volumio[841]: assert.ok(self.idling) Oct 17 12:14:22 volumio-x86 volumio[841]: error: updateQueue error: null Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioPlay Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::play index undefined Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::startPlaybackTimer Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::clearAddPlayTracks NAS/MusicServer/個人精選/大陸歌手/勤琴/致命的溫柔/勤琴 - 三个人的晚餐.wav Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand stop Oct 17 12:14:23 volumio-x86 volumio[841]: info: sendMpdCommand stop took 2 milliseconds Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand clear Oct 17 12:14:23 volumio-x86 volumio[841]: info: sendMpdCommand clear took 1 milliseconds Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand add "NAS/MusicServer/個人精選/大陸歌手/勤琴/致命的溫柔/勤琴 - 三个人的晚餐.wav" Oct 17 12:14:23 volumio-x86 volumio[841]: info: Oct 17 12:14:23 volumio-x86 volumio[841]: ---------------------------- MPD announces system playlist update Oct 17 12:14:23 volumio-x86 volumio[841]: info: Ignoring MPD Status Update Oct 17 12:14:23 volumio-x86 volumio[841]: info: Oct 17 12:14:23 volumio-x86 volumio[841]: ---------------------------- MPD announces system playlist update Oct 17 12:14:23 volumio-x86 volumio[841]: info: Ignoring MPD Status Update Oct 17 12:14:23 volumio-x86 volumio[841]: info: Oct 17 12:14:23 volumio-x86 volumio[841]: ---------------------------- MPD announces system playlist update Oct 17 12:14:23 volumio-x86 volumio[841]: info: Ignoring MPD Status Update Oct 17 12:14:23 volumio-x86 volumio[841]: info: Oct 17 12:14:23 volumio-x86 volumio[841]: ---------------------------- MPD announces system playlist update Oct 17 12:14:23 volumio-x86 volumio[841]: info: Ignoring MPD Status Update Oct 17 12:14:23 volumio-x86 volumio[841]: info: sendMpdCommand add "NAS/MusicServer/個人精選/大陸歌手/勤琴/致命的溫柔/勤琴 - 三个人的晚餐.wav" took 8 milliseconds Oct 17 12:14:23 volumio-x86 volumio[841]: info: ------------------------------ 7ms Oct 17 12:14:23 volumio-x86 volumio[841]: info: ------------------------------ 6ms Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand play Oct 17 12:14:23 volumio-x86 volumio[841]: info: Oct 17 12:14:23 volumio-x86 volumio[841]: ---------------------------- MPD announces system playlist update Oct 17 12:14:23 volumio-x86 volumio[841]: info: Ignoring MPD Status Update Oct 17 12:14:23 volumio-x86 volumio[841]: info: Oct 17 12:14:23 volumio-x86 volumio[841]: ---------------------------- MPD announces system playlist update Oct 17 12:14:23 volumio-x86 volumio[841]: info: Ignoring MPD Status Update Oct 17 12:14:23 volumio-x86 volumio[841]: info: Oct 17 12:14:23 volumio-x86 volumio[841]: ---------------------------- MPD announces system playlist update Oct 17 12:14:23 volumio-x86 volumio[841]: info: Ignoring MPD Status Update Oct 17 12:14:23 volumio-x86 volumio[841]: info: Oct 17 12:14:23 volumio-x86 volumio[841]: ---------------------------- MPD announces system playlist update Oct 17 12:14:23 volumio-x86 volumio[841]: info: Ignoring MPD Status Update Oct 17 12:14:23 volumio-x86 volumio[841]: info: Oct 17 12:14:23 volumio-x86 volumio[841]: ---------------------------- MPD announces system playlist update Oct 17 12:14:23 volumio-x86 volumio[841]: info: Ignoring MPD Status Update Oct 17 12:14:23 volumio-x86 volumio[841]: info: ------------------------------ 14ms Oct 17 12:14:23 volumio-x86 volumio[841]: info: ------------------------------ 14ms Oct 17 12:14:23 volumio-x86 volumio[841]: info: sendMpdCommand play took 10 milliseconds Oct 17 12:14:23 volumio-x86 volumio[841]: info: ------------------------------ 9ms Oct 17 12:14:23 volumio-x86 volumio[841]: info: ------------------------------ 8ms Oct 17 12:14:23 volumio-x86 volumio[841]: info: ------------------------------ 7ms Oct 17 12:14:23 volumio-x86 volumio[841]: info: ------------------------------ 6ms Oct 17 12:14:23 volumio-x86 volumio[841]: info: ------------------------------ 5ms Oct 17 12:14:23 volumio-x86 volumio[841]: info: Oct 17 12:14:23 volumio-x86 volumio[841]: ---------------------------- MPD announces system playlist update Oct 17 12:14:23 volumio-x86 volumio[841]: info: Ignoring MPD Status Update Oct 17 12:14:23 volumio-x86 volumio[841]: info: Oct 17 12:14:23 volumio-x86 volumio[841]: ---------------------------- MPD announces system playlist update Oct 17 12:14:23 volumio-x86 volumio[841]: info: Ignoring MPD Status Update Oct 17 12:14:23 volumio-x86 volumio[841]: info: Oct 17 12:14:23 volumio-x86 volumio[841]: ---------------------------- MPD announces system playlist update Oct 17 12:14:23 volumio-x86 volumio[841]: info: Ignoring MPD Status Update Oct 17 12:14:23 volumio-x86 volumio[841]: info: ------------------------------ 8ms Oct 17 12:14:23 volumio-x86 volumio[841]: info: ------------------------------ 8ms Oct 17 12:14:23 volumio-x86 volumio[841]: info: ------------------------------ 7ms Oct 17 12:14:23 volumio-x86 volumio[841]: info: Oct 17 12:14:23 volumio-x86 volumio[841]: ---------------------------- MPD announces state update: player Oct 17 12:14:23 volumio-x86 volumio[841]: info: ControllerMpd::getState Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:14:23 volumio-x86 volumio[841]: info: Oct 17 12:14:23 volumio-x86 volumio[841]: ---------------------------- MPD announces state update: player Oct 17 12:14:23 volumio-x86 volumio[841]: info: ControllerMpd::getState Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:14:23 volumio-x86 volumio[841]: info: Oct 17 12:14:23 volumio-x86 volumio[841]: ---------------------------- MPD announces state update: player Oct 17 12:14:23 volumio-x86 volumio[841]: info: ControllerMpd::getState Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:14:23 volumio-x86 volumio[841]: info: Oct 17 12:14:23 volumio-x86 volumio[841]: ---------------------------- MPD announces state update: player Oct 17 12:14:23 volumio-x86 volumio[841]: info: ControllerMpd::getState Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:14:23 volumio-x86 volumio[841]: info: Oct 17 12:14:23 volumio-x86 volumio[841]: ---------------------------- MPD announces state update: player Oct 17 12:14:23 volumio-x86 volumio[841]: info: ControllerMpd::getState Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:14:23 volumio-x86 volumio[841]: info: Oct 17 12:14:23 volumio-x86 volumio[841]: ---------------------------- MPD announces state update: player Oct 17 12:14:23 volumio-x86 volumio[841]: info: ControllerMpd::getState Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:14:23 volumio-x86 volumio[841]: info: Oct 17 12:14:23 volumio-x86 volumio[841]: ---------------------------- MPD announces state update: player Oct 17 12:14:23 volumio-x86 volumio[841]: info: sendMpdCommand status took 66 milliseconds Oct 17 12:14:23 volumio-x86 volumio[841]: info: sendMpdCommand status took 64 milliseconds Oct 17 12:14:23 volumio-x86 volumio[841]: info: sendMpdCommand status took 62 milliseconds Oct 17 12:14:23 volumio-x86 volumio[841]: info: sendMpdCommand status took 61 milliseconds Oct 17 12:14:23 volumio-x86 volumio[841]: info: sendMpdCommand status took 60 milliseconds Oct 17 12:14:23 volumio-x86 volumio[841]: info: sendMpdCommand status took 58 milliseconds Oct 17 12:14:23 volumio-x86 volumio[841]: info: ControllerMpd::getState Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::parseState Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::parseState Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::parseState Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::parseState Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::parseState Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::parseState Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:14:23 volumio-x86 volumio[841]: info: sendMpdCommand status took 11 milliseconds Oct 17 12:14:23 volumio-x86 volumio[841]: info: sendMpdCommand playlistinfo took 9 milliseconds Oct 17 12:14:23 volumio-x86 volumio[841]: info: sendMpdCommand playlistinfo took 9 milliseconds Oct 17 12:14:23 volumio-x86 volumio[841]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 17 12:14:23 volumio-x86 volumio[841]: info: sendMpdCommand playlistinfo took 7 milliseconds Oct 17 12:14:23 volumio-x86 volumio[841]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 17 12:14:23 volumio-x86 volumio[841]: info: sendMpdCommand playlistinfo took 7 milliseconds Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::parseState Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:14:23 volumio-x86 volumio[841]: info: ControllerMpd::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::servicePushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"三个人的晚餐","artist":"勤琴","album":"致命的温柔","uri":"NAS/MusicServer/個人精選/大陸歌手/勤琴/致命的溫柔/勤琴 - 三个人的晚餐.wav","trackType":"wav"} Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: CURRENT POSITION 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::syncState stateService play Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::syncState currentStatus stop Oct 17 12:14:23 volumio-x86 volumio[841]: info: ControllerMpd::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::servicePushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"三个人的晚餐","artist":"勤琴","album":"致命的温柔","uri":"NAS/MusicServer/個人精選/大陸歌手/勤琴/致命的溫柔/勤琴 - 三个人的晚餐.wav","trackType":"wav"} Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: CURRENT POSITION 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::syncState stateService play Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::syncState currentStatus play Oct 17 12:14:23 volumio-x86 volumio[841]: info: Received an update from plugin. extracting info from payload Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioPushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioPushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: ControllerMpd::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::servicePushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"三个人的晚餐","artist":"勤琴","album":"致命的温柔","uri":"NAS/MusicServer/個人精選/大陸歌手/勤琴/致命的溫柔/勤琴 - 三个人的晚餐.wav","trackType":"wav"} Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: CURRENT POSITION 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::syncState stateService play Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::syncState currentStatus play Oct 17 12:14:23 volumio-x86 volumio[841]: info: Received an update from plugin. extracting info from payload Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioPushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioPushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: ControllerMpd::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::servicePushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: STATE SERVICE {"status":"play","position":0,"seek":182,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"三个人的晚餐","artist":"勤琴","album":"致命的温柔","uri":"NAS/MusicServer/個人精選/大陸歌手/勤琴/致命的溫柔/勤琴 - 三个人的晚餐.wav","trackType":"wav"} Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: CURRENT POSITION 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::syncState stateService play Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::syncState currentStatus play Oct 17 12:14:23 volumio-x86 volumio[841]: info: Received an update from plugin. extracting info from payload Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioPushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioPushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: ControllerMpd::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::servicePushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: STATE SERVICE {"status":"play","position":0,"seek":204,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"三个人的晚餐","artist":"勤琴","album":"致命的温柔","uri":"NAS/MusicServer/個人精選/大陸歌手/勤琴/致命的溫柔/勤琴 - 三个人的晚餐.wav","trackType":"wav"} Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: CURRENT POSITION 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::syncState stateService play Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::syncState currentStatus play Oct 17 12:14:23 volumio-x86 volumio[841]: info: Received an update from plugin. extracting info from payload Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioPushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioPushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: ControllerMpd::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::servicePushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: STATE SERVICE {"status":"play","position":0,"seek":250,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"三个人的晚餐","artist":"勤琴","album":"致命的温柔","uri":"NAS/MusicServer/個人精選/大陸歌手/勤琴/致命的溫柔/勤琴 - 三个人的晚餐.wav","trackType":"wav"} Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: CURRENT POSITION 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::syncState stateService play Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::syncState currentStatus play Oct 17 12:14:23 volumio-x86 volumio[841]: info: Received an update from plugin. extracting info from payload Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioPushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioPushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: ------------------------------ 154ms Oct 17 12:14:23 volumio-x86 volumio[841]: info: ------------------------------ 243ms Oct 17 12:14:23 volumio-x86 volumio[841]: info: ------------------------------ 242ms Oct 17 12:14:23 volumio-x86 volumio[841]: info: ------------------------------ 241ms Oct 17 12:14:23 volumio-x86 volumio[841]: info: ------------------------------ 240ms Oct 17 12:14:23 volumio-x86 volumio[841]: info: ------------------------------ 239ms Oct 17 12:14:23 volumio-x86 volumio[841]: info: Oct 17 12:14:23 volumio-x86 volumio[841]: ---------------------------- MPD announces state update: player Oct 17 12:14:23 volumio-x86 volumio[841]: info: ControllerMpd::getState Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:14:23 volumio-x86 volumio[841]: info: Oct 17 12:14:23 volumio-x86 volumio[841]: ---------------------------- MPD announces state update: player Oct 17 12:14:23 volumio-x86 volumio[841]: info: ControllerMpd::getState Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:14:23 volumio-x86 volumio[841]: info: Oct 17 12:14:23 volumio-x86 volumio[841]: ---------------------------- MPD announces state update: player Oct 17 12:14:23 volumio-x86 volumio[841]: info: ControllerMpd::getState Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:14:23 volumio-x86 volumio[841]: info: Oct 17 12:14:23 volumio-x86 volumio[841]: ---------------------------- MPD announces state update: player Oct 17 12:14:23 volumio-x86 volumio[841]: info: ControllerMpd::getState Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:14:23 volumio-x86 volumio[841]: info: Oct 17 12:14:23 volumio-x86 volumio[841]: ---------------------------- MPD announces state update: player Oct 17 12:14:23 volumio-x86 volumio[841]: info: ControllerMpd::getState Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:14:23 volumio-x86 volumio[841]: info: sendMpdCommand playlistinfo took 184 milliseconds Oct 17 12:14:23 volumio-x86 volumio[841]: info: sendMpdCommand status took 20 milliseconds Oct 17 12:14:23 volumio-x86 volumio[841]: info: sendMpdCommand status took 17 milliseconds Oct 17 12:14:23 volumio-x86 volumio[841]: info: sendMpdCommand status took 16 milliseconds Oct 17 12:14:23 volumio-x86 volumio[841]: info: sendMpdCommand status took 14 milliseconds Oct 17 12:14:23 volumio-x86 volumio[841]: info: sendMpdCommand status took 12 milliseconds Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::parseState Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::parseState Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::parseState Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::parseState Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::parseState Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:14:23 volumio-x86 volumio[841]: info: ControllerMpd::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::servicePushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"三个人的晚餐","artist":"勤琴","album":"致命的温柔","uri":"NAS/MusicServer/個人精選/大陸歌手/勤琴/致命的溫柔/勤琴 - 三个人的晚餐.wav","trackType":"wav"} Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: CURRENT POSITION 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::syncState stateService play Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::syncState currentStatus play Oct 17 12:14:23 volumio-x86 volumio[841]: info: Received an update from plugin. extracting info from payload Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioPushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioPushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: ------------------------------ 263ms Oct 17 12:14:23 volumio-x86 volumio[841]: info: sendMpdCommand playlistinfo took 103 milliseconds Oct 17 12:14:23 volumio-x86 volumio[841]: info: sendMpdCommand playlistinfo took 103 milliseconds Oct 17 12:14:23 volumio-x86 volumio[841]: info: sendMpdCommand playlistinfo took 102 milliseconds Oct 17 12:14:23 volumio-x86 volumio[841]: info: sendMpdCommand playlistinfo took 103 milliseconds Oct 17 12:14:23 volumio-x86 volumio[841]: info: sendMpdCommand playlistinfo took 102 milliseconds Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:14:23 volumio-x86 volumio[841]: info: ControllerMpd::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::servicePushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: STATE SERVICE {"status":"play","position":0,"seek":887,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"三个人的晚餐","artist":"勤琴","album":"致命的温柔","uri":"NAS/MusicServer/個人精選/大陸歌手/勤琴/致命的溫柔/勤琴 - 三个人的晚餐.wav","trackType":"wav"} Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: CURRENT POSITION 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::syncState stateService play Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::syncState currentStatus play Oct 17 12:14:23 volumio-x86 volumio[841]: info: Received an update from plugin. extracting info from payload Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioPushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioPushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: ControllerMpd::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::servicePushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: STATE SERVICE {"status":"play","position":0,"seek":887,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"三个人的晚餐","artist":"勤琴","album":"致命的温柔","uri":"NAS/MusicServer/個人精選/大陸歌手/勤琴/致命的溫柔/勤琴 - 三个人的晚餐.wav","trackType":"wav"} Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: CURRENT POSITION 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::syncState stateService play Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::syncState currentStatus play Oct 17 12:14:23 volumio-x86 volumio[841]: info: Received an update from plugin. extracting info from payload Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioPushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioPushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: ControllerMpd::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::servicePushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: STATE SERVICE {"status":"play","position":0,"seek":887,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"三个人的晚餐","artist":"勤琴","album":"致命的温柔","uri":"NAS/MusicServer/個人精選/大陸歌手/勤琴/致命的溫柔/勤琴 - 三个人的晚餐.wav","trackType":"wav"} Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: CURRENT POSITION 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::syncState stateService play Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::syncState currentStatus play Oct 17 12:14:23 volumio-x86 volumio[841]: info: Received an update from plugin. extracting info from payload Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioPushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioPushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: ControllerMpd::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::servicePushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: STATE SERVICE {"status":"play","position":0,"seek":887,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"三个人的晚餐","artist":"勤琴","album":"致命的温柔","uri":"NAS/MusicServer/個人精選/大陸歌手/勤琴/致命的溫柔/勤琴 - 三个人的晚餐.wav","trackType":"wav"} Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: CURRENT POSITION 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::syncState stateService play Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::syncState currentStatus play Oct 17 12:14:23 volumio-x86 volumio[841]: info: Received an update from plugin. extracting info from payload Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioPushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioPushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: ControllerMpd::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::servicePushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: STATE SERVICE {"status":"play","position":0,"seek":887,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"三个人的晚餐","artist":"勤琴","album":"致命的温柔","uri":"NAS/MusicServer/個人精選/大陸歌手/勤琴/致命的溫柔/勤琴 - 三个人的晚餐.wav","trackType":"wav"} Oct 17 12:14:23 volumio-x86 volumio[841]: verbose: CURRENT POSITION 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::syncState stateService play Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::syncState currentStatus play Oct 17 12:14:23 volumio-x86 volumio[841]: info: Received an update from plugin. extracting info from payload Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioPushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreStateMachine::pushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:23 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioPushState Oct 17 12:14:23 volumio-x86 volumio[841]: info: ------------------------------ 279ms Oct 17 12:14:23 volumio-x86 volumio[841]: info: ------------------------------ 277ms Oct 17 12:14:23 volumio-x86 volumio[841]: info: ------------------------------ 276ms Oct 17 12:14:23 volumio-x86 volumio[841]: info: ------------------------------ 275ms Oct 17 12:14:23 volumio-x86 volumio[841]: info: ------------------------------ 274ms Oct 17 12:14:25 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioGetState Oct 17 12:14:25 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:25 volumio-x86 sudo[3266]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/usr/bin/python3 ./screensaver/volumio_peppymeter.py Oct 17 12:14:25 volumio-x86 sudo[3266]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 17 12:14:33 volumio-x86 volumio[841]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 7 Oct 17 12:14:33 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioGetState Oct 17 12:14:33 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioPause Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreStateMachine::pause Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreStateMachine::stPlaybackTimer Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreStateMachine::servicePause Oct 17 12:14:41 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreCommandRouter::servicePause Oct 17 12:14:41 volumio-x86 volumio[841]: info: ControllerMpd::pause Oct 17 12:14:41 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand pause Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioPause Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreStateMachine::pause Oct 17 12:14:41 volumio-x86 volumio[841]: info: Oct 17 12:14:41 volumio-x86 volumio[841]: ---------------------------- MPD announces state update: player Oct 17 12:14:41 volumio-x86 volumio[841]: info: sendMpdCommand pause took 10 milliseconds Oct 17 12:14:41 volumio-x86 volumio[841]: info: ControllerMpd::getState Oct 17 12:14:41 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:14:41 volumio-x86 volumio[841]: info: Oct 17 12:14:41 volumio-x86 volumio[841]: ---------------------------- MPD announces state update: player Oct 17 12:14:41 volumio-x86 volumio[841]: info: ControllerMpd::getState Oct 17 12:14:41 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:14:41 volumio-x86 volumio[841]: info: Oct 17 12:14:41 volumio-x86 volumio[841]: ---------------------------- MPD announces state update: player Oct 17 12:14:41 volumio-x86 volumio[841]: info: ControllerMpd::getState Oct 17 12:14:41 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:14:41 volumio-x86 volumio[841]: info: Oct 17 12:14:41 volumio-x86 volumio[841]: ---------------------------- MPD announces state update: player Oct 17 12:14:41 volumio-x86 volumio[841]: info: ControllerMpd::getState Oct 17 12:14:41 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:14:41 volumio-x86 volumio[841]: info: Oct 17 12:14:41 volumio-x86 volumio[841]: ---------------------------- MPD announces state update: player Oct 17 12:14:41 volumio-x86 volumio[841]: info: ControllerMpd::getState Oct 17 12:14:41 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:14:41 volumio-x86 volumio[841]: info: Oct 17 12:14:41 volumio-x86 volumio[841]: ---------------------------- MPD announces state update: player Oct 17 12:14:41 volumio-x86 volumio[841]: info: ControllerMpd::getState Oct 17 12:14:41 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand status Oct 17 12:14:41 volumio-x86 volumio[841]: info: sendMpdCommand status took 13 milliseconds Oct 17 12:14:41 volumio-x86 volumio[841]: info: sendMpdCommand status took 11 milliseconds Oct 17 12:14:41 volumio-x86 volumio[841]: info: sendMpdCommand status took 10 milliseconds Oct 17 12:14:41 volumio-x86 volumio[841]: info: sendMpdCommand status took 8 milliseconds Oct 17 12:14:41 volumio-x86 volumio[841]: info: sendMpdCommand status took 6 milliseconds Oct 17 12:14:41 volumio-x86 volumio[841]: info: sendMpdCommand status took 5 milliseconds Oct 17 12:14:41 volumio-x86 volumio[841]: verbose: ControllerMpd::parseState Oct 17 12:14:41 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:14:41 volumio-x86 volumio[841]: verbose: ControllerMpd::parseState Oct 17 12:14:41 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:14:41 volumio-x86 volumio[841]: verbose: ControllerMpd::parseState Oct 17 12:14:41 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:14:41 volumio-x86 volumio[841]: verbose: ControllerMpd::parseState Oct 17 12:14:41 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:14:41 volumio-x86 volumio[841]: verbose: ControllerMpd::parseState Oct 17 12:14:41 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:14:41 volumio-x86 volumio[841]: verbose: ControllerMpd::parseState Oct 17 12:14:41 volumio-x86 volumio[841]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 17 12:14:41 volumio-x86 volumio[841]: info: sendMpdCommand playlistinfo took 26 milliseconds Oct 17 12:14:41 volumio-x86 volumio[841]: info: sendMpdCommand playlistinfo took 27 milliseconds Oct 17 12:14:41 volumio-x86 volumio[841]: info: sendMpdCommand playlistinfo took 28 milliseconds Oct 17 12:14:41 volumio-x86 volumio[841]: info: sendMpdCommand playlistinfo took 27 milliseconds Oct 17 12:14:41 volumio-x86 volumio[841]: info: sendMpdCommand playlistinfo took 28 milliseconds Oct 17 12:14:41 volumio-x86 volumio[841]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:14:41 volumio-x86 volumio[841]: verbose: ControllerMpd::parseTrackInfo Oct 17 12:14:41 volumio-x86 volumio[841]: info: ControllerMpd::pushState Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreCommandRouter::servicePushState Oct 17 12:14:41 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:41 volumio-x86 volumio[841]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":18258,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"三个人的晚餐","artist":"勤琴","album":"致命的温柔","uri":"NAS/MusicServer/個人精選/大陸歌手/勤琴/致命的溫柔/勤琴 - 三个人的晚餐.wav","trackType":"wav"} Oct 17 12:14:41 volumio-x86 volumio[841]: verbose: CURRENT POSITION 0 Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreStateMachine::syncState stateService pause Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreStateMachine::syncState currentStatus pause Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreStateMachine::pushState Oct 17 12:14:41 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioPushState Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreStateMachine::stPlaybackTimer Oct 17 12:14:41 volumio-x86 volumio[841]: info: ControllerMpd::pushState Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreCommandRouter::servicePushState Oct 17 12:14:41 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:41 volumio-x86 volumio[841]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":18258,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"三个人的晚餐","artist":"勤琴","album":"致命的温柔","uri":"NAS/MusicServer/個人精選/大陸歌手/勤琴/致命的溫柔/勤琴 - 三个人的晚餐.wav","trackType":"wav"} Oct 17 12:14:41 volumio-x86 volumio[841]: verbose: CURRENT POSITION 0 Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreStateMachine::syncState stateService pause Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreStateMachine::syncState currentStatus pause Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreStateMachine::pushState Oct 17 12:14:41 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioPushState Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreStateMachine::stPlaybackTimer Oct 17 12:14:41 volumio-x86 volumio[841]: info: ControllerMpd::pushState Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreCommandRouter::servicePushState Oct 17 12:14:41 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:41 volumio-x86 volumio[841]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":18258,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"三个人的晚餐","artist":"勤琴","album":"致命的温柔","uri":"NAS/MusicServer/個人精選/大陸歌手/勤琴/致命的溫柔/勤琴 - 三个人的晚餐.wav","trackType":"wav"} Oct 17 12:14:41 volumio-x86 volumio[841]: verbose: CURRENT POSITION 0 Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreStateMachine::syncState stateService pause Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreStateMachine::syncState currentStatus pause Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreStateMachine::pushState Oct 17 12:14:41 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioPushState Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreStateMachine::stPlaybackTimer Oct 17 12:14:41 volumio-x86 volumio[841]: info: ControllerMpd::pushState Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreCommandRouter::servicePushState Oct 17 12:14:41 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:41 volumio-x86 volumio[841]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":18258,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"三个人的晚餐","artist":"勤琴","album":"致命的温柔","uri":"NAS/MusicServer/個人精選/大陸歌手/勤琴/致命的溫柔/勤琴 - 三个人的晚餐.wav","trackType":"wav"} Oct 17 12:14:41 volumio-x86 volumio[841]: verbose: CURRENT POSITION 0 Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreStateMachine::syncState stateService pause Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreStateMachine::syncState currentStatus pause Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreStateMachine::pushState Oct 17 12:14:41 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioPushState Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreStateMachine::stPlaybackTimer Oct 17 12:14:41 volumio-x86 volumio[841]: info: ControllerMpd::pushState Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreCommandRouter::servicePushState Oct 17 12:14:41 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:41 volumio-x86 volumio[841]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":18258,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"三个人的晚餐","artist":"勤琴","album":"致命的温柔","uri":"NAS/MusicServer/個人精選/大陸歌手/勤琴/致命的溫柔/勤琴 - 三个人的晚餐.wav","trackType":"wav"} Oct 17 12:14:41 volumio-x86 volumio[841]: verbose: CURRENT POSITION 0 Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreStateMachine::syncState stateService pause Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreStateMachine::syncState currentStatus pause Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreStateMachine::pushState Oct 17 12:14:41 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioPushState Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreStateMachine::stPlaybackTimer Oct 17 12:14:41 volumio-x86 volumio[841]: info: ControllerMpd::pushState Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreCommandRouter::servicePushState Oct 17 12:14:41 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:41 volumio-x86 volumio[841]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":18258,"duration":265,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"三个人的晚餐","artist":"勤琴","album":"致命的温柔","uri":"NAS/MusicServer/個人精選/大陸歌手/勤琴/致命的溫柔/勤琴 - 三个人的晚餐.wav","trackType":"wav"} Oct 17 12:14:41 volumio-x86 volumio[841]: verbose: CURRENT POSITION 0 Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreStateMachine::syncState stateService pause Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreStateMachine::syncState currentStatus pause Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreStateMachine::pushState Oct 17 12:14:41 volumio-x86 volumio[841]: info: CorePlayQueue::getTrack 0 Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreCommandRouter::volumioPushState Oct 17 12:14:41 volumio-x86 volumio[841]: info: CoreStateMachine::stPlaybackTimer Oct 17 12:14:41 volumio-x86 volumio[841]: info: ------------------------------ 191ms Oct 17 12:14:41 volumio-x86 volumio[841]: info: ------------------------------ 188ms Oct 17 12:14:41 volumio-x86 volumio[841]: info: ------------------------------ 187ms Oct 17 12:14:41 volumio-x86 volumio[841]: info: ------------------------------ 186ms Oct 17 12:14:41 volumio-x86 volumio[841]: info: ------------------------------ 185ms Oct 17 12:14:41 volumio-x86 volumio[841]: info: ------------------------------ 184ms Oct 17 12:14:41 volumio-x86 volumio[841]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 17 12:14:41 volumio-x86 volumio[841]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning' Oct 17 12:14:41 volumio-x86 volumio[841]: at Object.readdirSync (fs.js:1048:3) Oct 17 12:14:41 volumio-x86 volumio[841]: at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11) Oct 17 12:14:41 volumio-x86 volumio[841]: at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7) Oct 17 12:14:41 volumio-x86 volumio[841]: at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62) Oct 17 12:14:41 volumio-x86 volumio[841]: at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17) Oct 17 12:14:41 volumio-x86 volumio[841]: at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48) Oct 17 12:14:41 volumio-x86 volumio[841]: at Socket.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Oct 17 12:14:41 volumio-x86 volumio[841]: at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10) Oct 17 12:14:41 volumio-x86 volumio[841]: at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12) Oct 17 12:14:41 volumio-x86 volumio[841]: at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Oct 17 12:14:41 volumio-x86 volumio[841]: at Manager.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Oct 17 12:14:41 volumio-x86 volumio[841]: at Manager.ondecoded (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:349:8) Oct 17 12:14:41 volumio-x86 volumio[841]: at Decoder. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Oct 17 12:14:41 volumio-x86 volumio[841]: at Decoder.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Oct 17 12:14:41 volumio-x86 volumio[841]: at Decoder.add (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-parser/index.js:251:12) Oct 17 12:14:41 volumio-x86 volumio[841]: at Manager.ondata (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:339:16) { Oct 17 12:14:41 volumio-x86 volumio[841]: errno: -20, Oct 17 12:14:41 volumio-x86 volumio[841]: syscall: 'scandir', Oct 17 12:14:41 volumio-x86 volumio[841]: code: 'ENOTDIR', Oct 17 12:14:41 volumio-x86 volumio[841]: path: '/tmp/peppyrunning' Oct 17 12:14:41 volumio-x86 volumio[841]: } Oct 17 12:14:41 volumio-x86 volumio[841]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 17 12:14:41 volumio-x86 sudo[3324]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-17 12:13 Oct 17 12:14:41 volumio-x86 sudo[3324]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:33:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ee834e1c2a28de3c5d8c48611ecf1167"