-- Logs begin at Sat 2024-11-23 15:38:56 UTC, end at Fri 2024-11-29 14:55:48 UTC. -- Nov 29 14:54:00 fph kernel: usb 1-1.4: device not accepting address 42, error -32 Nov 29 14:54:00 fph kernel: usb 1-1-port4: unable to enumerate USB device Nov 29 14:54:00 fph volumio[3873]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesQOBUZ Nov 29 14:54:00 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 29 14:54:00 fph volumio[3873]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesTIDAL Nov 29 14:54:00 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 29 14:54:23 fph volumio[3873]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 14:54:23 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 29 14:54:23 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 29 14:54:23 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 29 14:54:23 fph volumio[3873]: Invalid card number. Nov 29 14:54:23 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:54:23 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:54:23 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:54:23 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:54:23 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:54:23 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:54:23 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:54:23 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Nov 29 14:54:23 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 29 14:54:32 fph kernel: usb 1-1.3: new high-speed USB device number 43 using dwc_otg Nov 29 14:54:32 fph kernel: usb 1-1.3: New USB device found, idVendor=06cb, idProduct=1595, bcdDevice= 0.02 Nov 29 14:54:32 fph kernel: usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Nov 29 14:54:32 fph kernel: usb 1-1.3: Product: CX31993 384Khz HIFI AUDIO Nov 29 14:54:32 fph kernel: usb 1-1.3: Manufacturer: Synaptics Nov 29 14:54:32 fph kernel: input: Synaptics CX31993 384Khz HIFI AUDIO Consumer Control as /devices/platform/soc/3f980000.usb/usb1/1-1/1-1.3/1-1.3:1.2/0003:06CB:1595.0012/input/input18 Nov 29 14:54:32 fph kernel: hid-generic 0003:06CB:1595.0012: input,hidraw0: USB HID v1.11 Device [Synaptics CX31993 384Khz HIFI AUDIO] on usb-3f980000.usb-1.3/input2 Nov 29 14:54:32 fph volumio[3873]: info: Nov 29 14:54:32 fph volumio[3873]: ---------------------------- USB Audio Device Attached Nov 29 14:54:32 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Nov 29 14:54:38 fph volumio[3873]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 14:54:38 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 29 14:54:38 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 29 14:54:38 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 29 14:54:38 fph volumio[3873]: Invalid card number. Nov 29 14:54:38 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:54:38 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:54:38 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:54:38 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:54:38 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:54:38 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:54:38 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:54:38 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Nov 29 14:54:38 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 29 14:54:43 fph volumio[3873]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Nov 29 14:54:43 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Nov 29 14:54:43 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 29 14:54:43 fph volumio[3873]: info: Output device has changed, restarting MPD Nov 29 14:54:43 fph sudo[4455]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 29 14:54:43 fph volumio[3873]: info: Output device has changed, restarting Shairport Sync Nov 29 14:54:43 fph sudo[4455]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 14:54:43 fph sudo[4455]: pam_unix(sudo:session): session closed for user root Nov 29 14:54:43 fph sudo[4458]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 29 14:54:43 fph sudo[4458]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 14:54:43 fph systemd[1]: Stopping Music Player Daemon... Nov 29 14:54:43 fph volumio[3873]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 29 14:54:43 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 29 14:54:43 fph volumio[3873]: info: Setting mixer PCM for card CX31993 384Khz HIFI AUDIO Nov 29 14:54:43 fph systemd[1]: Starting Music Player Daemon... Nov 29 14:54:43 fph volumio[3873]: info: CoreCommandRouter::volumioUpdateVolumeSettings Nov 29 14:54:43 fph volumio[3873]: info: Updating Volume Controller Parameters: Device: 5 Name: Mixer: PCM Max Vol: 60 Vol Curve; logarithmic Vol Steps: 5 Nov 29 14:54:43 fph volumio[3873]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 14:54:43 fph volumio[3873]: info: MPD Permissions set Nov 29 14:54:43 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 14:54:43 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 14:54:43 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 14:54:43 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 14:54:43 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 14:54:43 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 14:54:43 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 14:54:43 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 29 14:54:43 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 14:54:43 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 29 14:54:43 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 29 14:54:43 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 29 14:54:43 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:54:43 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:54:43 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:54:43 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:54:43 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:54:43 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:54:43 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:54:43 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Nov 29 14:54:43 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 29 14:54:43 fph volumio[3873]: info: Starting Shairport Sync Nov 29 14:54:43 fph volumio[3873]: info: VolumeController:: Volume=43 Mute =false Nov 29 14:54:43 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:54:43 fph sudo[4491]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 29 14:54:43 fph volumio[3873]: info: CorePlayQueue::getTrack 0 Nov 29 14:54:43 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:54:43 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:54:43 fph sudo[4491]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 14:54:43 fph systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 29 14:54:43 fph systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Nov 29 14:54:43 fph systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 29 14:54:43 fph sudo[4491]: pam_unix(sudo:session): session closed for user root Nov 29 14:54:43 fph volumio[3873]: info: Shairport-Sync Started Nov 29 14:54:43 fph systemd[1]: Started Music Player Daemon. Nov 29 14:54:43 fph sudo[4458]: pam_unix(sudo:session): session closed for user root Nov 29 14:54:43 fph volumio[3873]: error: updateQueue error: null Nov 29 14:54:43 fph volumio[3873]: error: Upnp client error: Error: This socket has been ended by the other party Nov 29 14:54:45 fph volumio[3873]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Nov 29 14:54:45 fph volumio[3873]: info: CoreStateMachine::getcurrentVolume Nov 29 14:54:45 fph volumio[3873]: info: CoreCommandRouter::volumioRetrievevolume Nov 29 14:54:45 fph volumio[3873]: info: VolumeController:: Volume=43 Mute =false Nov 29 14:54:45 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:54:45 fph volumio[3873]: info: CorePlayQueue::getTrack 0 Nov 29 14:54:45 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:54:45 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:54:45 fph volumio[3873]: info: CoreStateMachine::updateTrackBlock Nov 29 14:54:45 fph volumio[3873]: info: CorePlayQueue::getTrackBlock Nov 29 14:54:45 fph volumio[3873]: info: CoreCommandRouter::volumioRetrievevolume Nov 29 14:54:46 fph volumio[3873]: info: VolumeController:: Volume=43 Mute =false Nov 29 14:54:46 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:54:46 fph volumio[3873]: info: CorePlayQueue::getTrack 0 Nov 29 14:54:46 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:54:46 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:54:53 fph volumio[3873]: info: VolumeController::SetAlsaVolume25 Nov 29 14:54:53 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:54:53 fph volumio[3873]: info: CorePlayQueue::getTrack 0 Nov 29 14:54:53 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:54:53 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:54:54 fph volumio[3873]: info: CoreCommandRouter::volumioPlay Nov 29 14:54:54 fph volumio[3873]: UNSET VOLATILE Nov 29 14:54:54 fph volumio[3873]: info: CoreStateMachine::play index undefined Nov 29 14:54:54 fph volumio[3873]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 29 14:54:54 fph volumio[3873]: info: CorePlayQueue::getTrack 0 Nov 29 14:54:54 fph volumio[3873]: info: CoreStateMachine::startPlaybackTimer Nov 29 14:54:54 fph volumio[3873]: info: CorePlayQueue::getTrack 0 Nov 29 14:54:54 fph volumio[3873]: info: ControllerMpd::resume Nov 29 14:54:54 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand play Nov 29 14:55:03 fph volumio[3873]: info: CorePlayQueue::getTrack 0 Nov 29 14:55:03 fph volumio[3873]: info: CorePlayQueue::getTrack 181 Nov 29 14:55:03 fph volumio[3873]: info: Prefetching next song Nov 29 14:55:03 fph volumio[3873]: info: DOING PREFETCH IN MPD Nov 29 14:55:03 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand add "USB/FPH/music/HOYO-MiX - 永不复焉 Nevermore.mp3" Nov 29 14:55:03 fph volumio[3873]: info: Nov 29 14:55:03 fph volumio[3873]: ---------------------------- MPD announces system playlist update Nov 29 14:55:03 fph volumio[3873]: info: Ignoring MPD Status Update Nov 29 14:55:03 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand consume 1 Nov 29 14:55:03 fph volumio[3873]: info: Nov 29 14:55:03 fph volumio[3873]: ---------------------------- MPD announces state update: options Nov 29 14:55:03 fph volumio[3873]: info: ------------------------------ 7ms Nov 29 14:55:03 fph volumio[3873]: info: ControllerMpd::getState Nov 29 14:55:03 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand status Nov 29 14:55:03 fph volumio[3873]: verbose: ControllerMpd::parseState Nov 29 14:55:03 fph volumio[3873]: info: ControllerMpd::pushState Nov 29 14:55:03 fph volumio[3873]: info: CoreCommandRouter::servicePushState Nov 29 14:55:03 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:03 fph volumio[3873]: info: CorePlayQueue::getTrack 0 Nov 29 14:55:03 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:03 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:03 fph volumio[3873]: info: CorePlayQueue::getTrack 0 Nov 29 14:55:03 fph volumio[3873]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Nov 29 14:55:03 fph volumio[3873]: verbose: CURRENT POSITION 0 Nov 29 14:55:03 fph volumio[3873]: info: CoreStateMachine::syncState stateService stop Nov 29 14:55:03 fph volumio[3873]: info: CoreStateMachine::syncState currentStatus pause Nov 29 14:55:03 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:03 fph volumio[3873]: info: CorePlayQueue::getTrack 0 Nov 29 14:55:03 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:03 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:03 fph volumio[3873]: info: ------------------------------ 74ms Nov 29 14:55:08 fph volumio[3873]: info: CoreStateMachine::startPlaybackTimer Nov 29 14:55:08 fph volumio[3873]: info: CorePlayQueue::getTrack 181 Nov 29 14:55:08 fph volumio[3873]: info: CoreCommandRouter::volumioSeek Nov 29 14:55:08 fph volumio[3873]: info: CoreStateMachine::seek Nov 29 14:55:08 fph volumio[3873]: info: CorePlayQueue::getTrack 181 Nov 29 14:55:08 fph volumio[3873]: info: TRACKBLOCK {"uri":"mnt/USB/FPH/music/HOYO-MiX - 永不复焉 Nevermore.mp3","service":"mpd","name":"永不复焉 Nevermore","artist":"HOYO-MiX","album":"崩坏星穹铁道-飞来波的圣状（上篇）The Flapper Sinthome Disc1","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=235&web=HOYO-MiX/%E5%B4%A9%E5%9D%8F%E6%98%9F%E7%A9%B9%E9%93%81%E9%81%93-%E9%A3%9E%E6%9D%A5%E6%B3%A2%E7%9A%84%E5%9C%A3%E7%8A%B6%EF%BC%88%E4%B8%8A%E7%AF%87%EF%BC%89The%20Flapper%20Sinthome%20Disc1/large&path=%2FUSB%2FFPH%2Fmusic&metadata=false","duration":122,"trackType":"mp3"} Nov 29 14:55:08 fph volumio[3873]: info: CoreStateMachine::startPlaybackTimer Nov 29 14:55:08 fph volumio[3873]: info: CorePlayQueue::getTrack 181 Nov 29 14:55:08 fph volumio[3873]: info: ControllerMpd::seek Nov 29 14:55:08 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:08 fph volumio[3873]: info: CorePlayQueue::getTrack 181 Nov 29 14:55:08 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:08 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:09 fph volumio[3873]: error: null Nov 29 14:55:09 fph volumio[3873]: info: Nov 29 14:55:09 fph volumio[3873]: ---------------------------- MPD announces state update: player Nov 29 14:55:09 fph volumio[3873]: info: ControllerMpd::getState Nov 29 14:55:09 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand status Nov 29 14:55:09 fph volumio[3873]: verbose: ControllerMpd::parseState Nov 29 14:55:09 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 14:55:09 fph volumio[3873]: verbose: ControllerMpd::parseTrackInfo Nov 29 14:55:09 fph volumio[3873]: info: ControllerMpd::pushState Nov 29 14:55:09 fph volumio[3873]: info: CoreCommandRouter::servicePushState Nov 29 14:55:09 fph volumio[3873]: info: CorePlayQueue::getTrack 181 Nov 29 14:55:09 fph volumio[3873]: verbose: STATE SERVICE {"status":"play","position":0,"seek":40000,"duration":122,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"永不复焉 Nevermore","artist":"HOYO-MiX","album":"崩坏星穹铁道-飞来波的圣状（上篇）The Flapper Sinthome Disc1","uri":"USB/FPH/music/HOYO-MiX - 永不复焉 Nevermore.mp3","trackType":"mp3"} Nov 29 14:55:09 fph volumio[3873]: verbose: CURRENT POSITION 181 Nov 29 14:55:09 fph volumio[3873]: info: CoreStateMachine::syncState stateService play Nov 29 14:55:09 fph volumio[3873]: info: CoreStateMachine::syncState currentStatus pause Nov 29 14:55:09 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:09 fph volumio[3873]: info: CorePlayQueue::getTrack 181 Nov 29 14:55:09 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:09 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:09 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:09 fph volumio[3873]: info: CorePlayQueue::getTrack 181 Nov 29 14:55:09 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:09 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:09 fph volumio[3873]: info: ------------------------------ 39ms Nov 29 14:55:09 fph volumio[3873]: info: Nov 29 14:55:09 fph volumio[3873]: ---------------------------- MPD announces state update: player Nov 29 14:55:09 fph volumio[3873]: info: ControllerMpd::getState Nov 29 14:55:09 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand status Nov 29 14:55:09 fph volumio[3873]: info: Nov 29 14:55:09 fph volumio[3873]: ---------------------------- MPD announces state update: player Nov 29 14:55:09 fph volumio[3873]: info: ControllerMpd::getState Nov 29 14:55:09 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand status Nov 29 14:55:09 fph volumio[3873]: verbose: ControllerMpd::parseState Nov 29 14:55:09 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 14:55:09 fph volumio[3873]: verbose: ControllerMpd::parseState Nov 29 14:55:09 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 14:55:09 fph volumio[3873]: verbose: ControllerMpd::parseTrackInfo Nov 29 14:55:09 fph volumio[3873]: info: ControllerMpd::pushState Nov 29 14:55:09 fph volumio[3873]: info: CoreCommandRouter::servicePushState Nov 29 14:55:09 fph volumio[3873]: info: CorePlayQueue::getTrack 181 Nov 29 14:55:09 fph volumio[3873]: verbose: STATE SERVICE {"status":"play","position":0,"seek":40490,"duration":122,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"永不复焉 Nevermore","artist":"HOYO-MiX","album":"崩坏星穹铁道-飞来波的圣状（上篇）The Flapper Sinthome Disc1","uri":"USB/FPH/music/HOYO-MiX - 永不复焉 Nevermore.mp3","trackType":"mp3"} Nov 29 14:55:09 fph volumio[3873]: verbose: CURRENT POSITION 181 Nov 29 14:55:09 fph volumio[3873]: info: CoreStateMachine::syncState stateService play Nov 29 14:55:09 fph volumio[3873]: info: CoreStateMachine::syncState currentStatus play Nov 29 14:55:09 fph volumio[3873]: info: Received an update from plugin. extracting info from payload Nov 29 14:55:09 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:09 fph volumio[3873]: info: CorePlayQueue::getTrack 181 Nov 29 14:55:09 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:09 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:09 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:09 fph volumio[3873]: info: CorePlayQueue::getTrack 181 Nov 29 14:55:09 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:09 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:09 fph volumio[3873]: info: ------------------------------ 57ms Nov 29 14:55:09 fph volumio[3873]: verbose: ControllerMpd::parseTrackInfo Nov 29 14:55:09 fph volumio[3873]: info: ControllerMpd::pushState Nov 29 14:55:09 fph volumio[3873]: info: CoreCommandRouter::servicePushState Nov 29 14:55:09 fph volumio[3873]: info: CorePlayQueue::getTrack 181 Nov 29 14:55:09 fph volumio[3873]: verbose: STATE SERVICE {"status":"play","position":0,"seek":40490,"duration":122,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"永不复焉 Nevermore","artist":"HOYO-MiX","album":"崩坏星穹铁道-飞来波的圣状（上篇）The Flapper Sinthome Disc1","uri":"USB/FPH/music/HOYO-MiX - 永不复焉 Nevermore.mp3","trackType":"mp3"} Nov 29 14:55:09 fph volumio[3873]: verbose: CURRENT POSITION 181 Nov 29 14:55:09 fph volumio[3873]: info: CoreStateMachine::syncState stateService play Nov 29 14:55:09 fph volumio[3873]: info: CoreStateMachine::syncState currentStatus play Nov 29 14:55:09 fph volumio[3873]: info: Received an update from plugin. extracting info from payload Nov 29 14:55:09 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:09 fph volumio[3873]: info: CorePlayQueue::getTrack 181 Nov 29 14:55:09 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:09 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:09 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:09 fph volumio[3873]: info: CorePlayQueue::getTrack 181 Nov 29 14:55:09 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:09 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:09 fph volumio[3873]: info: ------------------------------ 67ms Nov 29 14:55:11 fph volumio[3873]: info: CoreCommandRouter::volumioNext Nov 29 14:55:11 fph volumio[3873]: info: CoreStateMachine::next Nov 29 14:55:11 fph volumio[3873]: info: CoreStateMachine::stop Nov 29 14:55:11 fph volumio[3873]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 29 14:55:11 fph volumio[3873]: UNSET VOLATILE Nov 29 14:55:11 fph volumio[3873]: info: CoreStateMachine::stPlaybackTimer Nov 29 14:55:11 fph volumio[3873]: info: CoreStateMachine::updateTrackBlock Nov 29 14:55:11 fph volumio[3873]: info: CorePlayQueue::getTrackBlock Nov 29 14:55:11 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:11 fph volumio[3873]: info: CorePlayQueue::getTrack 181 Nov 29 14:55:11 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:11 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:11 fph volumio[3873]: info: CoreStateMachine::serviceStop Nov 29 14:55:11 fph volumio[3873]: info: CorePlayQueue::getTrack 181 Nov 29 14:55:11 fph volumio[3873]: info: CoreCommandRouter::serviceStop Nov 29 14:55:11 fph volumio[3873]: info: ControllerMpd::stop Nov 29 14:55:11 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand stop Nov 29 14:55:11 fph volumio[3873]: info: CoreStateMachine::play index undefined Nov 29 14:55:11 fph volumio[3873]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 29 14:55:11 fph volumio[3873]: info: CorePlayQueue::getTrack 147 Nov 29 14:55:11 fph volumio[3873]: info: CoreStateMachine::startPlaybackTimer Nov 29 14:55:11 fph volumio[3873]: info: CorePlayQueue::getTrack 147 Nov 29 14:55:11 fph volumio[3873]: verbose: ControllerMpd::clearAddPlayTracks USB/FPH/music/HOYO-MiX - 一夜无事 Uneventful Night.flac Nov 29 14:55:11 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand stop Nov 29 14:55:11 fph volumio[3873]: info: CoreStateMachine::updateTrackBlock Nov 29 14:55:11 fph volumio[3873]: info: CorePlayQueue::getTrackBlock Nov 29 14:55:11 fph volumio[3873]: info: Nov 29 14:55:11 fph volumio[3873]: ---------------------------- MPD announces state update: player Nov 29 14:55:11 fph volumio[3873]: info: ControllerMpd::getState Nov 29 14:55:11 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand status Nov 29 14:55:11 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand clear Nov 29 14:55:11 fph volumio[3873]: info: Nov 29 14:55:11 fph volumio[3873]: ---------------------------- MPD announces system playlist update Nov 29 14:55:11 fph volumio[3873]: info: Ignoring MPD Status Update Nov 29 14:55:11 fph volumio[3873]: verbose: ControllerMpd::parseState Nov 29 14:55:11 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 14:55:11 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand add "USB/FPH/music/HOYO-MiX - 一夜无事 Uneventful Night.flac" Nov 29 14:55:11 fph volumio[3873]: error: updateQueue error: null Nov 29 14:55:11 fph volumio[3873]: info: Nov 29 14:55:11 fph volumio[3873]: ---------------------------- MPD announces system playlist update Nov 29 14:55:11 fph volumio[3873]: info: Ignoring MPD Status Update Nov 29 14:55:11 fph volumio[3873]: info: ------------------------------ 7ms Nov 29 14:55:11 fph volumio[3873]: verbose: ControllerMpd::parseTrackInfo Nov 29 14:55:11 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand play Nov 29 14:55:11 fph volumio[3873]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 29 14:55:11 fph volumio[3873]: info: ------------------------------ 21ms Nov 29 14:55:11 fph volumio[3873]: info: ------------------------------ 16ms Nov 29 14:55:11 fph volumio[3873]: info: Nov 29 14:55:11 fph volumio[3873]: ---------------------------- MPD announces state update: player Nov 29 14:55:11 fph volumio[3873]: info: ControllerMpd::getState Nov 29 14:55:11 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand status Nov 29 14:55:11 fph volumio[3873]: info: Nov 29 14:55:11 fph volumio[3873]: ---------------------------- MPD announces state update: player Nov 29 14:55:11 fph volumio[3873]: info: ControllerMpd::getState Nov 29 14:55:11 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand status Nov 29 14:55:11 fph volumio[3873]: verbose: ControllerMpd::parseState Nov 29 14:55:11 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 14:55:11 fph volumio[3873]: verbose: ControllerMpd::parseState Nov 29 14:55:11 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 14:55:11 fph volumio[3873]: verbose: ControllerMpd::parseTrackInfo Nov 29 14:55:11 fph volumio[3873]: info: ControllerMpd::pushState Nov 29 14:55:11 fph volumio[3873]: info: CoreCommandRouter::servicePushState Nov 29 14:55:11 fph volumio[3873]: info: CorePlayQueue::getTrack 147 Nov 29 14:55:11 fph volumio[3873]: verbose: STATE SERVICE {"status":"play","position":0,"seek":357,"duration":85,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2108 Kbps","isStreaming":false,"title":"一夜无事 Uneventful Night","artist":"HOYO-MiX","album":"崩坏星穹铁道-行于命途 Experience the Paths","uri":"USB/FPH/music/HOYO-MiX - 一夜无事 Uneventful Night.flac","trackType":"flac"} Nov 29 14:55:11 fph volumio[3873]: verbose: CURRENT POSITION 147 Nov 29 14:55:11 fph volumio[3873]: info: CoreStateMachine::syncState stateService play Nov 29 14:55:11 fph volumio[3873]: info: CoreStateMachine::syncState currentStatus stop Nov 29 14:55:11 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:11 fph volumio[3873]: info: CorePlayQueue::getTrack 147 Nov 29 14:55:11 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:11 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:11 fph volumio[3873]: info: ------------------------------ 38ms Nov 29 14:55:11 fph volumio[3873]: verbose: ControllerMpd::parseTrackInfo Nov 29 14:55:11 fph volumio[3873]: info: ControllerMpd::pushState Nov 29 14:55:11 fph volumio[3873]: info: CoreCommandRouter::servicePushState Nov 29 14:55:11 fph volumio[3873]: info: CorePlayQueue::getTrack 147 Nov 29 14:55:11 fph volumio[3873]: verbose: STATE SERVICE {"status":"play","position":0,"seek":490,"duration":85,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2102 Kbps","isStreaming":false,"title":"一夜无事 Uneventful Night","artist":"HOYO-MiX","album":"崩坏星穹铁道-行于命途 Experience the Paths","uri":"USB/FPH/music/HOYO-MiX - 一夜无事 Uneventful Night.flac","trackType":"flac"} Nov 29 14:55:11 fph volumio[3873]: verbose: CURRENT POSITION 147 Nov 29 14:55:11 fph volumio[3873]: info: CoreStateMachine::syncState stateService play Nov 29 14:55:11 fph volumio[3873]: info: CoreStateMachine::syncState currentStatus play Nov 29 14:55:11 fph volumio[3873]: info: Received an update from plugin. extracting info from payload Nov 29 14:55:11 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:11 fph volumio[3873]: info: CorePlayQueue::getTrack 147 Nov 29 14:55:11 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:11 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:11 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:11 fph volumio[3873]: info: CorePlayQueue::getTrack 147 Nov 29 14:55:11 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:11 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:11 fph volumio[3873]: info: ------------------------------ 56ms Nov 29 14:55:14 fph volumio[3873]: info: CoreCommandRouter::volumioNext Nov 29 14:55:14 fph volumio[3873]: info: CoreStateMachine::next Nov 29 14:55:14 fph volumio[3873]: info: CoreStateMachine::stop Nov 29 14:55:14 fph volumio[3873]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 29 14:55:14 fph volumio[3873]: UNSET VOLATILE Nov 29 14:55:14 fph volumio[3873]: info: CoreStateMachine::stPlaybackTimer Nov 29 14:55:14 fph volumio[3873]: info: CoreStateMachine::updateTrackBlock Nov 29 14:55:14 fph volumio[3873]: info: CorePlayQueue::getTrackBlock Nov 29 14:55:14 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:14 fph volumio[3873]: info: CorePlayQueue::getTrack 147 Nov 29 14:55:14 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:14 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:14 fph volumio[3873]: info: CoreStateMachine::serviceStop Nov 29 14:55:14 fph volumio[3873]: info: CorePlayQueue::getTrack 147 Nov 29 14:55:14 fph volumio[3873]: info: CoreCommandRouter::serviceStop Nov 29 14:55:14 fph volumio[3873]: info: ControllerMpd::stop Nov 29 14:55:14 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand stop Nov 29 14:55:14 fph volumio[3873]: info: Nov 29 14:55:14 fph volumio[3873]: ---------------------------- MPD announces state update: player Nov 29 14:55:14 fph volumio[3873]: info: ControllerMpd::getState Nov 29 14:55:14 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand status Nov 29 14:55:14 fph volumio[3873]: info: CoreStateMachine::play index undefined Nov 29 14:55:14 fph volumio[3873]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 29 14:55:14 fph volumio[3873]: info: CorePlayQueue::getTrack 93 Nov 29 14:55:14 fph volumio[3873]: info: CoreStateMachine::startPlaybackTimer Nov 29 14:55:14 fph volumio[3873]: info: CorePlayQueue::getTrack 93 Nov 29 14:55:14 fph volumio[3873]: verbose: ControllerMpd::clearAddPlayTracks USB/FPH/music/陈致逸 HOYO-MiX - 梦之咏叹 Dream Aria (Genshin Impact Main Theme Var.).flac Nov 29 14:55:14 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand stop Nov 29 14:55:14 fph volumio[3873]: info: CoreStateMachine::updateTrackBlock Nov 29 14:55:14 fph volumio[3873]: info: CorePlayQueue::getTrackBlock Nov 29 14:55:14 fph volumio[3873]: verbose: ControllerMpd::parseState Nov 29 14:55:14 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 14:55:14 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand clear Nov 29 14:55:14 fph volumio[3873]: info: Nov 29 14:55:14 fph volumio[3873]: ---------------------------- MPD announces system playlist update Nov 29 14:55:14 fph volumio[3873]: info: Ignoring MPD Status Update Nov 29 14:55:14 fph volumio[3873]: verbose: ControllerMpd::parseTrackInfo Nov 29 14:55:14 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand add "USB/FPH/music/陈致逸 HOYO-MiX - 梦之咏叹 Dream Aria (Genshin Impact Main Theme Var.).flac" Nov 29 14:55:14 fph volumio[3873]: info: ControllerMpd::pushState Nov 29 14:55:14 fph volumio[3873]: info: CoreCommandRouter::servicePushState Nov 29 14:55:14 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:14 fph volumio[3873]: info: CorePlayQueue::getTrack 93 Nov 29 14:55:14 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:14 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:14 fph volumio[3873]: info: CorePlayQueue::getTrack 93 Nov 29 14:55:14 fph volumio[3873]: 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":"一夜无事 Uneventful Night","artist":"HOYO-MiX","album":"崩坏星穹铁道-行于命途 Experience the Paths","uri":"USB/FPH/music/HOYO-MiX - 一夜无事 Uneventful Night.flac","trackType":"flac"} Nov 29 14:55:14 fph volumio[3873]: verbose: CURRENT POSITION 93 Nov 29 14:55:14 fph volumio[3873]: info: CoreStateMachine::syncState stateService stop Nov 29 14:55:14 fph volumio[3873]: info: CoreStateMachine::syncState currentStatus stop Nov 29 14:55:14 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:14 fph volumio[3873]: info: CorePlayQueue::getTrack 93 Nov 29 14:55:14 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:14 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:14 fph volumio[3873]: info: No code Nov 29 14:55:14 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:14 fph volumio[3873]: info: CorePlayQueue::getTrack 93 Nov 29 14:55:14 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:14 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:14 fph volumio[3873]: info: ------------------------------ 42ms Nov 29 14:55:14 fph volumio[3873]: error: updateQueue error: null Nov 29 14:55:14 fph volumio[3873]: info: Nov 29 14:55:14 fph volumio[3873]: ---------------------------- MPD announces system playlist update Nov 29 14:55:14 fph volumio[3873]: info: Ignoring MPD Status Update Nov 29 14:55:14 fph volumio[3873]: info: ------------------------------ 29ms Nov 29 14:55:14 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand play Nov 29 14:55:14 fph volumio[3873]: info: ------------------------------ 23ms Nov 29 14:55:14 fph volumio[3873]: info: Nov 29 14:55:14 fph volumio[3873]: ---------------------------- MPD announces state update: player Nov 29 14:55:14 fph volumio[3873]: info: ControllerMpd::getState Nov 29 14:55:14 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand status Nov 29 14:55:14 fph volumio[3873]: info: Nov 29 14:55:14 fph volumio[3873]: ---------------------------- MPD announces state update: player Nov 29 14:55:14 fph volumio[3873]: info: ControllerMpd::getState Nov 29 14:55:14 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand status Nov 29 14:55:14 fph volumio[3873]: verbose: ControllerMpd::parseState Nov 29 14:55:14 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 14:55:14 fph volumio[3873]: verbose: ControllerMpd::parseState Nov 29 14:55:14 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 14:55:14 fph volumio[3873]: verbose: ControllerMpd::parseTrackInfo Nov 29 14:55:14 fph volumio[3873]: info: ControllerMpd::pushState Nov 29 14:55:14 fph volumio[3873]: info: CoreCommandRouter::servicePushState Nov 29 14:55:14 fph volumio[3873]: info: CorePlayQueue::getTrack 93 Nov 29 14:55:14 fph volumio[3873]: verbose: STATE SERVICE {"status":"play","position":0,"seek":447,"duration":99,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"586 Kbps","isStreaming":false,"title":"梦之咏叹 Dream Aria (Genshin Impact Main Theme Var.)","artist":"陈致逸/HOYO-MiX","album":"原神-风与异乡人 Le Vent et les Enfants des étoiles","uri":"USB/FPH/music/陈致逸 HOYO-MiX - 梦之咏叹 Dream Aria (Genshin Impact Main Theme Var.).flac","trackType":"flac"} Nov 29 14:55:14 fph volumio[3873]: verbose: CURRENT POSITION 93 Nov 29 14:55:14 fph volumio[3873]: info: CoreStateMachine::syncState stateService play Nov 29 14:55:14 fph volumio[3873]: info: CoreStateMachine::syncState currentStatus stop Nov 29 14:55:14 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:14 fph volumio[3873]: info: CorePlayQueue::getTrack 93 Nov 29 14:55:14 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:14 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:14 fph volumio[3873]: info: ------------------------------ 46ms Nov 29 14:55:14 fph volumio[3873]: verbose: ControllerMpd::parseTrackInfo Nov 29 14:55:14 fph volumio[3873]: info: ControllerMpd::pushState Nov 29 14:55:14 fph volumio[3873]: info: CoreCommandRouter::servicePushState Nov 29 14:55:14 fph volumio[3873]: info: CorePlayQueue::getTrack 93 Nov 29 14:55:14 fph volumio[3873]: verbose: STATE SERVICE {"status":"play","position":0,"seek":479,"duration":99,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"806 Kbps","isStreaming":false,"title":"梦之咏叹 Dream Aria (Genshin Impact Main Theme Var.)","artist":"陈致逸/HOYO-MiX","album":"原神-风与异乡人 Le Vent et les Enfants des étoiles","uri":"USB/FPH/music/陈致逸 HOYO-MiX - 梦之咏叹 Dream Aria (Genshin Impact Main Theme Var.).flac","trackType":"flac"} Nov 29 14:55:14 fph volumio[3873]: verbose: CURRENT POSITION 93 Nov 29 14:55:14 fph volumio[3873]: info: CoreStateMachine::syncState stateService play Nov 29 14:55:14 fph volumio[3873]: info: CoreStateMachine::syncState currentStatus play Nov 29 14:55:14 fph volumio[3873]: info: Received an update from plugin. extracting info from payload Nov 29 14:55:14 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:14 fph volumio[3873]: info: CorePlayQueue::getTrack 93 Nov 29 14:55:14 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:14 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:14 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:14 fph volumio[3873]: info: CorePlayQueue::getTrack 93 Nov 29 14:55:14 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:14 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:14 fph volumio[3873]: info: ------------------------------ 45ms Nov 29 14:55:15 fph volumio[3873]: info: CoreCommandRouter::volumioNext Nov 29 14:55:15 fph volumio[3873]: info: CoreStateMachine::next Nov 29 14:55:15 fph volumio[3873]: info: CoreStateMachine::stop Nov 29 14:55:15 fph volumio[3873]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 29 14:55:15 fph volumio[3873]: UNSET VOLATILE Nov 29 14:55:15 fph volumio[3873]: info: CoreStateMachine::stPlaybackTimer Nov 29 14:55:15 fph volumio[3873]: info: CoreStateMachine::updateTrackBlock Nov 29 14:55:15 fph volumio[3873]: info: CorePlayQueue::getTrackBlock Nov 29 14:55:15 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:15 fph volumio[3873]: info: CorePlayQueue::getTrack 93 Nov 29 14:55:15 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:15 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:15 fph volumio[3873]: info: CoreStateMachine::serviceStop Nov 29 14:55:15 fph volumio[3873]: info: CorePlayQueue::getTrack 93 Nov 29 14:55:15 fph volumio[3873]: info: CoreCommandRouter::serviceStop Nov 29 14:55:15 fph volumio[3873]: info: ControllerMpd::stop Nov 29 14:55:15 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand stop Nov 29 14:55:15 fph volumio[3873]: info: Nov 29 14:55:15 fph volumio[3873]: ---------------------------- MPD announces state update: player Nov 29 14:55:15 fph volumio[3873]: info: ControllerMpd::getState Nov 29 14:55:15 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand status Nov 29 14:55:15 fph volumio[3873]: info: CoreStateMachine::play index undefined Nov 29 14:55:15 fph volumio[3873]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 29 14:55:15 fph volumio[3873]: info: CorePlayQueue::getTrack 43 Nov 29 14:55:15 fph volumio[3873]: info: CoreStateMachine::startPlaybackTimer Nov 29 14:55:15 fph volumio[3873]: info: CorePlayQueue::getTrack 43 Nov 29 14:55:15 fph volumio[3873]: verbose: ControllerMpd::clearAddPlayTracks USB/FPH/music/HOYO-MiX - 六轮一露狂诗曲 Rhapsodia Roscida.flac Nov 29 14:55:15 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand stop Nov 29 14:55:15 fph volumio[3873]: info: CoreStateMachine::updateTrackBlock Nov 29 14:55:15 fph volumio[3873]: info: CorePlayQueue::getTrackBlock Nov 29 14:55:15 fph volumio[3873]: verbose: ControllerMpd::parseState Nov 29 14:55:15 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 14:55:15 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand clear Nov 29 14:55:15 fph volumio[3873]: info: Nov 29 14:55:15 fph volumio[3873]: ---------------------------- MPD announces system playlist update Nov 29 14:55:15 fph volumio[3873]: info: Ignoring MPD Status Update Nov 29 14:55:15 fph volumio[3873]: verbose: ControllerMpd::parseTrackInfo Nov 29 14:55:15 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand add "USB/FPH/music/HOYO-MiX - 六轮一露狂诗曲 Rhapsodia Roscida.flac" Nov 29 14:55:15 fph volumio[3873]: info: ControllerMpd::pushState Nov 29 14:55:15 fph volumio[3873]: info: CoreCommandRouter::servicePushState Nov 29 14:55:15 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:15 fph volumio[3873]: info: CorePlayQueue::getTrack 43 Nov 29 14:55:15 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:15 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:15 fph volumio[3873]: info: CorePlayQueue::getTrack 43 Nov 29 14:55:15 fph volumio[3873]: 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":"梦之咏叹 Dream Aria (Genshin Impact Main Theme Var.)","artist":"陈致逸/HOYO-MiX","album":"原神-风与异乡人 Le Vent et les Enfants des étoiles","uri":"USB/FPH/music/陈致逸 HOYO-MiX - 梦之咏叹 Dream Aria (Genshin Impact Main Theme Var.).flac","trackType":"flac"} Nov 29 14:55:15 fph volumio[3873]: verbose: CURRENT POSITION 43 Nov 29 14:55:15 fph volumio[3873]: info: CoreStateMachine::syncState stateService stop Nov 29 14:55:15 fph volumio[3873]: info: CoreStateMachine::syncState currentStatus stop Nov 29 14:55:15 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:15 fph volumio[3873]: info: CorePlayQueue::getTrack 43 Nov 29 14:55:15 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:15 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:15 fph volumio[3873]: info: No code Nov 29 14:55:15 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:15 fph volumio[3873]: info: CorePlayQueue::getTrack 43 Nov 29 14:55:15 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:15 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:15 fph volumio[3873]: info: ------------------------------ 42ms Nov 29 14:55:15 fph volumio[3873]: error: updateQueue error: null Nov 29 14:55:15 fph volumio[3873]: info: Nov 29 14:55:15 fph volumio[3873]: ---------------------------- MPD announces system playlist update Nov 29 14:55:15 fph volumio[3873]: info: Ignoring MPD Status Update Nov 29 14:55:15 fph volumio[3873]: info: ------------------------------ 29ms Nov 29 14:55:15 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand play Nov 29 14:55:15 fph volumio[3873]: info: ------------------------------ 15ms Nov 29 14:55:15 fph volumio[3873]: info: Nov 29 14:55:15 fph volumio[3873]: ---------------------------- MPD announces state update: player Nov 29 14:55:15 fph volumio[3873]: info: ControllerMpd::getState Nov 29 14:55:15 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand status Nov 29 14:55:15 fph volumio[3873]: info: Nov 29 14:55:15 fph volumio[3873]: ---------------------------- MPD announces state update: player Nov 29 14:55:15 fph volumio[3873]: info: ControllerMpd::getState Nov 29 14:55:15 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand status Nov 29 14:55:15 fph volumio[3873]: verbose: ControllerMpd::parseState Nov 29 14:55:15 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 14:55:15 fph volumio[3873]: verbose: ControllerMpd::parseState Nov 29 14:55:15 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 14:55:15 fph volumio[3873]: verbose: ControllerMpd::parseTrackInfo Nov 29 14:55:15 fph volumio[3873]: info: ControllerMpd::pushState Nov 29 14:55:15 fph volumio[3873]: info: CoreCommandRouter::servicePushState Nov 29 14:55:15 fph volumio[3873]: info: CorePlayQueue::getTrack 43 Nov 29 14:55:15 fph volumio[3873]: verbose: STATE SERVICE {"status":"play","position":0,"seek":245,"duration":169,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1068 Kbps","isStreaming":false,"title":"六轮一露狂诗曲 Rhapsodia Roscida","artist":"HOYO-MiX","album":"原神-啁哳流变之砂 The Unfathomable Sand Dunes","uri":"USB/FPH/music/HOYO-MiX - 六轮一露狂诗曲 Rhapsodia Roscida.flac","trackType":"flac"} Nov 29 14:55:15 fph volumio[3873]: verbose: CURRENT POSITION 43 Nov 29 14:55:15 fph volumio[3873]: info: CoreStateMachine::syncState stateService play Nov 29 14:55:15 fph volumio[3873]: info: CoreStateMachine::syncState currentStatus stop Nov 29 14:55:15 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:15 fph volumio[3873]: info: CorePlayQueue::getTrack 43 Nov 29 14:55:15 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:15 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:15 fph volumio[3873]: info: ------------------------------ 25ms Nov 29 14:55:15 fph volumio[3873]: verbose: ControllerMpd::parseTrackInfo Nov 29 14:55:15 fph volumio[3873]: info: ControllerMpd::pushState Nov 29 14:55:15 fph volumio[3873]: info: CoreCommandRouter::servicePushState Nov 29 14:55:15 fph volumio[3873]: info: CorePlayQueue::getTrack 43 Nov 29 14:55:15 fph volumio[3873]: verbose: STATE SERVICE {"status":"play","position":0,"seek":479,"duration":169,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1186 Kbps","isStreaming":false,"title":"六轮一露狂诗曲 Rhapsodia Roscida","artist":"HOYO-MiX","album":"原神-啁哳流变之砂 The Unfathomable Sand Dunes","uri":"USB/FPH/music/HOYO-MiX - 六轮一露狂诗曲 Rhapsodia Roscida.flac","trackType":"flac"} Nov 29 14:55:15 fph volumio[3873]: verbose: CURRENT POSITION 43 Nov 29 14:55:15 fph volumio[3873]: info: CoreStateMachine::syncState stateService play Nov 29 14:55:15 fph volumio[3873]: info: CoreStateMachine::syncState currentStatus play Nov 29 14:55:15 fph volumio[3873]: info: Received an update from plugin. extracting info from payload Nov 29 14:55:15 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:15 fph volumio[3873]: info: CorePlayQueue::getTrack 43 Nov 29 14:55:15 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:15 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:15 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:15 fph volumio[3873]: info: CorePlayQueue::getTrack 43 Nov 29 14:55:15 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:15 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:15 fph volumio[3873]: info: ------------------------------ 45ms Nov 29 14:55:17 fph volumio[3873]: info: CoreCommandRouter::volumioNext Nov 29 14:55:17 fph volumio[3873]: info: CoreStateMachine::next Nov 29 14:55:17 fph volumio[3873]: info: CoreStateMachine::stop Nov 29 14:55:17 fph volumio[3873]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 29 14:55:17 fph volumio[3873]: UNSET VOLATILE Nov 29 14:55:17 fph volumio[3873]: info: CoreStateMachine::stPlaybackTimer Nov 29 14:55:17 fph volumio[3873]: info: CoreStateMachine::updateTrackBlock Nov 29 14:55:17 fph volumio[3873]: info: CorePlayQueue::getTrackBlock Nov 29 14:55:17 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:17 fph volumio[3873]: info: CorePlayQueue::getTrack 43 Nov 29 14:55:17 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:17 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:17 fph volumio[3873]: info: CoreStateMachine::serviceStop Nov 29 14:55:17 fph volumio[3873]: info: CorePlayQueue::getTrack 43 Nov 29 14:55:17 fph volumio[3873]: info: CoreCommandRouter::serviceStop Nov 29 14:55:17 fph volumio[3873]: info: ControllerMpd::stop Nov 29 14:55:17 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand stop Nov 29 14:55:17 fph volumio[3873]: info: Nov 29 14:55:17 fph volumio[3873]: ---------------------------- MPD announces state update: player Nov 29 14:55:17 fph volumio[3873]: info: ControllerMpd::getState Nov 29 14:55:17 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand status Nov 29 14:55:17 fph volumio[3873]: info: CoreStateMachine::play index undefined Nov 29 14:55:17 fph volumio[3873]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 29 14:55:17 fph volumio[3873]: info: CorePlayQueue::getTrack 165 Nov 29 14:55:17 fph volumio[3873]: info: CoreStateMachine::startPlaybackTimer Nov 29 14:55:17 fph volumio[3873]: info: CorePlayQueue::getTrack 165 Nov 29 14:55:17 fph volumio[3873]: verbose: ControllerMpd::clearAddPlayTracks USB/FPH/music/HOYO-MiX - 误打误撞 Serendipity.flac Nov 29 14:55:17 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand stop Nov 29 14:55:17 fph volumio[3873]: info: CoreStateMachine::updateTrackBlock Nov 29 14:55:17 fph volumio[3873]: info: CorePlayQueue::getTrackBlock Nov 29 14:55:17 fph volumio[3873]: verbose: ControllerMpd::parseState Nov 29 14:55:17 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 14:55:17 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand clear Nov 29 14:55:17 fph volumio[3873]: info: Nov 29 14:55:17 fph volumio[3873]: ---------------------------- MPD announces system playlist update Nov 29 14:55:17 fph volumio[3873]: info: Ignoring MPD Status Update Nov 29 14:55:17 fph volumio[3873]: verbose: ControllerMpd::parseTrackInfo Nov 29 14:55:17 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand add "USB/FPH/music/HOYO-MiX - 误打误撞 Serendipity.flac" Nov 29 14:55:17 fph volumio[3873]: info: ControllerMpd::pushState Nov 29 14:55:17 fph volumio[3873]: info: CoreCommandRouter::servicePushState Nov 29 14:55:17 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:17 fph volumio[3873]: info: CorePlayQueue::getTrack 165 Nov 29 14:55:17 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:17 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:17 fph volumio[3873]: info: CorePlayQueue::getTrack 165 Nov 29 14:55:17 fph volumio[3873]: 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":"六轮一露狂诗曲 Rhapsodia Roscida","artist":"HOYO-MiX","album":"原神-啁哳流变之砂 The Unfathomable Sand Dunes","uri":"USB/FPH/music/HOYO-MiX - 六轮一露狂诗曲 Rhapsodia Roscida.flac","trackType":"flac"} Nov 29 14:55:17 fph volumio[3873]: verbose: CURRENT POSITION 165 Nov 29 14:55:17 fph volumio[3873]: info: CoreStateMachine::syncState stateService stop Nov 29 14:55:17 fph volumio[3873]: info: CoreStateMachine::syncState currentStatus stop Nov 29 14:55:17 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:17 fph volumio[3873]: info: CorePlayQueue::getTrack 165 Nov 29 14:55:17 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:17 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:17 fph volumio[3873]: info: No code Nov 29 14:55:17 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:17 fph volumio[3873]: info: CorePlayQueue::getTrack 165 Nov 29 14:55:17 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:17 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:17 fph volumio[3873]: info: ------------------------------ 43ms Nov 29 14:55:17 fph volumio[3873]: error: updateQueue error: null Nov 29 14:55:17 fph volumio[3873]: info: Nov 29 14:55:17 fph volumio[3873]: ---------------------------- MPD announces system playlist update Nov 29 14:55:17 fph volumio[3873]: info: Ignoring MPD Status Update Nov 29 14:55:17 fph volumio[3873]: info: ------------------------------ 29ms Nov 29 14:55:17 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand play Nov 29 14:55:17 fph volumio[3873]: info: ------------------------------ 15ms Nov 29 14:55:17 fph volumio[3873]: info: Nov 29 14:55:17 fph volumio[3873]: ---------------------------- MPD announces state update: player Nov 29 14:55:17 fph volumio[3873]: info: ControllerMpd::getState Nov 29 14:55:17 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand status Nov 29 14:55:17 fph volumio[3873]: info: Nov 29 14:55:17 fph volumio[3873]: ---------------------------- MPD announces state update: player Nov 29 14:55:17 fph volumio[3873]: info: ControllerMpd::getState Nov 29 14:55:17 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand status Nov 29 14:55:17 fph volumio[3873]: verbose: ControllerMpd::parseState Nov 29 14:55:17 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 14:55:17 fph volumio[3873]: verbose: ControllerMpd::parseState Nov 29 14:55:17 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 14:55:17 fph volumio[3873]: verbose: ControllerMpd::parseTrackInfo Nov 29 14:55:17 fph volumio[3873]: info: ControllerMpd::pushState Nov 29 14:55:17 fph volumio[3873]: info: CoreCommandRouter::servicePushState Nov 29 14:55:17 fph volumio[3873]: info: CorePlayQueue::getTrack 165 Nov 29 14:55:17 fph volumio[3873]: verbose: STATE SERVICE {"status":"play","position":0,"seek":16,"duration":128,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4128 Kbps","isStreaming":false,"title":"误打误撞 Serendipity","artist":"HOYO-MiX","album":"崩坏星穹铁道-行于命途3 Experience the Paths Vol.3","uri":"USB/FPH/music/HOYO-MiX - 误打误撞 Serendipity.flac","trackType":"flac"} Nov 29 14:55:17 fph volumio[3873]: verbose: CURRENT POSITION 165 Nov 29 14:55:17 fph volumio[3873]: info: CoreStateMachine::syncState stateService play Nov 29 14:55:17 fph volumio[3873]: info: CoreStateMachine::syncState currentStatus stop Nov 29 14:55:17 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:17 fph volumio[3873]: info: CorePlayQueue::getTrack 165 Nov 29 14:55:17 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:17 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:17 fph volumio[3873]: info: ------------------------------ 27ms Nov 29 14:55:17 fph volumio[3873]: verbose: ControllerMpd::parseTrackInfo Nov 29 14:55:17 fph volumio[3873]: info: ControllerMpd::pushState Nov 29 14:55:17 fph volumio[3873]: info: CoreCommandRouter::servicePushState Nov 29 14:55:17 fph volumio[3873]: info: CorePlayQueue::getTrack 165 Nov 29 14:55:17 fph volumio[3873]: verbose: STATE SERVICE {"status":"play","position":0,"seek":304,"duration":128,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4480 Kbps","isStreaming":false,"title":"误打误撞 Serendipity","artist":"HOYO-MiX","album":"崩坏星穹铁道-行于命途3 Experience the Paths Vol.3","uri":"USB/FPH/music/HOYO-MiX - 误打误撞 Serendipity.flac","trackType":"flac"} Nov 29 14:55:17 fph volumio[3873]: verbose: CURRENT POSITION 165 Nov 29 14:55:17 fph volumio[3873]: info: CoreStateMachine::syncState stateService play Nov 29 14:55:17 fph volumio[3873]: info: CoreStateMachine::syncState currentStatus play Nov 29 14:55:17 fph volumio[3873]: info: Received an update from plugin. extracting info from payload Nov 29 14:55:17 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:17 fph volumio[3873]: info: CorePlayQueue::getTrack 165 Nov 29 14:55:17 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:17 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:17 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:17 fph volumio[3873]: info: CorePlayQueue::getTrack 165 Nov 29 14:55:17 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:17 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:17 fph volumio[3873]: info: ------------------------------ 56ms Nov 29 14:55:20 fph volumio[3873]: info: CoreCommandRouter::volumioNext Nov 29 14:55:20 fph volumio[3873]: info: CoreStateMachine::next Nov 29 14:55:20 fph volumio[3873]: info: CoreStateMachine::stop Nov 29 14:55:20 fph volumio[3873]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 29 14:55:20 fph volumio[3873]: UNSET VOLATILE Nov 29 14:55:20 fph volumio[3873]: info: CoreStateMachine::stPlaybackTimer Nov 29 14:55:20 fph volumio[3873]: info: CoreStateMachine::updateTrackBlock Nov 29 14:55:20 fph volumio[3873]: info: CorePlayQueue::getTrackBlock Nov 29 14:55:20 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:20 fph volumio[3873]: info: CorePlayQueue::getTrack 165 Nov 29 14:55:20 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:20 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:20 fph volumio[3873]: info: CoreStateMachine::serviceStop Nov 29 14:55:20 fph volumio[3873]: info: CorePlayQueue::getTrack 165 Nov 29 14:55:20 fph volumio[3873]: info: CoreCommandRouter::serviceStop Nov 29 14:55:20 fph volumio[3873]: info: ControllerMpd::stop Nov 29 14:55:20 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand stop Nov 29 14:55:20 fph volumio[3873]: info: Nov 29 14:55:20 fph volumio[3873]: ---------------------------- MPD announces state update: player Nov 29 14:55:20 fph volumio[3873]: info: ControllerMpd::getState Nov 29 14:55:20 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand status Nov 29 14:55:20 fph volumio[3873]: info: CoreStateMachine::play index undefined Nov 29 14:55:20 fph volumio[3873]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 29 14:55:20 fph volumio[3873]: info: CorePlayQueue::getTrack 69 Nov 29 14:55:20 fph volumio[3873]: info: CoreStateMachine::startPlaybackTimer Nov 29 14:55:20 fph volumio[3873]: info: CorePlayQueue::getTrack 69 Nov 29 14:55:20 fph volumio[3873]: verbose: ControllerMpd::clearAddPlayTracks USB/FPH/music/陈致逸 HOYO-MiX - 麟跃幽岩 Qilin's Prance.flac Nov 29 14:55:20 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand stop Nov 29 14:55:20 fph volumio[3873]: info: CoreStateMachine::updateTrackBlock Nov 29 14:55:20 fph volumio[3873]: info: CorePlayQueue::getTrackBlock Nov 29 14:55:20 fph volumio[3873]: verbose: ControllerMpd::parseState Nov 29 14:55:20 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 14:55:20 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand clear Nov 29 14:55:20 fph volumio[3873]: info: Nov 29 14:55:20 fph volumio[3873]: ---------------------------- MPD announces system playlist update Nov 29 14:55:20 fph volumio[3873]: info: Ignoring MPD Status Update Nov 29 14:55:20 fph volumio[3873]: verbose: ControllerMpd::parseTrackInfo Nov 29 14:55:20 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand add "USB/FPH/music/陈致逸 HOYO-MiX - 麟跃幽岩 Qilin's Prance.flac" Nov 29 14:55:20 fph volumio[3873]: info: ControllerMpd::pushState Nov 29 14:55:20 fph volumio[3873]: info: CoreCommandRouter::servicePushState Nov 29 14:55:20 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:20 fph volumio[3873]: info: CorePlayQueue::getTrack 69 Nov 29 14:55:20 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:20 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:20 fph volumio[3873]: info: CorePlayQueue::getTrack 69 Nov 29 14:55:20 fph volumio[3873]: 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":"误打误撞 Serendipity","artist":"HOYO-MiX","album":"崩坏星穹铁道-行于命途3 Experience the Paths Vol.3","uri":"USB/FPH/music/HOYO-MiX - 误打误撞 Serendipity.flac","trackType":"flac"} Nov 29 14:55:20 fph volumio[3873]: verbose: CURRENT POSITION 69 Nov 29 14:55:20 fph volumio[3873]: info: CoreStateMachine::syncState stateService stop Nov 29 14:55:20 fph volumio[3873]: info: CoreStateMachine::syncState currentStatus stop Nov 29 14:55:20 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:20 fph volumio[3873]: info: CorePlayQueue::getTrack 69 Nov 29 14:55:20 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:20 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:20 fph volumio[3873]: info: No code Nov 29 14:55:20 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:20 fph volumio[3873]: info: CorePlayQueue::getTrack 69 Nov 29 14:55:20 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:20 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:20 fph volumio[3873]: info: ------------------------------ 49ms Nov 29 14:55:20 fph volumio[3873]: error: updateQueue error: null Nov 29 14:55:20 fph volumio[3873]: info: Nov 29 14:55:20 fph volumio[3873]: ---------------------------- MPD announces system playlist update Nov 29 14:55:20 fph volumio[3873]: info: Ignoring MPD Status Update Nov 29 14:55:20 fph volumio[3873]: info: ------------------------------ 36ms Nov 29 14:55:20 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand play Nov 29 14:55:20 fph volumio[3873]: info: ------------------------------ 14ms Nov 29 14:55:20 fph volumio[3873]: info: Nov 29 14:55:20 fph volumio[3873]: ---------------------------- MPD announces state update: player Nov 29 14:55:20 fph volumio[3873]: info: ControllerMpd::getState Nov 29 14:55:20 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand status Nov 29 14:55:20 fph volumio[3873]: info: Nov 29 14:55:20 fph volumio[3873]: ---------------------------- MPD announces state update: player Nov 29 14:55:20 fph volumio[3873]: info: ControllerMpd::getState Nov 29 14:55:20 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand status Nov 29 14:55:20 fph volumio[3873]: verbose: ControllerMpd::parseState Nov 29 14:55:20 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 14:55:20 fph volumio[3873]: verbose: ControllerMpd::parseState Nov 29 14:55:20 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 14:55:20 fph volumio[3873]: verbose: ControllerMpd::parseTrackInfo Nov 29 14:55:20 fph volumio[3873]: info: ControllerMpd::pushState Nov 29 14:55:20 fph volumio[3873]: info: CoreCommandRouter::servicePushState Nov 29 14:55:20 fph volumio[3873]: info: CorePlayQueue::getTrack 69 Nov 29 14:55:20 fph volumio[3873]: verbose: STATE SERVICE {"status":"play","position":0,"seek":106,"duration":101,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"997 Kbps","isStreaming":false,"title":"麟跃幽岩 Qilin's Prance","artist":"陈致逸/HOYO-MiX","album":"原神-闪耀的群星 The Stellar Moments","uri":"USB/FPH/music/陈致逸 HOYO-MiX - 麟跃幽岩 Qilin's Prance.flac","trackType":"flac"} Nov 29 14:55:20 fph volumio[3873]: verbose: CURRENT POSITION 69 Nov 29 14:55:20 fph volumio[3873]: info: CoreStateMachine::syncState stateService play Nov 29 14:55:20 fph volumio[3873]: info: CoreStateMachine::syncState currentStatus stop Nov 29 14:55:20 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:20 fph volumio[3873]: info: CorePlayQueue::getTrack 69 Nov 29 14:55:20 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:20 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:20 fph volumio[3873]: info: ------------------------------ 25ms Nov 29 14:55:20 fph volumio[3873]: verbose: ControllerMpd::parseTrackInfo Nov 29 14:55:20 fph volumio[3873]: info: ControllerMpd::pushState Nov 29 14:55:20 fph volumio[3873]: info: CoreCommandRouter::servicePushState Nov 29 14:55:20 fph volumio[3873]: info: CorePlayQueue::getTrack 69 Nov 29 14:55:20 fph volumio[3873]: verbose: STATE SERVICE {"status":"play","position":0,"seek":479,"duration":101,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1121 Kbps","isStreaming":false,"title":"麟跃幽岩 Qilin's Prance","artist":"陈致逸/HOYO-MiX","album":"原神-闪耀的群星 The Stellar Moments","uri":"USB/FPH/music/陈致逸 HOYO-MiX - 麟跃幽岩 Qilin's Prance.flac","trackType":"flac"} Nov 29 14:55:20 fph volumio[3873]: verbose: CURRENT POSITION 69 Nov 29 14:55:20 fph volumio[3873]: info: CoreStateMachine::syncState stateService play Nov 29 14:55:20 fph volumio[3873]: info: CoreStateMachine::syncState currentStatus play Nov 29 14:55:20 fph volumio[3873]: info: Received an update from plugin. extracting info from payload Nov 29 14:55:20 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:20 fph volumio[3873]: info: CorePlayQueue::getTrack 69 Nov 29 14:55:20 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:20 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:20 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:20 fph volumio[3873]: info: CorePlayQueue::getTrack 69 Nov 29 14:55:20 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:20 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:20 fph volumio[3873]: info: ------------------------------ 48ms Nov 29 14:55:21 fph volumio[3873]: info: CoreCommandRouter::volumioNext Nov 29 14:55:21 fph volumio[3873]: info: CoreStateMachine::next Nov 29 14:55:21 fph volumio[3873]: info: CoreStateMachine::stop Nov 29 14:55:21 fph volumio[3873]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 29 14:55:21 fph volumio[3873]: UNSET VOLATILE Nov 29 14:55:21 fph volumio[3873]: info: CoreStateMachine::stPlaybackTimer Nov 29 14:55:21 fph volumio[3873]: info: CoreStateMachine::updateTrackBlock Nov 29 14:55:21 fph volumio[3873]: info: CorePlayQueue::getTrackBlock Nov 29 14:55:21 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:21 fph volumio[3873]: info: CorePlayQueue::getTrack 69 Nov 29 14:55:21 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:21 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:21 fph volumio[3873]: info: CoreStateMachine::serviceStop Nov 29 14:55:21 fph volumio[3873]: info: CorePlayQueue::getTrack 69 Nov 29 14:55:21 fph volumio[3873]: info: CoreCommandRouter::serviceStop Nov 29 14:55:21 fph volumio[3873]: info: ControllerMpd::stop Nov 29 14:55:21 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand stop Nov 29 14:55:21 fph volumio[3873]: info: Nov 29 14:55:21 fph volumio[3873]: ---------------------------- MPD announces state update: player Nov 29 14:55:21 fph volumio[3873]: info: ControllerMpd::getState Nov 29 14:55:21 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand status Nov 29 14:55:21 fph volumio[3873]: info: CoreStateMachine::play index undefined Nov 29 14:55:21 fph volumio[3873]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 29 14:55:21 fph volumio[3873]: info: CorePlayQueue::getTrack 145 Nov 29 14:55:21 fph volumio[3873]: info: CoreStateMachine::startPlaybackTimer Nov 29 14:55:21 fph volumio[3873]: info: CorePlayQueue::getTrack 145 Nov 29 14:55:21 fph volumio[3873]: verbose: ControllerMpd::clearAddPlayTracks USB/FPH/music/HOYO-MiX - 追星星的人 Star Chaser.flac Nov 29 14:55:21 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand stop Nov 29 14:55:21 fph volumio[3873]: info: CoreStateMachine::updateTrackBlock Nov 29 14:55:21 fph volumio[3873]: info: CorePlayQueue::getTrackBlock Nov 29 14:55:21 fph volumio[3873]: verbose: ControllerMpd::parseState Nov 29 14:55:21 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 14:55:21 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand clear Nov 29 14:55:21 fph volumio[3873]: info: Nov 29 14:55:21 fph volumio[3873]: ---------------------------- MPD announces system playlist update Nov 29 14:55:21 fph volumio[3873]: info: Ignoring MPD Status Update Nov 29 14:55:21 fph volumio[3873]: verbose: ControllerMpd::parseTrackInfo Nov 29 14:55:21 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand add "USB/FPH/music/HOYO-MiX - 追星星的人 Star Chaser.flac" Nov 29 14:55:21 fph volumio[3873]: info: ControllerMpd::pushState Nov 29 14:55:21 fph volumio[3873]: info: CoreCommandRouter::servicePushState Nov 29 14:55:21 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:21 fph volumio[3873]: info: CorePlayQueue::getTrack 145 Nov 29 14:55:21 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:21 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:21 fph volumio[3873]: info: CorePlayQueue::getTrack 145 Nov 29 14:55:21 fph volumio[3873]: 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":"麟跃幽岩 Qilin's Prance","artist":"陈致逸/HOYO-MiX","album":"原神-闪耀的群星 The Stellar Moments","uri":"USB/FPH/music/陈致逸 HOYO-MiX - 麟跃幽岩 Qilin's Prance.flac","trackType":"flac"} Nov 29 14:55:21 fph volumio[3873]: verbose: CURRENT POSITION 145 Nov 29 14:55:21 fph volumio[3873]: info: CoreStateMachine::syncState stateService stop Nov 29 14:55:21 fph volumio[3873]: info: CoreStateMachine::syncState currentStatus stop Nov 29 14:55:21 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:21 fph volumio[3873]: info: CorePlayQueue::getTrack 145 Nov 29 14:55:21 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:21 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:21 fph volumio[3873]: info: No code Nov 29 14:55:21 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:21 fph volumio[3873]: info: CorePlayQueue::getTrack 145 Nov 29 14:55:21 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:21 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:21 fph volumio[3873]: info: ------------------------------ 41ms Nov 29 14:55:21 fph volumio[3873]: error: updateQueue error: null Nov 29 14:55:21 fph volumio[3873]: info: Nov 29 14:55:21 fph volumio[3873]: ---------------------------- MPD announces system playlist update Nov 29 14:55:21 fph volumio[3873]: info: Ignoring MPD Status Update Nov 29 14:55:21 fph volumio[3873]: info: ------------------------------ 31ms Nov 29 14:55:21 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand play Nov 29 14:55:21 fph volumio[3873]: info: ------------------------------ 20ms Nov 29 14:55:21 fph volumio[3873]: info: Nov 29 14:55:21 fph volumio[3873]: ---------------------------- MPD announces state update: player Nov 29 14:55:21 fph volumio[3873]: info: ControllerMpd::getState Nov 29 14:55:21 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand status Nov 29 14:55:21 fph volumio[3873]: info: Nov 29 14:55:21 fph volumio[3873]: ---------------------------- MPD announces state update: player Nov 29 14:55:21 fph volumio[3873]: info: ControllerMpd::getState Nov 29 14:55:21 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand status Nov 29 14:55:21 fph volumio[3873]: verbose: ControllerMpd::parseState Nov 29 14:55:21 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 14:55:21 fph volumio[3873]: verbose: ControllerMpd::parseState Nov 29 14:55:21 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 14:55:21 fph volumio[3873]: verbose: ControllerMpd::parseTrackInfo Nov 29 14:55:21 fph volumio[3873]: verbose: ControllerMpd::parseTrackInfo Nov 29 14:55:21 fph volumio[3873]: info: ControllerMpd::pushState Nov 29 14:55:21 fph volumio[3873]: info: CoreCommandRouter::servicePushState Nov 29 14:55:21 fph volumio[3873]: info: CorePlayQueue::getTrack 145 Nov 29 14:55:21 fph volumio[3873]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":78,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"追星星的人 Star Chaser","artist":"HOYO-MiX","album":"崩坏星穹铁道-行于命途 Experience the Paths","uri":"USB/FPH/music/HOYO-MiX - 追星星的人 Star Chaser.flac","trackType":"flac"} Nov 29 14:55:21 fph volumio[3873]: verbose: CURRENT POSITION 145 Nov 29 14:55:21 fph volumio[3873]: info: CoreStateMachine::syncState stateService play Nov 29 14:55:21 fph volumio[3873]: info: CoreStateMachine::syncState currentStatus stop Nov 29 14:55:21 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:21 fph volumio[3873]: info: CorePlayQueue::getTrack 145 Nov 29 14:55:21 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:21 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:21 fph volumio[3873]: info: ControllerMpd::pushState Nov 29 14:55:21 fph volumio[3873]: info: CoreCommandRouter::servicePushState Nov 29 14:55:21 fph volumio[3873]: info: CorePlayQueue::getTrack 145 Nov 29 14:55:21 fph volumio[3873]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":78,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"追星星的人 Star Chaser","artist":"HOYO-MiX","album":"崩坏星穹铁道-行于命途 Experience the Paths","uri":"USB/FPH/music/HOYO-MiX - 追星星的人 Star Chaser.flac","trackType":"flac"} Nov 29 14:55:21 fph volumio[3873]: verbose: CURRENT POSITION 145 Nov 29 14:55:21 fph volumio[3873]: info: CoreStateMachine::syncState stateService play Nov 29 14:55:21 fph volumio[3873]: info: CoreStateMachine::syncState currentStatus play Nov 29 14:55:21 fph volumio[3873]: info: Received an update from plugin. extracting info from payload Nov 29 14:55:21 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:21 fph volumio[3873]: info: CorePlayQueue::getTrack 145 Nov 29 14:55:21 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:21 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:21 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:21 fph volumio[3873]: info: CorePlayQueue::getTrack 145 Nov 29 14:55:21 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:21 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:21 fph volumio[3873]: info: ------------------------------ 46ms Nov 29 14:55:21 fph volumio[3873]: info: ------------------------------ 45ms Nov 29 14:55:22 fph volumio[3873]: info: CoreCommandRouter::volumioNext Nov 29 14:55:22 fph volumio[3873]: info: CoreStateMachine::next Nov 29 14:55:22 fph volumio[3873]: info: CoreStateMachine::stop Nov 29 14:55:22 fph volumio[3873]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 29 14:55:22 fph volumio[3873]: UNSET VOLATILE Nov 29 14:55:22 fph volumio[3873]: info: CoreStateMachine::stPlaybackTimer Nov 29 14:55:22 fph volumio[3873]: info: CoreStateMachine::updateTrackBlock Nov 29 14:55:22 fph volumio[3873]: info: CorePlayQueue::getTrackBlock Nov 29 14:55:22 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:22 fph volumio[3873]: info: CorePlayQueue::getTrack 145 Nov 29 14:55:22 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:22 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:22 fph volumio[3873]: info: CoreStateMachine::serviceStop Nov 29 14:55:22 fph volumio[3873]: info: CorePlayQueue::getTrack 145 Nov 29 14:55:22 fph volumio[3873]: info: CoreCommandRouter::serviceStop Nov 29 14:55:22 fph volumio[3873]: info: ControllerMpd::stop Nov 29 14:55:22 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand stop Nov 29 14:55:22 fph volumio[3873]: info: CoreStateMachine::play index undefined Nov 29 14:55:22 fph volumio[3873]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 29 14:55:22 fph volumio[3873]: info: CorePlayQueue::getTrack 85 Nov 29 14:55:22 fph volumio[3873]: info: CoreStateMachine::startPlaybackTimer Nov 29 14:55:22 fph volumio[3873]: info: CorePlayQueue::getTrack 85 Nov 29 14:55:22 fph volumio[3873]: verbose: ControllerMpd::clearAddPlayTracks USB/FPH/music/行水盈盈 Serene and Fathomless - HOYO-MiX.mp3 Nov 29 14:55:22 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand stop Nov 29 14:55:22 fph volumio[3873]: info: CoreStateMachine::updateTrackBlock Nov 29 14:55:22 fph volumio[3873]: info: CorePlayQueue::getTrackBlock Nov 29 14:55:22 fph volumio[3873]: info: Nov 29 14:55:22 fph volumio[3873]: ---------------------------- MPD announces state update: player Nov 29 14:55:22 fph volumio[3873]: info: ControllerMpd::getState Nov 29 14:55:22 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand status Nov 29 14:55:22 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand clear Nov 29 14:55:22 fph volumio[3873]: info: Nov 29 14:55:22 fph volumio[3873]: ---------------------------- MPD announces system playlist update Nov 29 14:55:22 fph volumio[3873]: info: Ignoring MPD Status Update Nov 29 14:55:22 fph volumio[3873]: verbose: ControllerMpd::parseState Nov 29 14:55:22 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 14:55:22 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand add "USB/FPH/music/行水盈盈 Serene and Fathomless - HOYO-MiX.mp3" Nov 29 14:55:22 fph volumio[3873]: error: updateQueue error: null Nov 29 14:55:22 fph volumio[3873]: info: Nov 29 14:55:22 fph volumio[3873]: ---------------------------- MPD announces system playlist update Nov 29 14:55:22 fph volumio[3873]: info: Ignoring MPD Status Update Nov 29 14:55:22 fph volumio[3873]: info: ------------------------------ 6ms Nov 29 14:55:22 fph volumio[3873]: verbose: ControllerMpd::parseTrackInfo Nov 29 14:55:22 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand play Nov 29 14:55:22 fph volumio[3873]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 29 14:55:22 fph volumio[3873]: info: ------------------------------ 14ms Nov 29 14:55:22 fph volumio[3873]: info: ------------------------------ 6ms Nov 29 14:55:22 fph volumio[3873]: info: Nov 29 14:55:22 fph volumio[3873]: ---------------------------- MPD announces state update: player Nov 29 14:55:22 fph volumio[3873]: info: ControllerMpd::getState Nov 29 14:55:22 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand status Nov 29 14:55:22 fph volumio[3873]: info: Nov 29 14:55:22 fph volumio[3873]: ---------------------------- MPD announces state update: player Nov 29 14:55:22 fph volumio[3873]: info: ControllerMpd::getState Nov 29 14:55:22 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand status Nov 29 14:55:22 fph volumio[3873]: verbose: ControllerMpd::parseState Nov 29 14:55:22 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 14:55:22 fph volumio[3873]: verbose: ControllerMpd::parseState Nov 29 14:55:22 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 14:55:22 fph volumio[3873]: verbose: ControllerMpd::parseTrackInfo Nov 29 14:55:22 fph volumio[3873]: info: ControllerMpd::pushState Nov 29 14:55:22 fph volumio[3873]: info: CoreCommandRouter::servicePushState Nov 29 14:55:22 fph volumio[3873]: info: CorePlayQueue::getTrack 85 Nov 29 14:55:22 fph volumio[3873]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":158,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"行水盈盈 Serene and Fathomless","artist":"HOYO-MiX","album":"原神-闪耀的群星3 The Stellar Moments Vol. 3","uri":"USB/FPH/music/行水盈盈 Serene and Fathomless - HOYO-MiX.mp3","trackType":"mp3"} Nov 29 14:55:22 fph volumio[3873]: verbose: CURRENT POSITION 85 Nov 29 14:55:22 fph volumio[3873]: info: CoreStateMachine::syncState stateService play Nov 29 14:55:22 fph volumio[3873]: info: CoreStateMachine::syncState currentStatus stop Nov 29 14:55:22 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:22 fph volumio[3873]: info: CorePlayQueue::getTrack 85 Nov 29 14:55:22 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:22 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:22 fph volumio[3873]: info: ------------------------------ 27ms Nov 29 14:55:22 fph volumio[3873]: verbose: ControllerMpd::parseTrackInfo Nov 29 14:55:22 fph volumio[3873]: info: ControllerMpd::pushState Nov 29 14:55:22 fph volumio[3873]: info: CoreCommandRouter::servicePushState Nov 29 14:55:22 fph volumio[3873]: info: CorePlayQueue::getTrack 85 Nov 29 14:55:22 fph volumio[3873]: verbose: STATE SERVICE {"status":"play","position":0,"seek":479,"duration":158,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"行水盈盈 Serene and Fathomless","artist":"HOYO-MiX","album":"原神-闪耀的群星3 The Stellar Moments Vol. 3","uri":"USB/FPH/music/行水盈盈 Serene and Fathomless - HOYO-MiX.mp3","trackType":"mp3"} Nov 29 14:55:22 fph volumio[3873]: verbose: CURRENT POSITION 85 Nov 29 14:55:22 fph volumio[3873]: info: CoreStateMachine::syncState stateService play Nov 29 14:55:22 fph volumio[3873]: info: CoreStateMachine::syncState currentStatus play Nov 29 14:55:22 fph volumio[3873]: info: Received an update from plugin. extracting info from payload Nov 29 14:55:22 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:22 fph volumio[3873]: info: CorePlayQueue::getTrack 85 Nov 29 14:55:22 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:22 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:22 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:22 fph volumio[3873]: info: CorePlayQueue::getTrack 85 Nov 29 14:55:22 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:22 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:22 fph volumio[3873]: info: ------------------------------ 47ms Nov 29 14:55:23 fph volumio[3873]: info: CoreCommandRouter::volumioNext Nov 29 14:55:23 fph volumio[3873]: info: CoreStateMachine::next Nov 29 14:55:23 fph volumio[3873]: info: CoreStateMachine::stop Nov 29 14:55:23 fph volumio[3873]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 29 14:55:23 fph volumio[3873]: UNSET VOLATILE Nov 29 14:55:23 fph volumio[3873]: info: CoreStateMachine::stPlaybackTimer Nov 29 14:55:23 fph volumio[3873]: info: CoreStateMachine::updateTrackBlock Nov 29 14:55:23 fph volumio[3873]: info: CorePlayQueue::getTrackBlock Nov 29 14:55:23 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:23 fph volumio[3873]: info: CorePlayQueue::getTrack 85 Nov 29 14:55:23 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:23 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:23 fph volumio[3873]: info: CoreStateMachine::serviceStop Nov 29 14:55:23 fph volumio[3873]: info: CorePlayQueue::getTrack 85 Nov 29 14:55:23 fph volumio[3873]: info: CoreCommandRouter::serviceStop Nov 29 14:55:23 fph volumio[3873]: info: ControllerMpd::stop Nov 29 14:55:23 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand stop Nov 29 14:55:23 fph volumio[3873]: info: CoreStateMachine::play index undefined Nov 29 14:55:23 fph volumio[3873]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 29 14:55:23 fph volumio[3873]: info: CorePlayQueue::getTrack 15 Nov 29 14:55:23 fph volumio[3873]: info: CoreStateMachine::startPlaybackTimer Nov 29 14:55:23 fph volumio[3873]: info: CorePlayQueue::getTrack 15 Nov 29 14:55:23 fph volumio[3873]: verbose: ControllerMpd::clearAddPlayTracks USB/FPH/music/夫道 World of Tanks - World of Tanks9.15 The op BGM.mp3 Nov 29 14:55:23 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand stop Nov 29 14:55:23 fph volumio[3873]: info: CoreStateMachine::updateTrackBlock Nov 29 14:55:23 fph volumio[3873]: info: CorePlayQueue::getTrackBlock Nov 29 14:55:23 fph volumio[3873]: info: Nov 29 14:55:23 fph volumio[3873]: ---------------------------- MPD announces state update: player Nov 29 14:55:23 fph volumio[3873]: info: ControllerMpd::getState Nov 29 14:55:23 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand status Nov 29 14:55:23 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand clear Nov 29 14:55:23 fph volumio[3873]: verbose: ControllerMpd::parseState Nov 29 14:55:23 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 14:55:23 fph volumio[3873]: info: Nov 29 14:55:23 fph volumio[3873]: ---------------------------- MPD announces system playlist update Nov 29 14:55:23 fph volumio[3873]: info: Ignoring MPD Status Update Nov 29 14:55:23 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand add "USB/FPH/music/夫道 World of Tanks - World of Tanks9.15 The op BGM.mp3" Nov 29 14:55:23 fph volumio[3873]: verbose: ControllerMpd::parseTrackInfo Nov 29 14:55:23 fph volumio[3873]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 29 14:55:23 fph volumio[3873]: info: ------------------------------ 12ms Nov 29 14:55:23 fph volumio[3873]: error: updateQueue error: null Nov 29 14:55:23 fph volumio[3873]: info: Nov 29 14:55:23 fph volumio[3873]: ---------------------------- MPD announces system playlist update Nov 29 14:55:23 fph volumio[3873]: info: Ignoring MPD Status Update Nov 29 14:55:23 fph volumio[3873]: info: ------------------------------ 6ms Nov 29 14:55:23 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand play Nov 29 14:55:23 fph volumio[3873]: info: ------------------------------ 6ms Nov 29 14:55:23 fph volumio[3873]: info: Nov 29 14:55:23 fph volumio[3873]: ---------------------------- MPD announces state update: player Nov 29 14:55:23 fph volumio[3873]: info: ControllerMpd::getState Nov 29 14:55:23 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand status Nov 29 14:55:23 fph volumio[3873]: info: Nov 29 14:55:23 fph volumio[3873]: ---------------------------- MPD announces state update: player Nov 29 14:55:23 fph volumio[3873]: info: ControllerMpd::getState Nov 29 14:55:23 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand status Nov 29 14:55:23 fph volumio[3873]: verbose: ControllerMpd::parseState Nov 29 14:55:23 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 14:55:23 fph volumio[3873]: verbose: ControllerMpd::parseState Nov 29 14:55:23 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 14:55:23 fph volumio[3873]: verbose: ControllerMpd::parseTrackInfo Nov 29 14:55:23 fph volumio[3873]: info: ControllerMpd::pushState Nov 29 14:55:23 fph volumio[3873]: info: CoreCommandRouter::servicePushState Nov 29 14:55:23 fph volumio[3873]: info: CorePlayQueue::getTrack 15 Nov 29 14:55:23 fph volumio[3873]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":123,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"World of Tanks9.15 The op BGM","artist":"夫道/World of Tanks","album":"World of Tanks BGM","uri":"USB/FPH/music/夫道 World of Tanks - World of Tanks9.15 The op BGM.mp3","trackType":"mp3"} Nov 29 14:55:23 fph volumio[3873]: verbose: CURRENT POSITION 15 Nov 29 14:55:23 fph volumio[3873]: info: CoreStateMachine::syncState stateService play Nov 29 14:55:23 fph volumio[3873]: info: CoreStateMachine::syncState currentStatus stop Nov 29 14:55:23 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:23 fph volumio[3873]: info: CorePlayQueue::getTrack 15 Nov 29 14:55:23 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:23 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:23 fph volumio[3873]: info: ------------------------------ 24ms Nov 29 14:55:23 fph volumio[3873]: verbose: ControllerMpd::parseTrackInfo Nov 29 14:55:23 fph volumio[3873]: info: ControllerMpd::pushState Nov 29 14:55:23 fph volumio[3873]: info: CoreCommandRouter::servicePushState Nov 29 14:55:23 fph volumio[3873]: info: CorePlayQueue::getTrack 15 Nov 29 14:55:23 fph volumio[3873]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":123,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"World of Tanks9.15 The op BGM","artist":"夫道/World of Tanks","album":"World of Tanks BGM","uri":"USB/FPH/music/夫道 World of Tanks - World of Tanks9.15 The op BGM.mp3","trackType":"mp3"} Nov 29 14:55:23 fph volumio[3873]: verbose: CURRENT POSITION 15 Nov 29 14:55:23 fph volumio[3873]: info: CoreStateMachine::syncState stateService play Nov 29 14:55:23 fph volumio[3873]: info: CoreStateMachine::syncState currentStatus play Nov 29 14:55:23 fph volumio[3873]: info: Received an update from plugin. extracting info from payload Nov 29 14:55:23 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:23 fph volumio[3873]: info: CorePlayQueue::getTrack 15 Nov 29 14:55:23 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:23 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:23 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:23 fph volumio[3873]: info: CorePlayQueue::getTrack 15 Nov 29 14:55:23 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:23 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:23 fph volumio[3873]: info: ------------------------------ 36ms Nov 29 14:55:24 fph volumio[3873]: info: CoreCommandRouter::volumioNext Nov 29 14:55:24 fph volumio[3873]: info: CoreStateMachine::next Nov 29 14:55:24 fph volumio[3873]: info: CoreStateMachine::stop Nov 29 14:55:24 fph volumio[3873]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 29 14:55:24 fph volumio[3873]: UNSET VOLATILE Nov 29 14:55:24 fph volumio[3873]: info: CoreStateMachine::stPlaybackTimer Nov 29 14:55:24 fph volumio[3873]: info: CoreStateMachine::updateTrackBlock Nov 29 14:55:24 fph volumio[3873]: info: CorePlayQueue::getTrackBlock Nov 29 14:55:24 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:24 fph volumio[3873]: info: CorePlayQueue::getTrack 15 Nov 29 14:55:24 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:24 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:24 fph volumio[3873]: info: CoreStateMachine::serviceStop Nov 29 14:55:24 fph volumio[3873]: info: CorePlayQueue::getTrack 15 Nov 29 14:55:24 fph volumio[3873]: info: CoreCommandRouter::serviceStop Nov 29 14:55:24 fph volumio[3873]: info: ControllerMpd::stop Nov 29 14:55:24 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand stop Nov 29 14:55:24 fph volumio[3873]: info: Nov 29 14:55:24 fph volumio[3873]: ---------------------------- MPD announces state update: player Nov 29 14:55:24 fph volumio[3873]: info: ControllerMpd::getState Nov 29 14:55:24 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand status Nov 29 14:55:24 fph volumio[3873]: info: CoreStateMachine::play index undefined Nov 29 14:55:24 fph volumio[3873]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 29 14:55:24 fph volumio[3873]: info: CorePlayQueue::getTrack 116 Nov 29 14:55:24 fph volumio[3873]: info: CoreStateMachine::startPlaybackTimer Nov 29 14:55:24 fph volumio[3873]: info: CorePlayQueue::getTrack 116 Nov 29 14:55:24 fph volumio[3873]: verbose: ControllerMpd::clearAddPlayTracks USB/FPH/music/HOYO-MiX、Reol - 不乱不破.flac Nov 29 14:55:24 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand stop Nov 29 14:55:24 fph volumio[3873]: info: CoreStateMachine::updateTrackBlock Nov 29 14:55:24 fph volumio[3873]: info: CorePlayQueue::getTrackBlock Nov 29 14:55:24 fph volumio[3873]: verbose: ControllerMpd::parseState Nov 29 14:55:24 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 14:55:24 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand clear Nov 29 14:55:24 fph volumio[3873]: info: Nov 29 14:55:24 fph volumio[3873]: ---------------------------- MPD announces system playlist update Nov 29 14:55:24 fph volumio[3873]: info: Ignoring MPD Status Update Nov 29 14:55:24 fph volumio[3873]: verbose: ControllerMpd::parseTrackInfo Nov 29 14:55:24 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand add "USB/FPH/music/HOYO-MiX、Reol - 不乱不破.flac" Nov 29 14:55:24 fph volumio[3873]: info: ControllerMpd::pushState Nov 29 14:55:24 fph volumio[3873]: info: CoreCommandRouter::servicePushState Nov 29 14:55:24 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:24 fph volumio[3873]: info: CorePlayQueue::getTrack 116 Nov 29 14:55:24 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:24 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:24 fph volumio[3873]: info: CorePlayQueue::getTrack 116 Nov 29 14:55:24 fph volumio[3873]: 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":"World of Tanks9.15 The op BGM","artist":"夫道/World of Tanks","album":"World of Tanks BGM","uri":"USB/FPH/music/夫道 World of Tanks - World of Tanks9.15 The op BGM.mp3","trackType":"mp3"} Nov 29 14:55:24 fph volumio[3873]: verbose: CURRENT POSITION 116 Nov 29 14:55:24 fph volumio[3873]: info: CoreStateMachine::syncState stateService stop Nov 29 14:55:24 fph volumio[3873]: info: CoreStateMachine::syncState currentStatus stop Nov 29 14:55:24 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:24 fph volumio[3873]: info: CorePlayQueue::getTrack 116 Nov 29 14:55:24 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:24 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:24 fph volumio[3873]: info: No code Nov 29 14:55:24 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:24 fph volumio[3873]: info: CorePlayQueue::getTrack 116 Nov 29 14:55:24 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:24 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:24 fph volumio[3873]: info: ------------------------------ 43ms Nov 29 14:55:24 fph volumio[3873]: error: updateQueue error: null Nov 29 14:55:24 fph volumio[3873]: info: Nov 29 14:55:24 fph volumio[3873]: ---------------------------- MPD announces system playlist update Nov 29 14:55:24 fph volumio[3873]: info: Ignoring MPD Status Update Nov 29 14:55:24 fph volumio[3873]: info: ------------------------------ 33ms Nov 29 14:55:24 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand play Nov 29 14:55:24 fph volumio[3873]: info: ------------------------------ 20ms Nov 29 14:55:24 fph volumio[3873]: info: Nov 29 14:55:24 fph volumio[3873]: ---------------------------- MPD announces state update: player Nov 29 14:55:24 fph volumio[3873]: info: ControllerMpd::getState Nov 29 14:55:24 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand status Nov 29 14:55:24 fph volumio[3873]: info: Nov 29 14:55:24 fph volumio[3873]: ---------------------------- MPD announces state update: player Nov 29 14:55:24 fph volumio[3873]: info: ControllerMpd::getState Nov 29 14:55:24 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand status Nov 29 14:55:24 fph volumio[3873]: verbose: ControllerMpd::parseState Nov 29 14:55:24 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 14:55:24 fph volumio[3873]: verbose: ControllerMpd::parseState Nov 29 14:55:24 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 14:55:24 fph volumio[3873]: verbose: ControllerMpd::parseTrackInfo Nov 29 14:55:24 fph volumio[3873]: info: ControllerMpd::pushState Nov 29 14:55:24 fph volumio[3873]: info: CoreCommandRouter::servicePushState Nov 29 14:55:24 fph volumio[3873]: info: CorePlayQueue::getTrack 116 Nov 29 14:55:24 fph volumio[3873]: verbose: STATE SERVICE {"status":"play","position":0,"seek":114,"duration":139,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3049 Kbps","isStreaming":false,"title":"不乱不破","artist":"HOYO-MiX、Reol","album":"崩坏星穹铁道-不乱不破 No Dazzle, No Break","uri":"USB/FPH/music/HOYO-MiX、Reol - 不乱不破.flac","trackType":"flac"} Nov 29 14:55:24 fph volumio[3873]: verbose: CURRENT POSITION 116 Nov 29 14:55:24 fph volumio[3873]: info: CoreStateMachine::syncState stateService play Nov 29 14:55:24 fph volumio[3873]: info: CoreStateMachine::syncState currentStatus stop Nov 29 14:55:24 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:24 fph volumio[3873]: info: CorePlayQueue::getTrack 116 Nov 29 14:55:24 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:24 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:24 fph volumio[3873]: info: ------------------------------ 33ms Nov 29 14:55:24 fph volumio[3873]: verbose: ControllerMpd::parseTrackInfo Nov 29 14:55:24 fph volumio[3873]: info: ControllerMpd::pushState Nov 29 14:55:24 fph volumio[3873]: info: CoreCommandRouter::servicePushState Nov 29 14:55:24 fph volumio[3873]: info: CorePlayQueue::getTrack 116 Nov 29 14:55:24 fph volumio[3873]: verbose: STATE SERVICE {"status":"play","position":0,"seek":213,"duration":139,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"3276 Kbps","isStreaming":false,"title":"不乱不破","artist":"HOYO-MiX、Reol","album":"崩坏星穹铁道-不乱不破 No Dazzle, No Break","uri":"USB/FPH/music/HOYO-MiX、Reol - 不乱不破.flac","trackType":"flac"} Nov 29 14:55:24 fph volumio[3873]: verbose: CURRENT POSITION 116 Nov 29 14:55:24 fph volumio[3873]: info: CoreStateMachine::syncState stateService play Nov 29 14:55:24 fph volumio[3873]: info: CoreStateMachine::syncState currentStatus play Nov 29 14:55:24 fph volumio[3873]: info: Received an update from plugin. extracting info from payload Nov 29 14:55:24 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:24 fph volumio[3873]: info: CorePlayQueue::getTrack 116 Nov 29 14:55:24 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:24 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:24 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:24 fph volumio[3873]: info: CorePlayQueue::getTrack 116 Nov 29 14:55:24 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:24 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:24 fph volumio[3873]: info: ------------------------------ 46ms Nov 29 14:55:32 fph volumio[3873]: info: CoreCommandRouter::volumioPause Nov 29 14:55:32 fph volumio[3873]: info: CoreStateMachine::pause Nov 29 14:55:32 fph volumio[3873]: info: CoreStateMachine::stPlaybackTimer Nov 29 14:55:32 fph volumio[3873]: info: CoreStateMachine::servicePause Nov 29 14:55:32 fph volumio[3873]: info: CorePlayQueue::getTrack 116 Nov 29 14:55:32 fph volumio[3873]: info: CoreCommandRouter::servicePause Nov 29 14:55:32 fph volumio[3873]: info: ControllerMpd::pause Nov 29 14:55:32 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand pause Nov 29 14:55:32 fph volumio[3873]: info: Nov 29 14:55:32 fph volumio[3873]: ---------------------------- MPD announces state update: player Nov 29 14:55:32 fph volumio[3873]: info: ControllerMpd::getState Nov 29 14:55:32 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand status Nov 29 14:55:32 fph volumio[3873]: verbose: ControllerMpd::parseState Nov 29 14:55:32 fph volumio[3873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 29 14:55:32 fph volumio[3873]: verbose: ControllerMpd::parseTrackInfo Nov 29 14:55:32 fph volumio[3873]: info: ControllerMpd::pushState Nov 29 14:55:32 fph volumio[3873]: info: CoreCommandRouter::servicePushState Nov 29 14:55:32 fph volumio[3873]: info: CorePlayQueue::getTrack 116 Nov 29 14:55:32 fph volumio[3873]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":8245,"duration":139,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"6454 Kbps","isStreaming":false,"title":"不乱不破","artist":"HOYO-MiX、Reol","album":"崩坏星穹铁道-不乱不破 No Dazzle, No Break","uri":"USB/FPH/music/HOYO-MiX、Reol - 不乱不破.flac","trackType":"flac"} Nov 29 14:55:32 fph volumio[3873]: verbose: CURRENT POSITION 116 Nov 29 14:55:32 fph volumio[3873]: info: CoreStateMachine::syncState stateService pause Nov 29 14:55:32 fph volumio[3873]: info: CoreStateMachine::syncState currentStatus pause Nov 29 14:55:32 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:32 fph volumio[3873]: info: CorePlayQueue::getTrack 116 Nov 29 14:55:32 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:32 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:32 fph volumio[3873]: info: CoreStateMachine::stPlaybackTimer Nov 29 14:55:32 fph volumio[3873]: info: ------------------------------ 14ms Nov 29 14:55:35 fph kernel: usb 1-1.3: USB disconnect, device number 43 Nov 29 14:55:35 fph volumio[3873]: info: Nov 29 14:55:35 fph volumio[3873]: ---------------------------- USB Audio Device Detached Nov 29 14:55:35 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Nov 29 14:55:35 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 29 14:55:35 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Nov 29 14:55:36 fph kernel: usb 1-1.3: new high-speed USB device number 44 using dwc_otg Nov 29 14:55:36 fph kernel: usb 1-1.3: New USB device found, idVendor=06cb, idProduct=1595, bcdDevice= 0.02 Nov 29 14:55:36 fph kernel: usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Nov 29 14:55:36 fph kernel: usb 1-1.3: Product: CX31993 384Khz HIFI AUDIO Nov 29 14:55:36 fph kernel: usb 1-1.3: Manufacturer: Synaptics Nov 29 14:55:36 fph kernel: input: Synaptics CX31993 384Khz HIFI AUDIO Consumer Control as /devices/platform/soc/3f980000.usb/usb1/1-1/1-1.3/1-1.3:1.2/0003:06CB:1595.0013/input/input19 Nov 29 14:55:36 fph kernel: hid-generic 0003:06CB:1595.0013: input,hidraw0: USB HID v1.11 Device [Synaptics CX31993 384Khz HIFI AUDIO] on usb-3f980000.usb-1.3/input2 Nov 29 14:55:36 fph volumio[3873]: info: Nov 29 14:55:36 fph volumio[3873]: ---------------------------- USB Audio Device Attached Nov 29 14:55:36 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Nov 29 14:55:36 fph volumio[3873]: info: CoreCommandRouter::Close All Modals sent Nov 29 14:55:36 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 29 14:55:36 fph volumio[3873]: info: Output device has changed, restarting MPD Nov 29 14:55:36 fph sudo[4605]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 29 14:55:36 fph volumio[3873]: info: Output device has changed, restarting Shairport Sync Nov 29 14:55:36 fph sudo[4605]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 14:55:36 fph sudo[4608]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 29 14:55:36 fph sudo[4605]: pam_unix(sudo:session): session closed for user root Nov 29 14:55:36 fph sudo[4608]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 14:55:36 fph systemd[1]: Stopping Music Player Daemon... Nov 29 14:55:36 fph volumio[3873]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 29 14:55:36 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 29 14:55:36 fph systemd[1]: Starting Music Player Daemon... Nov 29 14:55:36 fph volumio[3873]: info: Setting mixer PCM for card CX31993 384Khz HIFI AUDIO Nov 29 14:55:36 fph volumio[3873]: info: CoreCommandRouter::volumioUpdateVolumeSettings Nov 29 14:55:36 fph volumio[3873]: info: Updating Volume Controller Parameters: Device: 5 Name: Mixer: PCM Max Vol: 60 Vol Curve; logarithmic Vol Steps: 5 Nov 29 14:55:36 fph volumio[3873]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 14:55:36 fph volumio[3873]: info: MPD Permissions set Nov 29 14:55:36 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 14:55:36 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 14:55:36 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 14:55:36 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 14:55:36 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 14:55:36 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 14:55:36 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 14:55:36 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 29 14:55:36 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 14:55:36 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 29 14:55:37 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 29 14:55:37 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 29 14:55:37 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:55:37 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:55:37 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:55:37 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:55:37 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:55:37 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:55:37 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:55:37 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Nov 29 14:55:37 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 29 14:55:37 fph volumio[3873]: info: Starting Shairport Sync Nov 29 14:55:37 fph volumio[3873]: info: VolumeController:: Volume=43 Mute =false Nov 29 14:55:37 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:37 fph volumio[3873]: info: CorePlayQueue::getTrack 116 Nov 29 14:55:37 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:37 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:37 fph sudo[4641]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 29 14:55:37 fph sudo[4641]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 14:55:37 fph systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 29 14:55:37 fph systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Nov 29 14:55:37 fph systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 29 14:55:37 fph sudo[4641]: pam_unix(sudo:session): session closed for user root Nov 29 14:55:37 fph volumio[3873]: info: Shairport-Sync Started Nov 29 14:55:37 fph volumio[3873]: error: Upnp client error: Error: This socket has been ended by the other party Nov 29 14:55:37 fph systemd[1]: Started Music Player Daemon. Nov 29 14:55:37 fph sudo[4608]: pam_unix(sudo:session): session closed for user root Nov 29 14:55:37 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Nov 29 14:55:37 fph volumio[3873]: error: updateQueue error: null Nov 29 14:55:39 fph volumio[3873]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Nov 29 14:55:39 fph volumio[3873]: info: CoreStateMachine::getcurrentVolume Nov 29 14:55:39 fph volumio[3873]: info: CoreCommandRouter::volumioRetrievevolume Nov 29 14:55:39 fph volumio[3873]: info: VolumeController:: Volume=43 Mute =false Nov 29 14:55:39 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:39 fph volumio[3873]: info: CorePlayQueue::getTrack 116 Nov 29 14:55:39 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:39 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:39 fph volumio[3873]: info: CoreStateMachine::updateTrackBlock Nov 29 14:55:39 fph volumio[3873]: info: CorePlayQueue::getTrackBlock Nov 29 14:55:39 fph volumio[3873]: info: CoreCommandRouter::volumioRetrievevolume Nov 29 14:55:39 fph volumio[3873]: info: VolumeController:: Volume=43 Mute =false Nov 29 14:55:39 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:39 fph volumio[3873]: info: CorePlayQueue::getTrack 116 Nov 29 14:55:39 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:39 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:40 fph kernel: usb 1-1.3: USB disconnect, device number 44 Nov 29 14:55:40 fph volumio[3873]: info: Nov 29 14:55:40 fph volumio[3873]: ---------------------------- USB Audio Device Detached Nov 29 14:55:40 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Nov 29 14:55:40 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 29 14:55:40 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Nov 29 14:55:41 fph kernel: usb 1-1.3: new high-speed USB device number 45 using dwc_otg Nov 29 14:55:41 fph kernel: usb 1-1.3: New USB device found, idVendor=06cb, idProduct=1595, bcdDevice= 0.02 Nov 29 14:55:41 fph kernel: usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Nov 29 14:55:41 fph kernel: usb 1-1.3: Product: CX31993 384Khz HIFI AUDIO Nov 29 14:55:41 fph kernel: usb 1-1.3: Manufacturer: Synaptics Nov 29 14:55:41 fph kernel: input: Synaptics CX31993 384Khz HIFI AUDIO Consumer Control as /devices/platform/soc/3f980000.usb/usb1/1-1/1-1.3/1-1.3:1.2/0003:06CB:1595.0014/input/input20 Nov 29 14:55:41 fph kernel: hid-generic 0003:06CB:1595.0014: input,hidraw0: USB HID v1.11 Device [Synaptics CX31993 384Khz HIFI AUDIO] on usb-3f980000.usb-1.3/input2 Nov 29 14:55:41 fph volumio[3873]: info: Nov 29 14:55:41 fph volumio[3873]: ---------------------------- USB Audio Device Attached Nov 29 14:55:41 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Nov 29 14:55:41 fph volumio[3873]: info: CoreCommandRouter::Close All Modals sent Nov 29 14:55:41 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 29 14:55:41 fph volumio[3873]: info: Output device has changed, restarting MPD Nov 29 14:55:41 fph sudo[4689]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 29 14:55:41 fph volumio[3873]: info: Output device has changed, restarting Shairport Sync Nov 29 14:55:41 fph sudo[4689]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 14:55:41 fph sudo[4689]: pam_unix(sudo:session): session closed for user root Nov 29 14:55:41 fph sudo[4692]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 29 14:55:41 fph sudo[4692]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 14:55:41 fph systemd[1]: Stopping Music Player Daemon... Nov 29 14:55:41 fph volumio[3873]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 29 14:55:41 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 29 14:55:41 fph volumio[3873]: info: Setting mixer PCM for card CX31993 384Khz HIFI AUDIO Nov 29 14:55:41 fph systemd[1]: Starting Music Player Daemon... Nov 29 14:55:41 fph volumio[3873]: info: CoreCommandRouter::volumioUpdateVolumeSettings Nov 29 14:55:41 fph volumio[3873]: info: Updating Volume Controller Parameters: Device: 5 Name: Mixer: PCM Max Vol: 60 Vol Curve; logarithmic Vol Steps: 5 Nov 29 14:55:41 fph volumio[3873]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 14:55:41 fph volumio[3873]: info: MPD Permissions set Nov 29 14:55:41 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 14:55:41 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 14:55:41 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 14:55:41 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 14:55:41 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 14:55:41 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 14:55:41 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 14:55:41 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 29 14:55:41 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 14:55:41 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 29 14:55:41 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 29 14:55:41 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 29 14:55:41 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:55:41 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:55:41 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:55:41 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:55:41 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:55:41 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:55:41 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:55:41 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Nov 29 14:55:41 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 29 14:55:41 fph volumio[3873]: info: VolumeController:: Volume=43 Mute =false Nov 29 14:55:41 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:41 fph volumio[3873]: info: CorePlayQueue::getTrack 116 Nov 29 14:55:41 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:41 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:41 fph volumio[3873]: info: Starting Shairport Sync Nov 29 14:55:41 fph sudo[4726]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 29 14:55:41 fph sudo[4726]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 14:55:41 fph systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 29 14:55:42 fph systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Nov 29 14:55:42 fph systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 29 14:55:42 fph sudo[4726]: pam_unix(sudo:session): session closed for user root Nov 29 14:55:42 fph volumio[3873]: info: Shairport-Sync Started Nov 29 14:55:42 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Nov 29 14:55:42 fph systemd[1]: Started Music Player Daemon. Nov 29 14:55:42 fph sudo[4692]: pam_unix(sudo:session): session closed for user root Nov 29 14:55:42 fph volumio[3873]: error: updateQueue error: null Nov 29 14:55:44 fph volumio[3873]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Nov 29 14:55:44 fph volumio[3873]: info: CoreStateMachine::getcurrentVolume Nov 29 14:55:44 fph volumio[3873]: info: CoreCommandRouter::volumioRetrievevolume Nov 29 14:55:44 fph volumio[3873]: info: VolumeController:: Volume=43 Mute =false Nov 29 14:55:44 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:44 fph volumio[3873]: info: CorePlayQueue::getTrack 116 Nov 29 14:55:44 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:44 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:44 fph volumio[3873]: info: CoreStateMachine::updateTrackBlock Nov 29 14:55:44 fph volumio[3873]: info: CorePlayQueue::getTrackBlock Nov 29 14:55:44 fph volumio[3873]: info: CoreCommandRouter::volumioRetrievevolume Nov 29 14:55:44 fph volumio[3873]: info: VolumeController:: Volume=43 Mute =false Nov 29 14:55:44 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:44 fph volumio[3873]: info: CorePlayQueue::getTrack 116 Nov 29 14:55:44 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:44 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:44 fph kernel: usb 1-1.3: USB disconnect, device number 45 Nov 29 14:55:44 fph volumio[3873]: info: Nov 29 14:55:44 fph volumio[3873]: ---------------------------- USB Audio Device Detached Nov 29 14:55:44 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Nov 29 14:55:44 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 29 14:55:44 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Nov 29 14:55:45 fph kernel: usb 1-1.3: new high-speed USB device number 46 using dwc_otg Nov 29 14:55:45 fph kernel: usb 1-1.3: device descriptor read/64, error -71 Nov 29 14:55:45 fph kernel: usb 1-1.3: New USB device found, idVendor=06cb, idProduct=1595, bcdDevice= 0.02 Nov 29 14:55:45 fph kernel: usb 1-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=0 Nov 29 14:55:45 fph kernel: usb 1-1.3: Product: CX31993 384Khz HIFI AUDIO Nov 29 14:55:45 fph kernel: usb 1-1.3: Manufacturer: Synaptics Nov 29 14:55:45 fph kernel: input: Synaptics CX31993 384Khz HIFI AUDIO Consumer Control as /devices/platform/soc/3f980000.usb/usb1/1-1/1-1.3/1-1.3:1.2/0003:06CB:1595.0015/input/input21 Nov 29 14:55:45 fph kernel: hid-generic 0003:06CB:1595.0015: input,hidraw0: USB HID v1.11 Device [Synaptics CX31993 384Khz HIFI AUDIO] on usb-3f980000.usb-1.3/input2 Nov 29 14:55:45 fph volumio[3873]: info: Nov 29 14:55:45 fph volumio[3873]: ---------------------------- USB Audio Device Attached Nov 29 14:55:45 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Nov 29 14:55:45 fph volumio[3873]: info: CoreCommandRouter::Close All Modals sent Nov 29 14:55:45 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 29 14:55:45 fph volumio[3873]: info: Output device has changed, restarting MPD Nov 29 14:55:45 fph sudo[4769]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 29 14:55:45 fph volumio[3873]: info: Output device has changed, restarting Shairport Sync Nov 29 14:55:45 fph sudo[4769]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 14:55:45 fph sudo[4769]: pam_unix(sudo:session): session closed for user root Nov 29 14:55:45 fph sudo[4772]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 29 14:55:45 fph sudo[4772]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 14:55:45 fph systemd[1]: Stopping Music Player Daemon... Nov 29 14:55:45 fph volumio[3873]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 29 14:55:45 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 29 14:55:45 fph volumio[3873]: info: Setting mixer PCM for card CX31993 384Khz HIFI AUDIO Nov 29 14:55:45 fph systemd[1]: Starting Music Player Daemon... Nov 29 14:55:46 fph volumio[3873]: info: CoreCommandRouter::volumioUpdateVolumeSettings Nov 29 14:55:46 fph volumio[3873]: info: Updating Volume Controller Parameters: Device: 5 Name: Mixer: PCM Max Vol: 60 Vol Curve; logarithmic Vol Steps: 5 Nov 29 14:55:46 fph volumio[3873]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 29 14:55:46 fph volumio[3873]: info: MPD Permissions set Nov 29 14:55:46 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 14:55:46 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 14:55:46 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 14:55:46 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 14:55:46 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 14:55:46 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 14:55:46 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 14:55:46 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 29 14:55:46 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 29 14:55:46 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 29 14:55:46 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 29 14:55:46 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 29 14:55:46 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:55:46 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:55:46 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:55:46 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:55:46 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:55:46 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:55:46 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 29 14:55:46 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Nov 29 14:55:46 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 29 14:55:46 fph volumio[3873]: info: VolumeController:: Volume=43 Mute =false Nov 29 14:55:46 fph volumio[3873]: info: CoreStateMachine::pushState Nov 29 14:55:46 fph volumio[3873]: info: CorePlayQueue::getTrack 116 Nov 29 14:55:46 fph volumio[3873]: info: CoreCommandRouter::volumioPushState Nov 29 14:55:46 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 29 14:55:46 fph volumio[3873]: info: Starting Shairport Sync Nov 29 14:55:46 fph sudo[4805]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 29 14:55:46 fph sudo[4805]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 29 14:55:46 fph systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 29 14:55:46 fph systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Nov 29 14:55:46 fph systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 29 14:55:46 fph sudo[4805]: pam_unix(sudo:session): session closed for user root Nov 29 14:55:46 fph volumio[3873]: info: Shairport-Sync Started Nov 29 14:55:46 fph volumio[3873]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Nov 29 14:55:46 fph systemd[1]: Started Music Player Daemon. Nov 29 14:55:46 fph sudo[4772]: pam_unix(sudo:session): session closed for user root Nov 29 14:55:46 fph volumio[3873]: error: updateQueue error: null Nov 29 14:55:47 fph volumio[3873]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 29 14:55:47 fph volumio[3873]: { Error: connect ETIMEDOUT 199.96.63.53:443 Nov 29 14:55:47 fph volumio[3873]: at Object._errnoException (util.js:1022:11) Nov 29 14:55:47 fph volumio[3873]: at _exceptionWithHostPort (util.js:1044:20) Nov 29 14:55:47 fph volumio[3873]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Nov 29 14:55:47 fph volumio[3873]: code: 'ETIMEDOUT', Nov 29 14:55:47 fph volumio[3873]: errno: 'ETIMEDOUT', Nov 29 14:55:47 fph volumio[3873]: syscall: 'connect', Nov 29 14:55:47 fph volumio[3873]: address: '199.96.63.53', Nov 29 14:55:47 fph volumio[3873]: port: 443 } Nov 29 14:55:47 fph volumio[3873]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 29 14:55:48 fph sudo[4839]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-29 14:54 Nov 29 14:55:48 fph sudo[4839]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="74e4cc9de715c64d553d35948d017f973a622b6d" VOLUMIO_FE_VERSION="2be6c28eb9de74ec1f9662ca333f7bd51a232c33" VOLUMIO_BE_VERSION="259a7f2894e1376413ffac331be84e0e9a6173dd" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Sep 24 22:42:43 CEST 2020" VOLUMIO_VERSION="2.834" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="e41ef0f29aa50c1af109d3064a380c69"