Thank you for your donation!


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


Problem: Popping sound during playback
#5
Hi Tim,

Here's what I did:

1) Put a single FLAC 24/88.2 file on the USB stick
2) Plug the stick to Pi, rescan
3) Reboot
4) After reboot, click play on the web UI
5) Once the glitch occur around 3 or 4 times (1 minute 30 seconds in), click pause
6) Obtain the logs

I did a few reboots between step 3 to step 4 to get the process down right. The log files are as such:

1) Menu, Configure, System | Menu, System info


Code:
System information

            
      S Y S T E M    P A R A M E T E R S  

    Date and time    = 2018-05-24 13:02:26
    System uptime    = up 2 minutes
    Timezone    = America/Detroit
    moOde        = Release 4.1 2018-04-02

    Host name    = moode
    ETH0  IP    = 192.168.1.160
    ETH0  MAC    = b8:27:eb:61:49:c8
    WLAN0 IP    = unassigned
    WLAN0 MAC    = no adapter
    WiFi country    = SG

    HDWR REV    = Pi-3B 1GB v1.2
    SoC         = BCM2835
    CORES        = 4
    ARCH        = armv7l
    RASPBIAN    = 9.4
    KERNEL        = 4.14.32-v7+
    KTIMER FREQ    = 100 Hz
    USB BOOT    = not enabled
    Warranty    = OK

    ROOT size    = 7.2G
    ROOT used     = 30%
    ROOT avail    = 4.9G
    FS expand    = expanded
    MEM free     = 656 MB
    MEM used     = 56 MB
    Temperature     = 55.8°C
 
    CPU GOV        = performance
    MPD SCHDPOL    = TS
    P3-WIFI        = Off
    P3-BT        = Off
    HDMI        = Off
    ETH0 CHECK    = On
    MAX USB CUR    = Off
    UAC2 FIX    = On
    SSH server    = Off

    LED0        = on
    LED1        = on

      C O R E    S E R V E R S  

    PHP-FPM        = 7.0.27
    NGINX        = 1.10.3
    SQLite        = 3.16.2
    Bluetooth    = 5.49

      C P U    L O A D  

    CPU    %usr    %sys    %idle
    all    0.88    0.63    98.49
    0    0.00    0.00    100.00
    1    1.00    1.00    98.00
    2    0.00    1.49    98.51
    3    2.50    0.00    97.50

      P R O C E S S    L O A D  

    PRI RTPRIO COMMAND         %MEM PSR %CPU
     19      - sysinfo.sh       0.2   1  3.5
     29      - mpd              2.5   3  2.9
     19      - systemd          0.6   0  2.0
     19      - kworker/1:1      0.0   1  0.8
     19      - systemd-journal  0.4   2  0.6
     19      - sudo             0.3   3  0.5
     19      - systemd-udevd    0.3   0  0.4
     19      - php-fpm7.0       1.1   2  0.4
     19      - mmcqd/0          0.0   0  0.3

      C L O C K    F R E Q U E N C I E S  

         arm   = 600 MHz               pwm   = 0 MHz
         core  = 250 MHz               emmc  = 200 MHz
         h264  = 250 MHz               pixel = 0 MHz
         isp   = 250 MHz               vec   = 0 MHz
         v3d   = 250 MHz               hdmi  = 0 MHz
         uart  = 47 MHz               dpi   = 0 MHz

    SD card    = 50 MHz

      S Y S T E M    V O L T A G E S  

    core            = 1.2000V
    sdram controller    = 1.2000V
    sdram I/O        = 1.2000V
    sdram chip        = 1.2250V

      U I  C U S T O M I Z A T I O N S  

    Theme            = Standard
    Accent color        = Emerald
    Alpha blend        = 1.0
    Adaptive background    = No
    Background image    = No
    Playback history    = No
    Extra metadata        = Yes
    Library            = Use Artist

      A U D I O    P A R A M E T E R S  

    Audio device        = USB audio device
    Interface        = USB
    Hdwr volume        =
    Mixer name        = PCM
    Output stream        = Closed
    ALSA version        = 1.1.3-5+rpi3
    SoX version        = 0.1.2-2

    Volume knob        = 0
    Volume mute        = Unmuted

    Bluetooth controller    = Off
    Airplay receiver    = Off
    Squeezelite        = Off
    UPnP renderer        = On
    DLNA server        = Off

    Rotary encoder        = Off
    Encoder params        = 100 2 3 4 5
    Crossfeed        = Off
    Parametric EQ        = Off
    Graphic EQ        = Off
    Auto-shuffle        = Off
    Autoplay        = Off
    MPD crossfade        = Off

      M P D    S E T T I N G S  

    Version            = 0.20.18
    Volume control        = disabled
    ALSA device        = hw:1
    SoX resampling        = disabled
    SoX quality        = very high
    SoX multithreading    = off
    Audio buffer (kb)    = 4096
    Buffer before play    = 30%
    Output buffer size (kb)    = 81920
    Volume normalization    = no
    DSD over PCM (DoP)    = no
    Replay gain        = off

      A I R P L A Y    S E T T I N G S  

    Version            = 3.1.7
    Friendly name        = Moode Airplay
    ALSA device        = hw:1
    Volume mixer        = auto
    Resume MPD after    = No
    Output bit depth    = S16
    Output sample rate    = 44100
    Session interruption    = no
    Session timeout (ms)    = 120
    Audio buffer (secs)    = 0.0

      S Q U E E Z E L I T E    S E T T I N G S  

    Version            = 1.8.7-1052 "DSD/SRC enabled"
    Friendly name        = Moode
    ALSA device        = hw:0
    ALSA params        = 80:4::1
    Output buffers        = 40000:100000
    Task priority        = 45
    Codec list        = flac,pcm,mp3,ogg,aac,alac,dsd
    Other options        = -W -D 500 -R E

      M O O D E    L O G  

    20180524 130026 worker: - Start
    20180524 130027 worker: Successfully daemonized
    20180524 130027 worker: - Init
    20180524 130027 worker: Session loaded
    20180524 130027 worker: Debug logging (on)
    20180524 130028 worker: Host (moode)
    20180524 130028 worker: Hdwr (Pi-3B 1GB v1.2)
    20180524 130028 worker: Arch (armv7l)
    20180524 130028 worker: Rasp (9.4)
    20180524 130028 worker: Kver (4.14.32-v7+)
    20180524 130028 worker: Ktyp (Standard)
    20180524 130028 worker: Gov  (performance)
    20180524 130028 worker: Rel  (Moode 4.1 2018-04-02)
    20180524 130028 worker: Upd  (None)
    20180524 130028 worker: MPD  (0.20.18)
    20180524 130028 worker: USB boot not enabled yet
    20180524 130028 worker: File system expanded
    20180524 130028 worker: HDMI port off
    20180524 130029 worker: File check ok
    20180524 130029 worker: - Network
    20180524 130029 worker: eth0 exists
    20180524 130029 worker: eth0 (192.168.1.160)
    20180524 130029 worker: wlan0 does not exist
    20180524 130029 worker: - Audio
    20180524 130029 worker: ALSA outputs unmuted
    20180524 130029 worker: Audio output (USB audio device)
    20180524 130029 worker: ALSA mixer name (PCM)
    20180524 130029 worker: MPD volume control (disabled)
    20180524 130030 worker: Hdwr volume controller exists
    20180524 130030 worker: - Services
    20180524 130032 worker: MPD started
    20180524 130032 worker: MPD scheduler policy (time-share)
    20180524 130032 worker: Configure MPD outputs
    20180524 130032 readMpdResponse(): reading response
    20180524 130032 readMpdResponse(): success $str=(OK MPD 0.20.0)
    20180524 130032 readMpdResponse(): success $resp[0]=(OK MPD 0.20.0)
    20180524 130032 readMpdResponse(): reading response
    20180524 130032 readMpdResponse(): success $str=(OK)
    20180524 130032 readMpdResponse(): success $resp[0]=(outputid: 0)
    20180524 130032 worker: MPD output 1 ALSA default (on)
    20180524 130032 worker: MPD output 2 ALSA crossfeed (off)
    20180524 130032 worker: MPD output 3 ALSA parametric eq (off)
    20180524 130032 worker: MPD output 4 ALSA graphic eq (off)
    20180524 130032 worker: MPD output 5 ALSA bluetooth (off)
    20180524 130032 worker: MPD crossfade (off)
    20180524 130032 worker: UPnP renderer started
    20180524 130032 worker: - Last
    20180524 130032 worker: USB source (NEW VOLUME)
    20180524 130032 worker: NAS sources (none configured)
    20180524 130032 worker: Volume level (0) restored
    20180524 130032 readMpdResponse(): reading response
    20180524 130032 readMpdResponse(): success $str=(OK)
    20180524 130032 readMpdResponse(): success $resp[0]=(OK)
    20180524 130032 worker: Maintenance interval (21600)
    20180524 130032 worker: Watchdog started
    20180524 130032 worker: Ready
    20180524 130032 engine-mpd: Connect
    20180524 130032 engine-mpd: Session loaded
    20180524 130032 engine-mpd: Open socket
    20180524 130032 readMpdResponse(): reading response
    20180524 130032 readMpdResponse(): success $str=(OK MPD 0.20.0)
    20180524 130032 readMpdResponse(): success $resp[0]=(OK MPD 0.20.0)
    20180524 130032 engine-mpd: Get initial status
    20180524 130032 readMpdResponse(): reading response
    20180524 130032 readMpdResponse(): success $str=(OK)
    20180524 130032 readMpdResponse(): success $resp[0]=(volume: -1)
    20180524 130032 engine-mpd: UI state=(stop), MPD state=(stop)
    20180524 130032 engine-mpd: Idle
    20180524 130032 engine-mpd: Wait for idle timeout
    20180524 130032 readMpdResponse(): reading response
    20180524 130033 engine-mpd: Connect
    20180524 130033 engine-mpd: Session loaded
    20180524 130033 engine-mpd: Open socket
    20180524 130033 readMpdResponse(): reading response
    20180524 130033 readMpdResponse(): success $str=(OK MPD 0.20.0)
    20180524 130033 readMpdResponse(): success $resp[0]=(OK MPD 0.20.0)
    20180524 130033 engine-mpd: Get initial status
    20180524 130033 readMpdResponse(): reading response
    20180524 130033 readMpdResponse(): success $str=(OK)
    20180524 130033 readMpdResponse(): success $resp[0]=(volume: -1)
    20180524 130033 engine-mpd: UI state=(stop), MPD state=(stop)
    20180524 130033 engine-mpd: Idle
    20180524 130033 engine-mpd: Wait for idle timeout
    20180524 130033 readMpdResponse(): reading response
    20180524 130034 readMpdResponse(): reading response
    20180524 130034 readMpdResponse(): success $str=(OK MPD 0.20.0)
    20180524 130034 readMpdResponse(): success $resp[0]=(OK MPD 0.20.0)
    20180524 130034 readMpdResponse(): reading response
    20180524 130034 readMpdResponse(): success $str=(OK)
    20180524 130034 readMpdResponse(): success $resp[0]=(OK)
    20180524 130034 readMpdResponse(): success $str=(OK)
    20180524 130034 readMpdResponse(): success $resp[0]=(changed: player)
    20180524 130034 engine-mpd: resp[0]=(changed: player)
    20180524 130034 engine-mpd: Get new status
    20180524 130034 readMpdResponse(): reading response
    20180524 130034 readMpdResponse(): success $str=(OK)
    20180524 130034 readMpdResponse(): success $resp[0]=(volume: -1)
    20180524 130034 engine-mpd: Idle timeout event=(changed: player)
    20180524 130034 engine-mpd: Generating enhanced metadata
    20180524 130034 readMpdResponse(): reading response
    20180524 130034 readMpdResponse(): success $str=(OK)
    20180524 130034 readMpdResponse(): success $str=(OK)
    20180524 130034 readMpdResponse(): success $resp[0]=(file: USB/NEW VOLUME/test.flac)
    20180524 130034 readMpdResponse(): success $resp[0]=(changed: player)
    20180524 130034 engine-mpd: resp[0]=(changed: player)
    20180524 130034 avprobe -show_streams "/var/lib/mpd/music/USB/NEW VOLUME/test.flac" 2>&1 | egrep "codec_name|sample_fmt|sample_rate|channels|bits_per_raw_sample"
    20180524 130034 engine-mpd: Get new status
    20180524 130034 readMpdResponse(): reading response
    20180524 130034 readMpdResponse(): success $str=(OK)
    20180524 130034 readMpdResponse(): success $resp[0]=(volume: -1)
    20180524 130034 engine-mpd: Idle timeout event=(changed: player)
    20180524 130034 engine-mpd: Generating enhanced metadata
    20180524 130034 readMpdResponse(): reading response
    20180524 130034 readMpdResponse(): success $str=(OK)
    20180524 130034 readMpdResponse(): success $resp[0]=(file: USB/NEW VOLUME/test.flac)
    20180524 130034 avprobe -show_streams "/var/lib/mpd/music/USB/NEW VOLUME/test.flac" 2>&1 | egrep "codec_name|sample_fmt|sample_rate|channels|bits_per_raw_sample"
    20180524 130035 enhanceMetadata(): coverurl: (/coverart.php/USB%2FNEW%20VOLUME%2Ftest.flac)
    20180524 130035 enhanceMetadata(): Song file
    20180524 130035 engine-mpd: Metadata returned to client: Size=(30)
    20180524 130035 enhanceMetadata(): coverurl: (/coverart.php/USB%2FNEW%20VOLUME%2Ftest.flac)
    20180524 130035 enhanceMetadata(): Song file
    20180524 130035 engine-mpd: Metadata returned to client: Size=(30)
    20180524 130036 engine-mpd: Connect
    20180524 130036 engine-mpd: Session loaded
    20180524 130036 engine-mpd: Open socket
    20180524 130036 readMpdResponse(): reading response
    20180524 130036 readMpdResponse(): success $str=(OK MPD 0.20.0)
    20180524 130036 readMpdResponse(): success $resp[0]=(OK MPD 0.20.0)
    20180524 130036 engine-mpd: Get initial status
    20180524 130036 readMpdResponse(): reading response
    20180524 130036 readMpdResponse(): success $str=(OK)
    20180524 130036 readMpdResponse(): success $resp[0]=(volume: -1)
    20180524 130036 engine-mpd: UI state=(play), MPD state=(play)
    20180524 130036 engine-mpd: Idle
    20180524 130036 engine-mpd: Wait for idle timeout
    20180524 130036 readMpdResponse(): reading response
    20180524 130036 engine-mpd: Connect
    20180524 130036 engine-mpd: Session loaded
    20180524 130036 engine-mpd: Open socket
    20180524 130036 readMpdResponse(): reading response
    20180524 130036 readMpdResponse(): success $str=(OK MPD 0.20.0)
    20180524 130036 readMpdResponse(): success $resp[0]=(OK MPD 0.20.0)
    20180524 130036 engine-mpd: Get initial status
    20180524 130036 readMpdResponse(): reading response
    20180524 130036 readMpdResponse(): success $str=(OK)
    20180524 130036 readMpdResponse(): success $resp[0]=(volume: -1)
    20180524 130036 engine-mpd: UI state=(play), MPD state=(play)
    20180524 130036 engine-mpd: Idle
    20180524 130036 engine-mpd: Wait for idle timeout
    20180524 130036 readMpdResponse(): reading response
    20180524 130218 readMpdResponse(): reading response
    20180524 130218 readMpdResponse(): success $str=(OK MPD 0.20.0)
    20180524 130218 readMpdResponse(): success $resp[0]=(OK MPD 0.20.0)
    20180524 130218 readMpdResponse(): reading response
    20180524 130218 readMpdResponse(): success $str=(OK)
    20180524 130218 readMpdResponse(): success $resp[0]=(changed: player)
    20180524 130218 readMpdResponse(): success $str=(OK)
    20180524 130218 engine-mpd: resp[0]=(changed: player)
    20180524 130218 readMpdResponse(): success $resp[0]=(changed: player)
    20180524 130218 engine-mpd: Get new status
    20180524 130218 engine-mpd: resp[0]=(changed: player)
    20180524 130218 engine-mpd: Get new status
    20180524 130218 readMpdResponse(): reading response
    20180524 130218 readMpdResponse(): reading response
    20180524 130218 readMpdResponse(): success $str=(OK)
    20180524 130218 readMpdResponse(): success $resp[0]=(volume: -1)
    20180524 130218 readMpdResponse(): success $str=(OK)
    20180524 130218 readMpdResponse(): success $resp[0]=(volume: -1)
    20180524 130218 engine-mpd: Idle timeout event=(changed: player)
    20180524 130218 engine-mpd: Idle timeout event=(changed: player)
    20180524 130218 engine-mpd: Generating enhanced metadata
    20180524 130218 engine-mpd: Generating enhanced metadata
    20180524 130218 readMpdResponse(): reading response
    20180524 130218 readMpdResponse(): reading response
    20180524 130218 readMpdResponse(): success $str=(OK)
    20180524 130218 readMpdResponse(): success $str=(OK)
    20180524 130218 readMpdResponse(): success $resp[0]=(file: USB/NEW VOLUME/test.flac)
    20180524 130218 readMpdResponse(): success $resp[0]=(file: USB/NEW VOLUME/test.flac)
    20180524 130218 enhanceMetadata(): coverurl: (/coverart.php/USB%2FNEW%20VOLUME%2Ftest.flac)
    20180524 130218 enhanceMetadata(): coverurl: (/coverart.php/USB%2FNEW%20VOLUME%2Ftest.flac)
    20180524 130218 enhanceMetadata(): Song file
    20180524 130218 enhanceMetadata(): Song file
    20180524 130218 engine-mpd: Metadata returned to client: Size=(30)
    20180524 130218 engine-mpd: Metadata returned to client: Size=(30)
    20180524 130218 readMpdResponse(): success $str=(OK)
    20180524 130218 readMpdResponse(): success $resp[0]=(OK)
    20180524 130218 engine-mpd: Connect
    20180524 130218 engine-mpd: Session loaded
    20180524 130218 engine-mpd: Open socket
    20180524 130218 readMpdResponse(): reading response
    20180524 130218 readMpdResponse(): success $str=(OK MPD 0.20.0)
    20180524 130218 readMpdResponse(): success $resp[0]=(OK MPD 0.20.0)
    20180524 130218 engine-mpd: Get initial status
    20180524 130218 readMpdResponse(): reading response
    20180524 130218 readMpdResponse(): success $str=(OK)
    20180524 130218 readMpdResponse(): success $resp[0]=(volume: -1)
    20180524 130218 engine-mpd: UI state=(pause), MPD state=(pause)
    20180524 130218 engine-mpd: Idle
    20180524 130218 engine-mpd: Wait for idle timeout
    20180524 130218 readMpdResponse(): reading response
    20180524 130218 engine-mpd: Connect
    20180524 130218 engine-mpd: Session loaded
    20180524 130218 engine-mpd: Open socket
    20180524 130218 readMpdResponse(): reading response
    20180524 130218 readMpdResponse(): success $str=(OK MPD 0.20.0)
    20180524 130218 readMpdResponse(): success $resp[0]=(OK MPD 0.20.0)
    20180524 130218 engine-mpd: Get initial status
    20180524 130218 readMpdResponse(): reading response
    20180524 130218 readMpdResponse(): success $str=(OK)
    20180524 130218 readMpdResponse(): success $resp[0]=(volume: -1)
    20180524 130218 engine-mpd: UI state=(pause), MPD state=(pause)
    20180524 130218 engine-mpd: Idle
    20180524 130218 engine-mpd: Wait for idle timeout
    20180524 130218 readMpdResponse(): reading response

