-- Logs begin at Sat 2025-07-26 16:31:15 +08, end at Sat 2025-10-25 22:00:26 +08. --
Oct 25 21:59:00 volumio volumio[759]: info:
Oct 25 21:59:00 volumio volumio[759]: ---------------------------- MPD announces state update: player
Oct 25 21:59:00 volumio kernel: usb 1-1.1: USB disconnect, device number 3
Oct 25 21:59:00 volumio kernel: usb 1-1.1: Unable to submit urb #9: -19 at snd_usb_queue_pending_output_urbs
Oct 25 21:59:00 volumio kernel: usb 1-1.1: cannot submit urb 0, error -19: no device
Oct 25 21:59:00 volumio kernel: usb 1-1.1: cannot submit urb 0, error -19: no device
Oct 25 21:59:00 volumio volumio[759]: info: ControllerMpd::getState
Oct 25 21:59:00 volumio volumio[759]: verbose: ControllerMpd::sendMpdCommand status
Oct 25 21:59:00 volumio volumio[759]: verbose: ControllerMpd::sendMpdCommand clearerror
Oct 25 21:59:00 volumio volumio[759]: info: sendMpdCommand status took 25 milliseconds
Oct 25 21:59:00 volumio volumio[759]: verbose: ControllerMpd::parseState
Oct 25 21:59:00 volumio volumio[759]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 25 21:59:00 volumio volumio[759]: info: sendMpdCommand clearerror took 6 milliseconds
Oct 25 21:59:00 volumio volumio[759]: info: sendMpdCommand playlistinfo took 5 milliseconds
Oct 25 21:59:00 volumio volumio[759]: verbose: ControllerMpd::parseTrackInfo
Oct 25 21:59:00 volumio volumio[759]: info: ControllerMpd::pushState
Oct 25 21:59:00 volumio volumio[759]: info: CoreCommandRouter::servicePushState
Oct 25 21:59:00 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 21:59:00 volumio volumio[759]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":48550,"duration":289,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"676 Kbps","isStreaming":false,"title":"棋子","artist":"Faye Wong","album":"菲賣品","uri":"NAS/FnOS/合集王菲/王菲 Faye Wong 1985-2022/王菲 { Tidal }/精选集合辑/2005 - 菲賣品/10 - 棋子.flac","trackType":"flac"}
Oct 25 21:59:00 volumio volumio[759]: verbose: CURRENT POSITION 585
Oct 25 21:59:00 volumio volumio[759]: info: CoreStateMachine::syncState   stateService pause
Oct 25 21:59:00 volumio volumio[759]: info: CoreStateMachine::syncState   currentStatus play
Oct 25 21:59:00 volumio volumio[759]: info: CoreStateMachine::pushState
Oct 25 21:59:00 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 21:59:00 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 21:59:00 volumio volumio[759]: info: CoreCommandRouter::volumioPushState
Oct 25 21:59:00 volumio volumio[759]: info: ------------------------------ 54ms
Oct 25 21:59:00 volumio volumio[759]: info:
Oct 25 21:59:00 volumio volumio[759]: ---------------------------- USB Audio Device Detached
Oct 25 21:59:00 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach
Oct 25 21:59:00 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 21:59:00 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: raat , onStop
Oct 25 21:59:01 volumio kernel: usb 1-1.1: new high-speed USB device number 4 using xhci-hcd
Oct 25 21:59:01 volumio kernel: usb 1-1.1: New USB device found, idVendor=2972, idProduct=0047, bcdDevice= 1.09
Oct 25 21:59:01 volumio kernel: usb 1-1.1: New USB device strings: Mfr=1, Product=3, SerialNumber=2
Oct 25 21:59:01 volumio kernel: usb 1-1.1: Product: FiiO Q7
Oct 25 21:59:01 volumio kernel: usb 1-1.1: Manufacturer: GuangZhou FiiO Electronics Co.,Ltd
Oct 25 21:59:01 volumio kernel: usb 1-1.1: 1:3 : unsupported format bits 0x100000000
Oct 25 21:59:01 volumio kernel: hid-generic 0003:2972:0047.0002: hiddev96,hidraw0: USB HID v1.10 Device [GuangZhou FiiO Electronics Co.,Ltd FiiO Q7] on usb-fe9c0000.xhci-1.1/input3
Oct 25 21:59:01 volumio volumio[759]: info:
Oct 25 21:59:01 volumio volumio[759]: ---------------------------- USB Audio Device Attached
Oct 25 21:59:01 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach
Oct 25 21:59:01 volumio volumio[759]: info: CoreCommandRouter::Close All Modals sent
Oct 25 21:59:01 volumio volumio[759]: info: Preparing to save Alsa Options, stopping services first
Oct 25 21:59:01 volumio volumio[759]: info: CoreCommandRouter::volumioGetState
Oct 25 21:59:01 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 21:59:01 volumio volumio[759]: info: CoreCommandRouter::volumioPause
Oct 25 21:59:01 volumio volumio[759]: info: CoreStateMachine::pause
Oct 25 21:59:01 volumio volumio[759]: info: CoreStateMachine::stPlaybackTimer
Oct 25 21:59:01 volumio volumio[759]: info: CoreStateMachine::servicePause
Oct 25 21:59:01 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 21:59:01 volumio volumio[759]: info: CoreCommandRouter::servicePause
Oct 25 21:59:01 volumio volumio[759]: info: ControllerMpd::pause
Oct 25 21:59:01 volumio volumio[759]: verbose: ControllerMpd::sendMpdCommand pause
Oct 25 21:59:01 volumio volumio[759]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"FiiO Q7","alsacard":"Q7"},"i2s":false}
Oct 25 21:59:01 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 21:59:01 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 21:59:01 volumio volumio[759]: info: Device 5 does not have any Mixer Control Available
Oct 25 21:59:01 volumio volumio[759]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Oct 25 21:59:01 volumio volumio[759]: info: Updating Volume Controller Parameters: Device: 5 Name: FiiO Q7 Mixer:  Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Oct 25 21:59:01 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Oct 25 21:59:01 volumio volumio[759]: info: Disabling external Volume Control
Oct 25 21:59:01 volumio volumio[759]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 25 21:59:01 volumio volumio[759]: info: CoreStateMachine::pushState
Oct 25 21:59:01 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 21:59:01 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 21:59:01 volumio volumio[759]: info: CoreCommandRouter::volumioPushState
Oct 25 21:59:01 volumio volumio[759]: info: Preparing to generate the ALSA configuration file
Oct 25 21:59:01 volumio volumio[759]: info:
Oct 25 21:59:01 volumio volumio[759]: ---------------------------- MPD announces state update: player
Oct 25 21:59:01 volumio volumio[759]: info: sendMpdCommand pause took 234 milliseconds
Oct 25 21:59:01 volumio volumio[759]: info: ControllerMpd::getState
Oct 25 21:59:01 volumio volumio[759]: verbose: ControllerMpd::sendMpdCommand status
Oct 25 21:59:01 volumio volumio[759]: info: sendMpdCommand status took 3 milliseconds
Oct 25 21:59:01 volumio volumio[759]: verbose: ControllerMpd::parseState
Oct 25 21:59:01 volumio volumio[759]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 25 21:59:01 volumio volumio[759]: info: sendMpdCommand playlistinfo took 6 milliseconds
Oct 25 21:59:01 volumio volumio[759]: verbose: ControllerMpd::parseTrackInfo
Oct 25 21:59:01 volumio volumio[759]: info: ControllerMpd::pushState
Oct 25 21:59:01 volumio volumio[759]: info: CoreCommandRouter::servicePushState
Oct 25 21:59:01 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 21:59:01 volumio volumio[759]: verbose: STATE SERVICE {"status":"play","position":0,"seek":49443,"duration":289,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"591 Kbps","isStreaming":false,"title":"棋子","artist":"Faye Wong","album":"菲賣品","uri":"NAS/FnOS/合集王菲/王菲 Faye Wong 1985-2022/王菲 { Tidal }/精选集合辑/2005 - 菲賣品/10 - 棋子.flac","trackType":"flac"}
Oct 25 21:59:01 volumio volumio[759]: verbose: CURRENT POSITION 585
Oct 25 21:59:01 volumio volumio[759]: info: CoreStateMachine::syncState   stateService play
Oct 25 21:59:01 volumio volumio[759]: info: CoreStateMachine::syncState   currentStatus pause
Oct 25 21:59:01 volumio volumio[759]: info: CoreStateMachine::pushState
Oct 25 21:59:01 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 21:59:01 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 21:59:01 volumio volumio[759]: info: CoreCommandRouter::volumioPushState
Oct 25 21:59:01 volumio volumio[759]: info: ------------------------------ 20ms
Oct 25 21:59:01 volumio volumio[759]: info: Asound.conf file unchanged, so no further update is needed
Oct 25 21:59:01 volumio volumio[759]: info: Output device has changed, restarting MPD
Oct 25 21:59:01 volumio sudo[4464]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Oct 25 21:59:01 volumio sudo[4464]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 21:59:01 volumio volumio[759]: info: Output device has changed, restarting Shairport Sync
Oct 25 21:59:01 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:01 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 25 21:59:01 volumio sudo[4464]: pam_unix(sudo:session): session closed for user root
Oct 25 21:59:01 volumio sudo[4466]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Oct 25 21:59:01 volumio sudo[4466]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 21:59:01 volumio systemd[1]: Stopping Music Player Daemon...
Oct 25 21:59:01 volumio volumio[759]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Oct 25 21:59:01 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Oct 25 21:59:01 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 25 21:59:01 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 21:59:02 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 21:59:02 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 21:59:02 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 21:59:02 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 21:59:02 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 21:59:02 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 21:59:02 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 21:59:02 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Oct 25 21:59:02 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Oct 25 21:59:02 volumio volumio[759]: info: MPD Permissions set
Oct 25 21:59:02 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:02 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:02 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:02 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:02 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:02 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:02 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:02 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:02 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 25 21:59:02 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:02 volumio volumio[759]: info: Starting Shairport Sync
Oct 25 21:59:02 volumio sudo[4481]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Oct 25 21:59:02 volumio sudo[4481]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 21:59:02 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Oct 25 21:59:02 volumio systemd[1]: shairport-sync.service: Succeeded.
Oct 25 21:59:02 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Oct 25 21:59:02 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Oct 25 21:59:02 volumio sudo[4481]: pam_unix(sudo:session): session closed for user root
Oct 25 21:59:02 volumio volumio[759]: info: Shairport-Sync Started
Oct 25 21:59:02 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat
Oct 25 21:59:05 volumio volumio[759]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Oct 25 21:59:05 volumio volumio[759]: info: CoreStateMachine::getcurrentVolume
Oct 25 21:59:05 volumio volumio[759]: info: CoreCommandRouter::volumioRetrievevolume
Oct 25 21:59:05 volumio volumio[759]: info: CoreStateMachine::pushState
Oct 25 21:59:05 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 21:59:05 volumio volumio[759]: info: CoreCommandRouter::volumioPushState
Oct 25 21:59:09 volumio kernel: usb 1-1.1: USB disconnect, device number 4
Oct 25 21:59:10 volumio volumio[759]: info:
Oct 25 21:59:10 volumio volumio[759]: ---------------------------- USB Audio Device Detached
Oct 25 21:59:10 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach
Oct 25 21:59:10 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 21:59:10 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: raat , onStop
Oct 25 21:59:10 volumio kernel: usb 1-1.1: new high-speed USB device number 5 using xhci-hcd
Oct 25 21:59:10 volumio kernel: usb 1-1.1: New USB device found, idVendor=2972, idProduct=0047, bcdDevice= 1.09
Oct 25 21:59:10 volumio kernel: usb 1-1.1: New USB device strings: Mfr=1, Product=3, SerialNumber=2
Oct 25 21:59:10 volumio kernel: usb 1-1.1: Product: FiiO Q7
Oct 25 21:59:10 volumio kernel: usb 1-1.1: Manufacturer: GuangZhou FiiO Electronics Co.,Ltd
Oct 25 21:59:10 volumio kernel: usb 1-1.1: 1:3 : unsupported format bits 0x100000000
Oct 25 21:59:10 volumio kernel: hid-generic 0003:2972:0047.0003: hiddev96,hidraw0: USB HID v1.10 Device [GuangZhou FiiO Electronics Co.,Ltd FiiO Q7] on usb-fe9c0000.xhci-1.1/input3
Oct 25 21:59:10 volumio volumio[759]: info:
Oct 25 21:59:10 volumio volumio[759]: ---------------------------- USB Audio Device Attached
Oct 25 21:59:10 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach
Oct 25 21:59:10 volumio volumio[759]: info: CoreCommandRouter::Close All Modals sent
Oct 25 21:59:10 volumio volumio[759]: info: Preparing to save Alsa Options, stopping services first
Oct 25 21:59:10 volumio volumio[759]: info: CoreCommandRouter::volumioGetState
Oct 25 21:59:10 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 21:59:10 volumio volumio[759]: info: CoreCommandRouter::volumioPause
Oct 25 21:59:10 volumio volumio[759]: info: CoreStateMachine::pause
Oct 25 21:59:10 volumio volumio[759]: info: CoreStateMachine::stPlaybackTimer
Oct 25 21:59:10 volumio volumio[759]: info: CoreStateMachine::servicePause
Oct 25 21:59:10 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 21:59:10 volumio volumio[759]: info: CoreCommandRouter::servicePause
Oct 25 21:59:10 volumio volumio[759]: info: ControllerMpd::pause
Oct 25 21:59:10 volumio volumio[759]: verbose: ControllerMpd::sendMpdCommand pause
Oct 25 21:59:10 volumio volumio[759]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"FiiO Q7","alsacard":"Q7"},"i2s":false}
Oct 25 21:59:10 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 21:59:10 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 21:59:10 volumio volumio[759]: info: Device 5 does not have any Mixer Control Available
Oct 25 21:59:10 volumio volumio[759]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Oct 25 21:59:10 volumio volumio[759]: info: Updating Volume Controller Parameters: Device: 5 Name: FiiO Q7 Mixer:  Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Oct 25 21:59:10 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Oct 25 21:59:10 volumio volumio[759]: info: Disabling external Volume Control
Oct 25 21:59:10 volumio volumio[759]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 25 21:59:11 volumio volumio[759]: info: CoreStateMachine::pushState
Oct 25 21:59:11 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 21:59:11 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 21:59:11 volumio volumio[759]: info: CoreCommandRouter::volumioPushState
Oct 25 21:59:11 volumio volumio[759]: info: Preparing to generate the ALSA configuration file
Oct 25 21:59:11 volumio volumio[759]: info: Asound.conf file unchanged, so no further update is needed
Oct 25 21:59:11 volumio volumio[759]: info: Output device has changed, restarting MPD
Oct 25 21:59:11 volumio sudo[4525]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Oct 25 21:59:11 volumio sudo[4525]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 21:59:11 volumio volumio[759]: info: Output device has changed, restarting Shairport Sync
Oct 25 21:59:11 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:11 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 25 21:59:11 volumio sudo[4525]: pam_unix(sudo:session): session closed for user root
Oct 25 21:59:11 volumio sudo[4527]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Oct 25 21:59:11 volumio sudo[4527]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 21:59:11 volumio volumio[759]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Oct 25 21:59:11 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Oct 25 21:59:11 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 25 21:59:11 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 21:59:11 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 21:59:11 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 21:59:11 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 21:59:11 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 21:59:11 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 21:59:11 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 21:59:11 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 21:59:11 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Oct 25 21:59:11 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Oct 25 21:59:11 volumio volumio[759]: info: MPD Permissions set
Oct 25 21:59:11 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:11 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:11 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:11 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:11 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:11 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:11 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:11 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:11 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 25 21:59:11 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:11 volumio volumio[759]: info: Starting Shairport Sync
Oct 25 21:59:11 volumio sudo[4542]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Oct 25 21:59:11 volumio sudo[4542]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 21:59:11 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Oct 25 21:59:11 volumio systemd[1]: shairport-sync.service: Succeeded.
Oct 25 21:59:11 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Oct 25 21:59:11 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Oct 25 21:59:11 volumio sudo[4542]: pam_unix(sudo:session): session closed for user root
Oct 25 21:59:11 volumio volumio[759]: info: Shairport-Sync Started
Oct 25 21:59:11 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat
Oct 25 21:59:14 volumio volumio[759]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Oct 25 21:59:14 volumio volumio[759]: info: CoreStateMachine::getcurrentVolume
Oct 25 21:59:14 volumio volumio[759]: info: CoreCommandRouter::volumioRetrievevolume
Oct 25 21:59:14 volumio volumio[759]: info: CoreStateMachine::pushState
Oct 25 21:59:14 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 21:59:14 volumio volumio[759]: info: CoreCommandRouter::volumioPushState
Oct 25 21:59:18 volumio mpd_monitor.sh[530]: MPD Monitor Service: MPD Appears to be inactive, restarting
Oct 25 21:59:33 volumio kernel: usb 1-1.1: USB disconnect, device number 5
Oct 25 21:59:33 volumio volumio[759]: info:
Oct 25 21:59:33 volumio volumio[759]: ---------------------------- USB Audio Device Detached
Oct 25 21:59:33 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach
Oct 25 21:59:33 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 21:59:33 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: raat , onStop
Oct 25 21:59:33 volumio kernel: usb 1-1.1: new high-speed USB device number 6 using xhci-hcd
Oct 25 21:59:33 volumio kernel: usb 1-1.1: New USB device found, idVendor=2972, idProduct=0047, bcdDevice= 1.09
Oct 25 21:59:34 volumio kernel: usb 1-1.1: New USB device strings: Mfr=1, Product=3, SerialNumber=2
Oct 25 21:59:34 volumio kernel: usb 1-1.1: Product: FiiO Q7
Oct 25 21:59:34 volumio kernel: usb 1-1.1: Manufacturer: GuangZhou FiiO Electronics Co.,Ltd
Oct 25 21:59:34 volumio kernel: usb 1-1.1: 1:3 : unsupported format bits 0x100000000
Oct 25 21:59:34 volumio kernel: hid-generic 0003:2972:0047.0004: hiddev96,hidraw0: USB HID v1.10 Device [GuangZhou FiiO Electronics Co.,Ltd FiiO Q7] on usb-fe9c0000.xhci-1.1/input3
Oct 25 21:59:34 volumio volumio[759]: info:
Oct 25 21:59:34 volumio volumio[759]: ---------------------------- USB Audio Device Attached
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::Close All Modals sent
Oct 25 21:59:34 volumio volumio[759]: info: Preparing to save Alsa Options, stopping services first
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::volumioGetState
Oct 25 21:59:34 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::volumioPause
Oct 25 21:59:34 volumio volumio[759]: info: CoreStateMachine::pause
Oct 25 21:59:34 volumio volumio[759]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"FiiO Q7","alsacard":"Q7"},"i2s":false}
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 21:59:34 volumio volumio[759]: info: Device 5 does not have any Mixer Control Available
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Oct 25 21:59:34 volumio volumio[759]: info: Updating Volume Controller Parameters: Device: 5 Name: FiiO Q7 Mixer:  Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Oct 25 21:59:34 volumio volumio[759]: info: Disabling external Volume Control
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 25 21:59:34 volumio volumio[759]: info: CoreStateMachine::pushState
Oct 25 21:59:34 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::volumioPushState
Oct 25 21:59:34 volumio volumio[759]: info: Preparing to generate the ALSA configuration file
Oct 25 21:59:34 volumio volumio[759]: info: Asound.conf file unchanged, so no further update is needed
Oct 25 21:59:34 volumio volumio[759]: info: Output device has changed, restarting MPD
Oct 25 21:59:34 volumio sudo[4641]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Oct 25 21:59:34 volumio volumio[759]: info: Output device has changed, restarting Shairport Sync
Oct 25 21:59:34 volumio sudo[4641]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 25 21:59:34 volumio sudo[4641]: pam_unix(sudo:session): session closed for user root
Oct 25 21:59:34 volumio sudo[4643]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Oct 25 21:59:34 volumio sudo[4643]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 21:59:34 volumio volumio[759]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Oct 25 21:59:34 volumio volumio[759]: info: MPD Permissions set
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 25 21:59:34 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:34 volumio volumio[759]: info: Starting Shairport Sync
Oct 25 21:59:34 volumio sudo[4658]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Oct 25 21:59:34 volumio sudo[4658]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 21:59:34 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Oct 25 21:59:34 volumio systemd[1]: shairport-sync.service: Succeeded.
Oct 25 21:59:34 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Oct 25 21:59:34 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Oct 25 21:59:34 volumio sudo[4658]: pam_unix(sudo:session): session closed for user root
Oct 25 21:59:34 volumio volumio[759]: info: Shairport-Sync Started
Oct 25 21:59:34 volumio volumio[759]: (node:759) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pbeg listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit
Oct 25 21:59:34 volumio volumio[759]: (Use `node --trace-warnings ...` to show where the warning was created)
Oct 25 21:59:34 volumio volumio[759]: (node:759) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 meta listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit
Oct 25 21:59:34 volumio volumio[759]: (node:759) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 prgr listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit
Oct 25 21:59:34 volumio volumio[759]: (node:759) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pvol listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit
Oct 25 21:59:34 volumio volumio[759]: (node:759) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pend listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit
Oct 25 21:59:35 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat
Oct 25 21:59:38 volumio volumio[759]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Oct 25 21:59:38 volumio volumio[759]: info: CoreStateMachine::getcurrentVolume
Oct 25 21:59:38 volumio volumio[759]: info: CoreCommandRouter::volumioRetrievevolume
Oct 25 21:59:38 volumio volumio[759]: info: CoreStateMachine::pushState
Oct 25 21:59:38 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 21:59:38 volumio volumio[759]: info: CoreCommandRouter::volumioPushState
Oct 25 21:59:39 volumio volumio[759]: info: CoreCommandRouter::volumioPlay
Oct 25 21:59:39 volumio volumio[759]: info: CoreStateMachine::play index undefined
Oct 25 21:59:39 volumio volumio[759]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 25 21:59:39 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 21:59:39 volumio volumio[759]: info: CoreStateMachine::startPlaybackTimer
Oct 25 21:59:39 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 21:59:39 volumio volumio[759]: info: ControllerMpd::resume
Oct 25 21:59:39 volumio volumio[759]: verbose: ControllerMpd::sendMpdCommand play
Oct 25 21:59:41 volumio volumio[759]: info: CoreCommandRouter::volumioPlay
Oct 25 21:59:41 volumio volumio[759]: info: CoreStateMachine::play index undefined
Oct 25 21:59:41 volumio volumio[759]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 25 21:59:41 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 21:59:41 volumio volumio[759]: info: CoreStateMachine::startPlaybackTimer
Oct 25 21:59:41 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 21:59:41 volumio volumio[759]: info: ControllerMpd::resume
Oct 25 21:59:41 volumio volumio[759]: verbose: ControllerMpd::sendMpdCommand play
Oct 25 21:59:46 volumio kernel: usb 1-1.1: USB disconnect, device number 6
Oct 25 21:59:46 volumio volumio[759]: info:
Oct 25 21:59:46 volumio volumio[759]: ---------------------------- USB Audio Device Detached
Oct 25 21:59:46 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach
Oct 25 21:59:46 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 21:59:46 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: raat , onStop
Oct 25 21:59:50 volumio kernel: usb 1-1-port1: over-current change #2
Oct 25 21:59:50 volumio kernel: usb 1-1-port2: over-current change #2
Oct 25 21:59:51 volumio kernel: usb 1-1-port3: over-current change #2
Oct 25 21:59:51 volumio kernel: usb 1-1-port4: over-current change #2
Oct 25 21:59:52 volumio kernel: usb 1-1.1: new high-speed USB device number 7 using xhci-hcd
Oct 25 21:59:52 volumio kernel: usb 1-1.1: New USB device found, idVendor=2972, idProduct=0047, bcdDevice= 1.09
Oct 25 21:59:52 volumio kernel: usb 1-1.1: New USB device strings: Mfr=1, Product=3, SerialNumber=2
Oct 25 21:59:52 volumio kernel: usb 1-1.1: Product: FiiO Q7
Oct 25 21:59:52 volumio kernel: usb 1-1.1: Manufacturer: GuangZhou FiiO Electronics Co.,Ltd
Oct 25 21:59:52 volumio kernel: usb 1-1.1: 1:3 : unsupported format bits 0x100000000
Oct 25 21:59:52 volumio kernel: hid-generic 0003:2972:0047.0005: hiddev96,hidraw0: USB HID v1.10 Device [GuangZhou FiiO Electronics Co.,Ltd FiiO Q7] on usb-fe9c0000.xhci-1.1/input3
Oct 25 21:59:52 volumio volumio[759]: info:
Oct 25 21:59:52 volumio volumio[759]: ---------------------------- USB Audio Device Attached
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::Close All Modals sent
Oct 25 21:59:52 volumio volumio[759]: info: Preparing to save Alsa Options, stopping services first
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::volumioGetState
Oct 25 21:59:52 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::volumioPause
Oct 25 21:59:52 volumio volumio[759]: info: CoreStateMachine::pause
Oct 25 21:59:52 volumio volumio[759]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"FiiO Q7","alsacard":"Q7"},"i2s":false}
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 21:59:52 volumio volumio[759]: info: Device 5 does not have any Mixer Control Available
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Oct 25 21:59:52 volumio volumio[759]: info: Updating Volume Controller Parameters: Device: 5 Name: FiiO Q7 Mixer:  Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Oct 25 21:59:52 volumio volumio[759]: info: Disabling external Volume Control
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 25 21:59:52 volumio volumio[759]: info: CoreStateMachine::pushState
Oct 25 21:59:52 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::volumioPushState
Oct 25 21:59:52 volumio volumio[759]: info: Preparing to generate the ALSA configuration file
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Oct 25 21:59:52 volumio volumio[759]: info: Asound.conf file unchanged, so no further update is needed
Oct 25 21:59:52 volumio volumio[759]: info: Output device has changed, restarting MPD
Oct 25 21:59:52 volumio sudo[4724]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Oct 25 21:59:52 volumio sudo[4724]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 21:59:52 volumio volumio[759]: info: Output device has changed, restarting Shairport Sync
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 25 21:59:52 volumio sudo[4724]: pam_unix(sudo:session): session closed for user root
Oct 25 21:59:52 volumio sudo[4726]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Oct 25 21:59:52 volumio sudo[4726]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 21:59:52 volumio volumio[759]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Oct 25 21:59:52 volumio volumio[759]: info: MPD Permissions set
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 25 21:59:52 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 21:59:52 volumio volumio[759]: info: Starting Shairport Sync
Oct 25 21:59:52 volumio sudo[4737]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Oct 25 21:59:52 volumio sudo[4737]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 21:59:53 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Oct 25 21:59:53 volumio systemd[1]: shairport-sync.service: Succeeded.
Oct 25 21:59:53 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Oct 25 21:59:53 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Oct 25 21:59:53 volumio sudo[4737]: pam_unix(sudo:session): session closed for user root
Oct 25 21:59:53 volumio volumio[759]: info: Shairport-Sync Started
Oct 25 21:59:53 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat
Oct 25 21:59:54 volumio volumio[759]: info: CoreCommandRouter::volumioPlay
Oct 25 21:59:54 volumio volumio[759]: info: CoreStateMachine::play index undefined
Oct 25 21:59:54 volumio volumio[759]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 25 21:59:54 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 21:59:54 volumio volumio[759]: info: CoreStateMachine::startPlaybackTimer
Oct 25 21:59:54 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 21:59:54 volumio volumio[759]: info: ControllerMpd::resume
Oct 25 21:59:54 volumio volumio[759]: verbose: ControllerMpd::sendMpdCommand play
Oct 25 21:59:55 volumio volumio[759]: info: CoreCommandRouter::volumioPlay
Oct 25 21:59:55 volumio volumio[759]: info: CoreStateMachine::play index undefined
Oct 25 21:59:55 volumio volumio[759]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 25 21:59:55 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 21:59:55 volumio volumio[759]: info: CoreStateMachine::startPlaybackTimer
Oct 25 21:59:55 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 21:59:55 volumio volumio[759]: info: ControllerMpd::resume
Oct 25 21:59:55 volumio volumio[759]: verbose: ControllerMpd::sendMpdCommand play
Oct 25 21:59:56 volumio volumio[759]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Oct 25 21:59:56 volumio volumio[759]: info: CoreStateMachine::getcurrentVolume
Oct 25 21:59:56 volumio volumio[759]: info: CoreCommandRouter::volumioRetrievevolume
Oct 25 21:59:56 volumio volumio[759]: info: CoreStateMachine::pushState
Oct 25 21:59:56 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 21:59:56 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 21:59:56 volumio volumio[759]: info: CoreCommandRouter::volumioPushState
Oct 25 21:59:58 volumio volumio[759]: info: CoreCommandRouter::volumioPlay
Oct 25 21:59:58 volumio volumio[759]: info: CoreStateMachine::play index undefined
Oct 25 21:59:58 volumio volumio[759]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 25 21:59:58 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 21:59:58 volumio volumio[759]: info: CoreStateMachine::startPlaybackTimer
Oct 25 21:59:58 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 21:59:58 volumio volumio[759]: info: ControllerMpd::resume
Oct 25 21:59:58 volumio volumio[759]: verbose: ControllerMpd::sendMpdCommand play
Oct 25 22:00:00 volumio volumio[759]: info: CoreCommandRouter::volumioNext
Oct 25 22:00:00 volumio volumio[759]: info: CoreStateMachine::next
Oct 25 22:00:00 volumio volumio[759]: info: CoreStateMachine::stop
Oct 25 22:00:00 volumio volumio[759]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 25 22:00:00 volumio volumio[759]: info: CoreStateMachine::updateTrackBlock
Oct 25 22:00:00 volumio volumio[759]: info: CorePlayQueue::getTrackBlock
Oct 25 22:00:00 volumio volumio[759]: info: CoreStateMachine::stPlaybackTimer
Oct 25 22:00:00 volumio volumio[759]: info: CoreStateMachine::pushState
Oct 25 22:00:00 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 22:00:00 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 22:00:00 volumio volumio[759]: info: CoreCommandRouter::volumioPushState
Oct 25 22:00:00 volumio volumio[759]: info: CoreStateMachine::serviceStop
Oct 25 22:00:00 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 22:00:00 volumio volumio[759]: info: CoreCommandRouter::serviceStop
Oct 25 22:00:00 volumio volumio[759]: info: ControllerMpd::stop
Oct 25 22:00:00 volumio volumio[759]: verbose: ControllerMpd::sendMpdCommand stop
Oct 25 22:00:03 volumio volumio[759]: info: CoreCommandRouter::volumioPlay
Oct 25 22:00:03 volumio volumio[759]: info: CoreStateMachine::play index undefined
Oct 25 22:00:03 volumio volumio[759]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 25 22:00:03 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 22:00:03 volumio volumio[759]: info: CoreStateMachine::startPlaybackTimer
Oct 25 22:00:03 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 22:00:03 volumio volumio[759]: verbose: ControllerMpd::clearAddPlayTracks NAS/FnOS/合集王菲/王菲 Faye Wong 1985-2022/王菲 { Tidal }/精选集合辑/2005 - 菲賣品/10 - 棋子.flac
Oct 25 22:00:03 volumio volumio[759]: verbose: ControllerMpd::sendMpdCommand stop
Oct 25 22:00:04 volumio volumio[759]: info: CoreCommandRouter::volumioRandom
Oct 25 22:00:04 volumio volumio[759]: info: CoreCommandRouter::writePlayerControls
Oct 25 22:00:04 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 22:00:04 volumio volumio[759]: info: CoreStateMachine::setRepeat true single true
Oct 25 22:00:04 volumio volumio[759]: info: CoreStateMachine::pushState
Oct 25 22:00:04 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 22:00:04 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 22:00:04 volumio volumio[759]: info: CoreCommandRouter::volumioPushState
Oct 25 22:00:05 volumio volumio[759]: info: CoreCommandRouter::volumioRandom
Oct 25 22:00:05 volumio volumio[759]: info: CoreCommandRouter::writePlayerControls
Oct 25 22:00:05 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 22:00:05 volumio volumio[759]: info: CoreStateMachine::setRepeat false single false
Oct 25 22:00:05 volumio volumio[759]: info: CoreStateMachine::pushState
Oct 25 22:00:05 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 22:00:05 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 22:00:05 volumio volumio[759]: info: CoreCommandRouter::volumioPushState
Oct 25 22:00:09 volumio volumio[759]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 25 22:00:09 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Oct 25 22:00:09 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 25 22:00:09 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 22:00:09 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 22:00:09 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 22:00:09 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 22:00:09 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 22:00:09 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 22:00:09 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 22:00:09 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 22:00:09 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Oct 25 22:00:09 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Oct 25 22:00:13 volumio volumio[759]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object]
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions
Oct 25 22:00:13 volumio volumio[759]: info: Preparing to save Alsa Options, stopping services first
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::volumioGetState
Oct 25 22:00:13 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::volumioPause
Oct 25 22:00:13 volumio volumio[759]: info: CoreStateMachine::pause
Oct 25 22:00:13 volumio volumio[759]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"FiiO Q7"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}}
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 22:00:13 volumio volumio[759]: info: Device 5 does not have any Mixer Control Available
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Oct 25 22:00:13 volumio volumio[759]: info: Updating Volume Controller Parameters: Device: 5 Name: FiiO Q7 Mixer:  Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Oct 25 22:00:13 volumio volumio[759]: info: Disabling external Volume Control
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 25 22:00:13 volumio volumio[759]: info: CoreStateMachine::pushState
Oct 25 22:00:13 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::volumioPushState
Oct 25 22:00:13 volumio volumio[759]: info: Preparing to generate the ALSA configuration file
Oct 25 22:00:13 volumio volumio[759]: info: Asound.conf file unchanged, so no further update is needed
Oct 25 22:00:13 volumio volumio[759]: info: Output device has changed, restarting MPD
Oct 25 22:00:13 volumio sudo[4783]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Oct 25 22:00:13 volumio volumio[759]: info: Output device has changed, restarting Shairport Sync
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 25 22:00:13 volumio sudo[4783]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 22:00:13 volumio sudo[4783]: pam_unix(sudo:session): session closed for user root
Oct 25 22:00:13 volumio sudo[4785]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Oct 25 22:00:13 volumio sudo[4785]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 22:00:13 volumio volumio[759]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Oct 25 22:00:13 volumio volumio[759]: info: MPD Permissions set
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 25 22:00:13 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 22:00:13 volumio volumio[759]: info: Starting Shairport Sync
Oct 25 22:00:13 volumio sudo[4800]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Oct 25 22:00:13 volumio sudo[4800]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 22:00:13 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Oct 25 22:00:13 volumio systemd[1]: shairport-sync.service: Succeeded.
Oct 25 22:00:13 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Oct 25 22:00:13 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Oct 25 22:00:13 volumio sudo[4800]: pam_unix(sudo:session): session closed for user root
Oct 25 22:00:13 volumio volumio[759]: info: Shairport-Sync Started
Oct 25 22:00:15 volumio volumio[759]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object]
Oct 25 22:00:15 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions
Oct 25 22:00:15 volumio volumio[759]: info: Preparing to save Alsa Options, stopping services first
Oct 25 22:00:15 volumio volumio[759]: info: CoreCommandRouter::volumioGetState
Oct 25 22:00:15 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 22:00:15 volumio volumio[759]: info: CoreCommandRouter::volumioPause
Oct 25 22:00:15 volumio volumio[759]: info: CoreStateMachine::pause
Oct 25 22:00:15 volumio volumio[759]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"FiiO Q7"},"i2s":false,"i2sid":{"value":"adafruit-max98357","label":"Adafruit MAX98357"}}
Oct 25 22:00:15 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 22:00:15 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 22:00:15 volumio volumio[759]: info: Device 5 does not have any Mixer Control Available
Oct 25 22:00:15 volumio volumio[759]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Oct 25 22:00:15 volumio volumio[759]: info: Updating Volume Controller Parameters: Device: 5 Name: FiiO Q7 Mixer:  Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Oct 25 22:00:15 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Oct 25 22:00:15 volumio volumio[759]: info: Disabling external Volume Control
Oct 25 22:00:15 volumio volumio[759]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 25 22:00:15 volumio volumio[759]: info: CoreStateMachine::pushState
Oct 25 22:00:15 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 22:00:15 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 22:00:15 volumio volumio[759]: info: CoreCommandRouter::volumioPushState
Oct 25 22:00:15 volumio volumio[759]: info: Preparing to generate the ALSA configuration file
Oct 25 22:00:15 volumio volumio[759]: info: Asound.conf file unchanged, so no further update is needed
Oct 25 22:00:15 volumio volumio[759]: info: Output device has changed, restarting MPD
Oct 25 22:00:16 volumio sudo[4828]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Oct 25 22:00:16 volumio volumio[759]: info: Output device has changed, restarting Shairport Sync
Oct 25 22:00:16 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 22:00:16 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 25 22:00:16 volumio sudo[4828]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 22:00:16 volumio sudo[4828]: pam_unix(sudo:session): session closed for user root
Oct 25 22:00:16 volumio sudo[4830]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Oct 25 22:00:16 volumio sudo[4830]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 22:00:16 volumio volumio[759]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Oct 25 22:00:16 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Oct 25 22:00:16 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 25 22:00:16 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 25 22:00:16 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 22:00:16 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 22:00:16 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 22:00:16 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 22:00:16 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 22:00:16 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 22:00:16 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 25 22:00:16 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Oct 25 22:00:16 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Oct 25 22:00:16 volumio volumio[759]: info: MPD Permissions set
Oct 25 22:00:16 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 22:00:16 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 22:00:16 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 22:00:16 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 22:00:16 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 22:00:16 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 22:00:16 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 22:00:16 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 22:00:16 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 25 22:00:16 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 25 22:00:16 volumio volumio[759]: info: Starting Shairport Sync
Oct 25 22:00:16 volumio sudo[4845]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Oct 25 22:00:16 volumio sudo[4845]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 25 22:00:16 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Oct 25 22:00:16 volumio systemd[1]: shairport-sync.service: Succeeded.
Oct 25 22:00:16 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Oct 25 22:00:16 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Oct 25 22:00:16 volumio sudo[4845]: pam_unix(sudo:session): session closed for user root
Oct 25 22:00:16 volumio volumio[759]: info: Shairport-Sync Started
Oct 25 22:00:17 volumio volumio[759]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Oct 25 22:00:17 volumio volumio[759]: info: CoreStateMachine::getcurrentVolume
Oct 25 22:00:17 volumio volumio[759]: info: CoreCommandRouter::volumioRetrievevolume
Oct 25 22:00:17 volumio volumio[759]: info: CoreStateMachine::pushState
Oct 25 22:00:17 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 22:00:17 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 22:00:17 volumio volumio[759]: info: CoreCommandRouter::volumioPushState
Oct 25 22:00:19 volumio volumio[759]: info: CoreCommandRouter::volumioGetState
Oct 25 22:00:19 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 22:00:19 volumio volumio[759]: info: CoreCommandRouter::volumioPlay
Oct 25 22:00:19 volumio volumio[759]: info: CoreStateMachine::play index undefined
Oct 25 22:00:19 volumio volumio[759]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 25 22:00:19 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 22:00:19 volumio volumio[759]: info: CoreStateMachine::startPlaybackTimer
Oct 25 22:00:19 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 22:00:19 volumio volumio[759]: verbose: ControllerMpd::clearAddPlayTracks NAS/FnOS/合集王菲/王菲 Faye Wong 1985-2022/王菲 { Tidal }/精选集合辑/2005 - 菲賣品/10 - 棋子.flac
Oct 25 22:00:19 volumio volumio[759]: verbose: ControllerMpd::sendMpdCommand stop
Oct 25 22:00:19 volumio volumio[759]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Oct 25 22:00:19 volumio volumio[759]: info: CoreStateMachine::getcurrentVolume
Oct 25 22:00:19 volumio volumio[759]: info: CoreCommandRouter::volumioRetrievevolume
Oct 25 22:00:19 volumio volumio[759]: info: CoreStateMachine::pushState
Oct 25 22:00:19 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 22:00:19 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 25 22:00:19 volumio volumio[759]: info: CoreCommandRouter::volumioPushState
Oct 25 22:00:23 volumio volumio[759]: info: CoreCommandRouter::volumioPlay
Oct 25 22:00:23 volumio volumio[759]: info: CoreStateMachine::play index undefined
Oct 25 22:00:23 volumio volumio[759]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 25 22:00:23 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 22:00:23 volumio volumio[759]: info: CoreStateMachine::startPlaybackTimer
Oct 25 22:00:23 volumio volumio[759]: info: CorePlayQueue::getTrack 585
Oct 25 22:00:23 volumio volumio[759]: verbose: ControllerMpd::clearAddPlayTracks NAS/FnOS/合集王菲/王菲 Faye Wong 1985-2022/王菲 { Tidal }/精选集合辑/2005 - 菲賣品/10 - 棋子.flac
Oct 25 22:00:23 volumio volumio[759]: verbose: ControllerMpd::sendMpdCommand stop
Oct 25 22:00:25 volumio volumio[759]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Oct 25 22:00:25 volumio volumio[759]: info: CURURI: music-library/NAS
Oct 25 22:00:26 volumio volumio[759]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 25 22:00:26 volumio volumio[759]: Error: connect ETIMEDOUT 108.160.172.232:443
Oct 25 22:00:26 volumio volumio[759]:     at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) {
Oct 25 22:00:26 volumio volumio[759]:   errno: -110,
Oct 25 22:00:26 volumio volumio[759]:   code: 'ETIMEDOUT',
Oct 25 22:00:26 volumio volumio[759]:   syscall: 'connect',
Oct 25 22:00:26 volumio volumio[759]:   address: '108.160.172.232',
Oct 25 22:00:26 volumio volumio[759]:   port: 443
Oct 25 22:00:26 volumio volumio[759]: }
Oct 25 22:00:26 volumio volumio[759]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 25 22:00:26 volumio sudo[4873]:  volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-25 21:59
Oct 25 22:00:26 volumio sudo[4873]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="29866754e5f1d7e4d0f581c10d9f22852f6f21db"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST"
VOLUMIO_VERSION="3.832"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"