moodeaudio.org > Moode Forum › moOde audio player › Support v
[SOLVED] CamillaDSP - MPD unable to play flat.yml

Thank you for your donation!


Cloudsmith graciously provides open-source package management and distribution for our project.


Thread Modes
Solved: CamillaDSP - MPD unable to play flat.yml
bitlab Offline
Senior Member
*
Posts: 571
Threads: 16
Joined: Apr 2020
Reputation: 23
#11
04-29-2021, 03:36 PM
(04-29-2021, 03:24 PM)katariat Wrote: Hi bitlab, looking for your help as well. Got the reference from gingerbeer, i am having similar issues and have tried to follow most of the recommendations but still cant seem to make moOde / Camilladsp to work.

my current step up - rasp pi, flashed the current moOde version (7.1) , creative xi fi 5.1 sound card. The intent is to create a 6 channel crossover + parametric eq etc

My past efforts to use camilladsp have been mixed...but they have been on another SBC (Rock64) with my creative sound card. I was able to make it work but with pulse and never using alsa.

This is what i did and still getting error message
- flashed the latest moOde 7.1
- set the MPD to Pi HDMI, the Mpd restarted
- went to audio settings, copied flat and renamed ....and when i click on check...it says its not a valid yml file
- went to the pipeline editor...made some changes
. . . . .went to capture device section, changed sample format to S16LE and get an error message that "500 Internal Server Error Server got itself in trouble"
can post logs record, playback details...

would greatly appreciate your help and guidance. Best