2) tail -f /var/log/mpd/log

Code:
May 24 12:32 : update: added USB/NEW VOLUME/test.flac
May 24 12:35 : player: played "USB/NEW VOLUME/test.flac"
May 24 12:41 : player: played "USB/NEW VOLUME/test.flac"
May 24 12:51 : player: played "USB/NEW VOLUME/test.flac"
May 24 13:00 : player: played "USB/NEW VOLUME/test.flac"

Thanks for your help
Reply


Messages In This Thread
Popping sound during playback - by placebo-fi - 05-24-2018, 02:37 AM
RE: Popping sound during playback - by Tim Curtis - 05-24-2018, 02:57 AM
RE: Popping sound during playback - by placebo-fi - 05-24-2018, 03:15 AM
RE: Popping sound during playback - by Tim Curtis - 05-24-2018, 03:54 AM
RE: Popping sound during playback - by placebo-fi - 05-24-2018, 05:14 PM
RE: Popping sound during playback - by Tim Curtis - 05-24-2018, 09:26 PM
RE: Popping sound during playback - by placebo-fi - 05-25-2018, 02:17 AM
RE: Popping sound during playback - by Tim Curtis - 05-25-2018, 02:48 AM
RE: Popping sound during playback - by placebo-fi - 05-25-2018, 03:10 AM
RE: Popping sound during playback - by Mullet - 11-18-2019, 04:40 AM
RE: Popping sound during playback - by Tim Curtis - 11-18-2019, 01:12 PM
RE: Popping sound during playback - by DRONE7 - 11-18-2019, 05:47 AM
RE: Popping sound during playback - by Mullet - 11-18-2019, 09:44 PM
RE: Popping sound during playback - by Tim Curtis - 11-18-2019, 05:18 PM
RE: Popping sound during playback - by leicray - 02-01-2020, 02:04 PM
RE: Popping sound during playback - by DRONE7 - 02-03-2020, 11:47 PM
RE: Popping sound during playback - by Tim Curtis - 02-04-2020, 12:29 AM
RE: Popping sound during playback - by leicray - 02-06-2020, 08:52 PM
RE: Popping sound during playback - by Tim Curtis - 02-06-2020, 09:07 PM
RE: Popping sound during playback - by Tim Curtis - 02-11-2020, 10:03 PM
RE: Popping sound during playback - by Tim Curtis - 02-12-2020, 01:05 AM
RE: Popping sound during playback - by Tim Curtis - 02-12-2020, 01:08 PM
RE: Popping sound during playback - by Tim Curtis - 02-14-2020, 01:54 PM
RE: Popping sound during playback - by DRONE7 - 02-12-2020, 05:48 PM
RE: Popping sound during playback - by Tim Curtis - 02-12-2020, 07:18 PM
RE: Popping sound during playback - by DRONE7 - 02-12-2020, 07:35 PM
RE: Popping sound during playback - by Tim Curtis - 02-12-2020, 08:28 PM
RE: Popping sound during playback - by DRONE7 - 02-12-2020, 09:53 PM
RE: Popping sound during playback - by Tim Curtis - 02-14-2020, 10:54 PM
RE: Popping sound during playback - by Tim Curtis - 02-14-2020, 11:36 PM
RE: Popping sound during playback - by codiac - 02-18-2020, 05:51 PM
RE: Popping sound during playback - by codiac - 02-18-2020, 06:03 PM
RE: Popping sound during playback - by codiac - 02-18-2020, 06:19 PM
RE: Popping sound during playback - by Tim Curtis - 02-18-2020, 07:00 PM
RE: Popping sound during playback - by codiac - 02-19-2020, 06:16 AM
RE: Popping sound during playback - by codiac - 02-19-2020, 06:17 AM
RE: Popping sound during playback - by codiac - 02-19-2020, 06:22 PM
RE: Popping sound during playback - by DRONE7 - 02-19-2020, 07:29 PM
RE: Popping sound during playback - by codiac - 02-19-2020, 06:03 PM
RE: Popping sound during playback - by codiac - 02-21-2020, 06:46 PM
RE: Popping sound during playback - by codiac - 02-22-2020, 01:34 PM
RE: Popping sound during playback - by codiac - 02-22-2020, 02:22 PM
RE: Popping sound during playback - by Tim Curtis - 02-22-2020, 02:47 PM
RE: Popping sound during playback - by codiac - 02-22-2020, 06:56 PM
RE: Popping sound during playback - by leicray - 02-23-2020, 01:52 PM
RE: Popping sound during playback - by codiac - 02-23-2020, 06:32 PM
RE: Popping sound during playback - by leicray - 02-24-2020, 11:08 AM
RE: Popping sound during playback - by leicray - 02-26-2020, 08:42 AM
RE: Popping sound during playback - by CallMeMike - 03-22-2020, 05:01 AM
Loud peak between two songs - by e11bits - 05-24-2018, 09:38 PM
RE: Loud peak between two songs - by rikardo1979 - 05-25-2018, 09:21 AM
RE: Loud peak between two songs - by Tim Curtis - 05-24-2018, 09:55 PM

Forum Jump: