-- Logs begin at Sat 2024-10-12 14:16:55 CST, end at Sat 2024-10-12 14:28:21 CST. -- Oct 12 14:27:04 volumio volumio[963]: info: CoreCommandRouter::volumioNext Oct 12 14:27:04 volumio volumio[963]: info: CoreStateMachine::next Oct 12 14:27:04 volumio volumio[963]: info: CoreStateMachine::stop Oct 12 14:27:04 volumio volumio[963]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 14:27:04 volumio volumio[963]: info: CoreStateMachine::stPlaybackTimer Oct 12 14:27:04 volumio volumio[963]: info: CoreStateMachine::updateTrackBlock Oct 12 14:27:04 volumio volumio[963]: info: CorePlayQueue::getTrackBlock Oct 12 14:27:04 volumio volumio[963]: info: CoreStateMachine::pushState Oct 12 14:27:04 volumio volumio[963]: info: CorePlayQueue::getTrack 0 Oct 12 14:27:04 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 14:27:04 volumio volumio[963]: info: CoreCommandRouter::volumioPushState Oct 12 14:27:04 volumio volumio[963]: info: CoreStateMachine::serviceStop Oct 12 14:27:04 volumio volumio[963]: info: CorePlayQueue::getTrack 0 Oct 12 14:27:04 volumio volumio[963]: info: CoreCommandRouter::serviceStop Oct 12 14:27:04 volumio volumio[963]: info: ControllerMpd::stop Oct 12 14:27:04 volumio volumio[963]: verbose: ControllerMpd::sendMpdCommand stop Oct 12 14:27:04 volumio volumio[963]: info: Oct 12 14:27:04 volumio volumio[963]: ---------------------------- MPD announces state update: player Oct 12 14:27:04 volumio volumio[963]: info: sendMpdCommand stop took 177 milliseconds Oct 12 14:27:04 volumio volumio[963]: info: ControllerMpd::getState Oct 12 14:27:04 volumio volumio[963]: verbose: ControllerMpd::sendMpdCommand status Oct 12 14:27:04 volumio volumio[963]: info: CoreStateMachine::play index undefined Oct 12 14:27:04 volumio volumio[963]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 14:27:04 volumio volumio[963]: info: CorePlayQueue::getTrack 1 Oct 12 14:27:04 volumio volumio[963]: info: CoreStateMachine::startPlaybackTimer Oct 12 14:27:04 volumio volumio[963]: info: CorePlayQueue::getTrack 1 Oct 12 14:27:04 volumio volumio[963]: verbose: ControllerMpd::clearAddPlayTracks USB/赵鹏 - 北国之春.flac Oct 12 14:27:04 volumio volumio[963]: verbose: ControllerMpd::sendMpdCommand stop Oct 12 14:27:04 volumio volumio[963]: info: CoreStateMachine::updateTrackBlock Oct 12 14:27:04 volumio volumio[963]: info: CorePlayQueue::getTrackBlock Oct 12 14:27:04 volumio volumio[963]: info: sendMpdCommand status took 7 milliseconds Oct 12 14:27:04 volumio volumio[963]: info: sendMpdCommand stop took 3 milliseconds Oct 12 14:27:04 volumio volumio[963]: verbose: ControllerMpd::parseState Oct 12 14:27:04 volumio volumio[963]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 14:27:04 volumio volumio[963]: verbose: ControllerMpd::sendMpdCommand clear Oct 12 14:27:04 volumio volumio[963]: info: Oct 12 14:27:04 volumio volumio[963]: ---------------------------- MPD announces system playlist update Oct 12 14:27:04 volumio volumio[963]: info: Ignoring MPD Status Update Oct 12 14:27:04 volumio volumio[963]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 12 14:27:04 volumio volumio[963]: info: sendMpdCommand clear took 4 milliseconds Oct 12 14:27:04 volumio volumio[963]: verbose: ControllerMpd::parseTrackInfo Oct 12 14:27:04 volumio volumio[963]: verbose: ControllerMpd::sendMpdCommand add "USB/赵鹏 - 北国之春.flac" Oct 12 14:27:04 volumio volumio[963]: info: ControllerMpd::pushState Oct 12 14:27:04 volumio volumio[963]: info: CoreCommandRouter::servicePushState Oct 12 14:27:04 volumio volumio[963]: info: CoreStateMachine::pushState Oct 12 14:27:04 volumio volumio[963]: info: CorePlayQueue::getTrack 1 Oct 12 14:27:04 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 14:27:04 volumio volumio[963]: info: CoreCommandRouter::volumioPushState Oct 12 14:27:04 volumio volumio[963]: info: CorePlayQueue::getTrack 1 Oct 12 14:27:04 volumio volumio[963]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"乌兰巴托的夜晚","artist":"赵鹏","album":"中国最好声音:人声测试专用大碟","uri":"USB/赵鹏 - 乌兰巴托的夜晚.flac","trackType":"flac"} Oct 12 14:27:04 volumio volumio[963]: verbose: CURRENT POSITION 1 Oct 12 14:27:04 volumio volumio[963]: info: CoreStateMachine::syncState stateService stop Oct 12 14:27:04 volumio volumio[963]: info: CoreStateMachine::syncState currentStatus stop Oct 12 14:27:04 volumio volumio[963]: info: CoreStateMachine::pushState Oct 12 14:27:04 volumio volumio[963]: info: CorePlayQueue::getTrack 1 Oct 12 14:27:04 volumio volumio[963]: info: CoreCommandRouter::volumioPushState Oct 12 14:27:04 volumio volumio[963]: info: No code Oct 12 14:27:04 volumio volumio[963]: info: CoreStateMachine::pushState Oct 12 14:27:04 volumio volumio[963]: info: CorePlayQueue::getTrack 1 Oct 12 14:27:04 volumio volumio[963]: info: CoreCommandRouter::volumioPushState Oct 12 14:27:04 volumio volumio[963]: info: ------------------------------ 44ms Oct 12 14:27:04 volumio volumio[963]: error: updateQueue error: null Oct 12 14:27:04 volumio volumio[963]: info: Oct 12 14:27:04 volumio volumio[963]: ---------------------------- MPD announces system playlist update Oct 12 14:27:04 volumio volumio[963]: info: Ignoring MPD Status Update Oct 12 14:27:04 volumio volumio[963]: info: ------------------------------ 34ms Oct 12 14:27:04 volumio volumio[963]: info: sendMpdCommand add "USB/赵鹏 - 北国之春.flac" took 31 milliseconds Oct 12 14:27:04 volumio volumio[963]: verbose: ControllerMpd::sendMpdCommand play Oct 12 14:27:04 volumio volumio[963]: info: Oct 12 14:27:04 volumio volumio[963]: ---------------------------- MPD announces state update: player Oct 12 14:27:04 volumio volumio[963]: info: ------------------------------ 17ms Oct 12 14:27:04 volumio volumio[963]: info: sendMpdCommand play took 15 milliseconds Oct 12 14:27:04 volumio volumio[963]: info: ControllerMpd::getState Oct 12 14:27:04 volumio volumio[963]: verbose: ControllerMpd::sendMpdCommand status Oct 12 14:27:04 volumio volumio[963]: info: Oct 12 14:27:04 volumio volumio[963]: ---------------------------- MPD announces state update: player Oct 12 14:27:04 volumio volumio[963]: info: sendMpdCommand status took 146 milliseconds Oct 12 14:27:04 volumio volumio[963]: info: ControllerMpd::getState Oct 12 14:27:04 volumio volumio[963]: verbose: ControllerMpd::sendMpdCommand status Oct 12 14:27:04 volumio volumio[963]: verbose: ControllerMpd::parseState Oct 12 14:27:05 volumio volumio[963]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 14:27:05 volumio volumio[963]: info: sendMpdCommand status took 2 milliseconds Oct 12 14:27:05 volumio volumio[963]: verbose: ControllerMpd::parseState Oct 12 14:27:05 volumio volumio[963]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 14:27:05 volumio volumio[963]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 12 14:27:05 volumio volumio[963]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 12 14:27:05 volumio volumio[963]: verbose: ControllerMpd::parseTrackInfo Oct 12 14:27:05 volumio volumio[963]: verbose: ControllerMpd::parseTrackInfo Oct 12 14:27:05 volumio volumio[963]: info: ControllerMpd::pushState Oct 12 14:27:05 volumio volumio[963]: info: CoreCommandRouter::servicePushState Oct 12 14:27:05 volumio volumio[963]: info: CorePlayQueue::getTrack 1 Oct 12 14:27:05 volumio volumio[963]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":272,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"北国之春","artist":"赵鹏","album":"中国最好声音:人声测试专用大碟","uri":"USB/赵鹏 - 北国之春.flac","trackType":"flac"} Oct 12 14:27:05 volumio volumio[963]: verbose: CURRENT POSITION 1 Oct 12 14:27:05 volumio volumio[963]: info: CoreStateMachine::syncState stateService play Oct 12 14:27:05 volumio volumio[963]: info: CoreStateMachine::syncState currentStatus stop Oct 12 14:27:05 volumio volumio[963]: info: ControllerMpd::pushState Oct 12 14:27:05 volumio volumio[963]: info: CoreCommandRouter::servicePushState Oct 12 14:27:05 volumio volumio[963]: info: CorePlayQueue::getTrack 1 Oct 12 14:27:05 volumio volumio[963]: verbose: STATE SERVICE {"status":"play","position":0,"seek":591,"duration":272,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"850 Kbps","isStreaming":false,"title":"北国之春","artist":"赵鹏","album":"中国最好声音:人声测试专用大碟","uri":"USB/赵鹏 - 北国之春.flac","trackType":"flac"} Oct 12 14:27:05 volumio volumio[963]: verbose: CURRENT POSITION 1 Oct 12 14:27:05 volumio volumio[963]: info: CoreStateMachine::syncState stateService play Oct 12 14:27:05 volumio volumio[963]: info: CoreStateMachine::syncState currentStatus play Oct 12 14:27:05 volumio volumio[963]: info: Received an update from plugin. extracting info from payload Oct 12 14:27:05 volumio volumio[963]: info: CoreStateMachine::pushState Oct 12 14:27:05 volumio volumio[963]: info: CorePlayQueue::getTrack 1 Oct 12 14:27:05 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 14:27:05 volumio volumio[963]: info: CoreCommandRouter::volumioPushState Oct 12 14:27:05 volumio volumio[963]: info: CoreStateMachine::pushState Oct 12 14:27:05 volumio volumio[963]: info: CorePlayQueue::getTrack 1 Oct 12 14:27:05 volumio volumio[963]: info: CoreCommandRouter::volumioPushState Oct 12 14:27:05 volumio volumio[963]: info: ------------------------------ 165ms Oct 12 14:27:05 volumio volumio[963]: info: ------------------------------ 23ms Oct 12 14:27:21 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 12 14:27:23 volumio volumio[963]: info: CoreCommandRouter::Close All Modals sent Oct 12 14:27:27 volumio volumio[963]: info: Enabling plugin peppy_screensaver Oct 12 14:27:27 volumio volumio[963]: info: Loading plugin "peppy_screensaver"... Oct 12 14:27:27 volumio volumio[963]: info: Applying required configuration parameters for plugin peppy_screensaver Oct 12 14:27:27 volumio volumio[963]: info: Preparing to generate the ALSA configuration file Oct 12 14:27:27 volumio volumio[963]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Oct 12 14:27:27 volumio volumio[963]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Oct 12 14:27:27 volumio volumio[963]: info: Reading ALSA contributions from plugins. Oct 12 14:27:27 volumio volumio[963]: info: Asound.conf file unchanged, so no further update is needed Oct 12 14:27:27 volumio volumio[963]: info: Output device has changed, restarting MPD Oct 12 14:27:27 volumio sudo[4501]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 12 14:27:27 volumio volumio[963]: info: Output device has changed, restarting Shairport Sync Oct 12 14:27:27 volumio sudo[4501]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 14:27:27 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 14:27:27 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 14:27:27 volumio sudo[4501]: pam_unix(sudo:session): session closed for user root Oct 12 14:27:27 volumio sudo[4503]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 12 14:27:27 volumio sudo[4503]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 14:27:27 volumio systemd[1]: Stopping Music Player Daemon... Oct 12 14:27:27 volumio volumio[963]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 12 14:27:27 volumio volumio[963]: info: PLUGIN START: peppy_screensaver Oct 12 14:27:27 volumio volumio[963]: info: Loading i18n strings for locale zh Oct 12 14:27:27 volumio volumio[963]: info: /tmp/myfifo created Oct 12 14:27:27 volumio volumio[963]: info: /tmp/myfifosa created Oct 12 14:27:27 volumio sudo[4514]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-dummy index=7 pcm_substreams=1 fake_buffer=0 Oct 12 14:27:27 volumio sudo[4514]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 14:27:27 volumio sudo[4514]: pam_unix(sudo:session): session closed for user root Oct 12 14:27:27 volumio volumio[963]: info: snd-dummy loaded Oct 12 14:27:27 volumio volumio[963]: info: Error: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning' Oct 12 14:27:27 volumio volumio[963]: info: MPD Permissions set Oct 12 14:27:27 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 14:27:27 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 14:27:27 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 14:27:27 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 14:27:27 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 14:27:27 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 14:27:27 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 14:27:27 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 14:27:27 volumio systemd[1]: mpd.service: Succeeded. Oct 12 14:27:27 volumio systemd[1]: Stopped Music Player Daemon. Oct 12 14:27:27 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 14:27:27 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 12 14:27:27 volumio systemd[1]: Starting Music Player Daemon... Oct 12 14:27:27 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 14:27:27 volumio volumio[963]: info: Starting Shairport Sync Oct 12 14:27:27 volumio sudo[4524]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 12 14:27:27 volumio sudo[4524]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 14:27:27 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 12 14:27:27 volumio systemd[1]: shairport-sync.service: Succeeded. Oct 12 14:27:27 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 12 14:27:27 volumio sudo[4520]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 12 14:27:27 volumio sudo[4520]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 14:27:27 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 12 14:27:27 volumio sudo[4520]: pam_unix(sudo:session): session closed for user root Oct 12 14:27:27 volumio sudo[4524]: pam_unix(sudo:session): session closed for user root Oct 12 14:27:27 volumio volumio[963]: info: Shairport-Sync Started Oct 12 14:27:27 volumio volumio[963]: (node:963) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pbeg listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Oct 12 14:27:27 volumio volumio[963]: (Use `node --trace-warnings ...` to show where the warning was created) Oct 12 14:27:27 volumio volumio[963]: (node:963) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 meta listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Oct 12 14:27:27 volumio volumio[963]: (node:963) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 prgr listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Oct 12 14:27:27 volumio volumio[963]: (node:963) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pvol listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Oct 12 14:27:27 volumio volumio[963]: (node:963) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pend listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Oct 12 14:27:27 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 14:27:27 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 14:27:28 volumio mpd[4528]: Oct 12 14:27 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 12 14:27:28 volumio systemd[1]: Started Music Player Daemon. Oct 12 14:27:28 volumio sudo[4503]: pam_unix(sudo:session): session closed for user root Oct 12 14:27:28 volumio volumio[963]: error: updateQueue error: null Oct 12 14:27:29 volumio volumio[963]: info: CoreCommandRouter::volumioNext Oct 12 14:27:29 volumio volumio[963]: info: CoreStateMachine::next Oct 12 14:27:29 volumio volumio[963]: info: CoreStateMachine::stop Oct 12 14:27:29 volumio volumio[963]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 14:27:29 volumio volumio[963]: info: CoreStateMachine::stPlaybackTimer Oct 12 14:27:29 volumio volumio[963]: info: CoreStateMachine::updateTrackBlock Oct 12 14:27:29 volumio volumio[963]: info: CorePlayQueue::getTrackBlock Oct 12 14:27:29 volumio volumio[963]: info: CoreStateMachine::pushState Oct 12 14:27:29 volumio volumio[963]: info: CorePlayQueue::getTrack 1 Oct 12 14:27:29 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 14:27:29 volumio volumio[963]: info: CoreCommandRouter::volumioPushState Oct 12 14:27:29 volumio volumio[963]: info: CoreStateMachine::serviceStop Oct 12 14:27:29 volumio volumio[963]: info: CorePlayQueue::getTrack 1 Oct 12 14:27:29 volumio volumio[963]: info: CoreCommandRouter::serviceStop Oct 12 14:27:29 volumio volumio[963]: info: ControllerMpd::stop Oct 12 14:27:29 volumio volumio[963]: verbose: ControllerMpd::sendMpdCommand stop Oct 12 14:27:30 volumio volumio[963]: info: sendMpdCommand stop took 9 milliseconds Oct 12 14:27:30 volumio volumio[963]: info: CoreStateMachine::play index undefined Oct 12 14:27:30 volumio volumio[963]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 14:27:30 volumio volumio[963]: info: CorePlayQueue::getTrack 2 Oct 12 14:27:30 volumio volumio[963]: info: CoreStateMachine::startPlaybackTimer Oct 12 14:27:30 volumio volumio[963]: info: CorePlayQueue::getTrack 2 Oct 12 14:27:30 volumio volumio[963]: verbose: ControllerMpd::clearAddPlayTracks USB/江智民,周虹 - 有没有人告诉你.flac Oct 12 14:27:30 volumio volumio[963]: verbose: ControllerMpd::sendMpdCommand stop Oct 12 14:27:30 volumio volumio[963]: info: CoreStateMachine::updateTrackBlock Oct 12 14:27:30 volumio volumio[963]: info: CorePlayQueue::getTrackBlock Oct 12 14:27:30 volumio volumio[963]: info: sendMpdCommand stop took 2 milliseconds Oct 12 14:27:30 volumio volumio[963]: verbose: ControllerMpd::sendMpdCommand clear Oct 12 14:27:30 volumio volumio[963]: info: Oct 12 14:27:30 volumio volumio[963]: ---------------------------- MPD announces system playlist update Oct 12 14:27:30 volumio volumio[963]: info: Ignoring MPD Status Update Oct 12 14:27:30 volumio volumio[963]: info: sendMpdCommand clear took 2 milliseconds Oct 12 14:27:30 volumio volumio[963]: verbose: ControllerMpd::sendMpdCommand add "USB/江智民,周虹 - 有没有人告诉你.flac" Oct 12 14:27:30 volumio volumio[963]: error: updateQueue error: null Oct 12 14:27:30 volumio volumio[963]: info: Oct 12 14:27:30 volumio volumio[963]: ---------------------------- MPD announces system playlist update Oct 12 14:27:30 volumio volumio[963]: info: Ignoring MPD Status Update Oct 12 14:27:30 volumio volumio[963]: info: ------------------------------ 4ms Oct 12 14:27:30 volumio volumio[963]: info: sendMpdCommand add "USB/江智民,周虹 - 有没有人告诉你.flac" took 2 milliseconds Oct 12 14:27:30 volumio volumio[963]: verbose: ControllerMpd::sendMpdCommand play Oct 12 14:27:30 volumio volumio[963]: info: ------------------------------ 3ms Oct 12 14:27:30 volumio volumio[963]: info: Oct 12 14:27:30 volumio volumio[963]: ---------------------------- MPD announces state update: player Oct 12 14:27:30 volumio volumio[963]: info: sendMpdCommand play took 10 milliseconds Oct 12 14:27:30 volumio volumio[963]: info: ControllerMpd::getState Oct 12 14:27:30 volumio volumio[963]: verbose: ControllerMpd::sendMpdCommand status Oct 12 14:27:30 volumio volumio[963]: info: sendMpdCommand status took 273 milliseconds Oct 12 14:27:30 volumio volumio[963]: verbose: ControllerMpd::parseState Oct 12 14:27:30 volumio volumio[963]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 14:27:30 volumio volumio[963]: info: Oct 12 14:27:30 volumio volumio[963]: ---------------------------- MPD announces state update: player Oct 12 14:27:30 volumio volumio[963]: info: ControllerMpd::getState Oct 12 14:27:30 volumio volumio[963]: verbose: ControllerMpd::sendMpdCommand status Oct 12 14:27:30 volumio volumio[963]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 12 14:27:30 volumio volumio[963]: verbose: ControllerMpd::parseTrackInfo Oct 12 14:27:30 volumio volumio[963]: info: ControllerMpd::pushState Oct 12 14:27:30 volumio volumio[963]: info: CoreCommandRouter::servicePushState Oct 12 14:27:30 volumio volumio[963]: info: CorePlayQueue::getTrack 2 Oct 12 14:27:30 volumio volumio[963]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":344,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"有没有人告诉你","artist":"江智民/周虹","album":"当流行遇上发烧时","uri":"USB/江智民,周虹 - 有没有人告诉你.flac","trackType":"flac"} Oct 12 14:27:30 volumio volumio[963]: verbose: CURRENT POSITION 2 Oct 12 14:27:30 volumio volumio[963]: info: CoreStateMachine::syncState stateService play Oct 12 14:27:30 volumio volumio[963]: info: CoreStateMachine::syncState currentStatus stop Oct 12 14:27:30 volumio volumio[963]: info: ------------------------------ 279ms Oct 12 14:27:30 volumio volumio[963]: info: sendMpdCommand status took 3 milliseconds Oct 12 14:27:30 volumio volumio[963]: verbose: ControllerMpd::parseState Oct 12 14:27:30 volumio volumio[963]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 14:27:30 volumio volumio[963]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 12 14:27:30 volumio volumio[963]: verbose: ControllerMpd::parseTrackInfo Oct 12 14:27:30 volumio volumio[963]: info: ControllerMpd::pushState Oct 12 14:27:30 volumio volumio[963]: info: CoreCommandRouter::servicePushState Oct 12 14:27:30 volumio volumio[963]: info: CorePlayQueue::getTrack 2 Oct 12 14:27:30 volumio volumio[963]: verbose: STATE SERVICE {"status":"play","position":0,"seek":591,"duration":344,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"179 Kbps","isStreaming":false,"title":"有没有人告诉你","artist":"江智民/周虹","album":"当流行遇上发烧时","uri":"USB/江智民,周虹 - 有没有人告诉你.flac","trackType":"flac"} Oct 12 14:27:30 volumio volumio[963]: verbose: CURRENT POSITION 2 Oct 12 14:27:30 volumio volumio[963]: info: CoreStateMachine::syncState stateService play Oct 12 14:27:30 volumio volumio[963]: info: CoreStateMachine::syncState currentStatus play Oct 12 14:27:30 volumio volumio[963]: info: Received an update from plugin. extracting info from payload Oct 12 14:27:30 volumio volumio[963]: info: CoreStateMachine::pushState Oct 12 14:27:30 volumio volumio[963]: info: CorePlayQueue::getTrack 2 Oct 12 14:27:30 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 14:27:30 volumio volumio[963]: info: CoreCommandRouter::volumioPushState Oct 12 14:27:30 volumio volumio[963]: info: CoreStateMachine::pushState Oct 12 14:27:30 volumio volumio[963]: info: CorePlayQueue::getTrack 2 Oct 12 14:27:30 volumio volumio[963]: info: CoreCommandRouter::volumioPushState Oct 12 14:27:30 volumio volumio[963]: info: ------------------------------ 16ms Oct 12 14:27:36 volumio volumio[963]: info: Enabling plugin peppy_screensaver Oct 12 14:27:36 volumio volumio[963]: info: Loading plugin "peppy_screensaver"... Oct 12 14:27:36 volumio volumio[963]: info: Applying required configuration parameters for plugin peppy_screensaver Oct 12 14:27:36 volumio volumio[963]: info: Preparing to generate the ALSA configuration file Oct 12 14:27:36 volumio volumio[963]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Oct 12 14:27:36 volumio volumio[963]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Oct 12 14:27:36 volumio volumio[963]: info: Reading ALSA contributions from plugins. Oct 12 14:27:36 volumio volumio[963]: info: Asound.conf file unchanged, so no further update is needed Oct 12 14:27:36 volumio volumio[963]: info: Output device has changed, restarting MPD Oct 12 14:27:36 volumio sudo[4550]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 12 14:27:36 volumio sudo[4550]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 14:27:36 volumio volumio[963]: info: Output device has changed, restarting Shairport Sync Oct 12 14:27:36 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 14:27:36 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 14:27:36 volumio sudo[4550]: pam_unix(sudo:session): session closed for user root Oct 12 14:27:36 volumio sudo[4553]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 12 14:27:36 volumio sudo[4553]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 14:27:36 volumio systemd[1]: Stopping Music Player Daemon... Oct 12 14:27:36 volumio volumio[963]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 12 14:27:36 volumio volumio[963]: info: PLUGIN START: peppy_screensaver Oct 12 14:27:36 volumio volumio[963]: info: Loading i18n strings for locale zh Oct 12 14:27:36 volumio volumio[963]: info: /tmp/myfifo created Oct 12 14:27:36 volumio volumio[963]: info: /tmp/myfifosa created Oct 12 14:27:36 volumio sudo[4563]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-dummy index=7 pcm_substreams=1 fake_buffer=0 Oct 12 14:27:36 volumio sudo[4563]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 14:27:36 volumio sudo[4563]: pam_unix(sudo:session): session closed for user root Oct 12 14:27:36 volumio volumio[963]: info: snd-dummy loaded Oct 12 14:27:36 volumio volumio[963]: info: Error: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning' Oct 12 14:27:36 volumio volumio[963]: info: MPD Permissions set Oct 12 14:27:36 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 14:27:36 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 14:27:36 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 14:27:36 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 14:27:36 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 14:27:36 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 14:27:36 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 14:27:36 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 14:27:36 volumio systemd[1]: mpd.service: Succeeded. Oct 12 14:27:36 volumio systemd[1]: Stopped Music Player Daemon. Oct 12 14:27:36 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 14:27:36 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 12 14:27:36 volumio systemd[1]: Starting Music Player Daemon... Oct 12 14:27:36 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 14:27:36 volumio volumio[963]: info: Starting Shairport Sync Oct 12 14:27:36 volumio sudo[4573]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 12 14:27:36 volumio sudo[4573]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 14:27:36 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 12 14:27:36 volumio systemd[1]: shairport-sync.service: Succeeded. Oct 12 14:27:36 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 12 14:27:36 volumio sudo[4566]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 12 14:27:36 volumio sudo[4566]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 12 14:27:36 volumio sudo[4566]: pam_unix(sudo:session): session closed for user root Oct 12 14:27:36 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 12 14:27:36 volumio sudo[4573]: pam_unix(sudo:session): session closed for user root Oct 12 14:27:36 volumio volumio[963]: info: Shairport-Sync Started Oct 12 14:27:36 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 14:27:36 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 14:27:37 volumio mpd[4577]: Oct 12 14:27 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 12 14:27:37 volumio systemd[1]: Started Music Player Daemon. Oct 12 14:27:37 volumio sudo[4553]: pam_unix(sudo:session): session closed for user root Oct 12 14:27:37 volumio volumio[963]: error: updateQueue error: null Oct 12 14:27:39 volumio volumio[963]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 14:27:39 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 14:27:47 volumio volumio[963]: info: CALLMETHOD: user_interface peppy_screensaver savePeppyMeterConf [object Object] Oct 12 14:27:47 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , savePeppyMeterConf Oct 12 14:27:47 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 14:27:47 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 14:27:47 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 14:27:47 volumio volumio[963]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 14:27:47 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 14:27:57 volumio volumio[963]: info: CALLMETHOD: user_interface peppy_screensaver saveVUMeterConf [object Object] Oct 12 14:27:57 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , saveVUMeterConf Oct 12 14:27:57 volumio volumio[963]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 12 14:27:57 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 14:28:01 volumio volumio[963]: info: CoreCommandRouter::volumioPrevious Oct 12 14:28:01 volumio volumio[963]: info: CoreStateMachine::previous Oct 12 14:28:01 volumio volumio[963]: info: CorePlayQueue::getTrack 2 Oct 12 14:28:01 volumio volumio[963]: info: ControllerMpd::seek Oct 12 14:28:01 volumio volumio[963]: error: [2@0] {seek} Bad song index Oct 12 14:28:08 volumio volumio[963]: info: CoreCommandRouter::volumioPrevious Oct 12 14:28:08 volumio volumio[963]: info: CoreStateMachine::previous Oct 12 14:28:08 volumio volumio[963]: info: CorePlayQueue::getTrack 2 Oct 12 14:28:08 volumio volumio[963]: info: ControllerMpd::seek Oct 12 14:28:08 volumio volumio[963]: error: [2@0] {seek} Bad song index Oct 12 14:28:14 volumio volumio[963]: info: CoreCommandRouter::volumioPrevious Oct 12 14:28:14 volumio volumio[963]: info: CoreStateMachine::previous Oct 12 14:28:14 volumio volumio[963]: info: CorePlayQueue::getTrack 2 Oct 12 14:28:14 volumio volumio[963]: info: ControllerMpd::seek Oct 12 14:28:14 volumio volumio[963]: error: [2@0] {seek} Bad song index Oct 12 14:28:16 volumio volumio[963]: info: CoreCommandRouter::volumioNext Oct 12 14:28:16 volumio volumio[963]: info: CoreStateMachine::next Oct 12 14:28:16 volumio volumio[963]: info: CoreStateMachine::stop Oct 12 14:28:16 volumio volumio[963]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 14:28:16 volumio volumio[963]: info: CoreStateMachine::stPlaybackTimer Oct 12 14:28:16 volumio volumio[963]: info: CoreStateMachine::updateTrackBlock Oct 12 14:28:16 volumio volumio[963]: info: CorePlayQueue::getTrackBlock Oct 12 14:28:16 volumio volumio[963]: info: CoreStateMachine::pushState Oct 12 14:28:16 volumio volumio[963]: info: CorePlayQueue::getTrack 2 Oct 12 14:28:16 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 14:28:16 volumio volumio[963]: info: CoreCommandRouter::volumioPushState Oct 12 14:28:16 volumio volumio[963]: info: CoreStateMachine::serviceStop Oct 12 14:28:16 volumio volumio[963]: info: CorePlayQueue::getTrack 2 Oct 12 14:28:16 volumio volumio[963]: info: CoreCommandRouter::serviceStop Oct 12 14:28:16 volumio volumio[963]: info: ControllerMpd::stop Oct 12 14:28:16 volumio volumio[963]: verbose: ControllerMpd::sendMpdCommand stop Oct 12 14:28:16 volumio volumio[963]: info: sendMpdCommand stop took 9 milliseconds Oct 12 14:28:16 volumio volumio[963]: info: CoreStateMachine::play index undefined Oct 12 14:28:16 volumio volumio[963]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 12 14:28:16 volumio volumio[963]: info: CorePlayQueue::getTrack 3 Oct 12 14:28:16 volumio volumio[963]: info: CoreStateMachine::startPlaybackTimer Oct 12 14:28:16 volumio volumio[963]: info: CorePlayQueue::getTrack 3 Oct 12 14:28:16 volumio volumio[963]: verbose: ControllerMpd::clearAddPlayTracks USB/区瑞强 - 偏偏喜欢你.flac Oct 12 14:28:16 volumio volumio[963]: verbose: ControllerMpd::sendMpdCommand stop Oct 12 14:28:16 volumio volumio[963]: info: CoreStateMachine::updateTrackBlock Oct 12 14:28:16 volumio volumio[963]: info: CorePlayQueue::getTrackBlock Oct 12 14:28:16 volumio volumio[963]: info: sendMpdCommand stop took 2 milliseconds Oct 12 14:28:16 volumio volumio[963]: verbose: ControllerMpd::sendMpdCommand clear Oct 12 14:28:16 volumio volumio[963]: info: Oct 12 14:28:16 volumio volumio[963]: ---------------------------- MPD announces system playlist update Oct 12 14:28:16 volumio volumio[963]: info: Ignoring MPD Status Update Oct 12 14:28:16 volumio volumio[963]: info: sendMpdCommand clear took 2 milliseconds Oct 12 14:28:16 volumio volumio[963]: verbose: ControllerMpd::sendMpdCommand add "USB/区瑞强 - 偏偏喜欢你.flac" Oct 12 14:28:16 volumio volumio[963]: error: updateQueue error: null Oct 12 14:28:16 volumio volumio[963]: info: Oct 12 14:28:16 volumio volumio[963]: ---------------------------- MPD announces system playlist update Oct 12 14:28:16 volumio volumio[963]: info: Ignoring MPD Status Update Oct 12 14:28:16 volumio volumio[963]: info: ------------------------------ 3ms Oct 12 14:28:16 volumio volumio[963]: info: sendMpdCommand add "USB/区瑞强 - 偏偏喜欢你.flac" took 2 milliseconds Oct 12 14:28:16 volumio volumio[963]: verbose: ControllerMpd::sendMpdCommand play Oct 12 14:28:16 volumio volumio[963]: info: ------------------------------ 2ms Oct 12 14:28:16 volumio volumio[963]: info: Oct 12 14:28:16 volumio volumio[963]: ---------------------------- MPD announces state update: player Oct 12 14:28:16 volumio volumio[963]: info: sendMpdCommand play took 3 milliseconds Oct 12 14:28:16 volumio volumio[963]: info: ControllerMpd::getState Oct 12 14:28:16 volumio volumio[963]: verbose: ControllerMpd::sendMpdCommand status Oct 12 14:28:16 volumio volumio[963]: info: Oct 12 14:28:16 volumio volumio[963]: ---------------------------- MPD announces state update: player Oct 12 14:28:16 volumio volumio[963]: info: sendMpdCommand status took 283 milliseconds Oct 12 14:28:16 volumio volumio[963]: info: ControllerMpd::getState Oct 12 14:28:16 volumio volumio[963]: verbose: ControllerMpd::sendMpdCommand status Oct 12 14:28:16 volumio volumio[963]: verbose: ControllerMpd::parseState Oct 12 14:28:16 volumio volumio[963]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 14:28:16 volumio volumio[963]: info: sendMpdCommand status took 2 milliseconds Oct 12 14:28:16 volumio volumio[963]: verbose: ControllerMpd::parseState Oct 12 14:28:16 volumio volumio[963]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 14:28:16 volumio volumio[963]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 12 14:28:16 volumio volumio[963]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 12 14:28:16 volumio volumio[963]: verbose: ControllerMpd::parseTrackInfo Oct 12 14:28:16 volumio volumio[963]: verbose: ControllerMpd::parseTrackInfo Oct 12 14:28:16 volumio volumio[963]: info: ControllerMpd::pushState Oct 12 14:28:16 volumio volumio[963]: info: CoreCommandRouter::servicePushState Oct 12 14:28:16 volumio volumio[963]: info: CorePlayQueue::getTrack 3 Oct 12 14:28:16 volumio volumio[963]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":216,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"120 Kbps","isStreaming":false,"title":"偏偏喜欢你","artist":"区瑞强","album":"惠威T200A试音碟","uri":"USB/区瑞强 - 偏偏喜欢你.flac","trackType":"flac"} Oct 12 14:28:16 volumio volumio[963]: verbose: CURRENT POSITION 3 Oct 12 14:28:16 volumio volumio[963]: info: CoreStateMachine::syncState stateService play Oct 12 14:28:16 volumio volumio[963]: info: CoreStateMachine::syncState currentStatus stop Oct 12 14:28:16 volumio volumio[963]: info: ControllerMpd::pushState Oct 12 14:28:16 volumio volumio[963]: info: CoreCommandRouter::servicePushState Oct 12 14:28:16 volumio volumio[963]: info: CorePlayQueue::getTrack 3 Oct 12 14:28:16 volumio volumio[963]: verbose: STATE SERVICE {"status":"play","position":0,"seek":432,"duration":216,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"779 Kbps","isStreaming":false,"title":"偏偏喜欢你","artist":"区瑞强","album":"惠威T200A试音碟","uri":"USB/区瑞强 - 偏偏喜欢你.flac","trackType":"flac"} Oct 12 14:28:16 volumio volumio[963]: verbose: CURRENT POSITION 3 Oct 12 14:28:16 volumio volumio[963]: info: CoreStateMachine::syncState stateService play Oct 12 14:28:16 volumio volumio[963]: info: CoreStateMachine::syncState currentStatus play Oct 12 14:28:16 volumio volumio[963]: info: Received an update from plugin. extracting info from payload Oct 12 14:28:16 volumio volumio[963]: info: CoreStateMachine::pushState Oct 12 14:28:16 volumio volumio[963]: info: CorePlayQueue::getTrack 3 Oct 12 14:28:16 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 14:28:16 volumio volumio[963]: info: CoreCommandRouter::volumioPushState Oct 12 14:28:16 volumio volumio[963]: info: CoreStateMachine::pushState Oct 12 14:28:16 volumio volumio[963]: info: CorePlayQueue::getTrack 3 Oct 12 14:28:16 volumio volumio[963]: info: CoreCommandRouter::volumioPushState Oct 12 14:28:16 volumio volumio[963]: info: ------------------------------ 298ms Oct 12 14:28:16 volumio volumio[963]: info: ------------------------------ 20ms Oct 12 14:28:20 volumio volumio[963]: info: CoreCommandRouter::volumioPause Oct 12 14:28:20 volumio volumio[963]: info: CoreStateMachine::pause Oct 12 14:28:20 volumio volumio[963]: info: CoreStateMachine::stPlaybackTimer Oct 12 14:28:20 volumio volumio[963]: info: CoreStateMachine::servicePause Oct 12 14:28:20 volumio volumio[963]: info: CorePlayQueue::getTrack 3 Oct 12 14:28:20 volumio volumio[963]: info: CoreCommandRouter::servicePause Oct 12 14:28:20 volumio volumio[963]: info: ControllerMpd::pause Oct 12 14:28:20 volumio volumio[963]: verbose: ControllerMpd::sendMpdCommand pause Oct 12 14:28:20 volumio volumio[963]: info: Oct 12 14:28:20 volumio volumio[963]: ---------------------------- MPD announces state update: player Oct 12 14:28:20 volumio volumio[963]: info: sendMpdCommand pause took 4 milliseconds Oct 12 14:28:20 volumio volumio[963]: info: ControllerMpd::getState Oct 12 14:28:20 volumio volumio[963]: verbose: ControllerMpd::sendMpdCommand status Oct 12 14:28:20 volumio volumio[963]: info: sendMpdCommand status took 1 milliseconds Oct 12 14:28:20 volumio volumio[963]: verbose: ControllerMpd::parseState Oct 12 14:28:20 volumio volumio[963]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 12 14:28:20 volumio volumio[963]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 12 14:28:20 volumio volumio[963]: verbose: ControllerMpd::parseTrackInfo Oct 12 14:28:20 volumio volumio[963]: info: ControllerMpd::pushState Oct 12 14:28:20 volumio volumio[963]: info: CoreCommandRouter::servicePushState Oct 12 14:28:20 volumio volumio[963]: info: CorePlayQueue::getTrack 3 Oct 12 14:28:20 volumio volumio[963]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":4712,"duration":216,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"544 Kbps","isStreaming":false,"title":"偏偏喜欢你","artist":"区瑞强","album":"惠威T200A试音碟","uri":"USB/区瑞强 - 偏偏喜欢你.flac","trackType":"flac"} Oct 12 14:28:20 volumio volumio[963]: verbose: CURRENT POSITION 3 Oct 12 14:28:20 volumio volumio[963]: info: CoreStateMachine::syncState stateService pause Oct 12 14:28:20 volumio volumio[963]: info: CoreStateMachine::syncState currentStatus pause Oct 12 14:28:20 volumio volumio[963]: info: CoreStateMachine::pushState Oct 12 14:28:20 volumio volumio[963]: info: CorePlayQueue::getTrack 3 Oct 12 14:28:20 volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 14:28:20 volumio volumio[963]: info: CoreCommandRouter::volumioPushState Oct 12 14:28:20 volumio volumio[963]: info: CoreStateMachine::stPlaybackTimer Oct 12 14:28:20 volumio volumio[963]: info: ------------------------------ 12ms Oct 12 14:28:20 volumio volumio[963]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 14:28:20 volumio volumio[963]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning' Oct 12 14:28:20 volumio volumio[963]: at Object.readdirSync (fs.js:1048:3) Oct 12 14:28:20 volumio volumio[963]: at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11) Oct 12 14:28:20 volumio volumio[963]: at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7) Oct 12 14:28:20 volumio volumio[963]: at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62) Oct 12 14:28:20 volumio volumio[963]: at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17) Oct 12 14:28:20 volumio volumio[963]: at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48) Oct 12 14:28:20 volumio volumio[963]: at Socket.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Oct 12 14:28:20 volumio volumio[963]: at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10) Oct 12 14:28:20 volumio volumio[963]: at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12) Oct 12 14:28:20 volumio volumio[963]: at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Oct 12 14:28:20 volumio volumio[963]: at Manager.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Oct 12 14:28:20 volumio volumio[963]: at Manager.ondecoded (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:349:8) Oct 12 14:28:20 volumio volumio[963]: at Decoder. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Oct 12 14:28:20 volumio volumio[963]: at Decoder.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Oct 12 14:28:20 volumio volumio[963]: at Decoder.add (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-parser/index.js:251:12) Oct 12 14:28:20 volumio volumio[963]: at Manager.ondata (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:339:16) { Oct 12 14:28:20 volumio volumio[963]: errno: -20, Oct 12 14:28:20 volumio volumio[963]: syscall: 'scandir', Oct 12 14:28:20 volumio volumio[963]: code: 'ENOTDIR', Oct 12 14:28:20 volumio volumio[963]: path: '/tmp/peppyrunning' Oct 12 14:28:20 volumio volumio[963]: } Oct 12 14:28:20 volumio volumio[963]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 14:28:21 volumio sudo[4664]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-12 14:27 Oct 12 14:28:21 volumio sudo[4664]: 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"