Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Need to switch Pulseeffects apps manually from pavucontrol to take effect but no permanent. #240

Closed
shutterPL opened this issue Jun 17, 2018 · 25 comments

Comments

@shutterPL
Copy link

I'm running Manjaro Deepin with Pulseeffects 4.0.4. "Start service at login" is enabled but when I run some music software nothing is happening. I need to turn on "Pulseefects.apps" manually in pavucontrol next to Spotify or any other music software to force Pulseeffects to run. When music plays without my interfere everything works, but a simple manual song change disables "Pulseeffects.apps" and default music output is enabled.

@wwmm
Copy link
Owner

wwmm commented Jun 17, 2018

Switch on Enable All Applications in the same menu where you have Start Service at Login

@shutterPL
Copy link
Author

I forgot to mention that I have enabled it already.

@wwmm
Copy link
Owner

wwmm commented Jun 17, 2018

Provide the information mentioned at Reporting-Bugs. If possible get a PulseEffects terminal output when the problem happens

@shutterPL
Copy link
Author

So here it is:

zrzut ekranu deepin_wybierz-obszar_20180618003351

Pulseeffects 4.0.4 installed from AUR repository.

  1. pactl list short

pactl list short.txt

  1. pacmd list-sinks

pacmd list-sinks.txt

  1. pacmd list-sink-inputs

pacmd list-sink-inputs.txt

  1. pacmd list-sources

pacmd list-sources.txt

  1. pacmd list-source-outputs

pacmd list-source-outputs.txt

This turn often into...
zrzut ekranu deepin_wybierz-obszar_20180618003103

this
zrzut ekranu deepin_wybierz-obszar_20180618002539

zrzut ekranu deepin_wybierz-obszar_20180618002635
zrzut ekranu deepin_wybierz-obszar_20180618002709
zrzut ekranu deepin_wybierz-obszar_20180618002758
zrzut ekranu deepin_wybierz-obszar_20180618002819

@wwmm
Copy link
Owner

wwmm commented Jun 17, 2018

Put also the output of PE running in DEBUG mode G_MESSAGES_DEBUG=pulseeffects pulseeffects. Try to trigger the bug in the process

@shutterPL
Copy link
Author

I run this G_MESSAGES_DEBUG=pulseeffects pulseeffects via terminal but I have no idea where to find log file.

@wwmm
Copy link
Owner

wwmm commented Jun 18, 2018

It is not saved to a file. It is printed in the terminal. Just copy and paste the lines printed by PE here

@shutterPL
Copy link
Author

zrzut ekranu deepin_deepin-terminal_20180618210744
This is how terminal looks when PE is running. Nothing happens.

@wwmm
Copy link
Owner

wwmm commented Jun 18, 2018

Strange. Here I have many lines printed. Maybe you have an instance already running. Try to execute G_MESSAGES_DEBUG=pulseeffects pulseeffects -q before trying to run G_MESSAGES_DEBUG=pulseeffects pulseeffects

@shutterPL
Copy link
Author

So here is printed output.

[marcin@marcin-pc ~]$ G_MESSAGES_DEBUG=pulseeffects pulseeffects
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:33.532: pulse_manager: context is connecting
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:33.532: pulse_manager: context is authorizing
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:33.532: pulse_manager: context is setting name
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:33.532: pulse_manager: context is ready
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:33.532: pulse_manager: connected to: unix:/run/user/1000/pulse/native
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:33.532: pulse_manager: protocol version: 32
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:33.533: pulse_manager: Pulseaudio version: 11.1
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:33.533: pulse_manager: default pulseaudio source: alsa_input.pci-0000_05_01.0.analog-stereo
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:33.533: pulse_manager: default pulseaudio sink: alsa_output.pci-0000_05_01.0.analog-surround-51
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:33.533: pulse_manager: loading Pulseeffects applications output sink...
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:33.533: pulse_manager: default pulseaudio sink sampling rate: 44100 Hz
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:33.533: pulse_manager: default pulseaudio sink audio format: s16le
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:33.533: pulse_manager: sink loaded
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:33.534: pulse_manager: loading Pulseeffects microphone output sink...
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:33.534: pulse_manager: default pulseaudio source sampling rate: 44100 Hz
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:33.534: pulse_manager: default pulseaudio source audio format: s16le
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:33.534: pulse_manager: sink loaded

(pulseeffects:3683): pulseeffects-WARNING **: 21:17:33.579: maximizer plugin was not found!

(pulseeffects:3683): pulseeffects-WARNING **: 21:17:33.579: delay plugin was not found!
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:33.595: presets_manager: user preset directory already exists: /home/marcin/.config/PulseEffects

(pulseeffects:3683): pulseeffects-CRITICAL **: 21:17:34.088: pulse_manager: failed to move source output 6 to PE
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:34.106: soe: spectrum enabled

(pulseeffects:3683): pulseeffects-CRITICAL **: 21:17:34.116: pulse_manager: failed to move source output 0 to PE

(pulseeffects:3683): pulseeffects-CRITICAL **: 21:17:34.118: pulse_manager: failed to move source output 1 to PE

(pulseeffects:3683): pulseeffects-CRITICAL **: 21:17:34.120: pulse_manager: failed to move source output 6 to PE
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:34.123: application_ui: output device changed: alsa_output.pci-0000_05_01.0.analog-surround-51
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:34.123: application_ui: added sink: alsa_output.pci-0000_05_01.0.analog-surround-51
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:34.123: application_ui: added source: alsa_output.pci-0000_05_01.0.analog-surround-51.monitor
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:34.123: application_ui: input device changed: alsa_input.pci-0000_05_01.0.analog-stereo
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:34.123: application_ui: added source: alsa_input.pci-0000_05_01.0.analog-stereo
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:34.124: soe: READY
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:34.124: soe: PAUSED
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:34.124: soe: pulsesrc latency [us]: 10000
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:34.124: soe: pulsesrc buffer [us]: 200000
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:34.124: soe: pulsesink latency [us]: 10000
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:34.124: soe: pulsesink buffer [us]: 200000
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:34.124: soe: PLAYING

(pulseeffects:3683): pulseeffects-CRITICAL **: 21:17:34.126: pulse_manager: failed to move source output 10 to PE

(pulseeffects:3683): pulseeffects-CRITICAL **: 21:17:45.381: pulse_manager: failed to move source output 11 to PE
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:45.658: sie: READY
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:45.659: sie: PAUSED
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:45.660: sie: equalizer enabled
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:45.662: sie: spectrum enabled

(pulseeffects:3683): pulseeffects-CRITICAL **: 21:17:45.714: pulse_manager: failed to move source output 12 to PE

(pulseeffects:3683): pulseeffects-CRITICAL **: 21:17:45.716: pulse_manager: failed to move source output 14 to PE
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:52.257: sie: READY
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:52.258: sie: PAUSED

(pulseeffects:3683): pulseeffects-CRITICAL **: 21:17:52.258: pulse_manager: failed to move source output 15 to PE
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:52.262: sie: pulsesrc latency [us]: 10000
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:52.262: sie: pulsesrc buffer [us]: 200000
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:52.266: sie: pulsesink latency [us]: 10000
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:52.266: sie: pulsesink buffer [us]: 200000
(pulseeffects:3683): pulseeffects-DEBUG: 21:17:52.298: sie: PLAYING

(pulseeffects:3683): pulseeffects-CRITICAL **: 21:17:52.300: pulse_manager: failed to move source output 17 to PE

(pulseeffects:3683): pulseeffects-CRITICAL **: 21:18:08.798: pulse_manager: failed to move source output 18 to PE
(pulseeffects:3683): pulseeffects-DEBUG: 21:18:22.024: sie: READY
(pulseeffects:3683): pulseeffects-DEBUG: 21:18:22.024: sie: PAUSED
(pulseeffects:3683): pulseeffects-DEBUG: 21:18:22.026: sie: pulsesrc latency [us]: 10000
(pulseeffects:3683): pulseeffects-DEBUG: 21:18:22.026: sie: pulsesrc buffer [us]: 200000

(pulseeffects:3683): pulseeffects-CRITICAL **: 21:18:22.026: pulse_manager: failed to move source output 20 to PE
(pulseeffects:3683): pulseeffects-DEBUG: 21:18:22.032: sie: pulsesink latency [us]: 10000
(pulseeffects:3683): pulseeffects-DEBUG: 21:18:22.032: sie: pulsesink buffer [us]: 200000
(pulseeffects:3683): pulseeffects-DEBUG: 21:18:22.091: sie: PLAYING

(pulseeffects:3683): pulseeffects-CRITICAL **: 21:18:22.093: pulse_manager: failed to move source output 21 to PE

(pulseeffects:3683): pulseeffects-CRITICAL **: 21:18:43.445: pulse_manager: failed to move source output 22 to PE
(pulseeffects:3683): pulseeffects-DEBUG: 21:18:47.452: sie: READY
(pulseeffects:3683): pulseeffects-DEBUG: 21:18:47.452: sie: PAUSED
(pulseeffects:3683): pulseeffects-DEBUG: 21:18:47.453: sie: pulsesrc latency [us]: 10000
(pulseeffects:3683): pulseeffects-DEBUG: 21:18:47.453: sie: pulsesrc buffer [us]: 200000

(pulseeffects:3683): pulseeffects-CRITICAL **: 21:18:47.456: pulse_manager: failed to move source output 24 to PE
(pulseeffects:3683): pulseeffects-DEBUG: 21:18:47.468: sie: pulsesink latency [us]: 10000
(pulseeffects:3683): pulseeffects-DEBUG: 21:18:47.468: sie: pulsesink buffer [us]: 200000
(pulseeffects:3683): pulseeffects-DEBUG: 21:18:47.503: sie: PLAYING

(pulseeffects:3683): pulseeffects-CRITICAL **: 21:18:47.503: pulse_manager: failed to move source output 25 to PE

@wwmm
Copy link
Owner

wwmm commented Jun 18, 2018

The errors failed to move source output should not happen. But it is not clear what is causing this. And to let things even more strange source outputs are from applications that record audio like skype and not from media players like spotify. In this case we would have failures with sink input in their messages

@shutterPL
Copy link
Author

failed to move source output happens when song is changed. But this...

(pulseeffects:3683): pulseeffects-DEBUG: 21:18:47.452: sie: READY
(pulseeffects:3683): pulseeffects-DEBUG: 21:18:47.452: sie: PAUSED
(pulseeffects:3683): pulseeffects-DEBUG: 21:18:47.453: sie: pulsesrc latency [us]: 10000
(pulseeffects:3683): pulseeffects-DEBUG: 21:18:47.453: sie: pulsesrc buffer [us]: 200000

is caused by changing manually to Pulseeffects.apps next to music player.

@shutterPL
Copy link
Author

Now i can't enable any application in PE when pavucontrol window is closed.

@wwmm
Copy link
Owner

wwmm commented Jun 21, 2018

Considering that there is nothing in your logs that would explain such a bizarre behavior I wonder if Deepin is somehow related to this. It is definitely not necessary to have pavucontrol even installed. I think we will have to put your pulseaudio in its highest verbose mode and take a look at its logs. Try the following:

  1. Increase the number of lines your terminal is able to show
  2. Execute pacmd in a terminal
  3. Now you are inside pacmd command line. Execute set-log-level 4
  4. Close Pavucontrol if it is open
  5. In another terminal execute sudo journalctl -fb | grep -i pulse
  6. Start PulseEffects and do what is necessary for the problems to happen. You should see lots of lines whenever an audio related action like volume changes is done
  7. Save the lines printed by journaltcl to a file and show me it

@shutterPL
Copy link
Author

journalctl-log.txt
The last part of this log says what happens when pavucontrol windows is closed and I'm trying to enable my music player in PE with no result.

cze 21 22:01:44 marcin-pc pulseaudio[2025]: I: [pulseaudio] sink-input.c: Freeing input 16 "Playback Stream"
cze 21 22:01:44 marcin-pc pulseaudio[2025]: I: [pulseaudio] client.c: Freed 24 "PulseEffects"
cze 21 22:01:44 marcin-pc pulseaudio[2025]: I: [pulseaudio] protocol-native.c: Connection died.
cze 21 22:01:44 marcin-pc pulseaudio[2025]: D: [pulseaudio] module-suspend-on-idle.c: Sink PulseEffects_apps becomes idle, timeout in 5 seconds.
cze 21 22:01:44 marcin-pc pulseaudio[2025]: I: [pulseaudio] source-output.c: Freeing output 21 "Record Stream"
cze 21 22:01:44 marcin-pc pulseaudio[2025]: I: [pulseaudio] client.c: Freed 25 "PulseEffects"
cze 21 22:01:44 marcin-pc pulseaudio[2025]: I: [pulseaudio] protocol-native.c: Connection died.

@wwmm
Copy link
Owner

wwmm commented Jun 21, 2018

At some points we have
[pulseaudio] sink-input.c: Starting to move sink input 0 from 'alsa_output.pci-0000_05_01.0.analog-surround-51'
[pulseaudio] sink-input.c: Successfully moved sink input 0 to PulseEffects_apps.

This means that at least for a brief moment the application was enabled. But then we have

[pulseaudio] sink-input.c: Starting to move sink input 0 from 'PulseEffects_apps'
[pulseaudio] sink-input.c: Successfully moved sink input 0 to alsa_output.pci-0000_05_01.0.analog-surround-51.

They mean that the app was disabled. So something is telling Pulseaudio to take the application away from PulseEffects. But it is not clear what could be doing that.

@wwmm
Copy link
Owner

wwmm commented Jun 21, 2018

And the Connection died errors do not sound good too.

@shutterPL
Copy link
Author

Maybe Deepin sound settings in Control Center is a cause of the problem. I mean you can't change settings in any other place, becouse Control Center is where settings are in "highest priority"?

zrzut ekranu deepin_wybierz-obszar_20180624221818

@wwmm
Copy link
Owner

wwmm commented Jun 24, 2018

At least KDE has an issue #235 where they do an audio routing that conflicts with the ones PE has to do. Maybe Deepin is also doing more than just set the default output device

@shutterPL
Copy link
Author

{"Profiles":{"alsa_card.pci-0000_01_00.1":"off","alsa_card.pci-0000_05_01.0":"output:analog-surround-51+input:analog-stereo"},"Sink":"alsa_output.pci-0000_05_01.0.analog-surround-51","Source":"alsa_input.pci-0000_05_01.0.analog-stereo","SinkPort":"analog-output","SourcePort":"analog-input-mic","SinkVolume":1,"SourceVolume":0.81646728515625}

This is how audio.json file looks in ~/.config/deepin/dde-daemon directory. Maybe here is a problem. I'm not sure where should I search for source of this issue.

@wwmm
Copy link
Owner

wwmm commented Jun 24, 2018

This file shows only default device setting. The app is disabled when it is moved to another sink. If Deepin is doing this it will not be visible in a file. I think it will be necessary to contact Deepin developers somehow

@victorcifuentes
Copy link

If you disable audio from dconf (com.deepin.dde.daemon) and restart, PulseEffects will works ok.

@shutterPL
Copy link
Author

shutterPL commented Jun 29, 2018

@victorcifuentes Works like a charm ;)
zrzut ekranu deepin_wybierz-obszar_20180629213316
Indeed the problem was in these settings. Now when this is empty everything works.

@wwmm
Copy link
Owner

wwmm commented Jun 29, 2018

Could you update the FAQ with the steps to fix the problem in Deepin?

In any case we can close this issue

@wwmm wwmm closed this as completed Jun 29, 2018
@shutterPL
Copy link
Author

I think @victorcifuentes should do that. He solved the problem.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

No branches or pull requests

3 participants