Bug #8110

/hipster: pulseaudio 10.0 dumps core on start and dies

Added by Predrag Zečević over 1 year ago. Updated 3 months ago.

Status:NewStart date:2017-04-26
Priority:HighDue date:
Assignee:-% Done:

0%

Category:-
Target version:-
Difficulty:Medium Tags:needs-triage

Description

Hi,
after updating pulseaudio to 10.0 (in #7009) it dies on start (dumps core):

$ uname -rosv
SunOS 5.11 illumos-63982b82e6 Solaris

$ grep [p]ulse /var/adm/messages
[2017-04-25 14:59:10] xxx pulseaudio[2731]: [ID 295310 user.error] [solaris] sink.c: Assertion '!pa_thread_mq_get()' failed at pulsecore/sink.c:2229, function pa_sink_set_mute(). Aborting.
[2017-04-25 14:59:10] xxx genunix: [ID 603404 kern.notice] NOTICE: core_log: pulseaudio[2731] core dumped: /export/tmp/cores/core.pulseaudio.2731

$ pkg info pulseaudio
          Name: library/audio/pulseaudio
       Summary: Sample Rate Converter for audio
      Category: System/Multimedia Libraries
         State: Installed
     Publisher: openindiana.org
       Version: 10.0
        Branch: 2017.0.0.0
Packaging Date: Sun Apr 23 08:35:43 2017
          Size: 12.60 MB
          FMRI: pkg://openindiana.org/library/audio/pulseaudio@10.0-2017.0.0.0:20170423T083543Z
   Project URL: http://www.freedesktop.org/wiki/Software/PulseAudio/
    Source URL: http://freedesktop.org/software/pulseaudio/releases/pulseaudio-10.0.tar.gz

In MATE environment, mate-volume-control-applet shows nothing and applet cannot control volume. VLC can play music and its controls work fine...

I have tried to start it with truss

$ truss -o /tmp/pulseaudio.truss -f /usr/bin/pulseaudio

and it has died again (truss file attached)

Regards.

pulseaudio.truss.txt.zip - zipped truss file (184 KB) Predrag Zečević, 2017-04-26 08:43 PM

pulseaudio.zip (169 KB) Joseph White, 2017-04-28 04:21 PM


Related issues

Related to illumos gate - Bug #8970: No sound on multicom xishan New 2018-01-18

History

#1 Updated by Alexander Pyhalov over 1 year ago

Can you share a core file?

#2 Updated by Predrag Zečević over 1 year ago

Looks like truss file is also not attached. Will add both right now...
Regards.

#3 Updated by Predrag Zečević over 1 year ago

truss file

#4 Updated by Predrag Zečević over 1 year ago

And core: https://www.dropbox.com/s/349r9bgc6hv5soo/core.pulseaudio.2731.zip?dl=0 (let me know when you have it, so I can remove data)

#5 Updated by Joseph White over 1 year ago

I also have this problem.

$ uname -rosv
SunOS 5.11 illumos-6175f5a92a Solaris

$ grep [p]ulse /var/adm/mesages
Apr 28 16:12:53 openindiana230 pulseaudio[1557]: [ID 295310 user.error] [(null)] pid.c: Daemon already running.
Apr 28 16:45:46 openindiana230 pulseaudio[2056]: [ID 295310 user.error] [(null)] module-device-restore.c: Failed to open volume database '/home/joe/.config/pulse/c496bedfadd92fe705d09bc0590363e6-device-volumes': I/O error
Apr 28 16:45:46 openindiana230 pulseaudio[2056]: [ID 295310 user.error] [(null)] module.c: Failed to load module "module-device-restore" (argument: ""): initialization failed.
Apr 28 16:45:46 openindiana230 pulseaudio[2056]: [ID 295310 user.error] [(null)] hook-list.c: Assertion '!slot->dead' failed at pulsecore/hook-list.c:83, function pa_hook_slot_free(). Aborting.
Apr 28 16:45:46 openindiana230 pulseaudio[2054]: [ID 295310 user.error] [(null)] main.c: Daemon startup failed.
Apr 28 16:50:03 openindiana230 pulseaudio[2160]: [ID 295310 user.error] [(null)] module-device-restore.c: Failed to open volume database '/home/joe/.config/pulse/c496bedfadd92fe705d09bc0590363e6-device-volumes': I/O error
Apr 28 16:50:03 openindiana230 pulseaudio[2160]: [ID 295310 user.error] [(null)] module.c: Failed to load module "module-device-restore" (argument: ""): initialization failed.
Apr 28 16:50:03 openindiana230 pulseaudio[2160]: [ID 295310 user.error] [(null)] hook-list.c: Assertion '!slot->dead' failed at pulsecore/hook-list.c:83, function pa_hook_slot_free(). Aborting.
Apr 28 16:50:03 openindiana230 pulseaudio[2157]: [ID 295310 user.error] [(null)] main.c: Daemon startup failed.
Apr 28 16:50:03 openindiana230 pulseaudio[2200]: [ID 295310 user.error] [(null)] pid.c: Daemon already running.
Apr 28 16:55:48 openindiana230 pulseaudio[2192]: [ID 295310 user.error] [solaris] sink.c: Assertion '!pa_thread_mq_get()' failed at pulsecore/sink.c:2229, function pa_sink_set_mute(). Aborting.
Apr 28 17:03:33 openindiana230 pulseaudio[2161]: [ID 295310 user.error] [(null)] module-device-restore.c: Failed to open volume database '/home/joe/.config/pulse/c496bedfadd92fe705d09bc0590363e6-device-volumes': I/O error
Apr 28 17:03:33 openindiana230 pulseaudio[2161]: [ID 295310 user.error] [(null)] module.c: Failed to load module "module-device-restore" (argument: ""): initialization failed.
Apr 28 17:03:33 openindiana230 pulseaudio[2161]: [ID 295310 user.error] [(null)] hook-list.c: Assertion '!slot->dead' failed at pulsecore/hook-list.c:83, function pa_hook_slot_free(). Aborting.
Apr 28 17:03:33 openindiana230 pulseaudio[2158]: [ID 295310 user.error] [(null)] main.c: Daemon startup failed.
Apr 28 17:03:33 openindiana230 pulseaudio[2209]: [ID 295310 user.error] [(null)] pid.c: Daemon already running.
Apr 28 17:05:17 openindiana230 pulseaudio[2205]: [ID 295310 user.error] [solaris] sink.c: Assertion '!pa_thread_mq_get()' failed at pulsecore/sink.c:2229, function pa_sink_set_mute(). Aborting.

$ pkg info pulseaudio
          Name: library/audio/pulseaudio
       Summary: Sample Rate Converter for audio
      Category: System/Multimedia Libraries
         State: Installed
     Publisher: openindiana.org
       Version: 10.0
        Branch: 2017.0.0.0
Packaging Date: 23 April 2017 08:35:43
          Size: 12.60 MB
          FMRI: pkg://openindiana.org/library/audio/pulseaudio@10.0-2017.0.0.0:20170423T083543Z
   Project URL: http://www.freedesktop.org/wiki/Software/PulseAudio/
    Source URL: http://freedesktop.org/software/pulseaudio/releases/pulseaudio-10.0.tar.gz

#6 Updated by Alexander Pyhalov over 1 year ago

Does removing ~/.config/pulse help?

#7 Updated by Alexander Pyhalov over 1 year ago

Have you found https://www.illumos.org/issues/7820 ? Is it related?

#8 Updated by Alexander Pyhalov over 1 year ago

Does 'rm -fr /etc/pulse && pkg fix pulseaudio' help?

#9 Updated by Joseph White over 1 year ago

Alexander Pyhalov wrote:

Does removing ~/.config/pulse help?

Yes, thanks. Removing ~/.config/pulse worked and seems persistent across reboots. I'm assuming removing /etc/pulse would work too. After making the change, the volume slider in Mate didn't work, so I rebooted, because I can't logout without my system hanging (unrelated bug with xorg vesa). In hind sight, running pulseaudio -k as user after making the change would've worked without needing a reboot.

#10 Updated by Predrag Zečević over 1 year ago

I have removed that file and now no sound is produced in VLC, Rhythmbox or FireFox :-(

From other side, this works:

$ audiotest 
Sound subsystem and version: SunOS Audio 4.0 (0x00040003)
Platform: SunOS 5.11 illumos-48d8443e35 i86pc

*** Scanning sound adapter #1 ***
/dev/sound/audiohd:0dsp (audio engine 0): audiohd#0
  - Performing audio playback test... 
        <left> ................OK
        <right> ...............OK
        <stereo> ..............OK
        <measured sample rate 47965,00 Hz (-0,07%)>

*** All tests completed OK ***

$ audioctl show-device
Device: /dev/sound/audiohd:0mixer
  Name    = audiohd#0
  Config  = onboard1 (a)
  HW Info = Unknown HD codec: 0x10ec0892

And pulseaudio -k cannot be stopped (killed):
$ ps -ef| grep [p]ulse
  global predrag*  3707     1   0 09:31:45 ?           0:00 /usr/bin/pulseaudio --start --log-target=syslog
$ kill -9 3707
$ ps -ef| grep [p]ulse
  global predrag*  3712     1   0 09:32:00 ?           0:00 /usr/bin/pulseaudio --start --log-target=syslog

#11 Updated by Predrag Zečević over 1 year ago

And found more interesting:

find ~/.pulse ~/.config/pulse -ls
 22481    1 drwx------   2 predrag_zecevic admin           3 May  2 12:23 /export/home/predrag_zecevic/.pulse
 22483    0 lrwxrwxrwx   1 predrag_zecevic admin          23 May  2 12:23 /export/home/predrag_zecevic/.pulse/fff003d0d35d39638afc7bd0568fd0f4-runtime -> /tmp/pulse-nIqTRXNgklNW
 22482    1 drwxr-xr-x   2 predrag_zecevic admin           2 May  2 12:22 /export/home/predrag_zecevic/.config/pulse

Looks like new pulseaudio does not use ~/.config/pulse at all...
If pulseaudo is started, its proxy function is broken (no sound). I have managed to terminate it with removal of those 2 directories, which in turn made VLC and Rhythmbox working again.
[2017-05-02 11:06:58] xxx pulseaudio[3473]: [ID 295310 user.error] [(null)] module-device-restore.c: Failed to open volume database '/export/home/predrag_zecevic/.pulse/fff003d0d35d39638afc7bd0568fd0f4-device-volumes': I/O error
[2017-05-02 11:06:58] xxx pulseaudio[3473]: [ID 295310 user.error] [(null)] module.c: Failed to load module "module-device-restore" (argument: ""): initialization failed.
[2017-05-02 11:06:58] xxx pulseaudio[3473]: [ID 295310 user.error] [(null)] hook-list.c: Assertion '!slot->dead' failed at pulsecore/hook-list.c:83, function pa_hook_slot_free(). Aborting.
[2017-05-02 11:06:59] xxx genunix: [ID 603404 kern.notice] NOTICE: core_log: pulseaudio[3473] core dumped: /export/tmp/cores/core.pulseaudio.3473
[2017-05-02 11:06:59] xxx pulseaudio[3471]: [ID 295310 user.error] [(null)] main.c: Daemon startup failed.

Will do more tests when time permits. Just wanted to share...
Regards.

#12 Updated by Predrag Zečević over 1 year ago

This morning I have update OS:

$ uname -rosv
SunOS 5.11 illumos-a160fd9a3a Solaris

And found that pulseaudio was started
$ ps -ef | grep [p]ulseaudio
  global predrag*  4931     1   0 08:52:03 ?           0:01 /usr/bin/amd64/pulseaudio --start --log-target=syslog

NOTE that this time, proper 64 bit version is started. Syslog shows only:
$ grep -E "2017-05-05.*[p]ulseaudio" /var/adm/messages
[2017-05-05 09:06:08] xxx pulseaudio[4931]: [ID 295310 user.error] [oss] module-oss.c: pa_read() failed: Resource temporarily unavailable

Also, I have spotted following:
a) pulseaudio down, VLC plays stream smoothly
b) pulseaudio up, VLC has few hiccups at the beginning of stream playing, then continues normally

Unfortunately rhythmbox still stops after 19 seconds of stream playing, so could not test relation to pulseaudio

Regards

#13 Updated by Dan-Simon Myrland 11 months ago

  • Related to Bug #8970: No sound on multicom xishan added

#14 Updated by Ken Mays 3 months ago

Please update your system to current and state the current condition.

Also available in: Atom