Lets first create a baseline:
  • If you have time please reinstall moOde with a fresh 7.2 (released today, and fixes some of the camilladsp configuration issues :-)
  • Do only the minimal configuration to have sound (use the standard supplied test track on the sd card and don't use camilladsp yet)
  • If you have sound, switch to the flat configuration (read previous posts above send from me to @gingerbeer on howto)
  • And let us now the results
  • If case you don't have sound, switch to the headphone or hdmi output to verify correct working of moOde vs your soundcard.
Find
Reply
katariat Offline
Junior Member
*
Posts: 9
Threads: 0
Joined: Apr 2021
Reputation: 0
#12
04-29-2021, 08:41 PM (This post was last modified: 04-29-2021, 09:28 PM by katariat.)
Hi @bitlab

thanks so much for your help & direction. here is what i did

- flashed the new moOde 7.2
- tested for sound out of headphone jack for both test file on the sd card, spotify render - check all works
- on the camilladsp, selected flat file and saved...went back to play the test file and get an error "MPD error failed to open audio output"
- selected another file, saved it. Selected back flat file and saved it ...same error
- no sound card connected from the start

post that, turned off camilladsp and played the test file on the sd card...everything works
looked at the mpd log and posting the error below

Code:
Apr 29 16:30 : exception: Failed to open audio output
Apr 29 16:30 : exception: Failed to play on "ALSA Default" (alsa): snd_pcm_poll_descriptors_revents() failed: No such device

what can i provide or share from the log to help further trouble shoot. thanks

Tarun
Find
Reply
bitlab Offline
Senior Member
*
Posts: 571
Threads: 16
Joined: Apr 2020
Reputation: 23
#13
04-29-2021, 08:56 PM
@katariat can you share:
  • the same log outputs as @gingerbeer did on the first post of this thread?
  • and also the output of the command 'cat /usr/share/camilladsp/working_config.yml'
Find
Reply
katariat Offline
Junior Member
*
Posts: 9
Threads: 0
Joined: Apr 2021
Reputation: 0
#14
04-29-2021, 09:47 PM (This post was last modified: 04-30-2021, 02:01 AM by katariat.)
this is for the cat /usr/share/camilladsp/working_config.yml command

Code:
devices:
 adjust_period: 10
 capture:
   type: File
   channels: 2
   filename: /dev/stdin
   format: S16LE
 capture_samplerate: 0
 chunksize: 1024
 enable_rate_adjust: false
 enable_resampling: false
 playback:
   type: Alsa
   channels: 2
   device: hw:1,0
   format: S16LE
 queuelimit: 1
 resampler_type: BalancedAsync
 samplerate: 44100
 silence_threshold: 0
 silence_timeout: 0
 target_level: 0
filters:
 peqgain:
   type: Gain
   parameters:
     gain: -6.000000
     inverted: false
 band_01:
   type: Biquad
   parameters:
     type: Peaking
     freq: 23
     q: 0.930000
     gain: 5.600000
 band_02:
   type: Biquad
   parameters:
     type: Peaking
     freq: 61
     q: 2.480000
     gain: 1.900000
 band_03:
   type: Biquad
   parameters:
     type: Peaking
     freq: 1702
     q: 2.130000
     gain: 3.200000
 band_04:
   type: Biquad
   parameters:
     type: Peaking
     freq: 3286
     q: 3.950000
     gain: 2.600000
 band_05:
   type: Biquad
   parameters:
     type: Peaking
     freq: 5648
     q: 3.940000
     gain: -4.600000
 band_06:
   type: Biquad
   parameters:
     type: Peaking
     freq: 210
     q: 1.320000
     gain: -2.300000
 band_07:
   type: Biquad
   parameters:
     type: Peaking
     freq: 449
     q: 0.720000
     gain: -0.700000
 band_08:
   type: Biquad
   parameters:
     type: Peaking
     freq: 4393
     q: 0.220000
     gain: 0.200000
 band_09:
   type: Biquad
   parameters:
     type: Peaking
     freq: 10533
     q: 1.170000
     gain: 2.200000
 band_10:
   type: Biquad
   parameters:
     type: Peaking
     freq: 19366
     q: 0.380000
     gain: -11.600000
mixers:
 stereo:
   channels:
     in: 2
     out: 2
   mapping:
   - dest: 0
     sources:
     - channel: 0
       gain: 0
       inverted: false
   - dest: 1
     sources:
     - channel: 1
       gain: 0
       inverted: false
pipeline:
- type: Mixer
 name: stereo
- type: Filter
 channel: 0
 names:
 - peqgain
 - band_01
 - band_02
 - band_03
 - band_04
 - band_05
 - band_06
 - band_07
 - band_08
 - band_09
 - band_10
- type: Filter
 channel: 1
 names:
 - peqgain
 - band_01
 - band_02
 - band_03
 - band_04
 - band_05
 - band_06
 - band_07
 - band_08
 - band_09
 - band_10

from /var/log/mpd/log

Code:
Apr 29 16:21 : player: played "SDCARD/Stereo Test/LRMonoPhase4.flac"
Apr 29 16:27 : player: played "SDCARD/Stereo Test/LRMonoPhase4.flac"
Apr 29 16:30 : exception: Failed to play on "ALSA Default" (alsa): snd_pcm_poll_descriptors_revents() failed: No such device
Apr 29 16:30 : exception: Failed to open audio output
Apr 29 16:30 : exception: Failed to play on "ALSA Default" (alsa): snd_pcm_poll_descriptors_revents() failed: No such device
Apr 29 16:30 : exception: Failed to open audio output
Apr 29 16:30 : exception: Failed to play on "ALSA Default" (alsa): snd_pcm_poll_descriptors_revents() failed: No such device
Apr 29 16:30 : exception: Failed to open audio output
Apr 29 16:32 : exception: Failed to play on "ALSA Default" (alsa): snd_pcm_poll_descriptors_revents() failed: No such device
Apr 29 16:32 : exception: Failed to open audio output
Apr 29 16:32 : exception: Failed to play on "ALSA Default" (alsa): snd_pcm_poll_descriptors_revents() failed: No such device
Apr 29 16:32 : exception: Failed to open audio output
Apr 29 16:32 : exception: Failed to play on "ALSA Default" (alsa): snd_pcm_poll_descriptors_revents() failed: No such device
Apr 29 16:32 : exception: Failed to open audio output
Apr 29 16:33 : exception: Failed to play on "ALSA Default" (alsa): snd_pcm_poll_descriptors_revents() failed: No such device
Apr 29 16:33 : exception: Failed to open audio output
Apr 29 16:33 : exception: Failed to play on "ALSA Default" (alsa): snd_pcm_poll_descriptors_revents() failed: No such device
Apr 29 16:33 : exception: Failed to open audio output
Apr 29 16:40 : exception: Failed to play on "ALSA Default" (alsa): snd_pcm_poll_descriptors_revents() failed: No such device
Apr 29 16:40 : exception: Failed to open audio output
Apr 29 16:40 : exception: Failed to play on "ALSA Default" (alsa): snd_pcm_poll_descriptors_revents() failed: No such device
Apr 29 16:40 : exception: Failed to open audio output
Apr 29 16:43 : player: played "SDCARD/Stereo Test/LRMonoPhase4.flac"
Apr 29 16:44 : player: played "SDCARD/Stereo Test/LRMonoPhase4.flac"

moodeutl -F

Code:
*** Scanning for playback devices ***
Card 0, ID `b1', name `bcm2835 HDMI 1'
 Device 0, ID `bcm2835 HDMI 1', name `bcm2835 HDMI 1', 4 subdevices (4 availabl                                                    e)
   1..8 channels, sampling rate 8000..192000 Hz
   Sample formats: U8, S16_LE
   Buffer size range from 80 to 131072
   Period size range from 80 to 131072

     Subdevice 0, name `subdevice #0'
     Subdevice 1, name `subdevice #1'
     Subdevice 2, name `subdevice #2'
     Subdevice 3, name `subdevice #3'
Card 1, ID `Headphones', name `bcm2835 Headphones'
 Device 0, ID `bcm2835 Headphones', name `bcm2835 Headphones', 4 subdevices (4                                                     available)
   1..8 channels, sampling rate 8000..192000 Hz
   Sample formats: U8, S16_LE
   Buffer size range from 80 to 131072
   Period size range from 80 to 131072

     Subdevice 0, name `subdevice #0'
     Subdevice 1, name `subdevice #1'
     Subdevice 2, name `subdevice #2'
     Subdevice 3, name `subdevice #3'
moodeutl -l
Code:
20210425 091304 worker: -- Start
20210425 091304 worker: Successfully daemonized
20210425 091306 worker: Integrity check (passed)
20210425 091308 moode.php: MPD connect failed: cmd=(playlist)
20210425 091311 worker: File check (OK)
20210425 091311 moode.php: MPD connect failed: cmd=(playlist)
20210429 161958 moode.php: MPD connect failed: cmd=(playlist)
20210429 162002 moode.php: MPD connect failed: cmd=(playlist)
20210429 162003 worker: Session vacuumed
20210429 162003 worker: Session loaded
20210429 162003 worker: Debug logging (OFF)
20210429 162004 worker: -- Audio debug
20210429 162004 worker: ALSA cards: (0:b1 | 1:Headphones | 2:empty | 3:empty
20210429 162004 worker: MPD config: (0:Pi HDMI 1 | mixer:(HDMI) | card:0)
20210429 162005 worker: ALSA mixer actual (HDMI)
20210429 162006 moode.php: MPD connect failed: cmd=(playlist)
20210429 162007 worker: ALSA HDMI volume set to (0%)
20210429 162007 worker: -- System
20210429 162014 worker: Host     (moode)
20210429 162014 worker: moOde    (7.2.0 2021-04-24)
20210429 162014 worker: RaspiOS  (10.6)
20210429 162014 worker: Kernel   (5.4.77+ #1371)
20210429 162014 worker: Platform (Pi-B+ 1.2 512MB)
20210429 162014 worker: ARM arch (armv6l, 32-bit kernel)
20210429 162014 worker: MPD ver  (0.22.6_p0x3)
20210429 162014 worker: CPU gov  (ondemand)
20210429 162014 worker: USB boot not available
20210429 162015 worker: File system not expanded yet
20210429 162015 worker: HDMI port on
20210429 162015 worker: -- Network
20210429 162015 worker: eth0 exists
20210429 162015 worker: IP addr (192.168.1.4)
20210429 162015 worker: Netmask (255.255.255.0)
20210429 162016 worker: Gateway (192.168.1.1)
20210429 162016 worker: Pri DNS (192.168.1.1)
20210429 162016 worker: Domain  (None)
20210429 162016 worker: wlan0 does not exist
20210429 162016 worker: -- Audio config
20210429 162016 worker: ALSA card number (0)
20210429 162016 worker: MPD audio output (Pi HDMI 1)
20210429 162017 worker: Audio formats (U8, S16_LE)
20210429 162018 worker: ALSA mixer name (HDMI)
20210429 162018 worker: MPD volume control (software)
20210429 162018 worker: Hdwr volume controller exists
20210429 162018 worker: Max ALSA volume (100%)
20210429 162018 worker: ALSA loopback (Off)
20210429 162018 worker: Reset renderer active flags
20210429 162018 worker: CamillaDSP (off)
20210429 162018 worker: -- MPD startup
20210429 162018 worker: MPD started
20210429 162021 worker: MPD accepting connections
20210429 162021 worker: MPD output 1 ALSA Default (on)
20210429 162021 worker: MPD output 2 ALSA Bluetooth (off)
20210429 162021 worker: MPD output 3 HTTP Server (off)
20210429 162021 worker: MPD crossfade (off)
20210429 162021 worker: MPD ignore CUE files (yes)
20210429 162021 worker: -- Feature availability
20210429 162021 worker: Source select (available)
20210429 162021 worker: Source select (source: MPD)
20210429 162022 worker: Source select (output: Pi HDMI 1)
20210429 162022 worker: Bluetooth (available)
20210429 162022 worker: Airplay renderer (available)
20210429 162022 worker: Spotify renderer (available)
20210429 162022 worker: Squeezelite (available)
20210429 162022 worker: RoonBridge renderer (not installed)
20210429 162022 worker: UPnP renderer (available)
20210429 162022 worker: DLNA server (available)
20210429 162022 worker: UPnP browser (available)
20210429 162022 worker: GPIO button handler (available)
20210429 162022 worker: Stream recorder (n/a)
20210429 162022 worker: -- Music sources
20210429 162022 worker: USB sources (none attached)
20210429 162022 worker: NAS and UPnP sources (none configured)
20210429 162022 worker: -- Other
20210429 162022 worker: USB volume knob (Off)
20210429 162022 worker: USB auto-mounter (udisks-glue)
20210429 162023 worker: LED0 (On)
20210429 162023 worker: LED1 (On)
20210429 162023 worker: Saved MPD vol level (0)
20210429 162023 worker: Preamp volume level (0)
20210429 162023 worker: MPD volume level (0) restored
20210429 162023 worker: ALSA HDMI volume (96%)
20210429 162023 worker: Auto-play (Off)
20210429 162023 worker: Maintenance interval (3 hours)
20210429 162023 worker: Screen saver activation (Never)
20210429 162024 worker: Session permissions (OK)
20210429 162024 worker: Watchdog started
20210429 162024 worker: Ready
20210429 162054 worker: Job mpdcfg
20210429 162239 worker: Job airplaysvc
20210429 162252 worker: Job spotifysvc
20210429 162550 worker: Job spotifysvc
20210429 162941 worker: Job camilladsp
20210429 164312 worker: Job camilladsp
20210429 172127 worker: Job mpdcfg
Find
Reply
bitlab Offline
Senior Member
*
Posts: 571
Threads: 16
Joined: Apr 2020
Reputation: 23
#15
04-30-2021, 12:54 PM
@katariat some remarks:
  1. The cat of the camilladsp config isn't from the default flat config. If show a configures 10 band peq.
  2. If this is the actual file content concerning whitespace, because this config isn't valid (you can use the check button to verify). Is this file maybe edit manually, because starting from line 117 is yml format is incorrect?
     (If I use this config in my system I would get the same error as in your mpd.log)
  3. The output of moode -l shows no active camilladsp config, so I assume that this output isn't captured while the flat config is active.
To be sure I just tested with the following procedure and that works as expected:
  1. fresh install 7.2 (no customizing at all)
  2. select headphone output and save it
  3. set the volume to a normal level (default is 0%)
  4. play the default supplied 'stereo test' track to verify sound
  5. in the quick configure menu select camilladsp
  6. select the 'flat' config
  7. press save
  8. again play the default supplied 'stereo test' track to verify sound
Find
Reply
katariat Offline
Junior Member
*
Posts: 9
Threads: 0
Joined: Apr 2021
Reputation: 0
#16
04-30-2021, 03:43 PM
Thanks so much @bitlab. I think i might have made a silly mistake when i shared the output...i can see that i should have turned on camilladsp with the flat file to provide the diagnostics. The dignostics that i shared were with the camilladsp turned off...so no wonder things didnt add up. 


this is what i followed now
- same moOde 7.2 from yesterday...tested that sound comes using the test track on the sd card
- selected the flat file from the configuration of the camilladsp, saved it
- played the test track and got the error

here are the outputs once again for your reference. 

cat /usr/share/camilladsp/working_config.yml
Quote:---
devices:
  samplerate: 44100
  chunksize: 1024
  queuelimit: 1
  capture:
    type: File
    channels: 2
    filename: /dev/stdin
    format: S16LE
  playback:
    type: Alsa
    channels: 2
    device: hw:1,0
    format: S16LE
mixers:
  stereo:
    channels:
      in: 2
      out: 2
    mapping:
    - dest: 0
      sources:
      - channel: 0
        gain: -3
        inverted: false
    - dest: 1
      sources:
      - channel: 1
        gain: -3
        inverted: false
pipeline:
- type: Mixer
  name: stereo
...
cat: command: No such file or directory

/var/log/mpd/log
Code:
Apr 30 11:32 : exception: Failed to play on "ALSA Default" (alsa): snd_pcm_poll_descriptors_revents() failed: No such device
Apr 30 11:32 : exception: Failed to open audio output
Apr 30 11:33 : exception: Failed to play on "ALSA Default" (alsa): snd_pcm_poll_descriptors_revents() failed: No such device
Apr 30 11:33 : exception: Failed to open audio output

moodeutl -F
Code:
*** Scanning for playback devices ***
Card 0, ID `b1', name `bcm2835 HDMI 1'
 Device 0, ID `bcm2835 HDMI 1', name `bcm2835 HDMI 1', 4 subdevices (4 available)
   1..8 channels, sampling rate 8000..192000 Hz
   Sample formats: U8, S16_LE
   Buffer size range from 80 to 131072
   Period size range from 80 to 131072

     Subdevice 0, name `subdevice #0'
     Subdevice 1, name `subdevice #1'
     Subdevice 2, name `subdevice #2'
     Subdevice 3, name `subdevice #3'
Card 1, ID `Headphones', name `bcm2835 Headphones'
 Device 0, ID `bcm2835 Headphones', name `bcm2835 Headphones', 4 subdevices (4 available)
   1..8 channels, sampling rate 8000..192000 Hz
   Sample formats: U8, S16_LE
   Buffer size range from 80 to 131072
   Period size range from 80 to 131072

     Subdevice 0, name `subdevice #0'
     Subdevice 1, name `subdevice #1'
     Subdevice 2, name `subdevice #2'
     Subdevice 3, name `subdevice #3'

moodeutl -l
Code:
20210425 091304 worker: -- Start
20210425 091304 worker: Successfully daemonized
20210425 091306 worker: Integrity check (passed)
20210425 091308 moode.php: MPD connect failed: cmd=(playlist)
20210425 091311 worker: File check (OK)
20210425 091311 moode.php: MPD connect failed: cmd=(playlist)
20210429 161958 moode.php: MPD connect failed: cmd=(playlist)
20210429 162002 moode.php: MPD connect failed: cmd=(playlist)
20210429 162003 worker: Session vacuumed
20210429 162003 worker: Session loaded
20210429 162003 worker: Debug logging (OFF)
20210429 162004 worker: -- Audio debug
20210429 162004 worker: ALSA cards: (0:b1 | 1:Headphones | 2:empty | 3:empty
20210429 162004 worker: MPD config: (0:Pi HDMI 1 | mixer:(HDMI) | card:0)
20210429 162005 worker: ALSA mixer actual (HDMI)
20210429 162006 moode.php: MPD connect failed: cmd=(playlist)
20210429 162007 worker: ALSA HDMI volume set to (0%)
20210429 162007 worker: -- System
20210429 162014 worker: Host     (moode)
20210429 162014 worker: moOde    (7.2.0 2021-04-24)
20210429 162014 worker: RaspiOS  (10.6)
20210429 162014 worker: Kernel   (5.4.77+ #1371)
20210429 162014 worker: Platform (Pi-B+ 1.2 512MB)
20210429 162014 worker: ARM arch (armv6l, 32-bit kernel)
20210429 162014 worker: MPD ver  (0.22.6_p0x3)
20210429 162014 worker: CPU gov  (ondemand)
20210429 162014 worker: USB boot not available
20210429 162015 worker: File system not expanded yet
20210429 162015 worker: HDMI port on
20210429 162015 worker: -- Network
20210429 162015 worker: eth0 exists
20210429 162015 worker: IP addr (192.168.1.4)
20210429 162015 worker: Netmask (255.255.255.0)
20210429 162016 worker: Gateway (192.168.1.1)
20210429 162016 worker: Pri DNS (192.168.1.1)
20210429 162016 worker: Domain  (None)
20210429 162016 worker: wlan0 does not exist
20210429 162016 worker: -- Audio config
20210429 162016 worker: ALSA card number (0)
20210429 162016 worker: MPD audio output (Pi HDMI 1)
20210429 162017 worker: Audio formats (U8, S16_LE)
20210429 162018 worker: ALSA mixer name (HDMI)
20210429 162018 worker: MPD volume control (software)
20210429 162018 worker: Hdwr volume controller exists
20210429 162018 worker: Max ALSA volume (100%)
20210429 162018 worker: ALSA loopback (Off)
20210429 162018 worker: Reset renderer active flags
20210429 162018 worker: CamillaDSP (off)
20210429 162018 worker: -- MPD startup
20210429 162018 worker: MPD started
20210429 162021 worker: MPD accepting connections
20210429 162021 worker: MPD output 1 ALSA Default (on)
20210429 162021 worker: MPD output 2 ALSA Bluetooth (off)
20210429 162021 worker: MPD output 3 HTTP Server (off)
20210429 162021 worker: MPD crossfade (off)
20210429 162021 worker: MPD ignore CUE files (yes)
20210429 162021 worker: -- Feature availability
20210429 162021 worker: Source select (available)
20210429 162021 worker: Source select (source: MPD)
20210429 162022 worker: Source select (output: Pi HDMI 1)
20210429 162022 worker: Bluetooth (available)
20210429 162022 worker: Airplay renderer (available)
20210429 162022 worker: Spotify renderer (available)
20210429 162022 worker: Squeezelite (available)
20210429 162022 worker: RoonBridge renderer (not installed)
20210429 162022 worker: UPnP renderer (available)
20210429 162022 worker: DLNA server (available)
20210429 162022 worker: UPnP browser (available)
20210429 162022 worker: GPIO button handler (available)
20210429 162022 worker: Stream recorder (n/a)
20210429 162022 worker: -- Music sources
20210429 162022 worker: USB sources (none attached)
20210429 162022 worker: NAS and UPnP sources (none configured)
20210429 162022 worker: -- Other
20210429 162022 worker: USB volume knob (Off)
20210429 162022 worker: USB auto-mounter (udisks-glue)
20210429 162023 worker: LED0 (On)
20210429 162023 worker: LED1 (On)
20210429 162023 worker: Saved MPD vol level (0)
20210429 162023 worker: Preamp volume level (0)
20210429 162023 worker: MPD volume level (0) restored
20210429 162023 worker: ALSA HDMI volume (96%)
20210429 162023 worker: Auto-play (Off)
20210429 162023 worker: Maintenance interval (3 hours)
20210429 162023 worker: Screen saver activation (Never)
20210429 162024 worker: Session permissions (OK)
20210429 162024 worker: Watchdog started
20210429 162024 worker: Ready
20210429 162054 worker: Job mpdcfg
20210429 162239 worker: Job airplaysvc
20210429 162252 worker: Job spotifysvc
20210429 162550 worker: Job spotifysvc
20210429 162941 worker: Job camilladsp
20210429 164312 worker: Job camilladsp
20210429 172127 worker: Job mpdcfg
20210430 113217 worker: Job camilladsp

Thanks a ton for your generosity to take you time to help me with this
Find
Reply
bitlab Offline
Senior Member
*
Posts: 571
Threads: 16
Joined: Apr 2020
Reputation: 23
#17
04-30-2021, 04:30 PM
@katariat  are you sure that moodeutl -l output is correct:
  • the date differs 5 days with the mpd log?
  • HDMI is active:
    20210429 162004 worker: MPD config: (0Tonguei HDMI 1 | mixerSadHDMI) | card:0)
    20210429 162005 worker: ALSA mixer actual (HDMI)
  • CamillaDSP is off:
    20210429 162018 worker: CamillaDSP (off)

To get more info:
  • under mpd setting enabled logging verbose (the option is at the bottom)
  • select the flat config + save again
  • run the command:
    moodeutl -r
  • run the following command from the cmdline to enable extra log info for camilladsp:
    sudo sed -i 's/#        -v/        -v/g' /etc/alsa/conf.d/camilladsp.conf
    (lateron you can disable it again with:   sudo sed -i 's/        -v/#        -v/g' /etc/alsa/conf.d/camilladsp.conf  )
  • try to start a song and post the output of the /var/log/mpd/log:
The output should look somewhat like:
Code:
Apr 30 18:28 : playlist: play 1:"SDCARD/Stereo Test/LRMonoPhase4.flac"
Apr 30 18:28 : client: [20] command returned 0
Apr 30 18:28 : decoder_thread: probing plugin flac
Apr 30 18:28 : playlist: queue song 1:"SDCARD/Stereo Test/LRMonoPhase4.flac"
Apr 30 18:28 : client: [20] process command list
Apr 30 18:28 : decoder: audio_format=48000:16:2, seekable=true
Apr 30 18:28 : client: process command "status"
Apr 30 18:28 : alsa_output: opened _audioout type=ROUTE
Apr 30 18:28 : alsa_output: buffer: size=3840..16384 time=80000..341334
Apr 30 18:28 : alsa_output: period: size=1920..2048 time=40000..42667
Apr 30 18:28 : alsa_output: default period_time = buffer_time/4 = 341333/4 = 85333
Apr 30 18:28 : alsa_output: format=S24_LE (Signed 24 bit Little Endian)
Apr 30 18:28 : alsa_output: buffer_size=16384 period_size=2048
Apr 30 18:28 : output: opened "ALSA Default" (alsa) audio_format=48000:24:4
Apr 30 18:28 : output: converting in=48000:16:2 -> f=48000:24:2 -> out=48000:24:4
Apr 30 18:28 : client: command returned 0
Apr 30 18:28 : client: process command "currentsong"
Apr 30 18:28 : client: command returned 0
Apr 30 18:28 : client: [20] process command list returned 0
Apr 30 18:28 : client: [20] closed
Apr 30 18:28 : client: [19] process command "status"
Apr 30 18:28 : client: [19] command returned 0
Apr 30 18:28 : client: [21] opened from 127.0.0.1:40472
Apr 30 18:28 : client: [21] process command "status"
Apr 30 18:28 : client: [21] command returned 0
Apr 30 18:28 : client: [17] process command "status"
Apr 30 18:28 : client: [17] command returned 0
Apr 30 18:28 : client: [15] process command "status"
Apr 30 18:28 : client: [15] command returned 0
Apr 30 18:28 : client: [12] process command "status"
Apr 30 18:28 : client: [12] command returned 0
Apr 30 18:28 : client: [8] process command "status"
Apr 30 18:28 : client: [8] command returned 0
Apr 30 18:28 : client: [17] process command "currentsong"
Apr 30 18:28 : client: [17] command returned 0
Apr 30 18:28 : client: [15] process command "currentsong"
Apr 30 18:28 : client: [15] command returned 0
Apr 30 18:28 : client: [12] process command "currentsong"
Apr 30 18:28 : client: [12] command returned 0
Apr 30 18:28 : client: [8] process command "currentsong"
Apr 30 18:28 : client: [8] command returned 0
Apr 30 18:28 : client: [21] process command "currentsong"
Apr 30 18:28 : client: [21] command returned 0
Apr 30 18:28 : client: [19] process command "currentsong"
Apr 30 18:28 : client: [19] command returned 0
Apr 30 18:28:03.852 DEBG Read config file Some("/usr/share/camilladsp/working_config.yml"), module: camilladsp
Apr 30 18:28:03.853 ERRO Invalid config file!
devices: missing field `samplerate` at line 3 column 10, module: camilladsp
Apr 30 18:28:03.853 DEBG Exiting due to config error, module: camilladsp
Apr 30 18:28 : exception: Failed to play on "ALSA Default" (alsa): snd_pcm_poll_descriptors_revents() failed: No such device
Apr 30 18:28 : client: [21] process command "playlistinfo "2""
Apr 30 18:28 : exception: Failed to open audio output
Apr 30 18:28 : client: [21] command returned 0
Apr 30 18:28 : output: closed "ALSA Default" (alsa)
Find
Reply
katariat Offline
Junior Member
*
Posts: 9
Threads: 0
Joined: Apr 2021
Reputation: 0
#18
05-01-2021, 05:41 PM
Hi @bitlab apologies for the delayed response and thanks for your continued help. Still getting the same error (mpd failed)...and posting the output of the various logs as requested.


Actions and sequence 
- new download of moOde 7.2, fresh sd card write and boot up
- played test sound on the card to the pi 3.5mm audio jack - works
- changed the mpd log to verbose, saved...restarted the mpd
- played test sound on the card - works
- on the audio config, went to the camilladsp, selected flat and clicked set. get a pop up confirmation
- clicked edit and went to the cammilladsp (flat was selected) ...clicked save
- Ran moodeutl -r...got a confirmation that services restarted
- ran the command sudo sed -i 's/#        -v/        -v/g' /etc/alsa/conf.d/camilladsp.conf as directed
- click on the test track on the sd card and get the MPD failed error

various log files below

 cat /usr/share/camilladsp/working_config.yml
Code:
---
devices:
 samplerate: 44100
 chunksize: 1024
 queuelimit: 1
 capture:
   type: File
   channels: 2
   filename: /dev/stdin
   format: S16LE
 playback:
   type: Alsa
   channels: 2
   device: hw:1,0
   format: S16LE
mixers:
 stereo:
   channels:
     in: 2
     out: 2
   mapping:
   - dest: 0
     sources:
     - channel: 0
       gain: -3
       inverted: false
   - dest: 1
     sources:
     - channel: 1
       gain: -3
       inverted: false
pipeline:
- type: Mixer
 name: stereo
...
cat: command: No such file or directory

moodeutl -F
Code:
*** Scanning for playback devices ***
Card 0, ID `b1', name `bcm2835 HDMI 1'
 Device 0, ID `bcm2835 HDMI 1', name `bcm2835 HDMI 1', 4 subdevices (4 available)
   1..8 channels, sampling rate 8000..192000 Hz
   Sample formats: U8, S16_LE
   Buffer size range from 80 to 131072
   Period size range from 80 to 131072

     Subdevice 0, name `subdevice #0'
     Subdevice 1, name `subdevice #1'
     Subdevice 2, name `subdevice #2'
     Subdevice 3, name `subdevice #3'
Card 1, ID `Headphones', name `bcm2835 Headphones'
 Device 0, ID `bcm2835 Headphones', name `bcm2835 Headphones', 4 subdevices (4 available)
   1..8 channels, sampling rate 8000..192000 Hz
   Sample formats: U8, S16_LE
   Buffer size range from 80 to 131072
   Period size range from 80 to 131072

     Subdevice 0, name `subdevice #0'
     Subdevice 1, name `subdevice #1'
     Subdevice 2, name `subdevice #2'
     Subdevice 3, name `subdevice #3'

moodeutl -l
Code:
20210501 131323 worker: -- Start
20210501 131323 worker: Successfully daemonized
20210501 131324 worker: Integrity check (passed)
20210501 131327 worker: File check (OK)
20210501 131327 moode.php: MPD connect failed: cmd=(playlist)
20210501 131329 worker: Session vacuumed
20210501 131330 worker: Session loaded
20210501 131330 worker: Debug logging (OFF)
20210501 131330 worker: -- Audio debug
20210501 131330 worker: ALSA cards: (0:b1 | 1:Headphones | 2:empty | 3:empty
20210501 131330 worker: MPD config: (1:Pi Headphone jack | mixer:(Headphone) | card:1)
20210501 131330 worker: ALSA mixer actual (Headphone)
20210501 131330 moode.php: MPD connect failed: cmd=(playlist)
20210501 131331 worker: ALSA Headphone volume set to (0%)
20210501 131331 worker: -- System
20210501 131335 worker: Host     (moode)
20210501 131335 worker: moOde    (7.2.0 2021-04-24)
20210501 131335 worker: RaspiOS  (10.6)
20210501 131335 worker: Kernel   (5.4.77+ #1371)
20210501 131335 worker: Platform (Pi-B+ 1.2 512MB)
20210501 131335 worker: ARM arch (armv6l, 32-bit kernel)
20210501 131335 worker: MPD ver  (0.22.6_p0x3)
20210501 131335 worker: CPU gov  (ondemand)
20210501 131335 worker: USB boot not available
20210501 131336 worker: File system not expanded yet
20210501 131336 worker: HDMI port on
20210501 131336 worker: -- Network
20210501 131336 worker: eth0 exists
20210501 131336 worker: IP addr (192.168.1.4)
20210501 131336 worker: Netmask (255.255.255.0)
20210501 131336 worker: Gateway (192.168.1.1)
20210501 131337 worker: Pri DNS (192.168.1.1)
20210501 131337 worker: Domain  (None)
20210501 131337 worker: wlan0 does not exist
20210501 131337 worker: -- Audio config
20210501 131337 worker: ALSA card number (1)
20210501 131337 worker: MPD audio output (Pi Headphone jack)
20210501 131338 worker: Audio formats (U8, S16_LE)
20210501 131338 worker: ALSA mixer name (Headphone)
20210501 131338 worker: MPD volume control (software)
20210501 131339 worker: Hdwr volume controller exists
20210501 131339 worker: Max ALSA volume (100%)
20210501 131339 worker: ALSA loopback (Off)
20210501 131339 worker: Reset renderer active flags
20210501 131339 worker: CamillaDSP (flat.yml)
20210501 131339 worker: -- MPD startup
20210501 131340 worker: MPD started
20210501 131342 worker: MPD accepting connections
20210501 131342 worker: MPD output 1 ALSA Default (on)
20210501 131342 worker: MPD output 2 ALSA Bluetooth (off)
20210501 131342 worker: MPD output 3 HTTP Server (off)
20210501 131342 worker: MPD crossfade (off)
20210501 131342 worker: MPD ignore CUE files (yes)
20210501 131342 worker: -- Feature availability
20210501 131342 worker: Source select (available)
20210501 131342 worker: Source select (source: MPD)
20210501 131343 worker: Source select (output: Pi Headphone jack)
20210501 131343 worker: Bluetooth (available)
20210501 131343 worker: Airplay renderer (available)
20210501 131343 worker: Spotify renderer (available)
20210501 131343 worker: Squeezelite (available)
20210501 131343 worker: RoonBridge renderer (not installed)
20210501 131343 worker: UPnP renderer (available)
20210501 131343 worker: DLNA server (available)
20210501 131343 worker: UPnP browser (available)
20210501 131343 worker: GPIO button handler (available)
20210501 131343 worker: Stream recorder (n/a)
20210501 131343 worker: -- Music sources
20210501 131343 worker: USB sources (none attached)
20210501 131343 worker: NAS and UPnP sources (none configured)
20210501 131343 worker: -- Other
20210501 131343 worker: USB volume knob (Off)
20210501 131343 worker: USB auto-mounter (udisks-glue)
20210501 131344 worker: LED0 (On)
20210501 131344 worker: LED1 (On)
20210501 131344 worker: Saved MPD vol level (0)
20210501 131344 worker: Preamp volume level (0)
20210501 131344 worker: MPD volume level (75) restored
20210501 131345 worker: ALSA Headphone volume (100%)
20210501 131345 worker: Auto-play (Off)
20210501 131345 worker: Maintenance interval (3 hours)
20210501 131345 worker: Screen saver activation (Never)
20210501 131345 worker: Session permissions (OK)
20210501 131345 worker: Watchdog started
20210501 131345 worker: Ready
Find
Reply
katariat Offline
Junior Member
*
Posts: 9
Threads: 0
Joined: Apr 2021
Reputation: 0
#19
05-01-2021, 05:43 PM
MPD log file 
Code:
May 01 13:08 : player: played "SDCARD/Stereo Test/LRMonoPhase4.flac"
May 01 13:09 : player: played "SDCARD/Stereo Test/LRMonoPhase4.flac"
May 01 13:09 : state_file: Loading state file /var/lib/mpd/state
May 01 13:09 : client: [0] opened from 127.0.0.1:47650
May 01 13:09 : client: [0] process command "close"
May 01 13:09 : client: [0] command returned 4
May 01 13:09 : client: [0] closed
May 01 13:09 : client: [1] opened from 127.0.0.1:47654
May 01 13:09 : client: [1] process command "setvol "0""
May 01 13:09 : client: [1] command returned 0
May 01 13:09 : client: [1] process command list
May 01 13:09 : client: process command "status"
May 01 13:09 : client: command returned 0
May 01 13:09 : client: process command "currentsong"
May 01 13:09 : client: command returned 0
May 01 13:09 : client: [1] process command list returned 0
May 01 13:09 : client: [1] closed
May 01 13:09 : client: [2] opened from 127.0.0.1:47658
May 01 13:09 : client: [2] process command "status"
May 01 13:09 : client: [2] command returned 0
May 01 13:09 : client: [2] process command "currentsong"
May 01 13:09 : client: [2] command returned 0
May 01 13:09 : client: [2] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:09 : client: [2] command returned 0
May 01 13:09 : client: [2] process command "close"
May 01 13:09 : client: [2] command returned 4
May 01 13:09 : client: [2] closed
May 01 13:09 : client: [3] opened from 127.0.0.1:47662
May 01 13:09 : client: [3] process command "status"
May 01 13:09 : client: [3] command returned 0
May 01 13:09 : client: [3] process command "idle"
May 01 13:09 : client: [3] command returned 1
May 01 13:09 : client: [4] opened from 127.0.0.1:47666
May 01 13:09 : client: [4] process command "close"
May 01 13:09 : client: [4] command returned 4
May 01 13:09 : client: [4] closed
May 01 13:09 : client: [5] opened from 127.0.0.1:47670
May 01 13:09 : client: [5] process command "lsinfo"
May 01 13:09 : client: [5] command returned 0
May 01 13:09 : client: [5] process command "close"
May 01 13:09 : client: [5] command returned 4
May 01 13:09 : client: [5] closed
May 01 13:09 : client: [6] opened from 127.0.0.1:47674
May 01 13:09 : client: [6] process command "status"
May 01 13:09 : client: [6] command returned 0
May 01 13:09 : client: [6] process command "currentsong"
May 01 13:09 : client: [6] command returned 0
May 01 13:09 : client: [6] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:09 : client: [6] command returned 0
May 01 13:09 : client: [6] process command "close"
May 01 13:09 : client: [6] command returned 4
May 01 13:09 : client: [6] closed
May 01 13:09 : client: [7] opened from 127.0.0.1:47678
May 01 13:09 : client: [7] process command "status"
May 01 13:09 : client: [7] command returned 0
May 01 13:09 : client: [7] process command "idle"
May 01 13:09 : client: [7] command returned 1
May 01 13:09 : client: [8] opened from 127.0.0.1:47682
May 01 13:09 : client: [8] process command "playlistinfo"
May 01 13:09 : client: [8] command returned 0
May 01 13:09 : client: [8] process command "close"
May 01 13:09 : client: [8] command returned 4
May 01 13:09 : client: [8] closed
May 01 13:09 : client: [9] opened from 127.0.0.1:47686
May 01 13:09 : client: [9] process command "play"
May 01 13:09 : playlist: play 47:"SDCARD/Stereo Test/LRMonoPhase4.flac"
May 01 13:09 : client: [9] command returned 0
May 01 13:09 : decoder_thread: probing plugin flac
May 01 13:09 : decoder: audio_format=48000:16:2, seekable=true
May 01 13:09 : client: [9] process command "close"
May 01 13:09 : client: [9] command returned 4
May 01 13:09 : client: [9] closed
May 01 13:09 : client: [3] process command "status"
May 01 13:09 : alsa_output: opened _audioout type=COPY
May 01 13:09 : alsa_output: buffer: size=480..32768 time=10000..682667
May 01 13:09 : alsa_output: period: size=480..32768 time=10000..682667
May 01 13:09 : alsa_output: default period_time = buffer_time/4 = 500000/4 = 125000
May 01 13:09 : alsa_output: format=S16_LE (Signed 16 bit Little Endian)
May 01 13:09 : alsa_output: buffer_size=24000 period_size=6000
May 01 13:09 : output: opened "ALSA Default" (alsa) audio_format=48000:16:2
May 01 13:09 : output: converting in=48000:16:2 -> f=48000:24:2 -> out=48000:16:2
May 01 13:09 : client: [3] command returned 0
May 01 13:09 : client: [7] process command "status"
May 01 13:09 : client: [7] command returned 0
May 01 13:09 : client: [3] process command "currentsong"
May 01 13:09 : client: [3] command returned 0
May 01 13:09 : client: [7] process command "currentsong"
May 01 13:09 : client: [7] command returned 0
May 01 13:09 : client: [3] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:09 : client: [3] command returned 0
May 01 13:09 : client: [3] process command "close"
May 01 13:09 : client: [3] command returned 4
May 01 13:09 : client: [3] closed
May 01 13:09 : client: [7] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:09 : client: [7] command returned 0
May 01 13:09 : client: [7] process command "close"
May 01 13:09 : client: [7] command returned 4
May 01 13:09 : client: [7] closed
May 01 13:09 : client: [10] opened from 127.0.0.1:47690
May 01 13:09 : client: [10] process command "status"
May 01 13:09 : client: [10] command returned 0
May 01 13:09 : client: [10] process command "idle"
May 01 13:09 : client: [10] command returned 1
May 01 13:09 : client: [11] opened from 127.0.0.1:47694
May 01 13:09 : client: [11] process command "playlistinfo"
May 01 13:09 : client: [11] command returned 0
May 01 13:09 : client: [11] process command "close"
May 01 13:09 : client: [11] command returned 4
May 01 13:09 : client: [11] closed
May 01 13:09 : client: [12] opened from 127.0.0.1:47698
May 01 13:09 : client: [12] process command "pause"
May 01 13:09 : output: closed "ALSA Default" (alsa)
May 01 13:09 : client: [12] command returned 0
May 01 13:09 : client: [10] process command "status"
May 01 13:09 : client: [10] command returned 0
May 01 13:09 : client: [10] process command "currentsong"
May 01 13:09 : client: [10] command returned 0
May 01 13:09 : client: [12] process command "close"
May 01 13:09 : client: [12] command returned 4
May 01 13:09 : client: [12] closed
May 01 13:10 : client: [10] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:10 : client: [10] command returned 0
May 01 13:10 : client: [10] process command "close"
May 01 13:10 : client: [10] command returned 4
May 01 13:10 : client: [10] closed
May 01 13:10 : client: [13] opened from 127.0.0.1:47702
May 01 13:10 : client: [13] process command "status"
May 01 13:10 : client: [13] command returned 0
May 01 13:10 : client: [13] process command "idle"
May 01 13:10 : client: [13] command returned 1
May 01 13:10 : client: [14] opened from 127.0.0.1:47706
May 01 13:10 : client: [14] process command "playlistinfo"
May 01 13:10 : client: [14] command returned 0
May 01 13:10 : client: [14] process command "close"
May 01 13:10 : client: [14] command returned 4
May 01 13:10 : client: [14] closed
May 01 13:10 : client: [15] opened from 127.0.0.1:47710
May 01 13:10 : client: [15] process command "setvol 1"
May 01 13:10 : client: [15] command returned 0
May 01 13:10 : client: [13] process command "status"
May 01 13:10 : client: [13] command returned 0
May 01 13:10 : client: [13] process command "currentsong"
May 01 13:10 : client: [13] command returned 0
May 01 13:10 : client: [15] process command "close"
May 01 13:10 : client: [15] command returned 4
May 01 13:10 : client: [15] closed
May 01 13:10 : client: [13] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:10 : client: [13] command returned 0
May 01 13:10 : client: [13] process command "close"
May 01 13:10 : client: [13] command returned 4
May 01 13:10 : client: [13] closed
May 01 13:10 : client: [16] opened from 127.0.0.1:47714
May 01 13:10 : client: [16] process command "status"
May 01 13:10 : client: [16] command returned 0
May 01 13:10 : client: [16] process command "idle"
May 01 13:10 : client: [16] command returned 1
May 01 13:10 : client: [17] opened from 127.0.0.1:47718
May 01 13:10 : client: [17] process command "setvol 2"
May 01 13:10 : client: [17] command returned 0
May 01 13:10 : client: [16] process command "status"
May 01 13:10 : client: [16] command returned 0
May 01 13:10 : client: [16] process command "currentsong"
May 01 13:10 : client: [16] command returned 0
May 01 13:10 : client: [17] process command "close"
May 01 13:10 : client: [17] command returned 4
May 01 13:10 : client: [17] closed
May 01 13:10 : client: [18] opened from 127.0.0.1:47722
May 01 13:10 : client: [18] process command "setvol 3"
May 01 13:10 : client: [18] command returned 0
May 01 13:10 : client: [18] process command "close"
May 01 13:10 : client: [18] command returned 4
May 01 13:10 : client: [18] closed
May 01 13:10 : client: [16] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:10 : client: [16] command returned 0
May 01 13:10 : client: [16] process command "close"
May 01 13:10 : client: [16] command returned 4
May 01 13:10 : client: [16] closed
May 01 13:10 : client: [19] opened from 127.0.0.1:47726
May 01 13:10 : client: [19] process command "status"
May 01 13:10 : client: [19] command returned 0
May 01 13:10 : client: [19] process command "idle"
May 01 13:10 : client: [19] command returned 1
May 01 13:10 : client: [20] opened from 127.0.0.1:47730
May 01 13:10 : client: [20] process command "setvol 4"
May 01 13:10 : client: [20] command returned 0
May 01 13:10 : client: [19] process command "status"
May 01 13:10 : client: [19] command returned 0
May 01 13:10 : client: [19] process command "currentsong"
May 01 13:10 : client: [19] command returned 0
May 01 13:10 : client: [20] process command "close"
May 01 13:10 : client: [20] command returned 4
May 01 13:10 : client: [20] closed
May 01 13:10 : client: [21] opened from 127.0.0.1:47734
May 01 13:10 : client: [21] process command "setvol 5"
May 01 13:10 : client: [21] command returned 0
May 01 13:10 : client: [21] process command "close"
May 01 13:10 : client: [21] command returned 4
May 01 13:10 : client: [21] closed
May 01 13:10 : client: [22] opened from 127.0.0.1:47738
May 01 13:10 : client: [22] process command "setvol 8"
May 01 13:10 : client: [22] command returned 0
May 01 13:10 : client: [22] process command "close"
May 01 13:10 : client: [22] command returned 4
May 01 13:10 : client: [22] closed
May 01 13:10 : client: [23] opened from 127.0.0.1:47742
May 01 13:10 : client: [23] process command "setvol 10"
May 01 13:10 : client: [23] command returned 0
May 01 13:10 : client: [23] process command "close"
May 01 13:10 : client: [23] command returned 4
May 01 13:10 : client: [23] closed
May 01 13:10 : client: [24] opened from 127.0.0.1:47746
May 01 13:10 : client: [24] process command "setvol 13"
May 01 13:10 : client: [24] command returned 0
May 01 13:10 : client: [24] process command "close"
May 01 13:10 : client: [24] command returned 4
May 01 13:10 : client: [24] closed
May 01 13:10 : client: [25] opened from 127.0.0.1:47750
May 01 13:10 : client: [25] process command "setvol 19"
May 01 13:10 : client: [25] command returned 0
May 01 13:10 : client: [25] process command "close"
May 01 13:10 : client: [25] command returned 4
May 01 13:10 : client: [25] closed
May 01 13:10 : client: [19] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:10 : client: [19] command returned 0
May 01 13:10 : client: [19] process command "close"
May 01 13:10 : client: [19] command returned 4
May 01 13:10 : client: [19] closed
May 01 13:10 : client: [26] opened from 127.0.0.1:47754
May 01 13:10 : client: [26] process command "setvol 23"
May 01 13:10 : client: [26] command returned 0
May 01 13:10 : client: [26] process command "close"
May 01 13:10 : client: [26] command returned 4
May 01 13:10 : client: [26] closed
May 01 13:10 : client: [27] opened from 127.0.0.1:47758
May 01 13:10 : client: [27] process command "setvol 26"
May 01 13:10 : client: [27] command returned 0
May 01 13:10 : client: [27] process command "close"
May 01 13:10 : client: [27] command returned 4
May 01 13:10 : client: [27] closed
May 01 13:10 : client: [28] opened from 127.0.0.1:47762
May 01 13:10 : client: [28] process command "setvol 27"
May 01 13:10 : client: [28] command returned 0
May 01 13:10 : client: [28] process command "close"
May 01 13:10 : client: [28] command returned 4
May 01 13:10 : client: [28] closed
May 01 13:10 : client: [29] opened from 127.0.0.1:47766
May 01 13:10 : client: [29] process command "setvol 30"
May 01 13:10 : client: [29] command returned 0
May 01 13:10 : client: [29] process command "close"
May 01 13:10 : client: [29] command returned 4
May 01 13:10 : client: [29] closed
May 01 13:10 : client: [30] opened from 127.0.0.1:47770
May 01 13:10 : client: [30] process command "setvol 32"
May 01 13:10 : client: [30] command returned 0
May 01 13:10 : client: [30] process command "close"
May 01 13:10 : client: [30] command returned 4
May 01 13:10 : client: [30] closed
May 01 13:10 : client: [31] opened from 127.0.0.1:47774
May 01 13:10 : client: [31] process command "setvol 34"
May 01 13:10 : client: [31] command returned 0
May 01 13:10 : client: [31] process command "close"
May 01 13:10 : client: [31] command returned 4
May 01 13:10 : client: [31] closed
May 01 13:10 : client: [32] opened from 127.0.0.1:47778
May 01 13:10 : client: [32] process command "setvol 36"
May 01 13:10 : client: [32] command returned 0
May 01 13:10 : client: [33] opened from 127.0.0.1:47782
May 01 13:10 : client: [32] process command "close"
May 01 13:10 : client: [32] command returned 4
May 01 13:10 : client: [32] closed
May 01 13:10 : client: [33] process command "setvol 38"
May 01 13:10 : client: [33] command returned 0
May 01 13:10 : client: [33] process command "close"
May 01 13:10 : client: [33] command returned 4
May 01 13:10 : client: [33] closed
May 01 13:10 : client: [34] opened from 127.0.0.1:47786
May 01 13:10 : client: [34] process command "setvol 40"
May 01 13:10 : client: [34] command returned 0
May 01 13:10 : client: [34] process command "close"
May 01 13:10 : client: [34] command returned 4
May 01 13:10 : client: [34] closed
May 01 13:10 : client: [35] opened from 127.0.0.1:47790
May 01 13:10 : client: [35] process command "setvol 42"
May 01 13:10 : client: [35] command returned 0
May 01 13:10 : client: [35] process command "close"
May 01 13:10 : client: [35] command returned 4
May 01 13:10 : client: [35] closed
May 01 13:10 : client: [36] opened from 127.0.0.1:47794
May 01 13:10 : client: [37] opened from 127.0.0.1:47798
May 01 13:10 : client: [36] process command "setvol 44"
May 01 13:10 : client: [36] command returned 0
May 01 13:10 : client: [36] process command "close"
May 01 13:10 : client: [36] command returned 4
May 01 13:10 : client: [36] closed
May 01 13:10 : client: [37] process command "setvol 50"
May 01 13:10 : client: [37] command returned 0
May 01 13:10 : client: [37] process command "close"
May 01 13:10 : client: [37] command returned 4
May 01 13:10 : client: [37] closed
May 01 13:10 : client: [38] opened from 127.0.0.1:47802
May 01 13:10 : client: [38] process command "setvol 55"
May 01 13:10 : client: [38] command returned 0
May 01 13:10 : client: [38] process command "close"
May 01 13:10 : client: [38] command returned 4
May 01 13:10 : client: [38] closed
May 01 13:10 : client: [39] opened from 127.0.0.1:47806
May 01 13:10 : client: [39] process command "setvol 59"
May 01 13:10 : client: [39] command returned 0
May 01 13:10 : client: [40] opened from 127.0.0.1:47810
May 01 13:10 : client: [39] process command "close"
May 01 13:10 : client: [39] command returned 4
May 01 13:10 : client: [39] closed
May 01 13:10 : client: [40] process command "setvol 61"
May 01 13:10 : client: [40] command returned 0
May 01 13:10 : client: [41] opened from 127.0.0.1:47814
May 01 13:10 : client: [40] process command "close"
May 01 13:10 : client: [40] command returned 4
May 01 13:10 : client: [40] closed
May 01 13:10 : client: [41] process command "status"
May 01 13:10 : client: [41] command returned 0
May 01 13:10 : client: [41] process command "idle"
May 01 13:10 : client: [41] command returned 1
May 01 13:10 : client: [42] opened from 127.0.0.1:47818
May 01 13:10 : client: [43] opened from 127.0.0.1:47822
May 01 13:10 : client: [42] process command "setvol 60"
May 01 13:10 : client: [42] command returned 0
May 01 13:10 : client: [41] process command "status"
May 01 13:10 : client: [41] command returned 0
May 01 13:10 : client: [41] process command "currentsong"
May 01 13:10 : client: [41] command returned 0
May 01 13:10 : client: [42] process command "close"
May 01 13:10 : client: [42] command returned 4
May 01 13:10 : client: [42] closed
May 01 13:10 : client: [43] process command "setvol 62"
May 01 13:10 : client: [43] command returned 0
May 01 13:10 : client: [43] process command "close"
May 01 13:10 : client: [43] command returned 4
May 01 13:10 : client: [43] closed
May 01 13:10 : client: [44] opened from 127.0.0.1:47826
May 01 13:10 : client: [44] process command "setvol 63"
May 01 13:10 : client: [44] command returned 0
May 01 13:10 : client: [44] process command "close"
May 01 13:10 : client: [44] command returned 4
May 01 13:10 : client: [44] closed
May 01 13:10 : client: [45] opened from 127.0.0.1:47830
May 01 13:10 : client: [45] process command "setvol 66"
May 01 13:10 : client: [45] command returned 0
May 01 13:10 : client: [45] process command "close"
May 01 13:10 : client: [45] command returned 4
May 01 13:10 : client: [45] closed
May 01 13:10 : client: [46] opened from 127.0.0.1:47834
May 01 13:10 : client: [46] process command "setvol 69"
May 01 13:10 : client: [46] command returned 0
May 01 13:10 : client: [46] process command "close"
May 01 13:10 : client: [46] command returned 4
May 01 13:10 : client: [46] closed
May 01 13:10 : client: [47] opened from 127.0.0.1:47838
May 01 13:10 : client: [47] process command "setvol 70"
May 01 13:10 : client: [47] command returned 0
May 01 13:10 : client: [47] process command "close"
May 01 13:10 : client: [47] command returned 4
May 01 13:10 : client: [47] closed
May 01 13:10 : client: [48] opened from 127.0.0.1:47842
May 01 13:10 : client: [48] process command "setvol 71"
May 01 13:10 : client: [48] command returned 0
May 01 13:10 : client: [49] opened from 127.0.0.1:47846
May 01 13:10 : client: [48] process command "close"
May 01 13:10 : client: [48] command returned 4
May 01 13:10 : client: [48] closed
May 01 13:10 : client: [49] process command "setvol 72"
May 01 13:10 : client: [49] command returned 0
May 01 13:10 : client: [49] process command "close"
May 01 13:10 : client: [49] command returned 4
May 01 13:10 : client: [49] closed
May 01 13:10 : client: [50] opened from 127.0.0.1:47850
May 01 13:10 : client: [50] process command "setvol 73"
May 01 13:10 : client: [50] command returned 0
May 01 13:10 : client: [50] process command "close"
May 01 13:10 : client: [50] command returned 4
May 01 13:10 : client: [50] closed
May 01 13:10 : client: [41] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:10 : client: [41] command returned 0
May 01 13:10 : client: [41] process command "close"
May 01 13:10 : client: [41] command returned 4
May 01 13:10 : client: [41] closed
May 01 13:10 : client: [51] opened from 127.0.0.1:47854
May 01 13:10 : client: [52] opened from 127.0.0.1:47858
May 01 13:10 : client: [51] process command "setvol 74"
May 01 13:10 : client: [51] command returned 0
May 01 13:10 : client: [51] process command "close"
May 01 13:10 : client: [51] command returned 4
May 01 13:10 : client: [51] closed
May 01 13:10 : client: [52] process command "setvol 75"
May 01 13:10 : client: [52] command returned 0
May 01 13:10 : client: [52] process command "close"
May 01 13:10 : client: [52] command returned 4
May 01 13:10 : client: [52] closed
May 01 13:10 : client: [53] opened from 127.0.0.1:47862
May 01 13:10 : client: [53] process command "status"
May 01 13:10 : client: [53] command returned 0
May 01 13:10 : client: [53] process command "idle"
May 01 13:10 : client: [53] command returned 1
May 01 13:10 : client: [54] opened from 127.0.0.1:47866
May 01 13:10 : client: [54] process command "setvol 76"
May 01 13:10 : client: [54] command returned 0
May 01 13:10 : client: [53] process command "status"
May 01 13:10 : client: [53] command returned 0
May 01 13:10 : client: [53] process command "currentsong"
May 01 13:10 : client: [53] command returned 0
May 01 13:10 : client: [54] process command "close"
May 01 13:10 : client: [54] command returned 4
May 01 13:10 : client: [54] closed
May 01 13:10 : client: [55] opened from 127.0.0.1:47870
May 01 13:10 : client: [55] process command "setvol 77"
May 01 13:10 : client: [55] command returned 0
May 01 13:10 : client: [55] process command "close"
May 01 13:10 : client: [55] command returned 4
May 01 13:10 : client: [55] closed
May 01 13:10 : client: [53] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:10 : client: [53] command returned 0
May 01 13:10 : client: [53] process command "close"
May 01 13:10 : client: [53] command returned 4
May 01 13:10 : client: [53] closed
May 01 13:10 : client: [56] opened from 127.0.0.1:47874
May 01 13:10 : client: [56] process command "status"
May 01 13:10 : client: [56] command returned 0
May 01 13:10 : client: [56] process command "idle"
May 01 13:10 : client: [56] command returned 1
May 01 13:10 : client: [57] opened from 127.0.0.1:47878
May 01 13:10 : client: [57] process command "setvol 62"
May 01 13:10 : client: [57] command returned 0
May 01 13:10 : client: [56] process command "status"
May 01 13:10 : client: [56] command returned 0
May 01 13:10 : client: [56] process command "currentsong"
May 01 13:10 : client: [56] command returned 0
May 01 13:10 : client: [57] process command "close"
May 01 13:10 : client: [57] command returned 4
May 01 13:10 : client: [57] closed
May 01 13:10 : client: [58] opened from 127.0.0.1:47882
May 01 13:10 : client: [58] process command "setvol 64"
May 01 13:10 : client: [58] command returned 0
May 01 13:10 : client: [58] process command "close"
May 01 13:10 : client: [58] command returned 4
May 01 13:10 : client: [58] closed
May 01 13:10 : client: [59] opened from 127.0.0.1:47886
May 01 13:10 : client: [59] process command "setvol 65"
May 01 13:10 : client: [59] command returned 0
May 01 13:10 : client: [59] process command "close"
May 01 13:10 : client: [59] command returned 4
May 01 13:10 : client: [59] closed
May 01 13:10 : client: [60] opened from 127.0.0.1:47890
May 01 13:10 : client: [60] process command "setvol 66"
May 01 13:10 : client: [60] command returned 0
May 01 13:10 : client: [60] process command "close"
May 01 13:10 : client: [60] command returned 4
May 01 13:10 : client: [60] closed
May 01 13:10 : client: [61] opened from 127.0.0.1:47894
May 01 13:10 : client: [61] process command "setvol 66"
May 01 13:10 : client: [61] command returned 0
May 01 13:10 : client: [61] process command "close"
May 01 13:10 : client: [61] command returned 4
May 01 13:10 : client: [61] closed
May 01 13:10 : client: [62] opened from 127.0.0.1:47898
May 01 13:10 : client: [56] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:10 : client: [56] command returned 0
May 01 13:10 : client: [56] process command "close"
May 01 13:10 : client: [56] command returned 4
May 01 13:10 : client: [56] closed
May 01 13:10 : client: [62] process command "setvol 67"
May 01 13:10 : client: [62] command returned 0
May 01 13:10 : client: [62] process command "close"
May 01 13:10 : client: [62] command returned 4
May 01 13:10 : client: [62] closed
May 01 13:10 : client: [63] opened from 127.0.0.1:47902
May 01 13:10 : client: [63] process command "status"
May 01 13:10 : client: [63] command returned 0
May 01 13:10 : client: [63] process command "idle"
May 01 13:10 : client: [63] command returned 1
May 01 13:10 : client: [64] opened from 127.0.0.1:47906
May 01 13:10 : client: [64] process command "setvol 68"
May 01 13:10 : client: [64] command returned 0
May 01 13:10 : client: [63] process command "status"
May 01 13:10 : client: [63] command returned 0
May 01 13:10 : client: [63] process command "currentsong"
May 01 13:10 : client: [63] command returned 0
May 01 13:10 : client: [64] process command "close"
May 01 13:10 : client: [64] command returned 4
May 01 13:10 : client: [64] closed
May 01 13:10 : client: [65] opened from 127.0.0.1:47910
May 01 13:10 : client: [66] opened from 127.0.0.1:47914
May 01 13:10 : client: [65] process command "setvol 69"
May 01 13:10 : client: [65] command returned 0
May 01 13:10 : client: [65] process command "close"
May 01 13:10 : client: [65] command returned 4
May 01 13:10 : client: [65] closed
May 01 13:10 : client: [66] process command "setvol 70"
May 01 13:10 : client: [66] command returned 0
May 01 13:10 : client: [66] process command "close"
May 01 13:10 : client: [66] command returned 4
May 01 13:10 : client: [66] closed
May 01 13:10 : client: [67] opened from 127.0.0.1:47918
May 01 13:10 : client: [67] process command "setvol 70"
May 01 13:10 : client: [67] command returned 0
May 01 13:10 : client: [67] process command "close"
May 01 13:10 : client: [67] command returned 4
May 01 13:10 : client: [67] closed
May 01 13:10 : client: [68] opened from 127.0.0.1:47922
May 01 13:10 : client: [68] process command "setvol 71"
May 01 13:10 : client: [68] command returned 0
May 01 13:10 : client: [68] process command "close"
May 01 13:10 : client: [68] command returned 4
May 01 13:10 : client: [68] closed
May 01 13:10 : client: [63] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:10 : client: [63] command returned 0
May 01 13:10 : client: [63] process command "close"
May 01 13:10 : client: [63] command returned 4
May 01 13:10 : client: [63] closed
May 01 13:10 : client: [69] opened from 127.0.0.1:47926
May 01 13:10 : client: [69] process command "status"
May 01 13:10 : client: [69] command returned 0
May 01 13:10 : client: [69] process command "idle"
May 01 13:10 : client: [69] command returned 1
May 01 13:10 : client: [70] opened from 127.0.0.1:47930
May 01 13:10 : client: [70] process command "setvol 72"
May 01 13:10 : client: [70] command returned 0
May 01 13:10 : client: [69] process command "status"
May 01 13:10 : client: [69] command returned 0
May 01 13:10 : client: [69] process command "currentsong"
May 01 13:10 : client: [69] command returned 0
May 01 13:10 : client: [70] process command "close"
May 01 13:10 : client: [70] command returned 4
May 01 13:10 : client: [70] closed
May 01 13:10 : client: [69] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:10 : client: [69] command returned 0
May 01 13:10 : client: [69] process command "close"
May 01 13:10 : client: [69] command returned 4
May 01 13:10 : client: [69] closed
May 01 13:10 : client: [71] opened from 127.0.0.1:47934
May 01 13:10 : client: [71] process command "status"
May 01 13:10 : client: [71] command returned 0
May 01 13:10 : client: [71] process command "idle"
May 01 13:10 : client: [71] command returned 1
May 01 13:10 : client: [72] opened from 127.0.0.1:47938
May 01 13:10 : client: [72] process command "setvol 73"
May 01 13:10 : client: [72] command returned 0
May 01 13:10 : client: [71] process command "status"
May 01 13:10 : client: [71] command returned 0
May 01 13:10 : client: [71] process command "currentsong"
May 01 13:10 : client: [71] command returned 0
May 01 13:10 : client: [72] process command "close"
May 01 13:10 : client: [72] command returned 4
May 01 13:10 : client: [72] closed
May 01 13:10 : client: [71] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:10 : client: [71] command returned 0
May 01 13:10 : client: [71] process command "close"
May 01 13:10 : client: [71] command returned 4
May 01 13:10 : client: [71] closed
May 01 13:10 : client: [73] opened from 127.0.0.1:47942
May 01 13:10 : client: [73] process command "status"
May 01 13:10 : client: [73] command returned 0
May 01 13:10 : client: [73] process command "idle"
May 01 13:10 : client: [73] command returned 1
May 01 13:10 : client: [74] opened from 127.0.0.1:47946
May 01 13:10 : client: [74] process command "setvol 74"
May 01 13:10 : client: [74] command returned 0
May 01 13:10 : client: [73] process command "status"
May 01 13:10 : client: [73] command returned 0
May 01 13:10 : client: [73] process command "currentsong"
May 01 13:10 : client: [73] command returned 0
May 01 13:10 : client: [74] process command "close"
May 01 13:10 : client: [74] command returned 4
May 01 13:10 : client: [74] closed
May 01 13:10 : client: [73] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:10 : client: [73] command returned 0
May 01 13:10 : client: [73] process command "close"
May 01 13:10 : client: [73] command returned 4
May 01 13:10 : client: [73] closed
May 01 13:10 : client: [75] opened from 127.0.0.1:47950
May 01 13:10 : client: [75] process command "status"
May 01 13:10 : client: [75] command returned 0
May 01 13:10 : client: [75] process command "idle"
May 01 13:10 : client: [75] command returned 1
May 01 13:10 : client: [76] opened from 127.0.0.1:47954
May 01 13:10 : client: [76] process command "setvol 75"
May 01 13:10 : client: [76] command returned 0
May 01 13:10 : client: [75] process command "status"
May 01 13:10 : client: [75] command returned 0
May 01 13:10 : client: [75] process command "currentsong"
May 01 13:10 : client: [75] command returned 0
May 01 13:10 : client: [76] process command "close"
May 01 13:10 : client: [76] command returned 4
May 01 13:10 : client: [76] closed
May 01 13:10 : client: [75] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:10 : client: [75] command returned 0
May 01 13:10 : client: [75] process command "close"
May 01 13:10 : client: [75] command returned 4
May 01 13:10 : client: [75] closed
May 01 13:10 : client: [77] opened from 127.0.0.1:47958
May 01 13:10 : client: [77] process command "status"
May 01 13:10 : client: [77] command returned 0
May 01 13:10 : client: [77] process command "idle"
May 01 13:10 : client: [77] command returned 1
May 01 13:10 : client: [78] opened from 127.0.0.1:47962
May 01 13:10 : client: [78] process command "play"
May 01 13:10 : alsa_output: opened _audioout type=COPY
May 01 13:10 : alsa_output: buffer: size=480..32768 time=10000..682667
May 01 13:10 : alsa_output: period: size=480..32768 time=10000..682667
May 01 13:10 : alsa_output: default period_time = buffer_time/4 = 500000/4 = 125000
May 01 13:10 : alsa_output: format=S16_LE (Signed 16 bit Little Endian)
May 01 13:10 : alsa_output: buffer_size=24000 period_size=6000
May 01 13:10 : output: opened "ALSA Default" (alsa) audio_format=48000:16:2
May 01 13:10 : output: converting in=48000:16:2 -> f=48000:24:2 -> out=48000:16:2
May 01 13:10 : client: [78] command returned 0
May 01 13:10 : client: [78] process command "close"
May 01 13:10 : client: [78] command returned 4
May 01 13:10 : client: [78] closed
May 01 13:10 : client: [77] process command "status"
May 01 13:10 : client: [77] command returned 0
May 01 13:10 : client: [77] process command "currentsong"
May 01 13:10 : client: [77] command returned 0
May 01 13:10 : client: [77] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:10 : client: [77] command returned 0
May 01 13:10 : client: [77] process command "close"
May 01 13:10 : client: [77] command returned 4
May 01 13:10 : client: [77] closed
May 01 13:10 : client: [79] opened from 127.0.0.1:47966
May 01 13:10 : client: [79] process command "status"
May 01 13:10 : client: [79] command returned 0
May 01 13:10 : client: [79] process command "idle"
May 01 13:10 : client: [79] command returned 1
May 01 13:10 : client: [80] opened from 127.0.0.1:47970
May 01 13:10 : client: [80] process command "playlistinfo"
May 01 13:10 : client: [80] command returned 0
May 01 13:10 : client: [80] process command "close"
May 01 13:10 : client: [80] command returned 4
May 01 13:10 : client: [80] closed
May 01 13:10 : client: [81] opened from 127.0.0.1:47974
May 01 13:10 : client: [81] process command "pause"
May 01 13:10 : client: [81] command returned 0
May 01 13:10 : output: closed "ALSA Default" (alsa)
May 01 13:10 : client: [79] process command "status"
May 01 13:10 : client: [79] command returned 0
May 01 13:10 : client: [79] process command "currentsong"
May 01 13:10 : client: [79] command returned 0
May 01 13:10 : client: [81] process command "close"
May 01 13:10 : client: [81] command returned 4
May 01 13:10 : client: [81] closed
May 01 13:10 : client: [79] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:10 : client: [79] command returned 0
May 01 13:10 : client: [79] process command "close"
May 01 13:10 : client: [79] command returned 4
May 01 13:10 : client: [79] closed
May 01 13:10 : client: [82] opened from 127.0.0.1:47978
May 01 13:10 : client: [82] process command "status"
May 01 13:10 : client: [82] command returned 0
May 01 13:10 : client: [82] process command "idle"
May 01 13:10 : client: [82] command returned 1
May 01 13:10 : client: [83] opened from 127.0.0.1:47982
May 01 13:10 : client: [83] process command "playlistinfo"
May 01 13:10 : client: [83] command returned 0
May 01 13:10 : client: [83] process command "close"
May 01 13:10 : client: [83] command returned 4
May 01 13:10 : client: [83] closed
May 01 13:10 : client: [84] opened from 127.0.0.1:47986
May 01 13:10 : client: [84] process command "status"
May 01 13:10 : client: [84] command returned 0
May 01 13:10 : client: [84] process command "currentsong"
May 01 13:10 : client: [84] command returned 0
May 01 13:10 : client: [84] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:10 : client: [84] command returned 0
May 01 13:10 : client: [84] process command "close"
May 01 13:10 : client: [84] command returned 4
May 01 13:10 : client: [84] closed
May 01 13:10 : client: [85] opened from 127.0.0.1:47990
May 01 13:10 : client: [85] process command "status"
May 01 13:10 : client: [85] command returned 0
May 01 13:10 : client: [85] process command "idle"
May 01 13:10 : client: [85] command returned 1
May 01 13:10 : client: [86] opened from 127.0.0.1:47994
May 01 13:10 : client: [86] process command list
May 01 13:10 : client: process command "status"
May 01 13:10 : client: command returned 0
May 01 13:10 : client: process command "currentsong"
May 01 13:10 : client: command returned 0
May 01 13:10 : client: [86] process command list returned 0
May 01 13:10 : client: [86] closed
May 01 13:10 : client: [87] opened from 127.0.0.1:47998
May 01 13:10 : client: [87] process command "stop"
May 01 13:10 : playlist: stop
May 01 13:10 : player: played "SDCARD/Stereo Test/LRMonoPhase4.flac"
May 01 13:10 : client: [87] command returned 0
May 01 13:10 : client: [87] process command list
May 01 13:10 : client: process command "status"
May 01 13:10 : client: command returned 0
May 01 13:10 : client: process command "currentsong"
May 01 13:10 : client: command returned 0
May 01 13:10 : client: [87] process command list returned 0
May 01 13:10 : client: [82] process command "status"
May 01 13:10 : client: [82] command returned 0
May 01 13:10 : client: [85] process command "status"
May 01 13:10 : client: [85] command returned 0
May 01 13:10 : client: [87] closed
May 01 13:10 : client: [85] process command "currentsong"
May 01 13:10 : client: [85] command returned 0
May 01 13:10 : client: [82] process command "currentsong"
May 01 13:10 : client: [82] command returned 0
May 01 13:10 : state_file: Saving state file /var/lib/mpd/state
May 01 13:11 : state_file: Loading state file /var/lib/mpd/state
May 01 13:11 : client: [0] opened from 127.0.0.1:48018
May 01 13:11 : client: [0] process command "close"
May 01 13:11 : client: [0] command returned 4
May 01 13:11 : client: [0] closed
May 01 13:11 : client: [1] opened from 127.0.0.1:48022
May 01 13:11 : client: [1] process command "setvol "75""
May 01 13:11 : client: [1] command returned 0
May 01 13:11 : client: [1] process command list
May 01 13:11 : client: process command "status"
May 01 13:11 : client: command returned 0
May 01 13:11 : client: process command "currentsong"
May 01 13:11 : client: command returned 0
May 01 13:11 : client: [1] process command list returned 0
May 01 13:11 : client: [1] closed
May 01 13:11 : client: [2] opened from 127.0.0.1:48042
May 01 13:11 : client: [2] process command "setvol "75""
May 01 13:11 : client: [2] command returned 0
May 01 13:11 : client: [2] process command list
May 01 13:11 : client: process command "status"
May 01 13:11 : client: command returned 0
May 01 13:11 : client: process command "currentsong"
May 01 13:11 : client: command returned 0
May 01 13:11 : client: [2] process command list returned 0
May 01 13:11 : client: [2] closed
May 01 13:11 : client: [3] opened from 127.0.0.1:48062
May 01 13:11 : client: [3] process command "outputs"
May 01 13:11 : client: [3] command returned 0
May 01 13:11 : client: [3] process command list
May 01 13:11 : client: process command "disableoutput "2""
May 01 13:11 : client: command returned 0
May 01 13:11 : client: [3] process command list returned 0
May 01 13:11 : client: [3] process command "outputs"
May 01 13:11 : client: [3] command returned 0
May 01 13:11 : client: [3] closed
May 01 13:11 : client: [4] opened from 127.0.0.1:48066
May 01 13:11 : client: [4] process command "status"
May 01 13:11 : client: [4] command returned 0
May 01 13:11 : client: [4] process command "currentsong"
May 01 13:11 : client: [4] command returned 0
May 01 13:11 : client: [4] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:11 : client: [4] command returned 0
May 01 13:11 : client: [4] process command "close"
May 01 13:11 : client: [4] command returned 4
May 01 13:11 : client: [4] closed
May 01 13:11 : client: [5] opened from 127.0.0.1:48070
May 01 13:11 : client: [5] process command "status"
May 01 13:11 : client: [5] command returned 0
May 01 13:11 : client: [5] process command "idle"
May 01 13:11 : client: [5] command returned 1
May 01 13:11 : client: [6] opened from 127.0.0.1:48074
May 01 13:11 : client: [6] process command "status"
May 01 13:11 : client: [6] command returned 0
May 01 13:11 : client: [6] process command "currentsong"
May 01 13:11 : client: [6] command returned 0
May 01 13:11 : client: [6] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:11 : client: [6] command returned 0
May 01 13:11 : client: [6] process command "close"
May 01 13:11 : client: [6] command returned 4
May 01 13:11 : client: [6] closed
May 01 13:11 : client: [7] opened from 127.0.0.1:48078
May 01 13:11 : client: [7] process command "status"
May 01 13:11 : client: [7] command returned 0
May 01 13:11 : client: [7] process command "idle"
May 01 13:11 : client: [7] command returned 1
May 01 13:11 : client: [8] opened from 127.0.0.1:48082
May 01 13:11 : client: [8] process command "status"
May 01 13:11 : client: [8] command returned 0
May 01 13:11 : client: [8] process command "currentsong"
May 01 13:11 : client: [8] command returned 0
May 01 13:11 : client: [8] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:11 : client: [8] command returned 0
May 01 13:11 : client: [8] process command "close"
May 01 13:11 : client: [8] command returned 4
May 01 13:11 : client: [8] closed
May 01 13:11 : client: [9] opened from 127.0.0.1:48086
May 01 13:11 : client: [9] process command "status"
May 01 13:11 : client: [9] command returned 0
May 01 13:11 : client: [9] process command "idle"
May 01 13:11 : client: [9] command returned 1
May 01 13:11 : client: [10] opened from 127.0.0.1:48090
May 01 13:11 : client: [10] process command "status"
May 01 13:11 : client: [10] command returned 0
May 01 13:11 : client: [10] process command "currentsong"
May 01 13:11 : client: [10] command returned 0
May 01 13:11 : client: [10] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:11 : client: [10] command returned 0
May 01 13:11 : client: [10] process command "close"
May 01 13:11 : client: [10] command returned 4
May 01 13:11 : client: [10] closed
May 01 13:11 : client: [11] opened from 127.0.0.1:48094
May 01 13:11 : client: [11] process command "status"
May 01 13:11 : client: [11] command returned 0
May 01 13:11 : client: [11] process command "idle"
May 01 13:11 : client: [11] command returned 1
May 01 13:12 : client: [12] opened from 127.0.0.1:48098
May 01 13:12 : client: [12] process command "status"
May 01 13:12 : client: [12] command returned 0
May 01 13:12 : client: [12] process command "currentsong"
May 01 13:12 : client: [12] command returned 0
May 01 13:12 : client: [12] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:12 : client: [12] command returned 0
May 01 13:12 : client: [12] process command "close"
May 01 13:12 : client: [12] command returned 4
May 01 13:12 : client: [12] closed
May 01 13:12 : client: [13] opened from 127.0.0.1:48102
May 01 13:12 : client: [13] process command "status"
May 01 13:12 : client: [13] command returned 0
May 01 13:12 : client: [13] process command "idle"
May 01 13:12 : client: [13] command returned 1
May 01 13:12 : client: [14] opened from 127.0.0.1:48106
May 01 13:12 : client: [14] process command "close"
May 01 13:12 : client: [14] command returned 4
May 01 13:12 : client: [14] closed
May 01 13:12 : client: [15] opened from 127.0.0.1:48110
May 01 13:12 : client: [15] process command "lsinfo"
May 01 13:12 : client: [15] command returned 0
May 01 13:12 : client: [15] process command "close"
May 01 13:12 : client: [15] command returned 4
May 01 13:12 : client: [15] closed
May 01 13:12 : client: [16] opened from 127.0.0.1:48114
May 01 13:12 : client: [16] process command "status"
May 01 13:12 : client: [16] command returned 0
May 01 13:12 : client: [16] process command "currentsong"
May 01 13:12 : client: [16] command returned 0
May 01 13:12 : client: [16] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:12 : client: [16] command returned 0
May 01 13:12 : client: [16] process command "close"
May 01 13:12 : client: [16] command returned 4
May 01 13:12 : client: [16] closed
May 01 13:12 : client: [17] opened from 127.0.0.1:48118
May 01 13:12 : client: [17] process command "status"
May 01 13:12 : client: [17] command returned 0
May 01 13:12 : client: [17] process command "idle"
May 01 13:12 : client: [17] command returned 1
May 01 13:12 : client: [18] opened from 127.0.0.1:48122
May 01 13:12 : client: [18] process command "playlistinfo"
May 01 13:12 : client: [18] command returned 0
May 01 13:12 : client: [18] process command "close"
May 01 13:12 : client: [18] command returned 4
May 01 13:12 : client: [18] closed
May 01 13:12 : client: [19] opened from 127.0.0.1:48126
May 01 13:12 : client: [19] process command "play"
May 01 13:12 : playlist: play 47:"SDCARD/Stereo Test/LRMonoPhase4.flac"
May 01 13:12 : client: [19] command returned 0
May 01 13:12 : decoder_thread: probing plugin flac
May 01 13:12 : decoder: audio_format=48000:16:2, seekable=true
May 01 13:12 : client: [19] process command "close"
May 01 13:12 : client: [19] command returned 4
May 01 13:12 : client: [19] closed
May 01 13:12 : alsa_output: opened _audioout type=COPY
May 01 13:12 : alsa_output: buffer: size=3840..16384 time=80000..341334
May 01 13:12 : alsa_output: period: size=1920..2048 time=40000..42667
May 01 13:12 : alsa_output: default period_time = buffer_time/4 = 341333/4 = 85333
May 01 13:12 : alsa_output: format=S24_LE (Signed 24 bit Little Endian)
May 01 13:12 : alsa_output: buffer_size=16384 period_size=2048
May 01 13:12 : output: opened "ALSA Default" (alsa) audio_format=48000:24:2
May 01 13:12 : output: converting in=48000:16:2 -> f=48000:24:2 -> out=48000:24:2
May 01 13:12 : client: [5] process command "status"
May 01 13:12 : client: [5] command returned 0
May 01 13:12 : client: [7] process command "status"
May 01 13:12 : client: [7] command returned 0
May 01 13:12 : client: [9] process command "status"
May 01 13:12 : client: [9] command returned 0
May 01 13:12 : client: [11] process command "status"
May 01 13:12 : client: [11] command returned 0
May 01 13:12 : client: [13] process command "status"
May 01 13:12 : client: [13] command returned 0
May 01 13:12 : client: [17] process command "status"
May 01 13:12 : client: [17] command returned 0
May 01 13:12 : client: [5] process command "currentsong"
May 01 13:12 : client: [5] command returned 0
May 01 13:12 : client: [7] process command "currentsong"
May 01 13:12 : client: [7] command returned 0
May 01 13:12 : client: [9] process command "currentsong"
May 01 13:12 : client: [9] command returned 0
May 01 13:12 : client: [11] process command "currentsong"
May 01 13:12 : client: [11] command returned 0
May 01 13:12 : client: [17] process command "currentsong"
May 01 13:12 : client: [17] command returned 0
May 01 13:12 : client: [13] process command "currentsong"
May 01 13:12 : client: [13] command returned 0
May 01 13:12 : exception: Failed to play on "ALSA Default" (alsa): snd_pcm_poll_descriptors_revents() failed: No such device
May 01 13:12 : exception: Failed to open audio output
May 01 13:12 : output: closed "ALSA Default" (alsa)
May 01 13:12 : client: [5] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:12 : client: [5] command returned 0
May 01 13:12 : client: [5] process command "close"
May 01 13:12 : client: [5] command returned 4
May 01 13:12 : client: [5] closed
May 01 13:12 : client: [7] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:12 : client: [7] command returned 0
May 01 13:12 : client: [7] process command "close"
May 01 13:12 : client: [7] command returned 4
May 01 13:12 : client: [7] closed
May 01 13:12 : client: [9] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:12 : client: [9] command returned 0
May 01 13:12 : client: [9] process command "close"
May 01 13:12 : client: [9] command returned 4
May 01 13:12 : client: [9] closed
May 01 13:12 : client: [11] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:12 : client: [11] command returned 0
May 01 13:12 : client: [11] process command "close"
May 01 13:12 : client: [11] command returned 4
May 01 13:12 : client: [11] closed
May 01 13:12 : client: [13] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:12 : client: [13] command returned 0
May 01 13:12 : client: [13] process command "close"
May 01 13:12 : client: [13] command returned 4
May 01 13:12 : client: [13] closed
May 01 13:12 : client: [17] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:12 : client: [17] command returned 0
May 01 13:12 : client: [17] process command "close"
May 01 13:12 : client: [17] command returned 4
May 01 13:12 : client: [17] closed
May 01 13:12 : client: [20] opened from 127.0.0.1:48130
May 01 13:12 : client: [20] process command "status"
May 01 13:12 : client: [20] command returned 0
May 01 13:12 : client: [20] process command "currentsong"
May 01 13:12 : client: [20] command returned 0
May 01 13:12 : client: [21] opened from 127.0.0.1:48134
May 01 13:12 : client: [21] process command "playlistinfo"
May 01 13:12 : client: [21] command returned 0
May 01 13:12 : client: [21] process command "close"
May 01 13:12 : client: [21] command returned 4
May 01 13:12 : client: [21] closed
May 01 13:12 : client: [20] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:12 : client: [20] command returned 0
May 01 13:12 : client: [20] process command "close"
May 01 13:12 : client: [20] command returned 4
May 01 13:12 : client: [20] closed
May 01 13:12 : client: [22] opened from 127.0.0.1:48138
May 01 13:12 : client: [22] process command "playlistinfo"
May 01 13:12 : client: [22] command returned 0
May 01 13:12 : client: [22] process command "close"
May 01 13:12 : client: [22] command returned 4
May 01 13:12 : client: [22] closed
May 01 13:12 : client: [23] opened from 127.0.0.1:48142
May 01 13:12 : client: [23] process command "status"
May 01 13:12 : client: [23] command returned 0
May 01 13:12 : client: [23] process command "idle"
May 01 13:12 : client: [23] command returned 1
May 01 13:13 : client: [23] closed
May 01 13:13 : state_file: Saving state file /var/lib/mpd/state
May 01 13:13 : player: played "SDCARD/Stereo Test/LRMonoPhase4.flac"
May 01 13:13 : state_file: Loading state file /var/lib/mpd/state
May 01 13:13 : decoder_thread: probing plugin flac
May 01 13:13 : decoder: audio_format=48000:16:2, seekable=true
May 01 13:13 : client: [0] opened from 127.0.0.1:48210
May 01 13:13 : client: [1] opened from 127.0.0.1:48214
May 01 13:13 : client: [1] process command "outputs"
May 01 13:13 : client: [1] command returned 0
May 01 13:13 : client: [1] process command list
May 01 13:13 : client: process command "enableoutput "0""
May 01 13:13 : client: command returned 0
May 01 13:13 : client: process command "disableoutput "1""
May 01 13:13 : client: command returned 0
May 01 13:13 : client: process command "disableoutput "2""
May 01 13:13 : client: command returned 0
May 01 13:13 : client: [1] process command list returned 0
May 01 13:13 : client: [1] process command "outputs"
May 01 13:13 : client: [1] command returned 0
May 01 13:13 : client: [1] closed
May 01 13:13 : client: [2] opened from 127.0.0.1:48218
May 01 13:13 : client: [2] process command "outputs"
May 01 13:13 : client: [2] command returned 0
May 01 13:13 : client: [2] process command list
May 01 13:13 : client: process command "disableoutput "2""
May 01 13:13 : client: command returned 0
May 01 13:13 : client: [2] process command list returned 0
May 01 13:13 : client: [2] process command "outputs"
May 01 13:13 : client: [2] command returned 0
May 01 13:13 : client: [2] closed
May 01 13:13 : client: [0] process command "outputs"
May 01 13:13 : client: [0] command returned 0
May 01 13:13 : client: [0] process command "crossfade 0"
May 01 13:13 : client: [0] command returned 0
May 01 13:13 : client: [3] opened from 127.0.0.1:48222
May 01 13:13 : client: [3] process command "stop"
May 01 13:13 : playlist: stop
May 01 13:13 : player: played "SDCARD/Stereo Test/LRMonoPhase4.flac"
May 01 13:13 : client: [3] command returned 0
May 01 13:13 : client: [3] process command list
May 01 13:13 : client: process command "status"
May 01 13:13 : client: command returned 0
May 01 13:13 : client: process command "currentsong"
May 01 13:13 : client: command returned 0
May 01 13:13 : client: [3] process command list returned 0
May 01 13:13 : client: [3] closed
May 01 13:13 : client: [4] opened from 127.0.0.1:48226
May 01 13:13 : client: [4] process command "setvol "75""
May 01 13:13 : client: [4] command returned 0
May 01 13:13 : client: [4] process command list
May 01 13:13 : client: process command "status"
May 01 13:13 : client: command returned 0
May 01 13:13 : client: process command "currentsong"
May 01 13:13 : client: command returned 0
May 01 13:13 : client: [4] process command list returned 0
May 01 13:13 : client: [4] closed
May 01 13:13 : client: [0] process command "stop"
May 01 13:13 : client: [0] command returned 0
May 01 13:13 : client: [0] process command "close"
May 01 13:13 : client: [0] command returned 4
May 01 13:13 : client: [0] closed
May 01 13:13 : client: [5] opened from 127.0.0.1:48234
May 01 13:13 : client: [6] opened from 127.0.0.1:48230
May 01 13:13 : client: [6] process command "playlistinfo"
May 01 13:13 : client: [6] command returned 0
May 01 13:13 : client: [5] process command "status"
May 01 13:13 : client: [5] command returned 0
May 01 13:13 : client: [5] process command "currentsong"
May 01 13:13 : client: [5] command returned 0
May 01 13:13 : client: [6] process command "close"
May 01 13:13 : client: [6] command returned 4
May 01 13:13 : client: [6] closed
May 01 13:13 : client: [7] opened from 127.0.0.1:48238
May 01 13:13 : client: [7] process command "playlistinfo"
May 01 13:13 : client: [7] command returned 0
May 01 13:13 : client: [7] process command "close"
May 01 13:13 : client: [7] command returned 4
May 01 13:13 : client: [7] closed
May 01 13:13 : client: [8] opened from 127.0.0.1:48242
May 01 13:13 : client: [8] process command "playlistinfo"
May 01 13:13 : client: [8] command returned 0
May 01 13:13 : client: [8] process command "close"
May 01 13:13 : client: [8] command returned 4
May 01 13:13 : client: [8] closed
May 01 13:13 : client: [9] opened from 127.0.0.1:48246
May 01 13:13 : client: [9] process command "playlistinfo"
May 01 13:13 : client: [9] command returned 0
May 01 13:13 : client: [9] process command "close"
May 01 13:13 : client: [9] command returned 4
May 01 13:13 : client: [9] closed
May 01 13:13 : client: [5] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:13 : client: [5] command returned 0
May 01 13:13 : client: [5] process command "close"
May 01 13:13 : client: [5] command returned 4
May 01 13:13 : client: [5] closed
May 01 13:13 : client: [10] opened from 127.0.0.1:48250
May 01 13:13 : client: [10] process command "playlistinfo"
May 01 13:13 : client: [10] command returned 0
May 01 13:13 : client: [11] opened from 127.0.0.1:48254
May 01 13:13 : client: [11] process command "status"
May 01 13:13 : client: [11] command returned 0
May 01 13:13 : client: [11] process command "idle"
May 01 13:13 : client: [11] command returned 1
May 01 13:13 : client: [10] process command "close"
May 01 13:13 : client: [10] command returned 4
May 01 13:13 : client: [10] closed
May 01 13:13 : client: [12] opened from 127.0.0.1:48258
May 01 13:13 : client: [12] process command "playlistinfo"
May 01 13:13 : client: [12] command returned 0
May 01 13:13 : client: [12] process command "close"
May 01 13:13 : client: [12] command returned 4
May 01 13:13 : client: [12] closed
May 01 13:13 : client: [13] opened from 127.0.0.1:48262
May 01 13:13 : client: [13] process command "play"
May 01 13:13 : playlist: play 47:"SDCARD/Stereo Test/LRMonoPhase4.flac"
May 01 13:13 : decoder_thread: probing plugin flac
May 01 13:13 : decoder: audio_format=48000:16:2, seekable=true
May 01 13:13 : alsa_output: opened _audioout type=COPY
May 01 13:13 : alsa_output: buffer: size=3840..16384 time=80000..341334
May 01 13:13 : alsa_output: period: size=1920..2048 time=40000..42667
May 01 13:13 : alsa_output: default period_time = buffer_time/4 = 341333/4 = 85333
May 01 13:13 : alsa_output: format=S24_LE (Signed 24 bit Little Endian)
May 01 13:13 : alsa_output: buffer_size=16384 period_size=2048
May 01 13:13 : output: opened "ALSA Default" (alsa) audio_format=48000:24:2
May 01 13:13 : output: converting in=48000:16:2 -> f=48000:24:2 -> out=48000:24:2
May 01 13:13 : client: [13] command returned 0
May 01 13:13 : client: [13] process command "close"
May 01 13:13 : client: [13] command returned 4
May 01 13:13 : client: [13] closed
May 01 13:13 : client: [11] process command "status"
May 01 13:13 : client: [11] command returned 0
May 01 13:13 : client: [11] process command "currentsong"
May 01 13:13 : client: [11] command returned 0
May 01 13:13 : exception: Failed to play on "ALSA Default" (alsa): snd_pcm_poll_descriptors_revents() failed: No such device
May 01 13:13 : exception: Failed to open audio output
May 01 13:13 : output: closed "ALSA Default" (alsa)
May 01 13:13 : client: [11] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:13 : client: [11] command returned 0
May 01 13:13 : client: [11] process command "close"
May 01 13:13 : client: [11] command returned 4
May 01 13:13 : client: [11] closed
May 01 13:13 : client: [14] opened from 127.0.0.1:48266
May 01 13:13 : client: [14] process command "status"
May 01 13:13 : client: [14] command returned 0
May 01 13:13 : client: [14] process command "currentsong"
May 01 13:13 : client: [14] command returned 0
May 01 13:13 : client: [15] opened from 127.0.0.1:48270
May 01 13:13 : client: [15] process command "playlistinfo"
May 01 13:13 : client: [15] command returned 0
May 01 13:13 : client: [15] process command "close"
May 01 13:13 : client: [15] command returned 4
May 01 13:13 : client: [15] closed
May 01 13:13 : client: [14] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:13 : client: [14] command returned 0
May 01 13:13 : client: [14] process command "close"
May 01 13:13 : client: [14] command returned 4
May 01 13:13 : client: [14] closed
May 01 13:13 : client: [16] opened from 127.0.0.1:48274
May 01 13:13 : client: [16] process command "playlistinfo"
May 01 13:13 : client: [16] command returned 0
May 01 13:13 : client: [16] process command "close"
May 01 13:13 : client: [16] command returned 4
May 01 13:13 : client: [16] closed
May 01 13:13 : client: [17] opened from 127.0.0.1:48278
May 01 13:13 : client: [17] process command "status"
May 01 13:13 : client: [17] command returned 0
May 01 13:13 : client: [17] process command "idle"
May 01 13:13 : client: [17] command returned 1
May 01 13:15 : state_file: Saving state file /var/lib/mpd/state
May 01 13:17 : client: [18] opened from 127.0.0.1:48282
May 01 13:17 : client: [18] process command "play"
May 01 13:17 : alsa_output: opened _audioout type=COPY
May 01 13:17 : alsa_output: buffer: size=3840..16384 time=80000..341334
May 01 13:17 : alsa_output: period: size=1920..2048 time=40000..42667
May 01 13:17 : alsa_output: default period_time = buffer_time/4 = 341333/4 = 85333
May 01 13:17 : alsa_output: format=S24_LE (Signed 24 bit Little Endian)
May 01 13:17 : alsa_output: buffer_size=16384 period_size=2048
May 01 13:17 : output: opened "ALSA Default" (alsa) audio_format=48000:24:2
May 01 13:17 : output: converting in=48000:16:2 -> f=48000:24:2 -> out=48000:24:2
May 01 13:17 : client: [18] command returned 0
May 01 13:17 : client: [18] process command "close"
May 01 13:17 : client: [18] command returned 4
May 01 13:17 : client: [18] closed
May 01 13:17 : client: [17] process command "status"
May 01 13:17 : client: [17] command returned 0
May 01 13:17 : client: [17] process command "currentsong"
May 01 13:17 : client: [17] command returned 0
May 01 13:17 : exception: Failed to play on "ALSA Default" (alsa): snd_pcm_poll_descriptors_revents() failed: No such device
May 01 13:17 : output: closed "ALSA Default" (alsa)
May 01 13:17 : exception: Failed to open audio output
May 01 13:17 : client: [17] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:17 : client: [17] command returned 0
May 01 13:17 : client: [17] process command "close"
May 01 13:17 : client: [17] command returned 4
May 01 13:17 : client: [17] closed
May 01 13:17 : client: [19] opened from 127.0.0.1:48286
May 01 13:17 : client: [19] process command "status"
May 01 13:17 : client: [19] command returned 0
May 01 13:17 : client: [19] process command "currentsong"
May 01 13:17 : client: [19] command returned 0
May 01 13:17 : client: [20] opened from 127.0.0.1:48290
May 01 13:17 : client: [20] process command "playlistinfo"
May 01 13:17 : client: [20] command returned 0
May 01 13:17 : client: [20] process command "close"
May 01 13:17 : client: [20] command returned 4
May 01 13:17 : client: [20] closed
May 01 13:17 : client: [19] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:17 : client: [19] command returned 0
May 01 13:17 : client: [19] process command "close"
May 01 13:17 : client: [19] command returned 4
May 01 13:17 : client: [19] closed
May 01 13:17 : client: [21] opened from 127.0.0.1:48294
May 01 13:17 : client: [21] process command "playlistinfo"
May 01 13:17 : client: [21] command returned 0
May 01 13:17 : client: [21] process command "close"
May 01 13:17 : client: [21] command returned 4
May 01 13:17 : client: [21] closed
May 01 13:17 : client: [22] opened from 127.0.0.1:48298
May 01 13:17 : client: [22] process command "status"
May 01 13:17 : client: [22] command returned 0
May 01 13:17 : client: [22] process command "idle"
May 01 13:17 : client: [22] command returned 1
May 01 13:19 : state_file: Saving state file /var/lib/mpd/state
May 01 13:31 : client: [23] opened from 127.0.0.1:48302
May 01 13:31 : client: [23] process command "subscribe dumy_channel"
May 01 13:31 : client: [23] command returned 0
May 01 13:31 : client: [22] process command "status"
May 01 13:31 : client: [22] command returned 0
May 01 13:31 : client: [22] process command "currentsong"
May 01 13:31 : client: [22] command returned 0
May 01 13:31 : client: [23] process command "close"
May 01 13:31 : client: [23] command returned 4
May 01 13:31 : client: [23] closed
May 01 13:31 : client: [22] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:31 : client: [22] command returned 0
May 01 13:31 : client: [22] process command "close"
May 01 13:31 : client: [22] command returned 4
May 01 13:31 : client: [22] closed
May 01 13:31 : client: [24] opened from 127.0.0.1:48306
May 01 13:31 : client: [24] process command "playlistinfo"
May 01 13:31 : client: [24] command returned 0
May 01 13:31 : client: [24] process command "close"
May 01 13:31 : client: [24] command returned 4
May 01 13:31 : client: [24] closed
May 01 13:31 : client: [25] opened from 127.0.0.1:48310
May 01 13:31 : client: [25] process command "status"
May 01 13:31 : client: [25] command returned 0
May 01 13:31 : client: [25] process command "idle"
May 01 13:31 : client: [25] command returned 1
May 01 13:32 : client: [26] opened from 127.0.0.1:48314
May 01 13:32 : client: [26] process command "subscribe dumy_channel"
May 01 13:32 : client: [26] command returned 0
May 01 13:32 : client: [25] process command "status"
May 01 13:32 : client: [25] command returned 0
May 01 13:32 : client: [25] process command "currentsong"
May 01 13:32 : client: [25] command returned 0
May 01 13:32 : client: [26] process command "close"
May 01 13:32 : client: [26] command returned 4
May 01 13:32 : client: [26] closed
May 01 13:32 : client: [25] process command "lsinfo "SDCARD/Stereo Test/LRMonoPhase4.flac""
May 01 13:32 : client: [25] command returned 0
May 01 13:32 : client: [25] process command "close"
May 01 13:32 : client: [25] command returned 4
May 01 13:32 : client: [25] closed
May 01 13:32 : client: [27] opened from 127.0.0.1:48318
May 01 13:32 : client: [27] process command "playlistinfo"
May 01 13:32 : client: [27] command returned 0
May 01 13:32 : client: [27] process command "close"
May 01 13:32 : client: [27] command returned 4
May 01 13:32 : client: [27] closed
May 01 13:32 : client: [28] opened from 127.0.0.1:48322
May 01 13:32 : client: [28] process command "play"
May 01 13:32 : alsa_output: opened _audioout type=COPY
May 01 13:32 : alsa_output: buffer: size=3840..16384 time=80000..341334
May 01 13:32 : alsa_output: period: size=1920..2048 time=40000..42667
May 01 13:32 : alsa_output: default period_time = buffer_time/4 = 341333/4 = 85333
May 01 13:32 : alsa_output: format=S24_LE (Signed 24 bit Little Endian)
May 01 13:32 : alsa_output: buffer_size=16384 period_size=2048
May 01 13:32 : output: opened "ALSA Default" (alsa) audio_format=48000:24:2
May 01 13:32 : output: converting in=48000:16:2 -> f=48000:24:2 -> out=48000:24:2
May 01 13:32 : client: [28] command returned 0
May 01 13:32 : client: [28] process command "close"
May 01 13:32 : client: [28] command returned 4
May 01 13:32 : client: [28] closed
May 01 13:32 : exception: Failed to play on "ALSA Default" (alsa): snd_pcm_poll_descriptors_revents() failed: No such device
May 01 13:32 : output: closed "ALSA Default" (alsa)
May 01 13:32 : exception: Failed to open audio output
May 01 13:32 : client: [29] opened from 127.0.0.1:48326
May 01 13:32 : client: [29] process command "status"
May 01 13:32 : client: [29] command returned 0
May 01 13:32 : client: [29] process command "idle"
May 01 13:32 : client: [29] command returned 1
May 01 13:34 : state_file: Saving state file /var/lib/mpd/state
Find
Reply
katariat Offline
Junior Member
*
Posts: 9
Threads: 0
Joined: Apr 2021
Reputation: 0
#20
05-01-2021, 06:10 PM
hi bitlab, i was also reviewing the log file and it seems that alsa is not finding the playback device...i typed alsamixer and saw the playback was defaulting it to HDMI. Been trying to save and move it to the audio jack but without luck
Find
Reply


Forum Jump: