[gelöst]systemd startet keine sound-datei

[xoric]

Hallo,
ich habe Debian9 auf einem MSI ge60 2qd Apache Laptop installiert. Funktioniert soweit (fast) alles. Das Problem ist allerdings, das ich eine Sound-datei während des Boot-und-Shutdown-Vorgangs abspielen lasse. Diese lief schon bei Debian6, ich habe sie dann erfolgreich schon in systemd portiert (ein Acer alt-Laptop und VM). In beiden Fällen wird die Datei von systemd "abgespielt". Doch bei dieser Maschine läuft das Script nicht. Übrigens funktioniert ein direktes "abspielen" des Scriptes problemlos.
Hier noch einige info:
MSI GE60 2QD Apache:

Code: Alles auswählen

[msi-deb6]> uname -a 
Linux msi-deb6 4.9.0-3-amd64 #1 SMP Debian 4.9.30-2+deb9u5 (2017-09-19) x86_64 GNU/Linux

Start.service:

Code: Alles auswählen

[Unit]
Description=Plays-Soundfile

[Service]
Type=oneshot
ExecStart=/usr/local/bin/alsstrt.sh

[Install]
WantedBy=multi-user.target

Stop.service:

Code: Alles auswählen

[Unit]
Description=Plays-Sound_on_shutdown
DefaultDependencies=no
Before=shutdown.target reboot.target halt.target

[Service]
ExecStart=/usr/local/bin/alsstop.sh
Type=oneshot

[Install]
WantedBy=shutdown.target reboot.target halt.target

Ausgabe systemctl start start.service nach systemctl enable start.service

Code: Alles auswählen

[msi-deb6]> systemctl enable alsstrt.service
Created symlink /etc/systemd/system/multi-user.target.wants/alsstrt.service → /etc/systemd/system/alsstrt.service.
[msi-deb6]> systemctl start alsstrt.service
Job for alsstrt.service failed because the control process exited with error code.
See "systemctl status alsstrt.service" and "journalctl -xe" for details.

Ausgabe systemctl status alsstrt.service und journalctl -xe

Code: Alles auswählen

[msi-deb6]> systemctl status alsstrt.service
● alsstrt.service - Plays-Soundfile
   Loaded: loaded (/etc/systemd/system/alsstrt.service; enabled; vendor preset: enabled)
   Active: failed (Result: exit-code) since Sun 2017-09-24 21:29:35 CEST; 2min 29s ago
  Process: 17931 ExecStart=/usr/local/bin/alsstrt.sh (code=exited, status=1/FAILURE)
 Main PID: 17931 (code=exited, status=1/FAILURE)

Sep 24 21:29:35 msi-deb6 systemd[1]: Starting Plays-Soundfile...
Sep 24 21:29:35 msi-deb6 systemd[1]: alsstrt.service: Main process exited, code=exited, status=1/FAILURE
Sep 24 21:29:35 msi-deb6 systemd[1]: Failed to start Plays-Soundfile.
Sep 24 21:29:35 msi-deb6 systemd[1]: alsstrt.service: Unit entered failed state.
Sep 24 21:29:35 msi-deb6 systemd[1]: alsstrt.service: Failed with result 'exit-code'.

[msi-deb6]> journalctl -xe
Sep 24 21:25:47 msi-deb6 kernel: nouveau 0000:01:00.0: DRM: waiting for kernel channels to go idle...
Sep 24 21:25:47 msi-deb6 kernel: nouveau 0000:01:00.0: DRM: suspending client object trees...
Sep 24 21:25:47 msi-deb6 kernel: nouveau 0000:01:00.0: DRM: suspending kernel object tree...
Sep 24 21:26:54 msi-deb6 kernel: nouveau 0000:01:00.0: DRM: resuming kernel object tree...
Sep 24 21:26:55 msi-deb6 kernel: nouveau 0000:01:00.0: priv: HUB0: 10ecc0 ffffffff (1e40822c)
Sep 24 21:26:55 msi-deb6 kernel: nouveau 0000:01:00.0: DRM: resuming client object trees...
Sep 24 21:27:00 msi-deb6 kernel: nouveau 0000:01:00.0: DRM: evicting buffers...
Sep 24 21:27:00 msi-deb6 kernel: nouveau 0000:01:00.0: DRM: waiting for kernel channels to go idle...
Sep 24 21:27:00 msi-deb6 kernel: nouveau 0000:01:00.0: DRM: suspending client object trees...
Sep 24 21:27:00 msi-deb6 kernel: nouveau 0000:01:00.0: DRM: suspending kernel object tree...
Sep 24 21:27:32 msi-deb6 kernel: nouveau 0000:01:00.0: DRM: resuming kernel object tree...
Sep 24 21:27:32 msi-deb6 kernel: nouveau 0000:01:00.0: priv: HUB0: 10ecc0 ffffffff (1e40822c)
Sep 24 21:27:32 msi-deb6 kernel: nouveau 0000:01:00.0: DRM: resuming client object trees...
Sep 24 21:27:37 msi-deb6 kernel: nouveau 0000:01:00.0: DRM: evicting buffers...
Sep 24 21:27:37 msi-deb6 kernel: nouveau 0000:01:00.0: DRM: waiting for kernel channels to go idle...
Sep 24 21:27:37 msi-deb6 kernel: nouveau 0000:01:00.0: DRM: suspending client object trees...
Sep 24 21:27:37 msi-deb6 kernel: nouveau 0000:01:00.0: DRM: suspending kernel object tree...
Sep 24 21:29:18 msi-deb6 systemd[1]: Configuration file /etc/systemd/system/alsstrt.service is marked executable. Please remove executable permission bits. Proceeding anyway.
Sep 24 21:29:18 msi-deb6 systemd[1]: Reloading.
Sep 24 21:29:18 msi-deb6 systemd[1]: Configuration file /etc/systemd/system/alsstp.service is marked executable. Please remove executable permission bits. Proceeding anyway.
Sep 24 21:29:18 msi-deb6 systemd[1]: Configuration file /etc/systemd/system/alsstrt.service is marked executable. Please remove executable permission bits. Proceeding anyway.
Sep 24 21:29:18 msi-deb6 systemd[1]: Configuration file /etc/systemd/system/kybclr.service is marked executable. Please remove executable permission bits. Proceeding anyway.
Sep 24 21:29:18 msi-deb6 systemd[1]: apt-daily-upgrade.timer: Adding 10min 52.158505s random time.
Sep 24 21:29:18 msi-deb6 systemd[1]: anacron.timer: Adding 1min 38.590101s random time.
Sep 24 21:29:18 msi-deb6 systemd[1]: apt-daily.timer: Adding 9h 12min 22.733027s random time.
Sep 24 21:29:35 msi-deb6 systemd[1]: Starting Plays-Soundfile...
-- Subject: Unit alsstrt.service has begun start-up
-- Defined-By: systemd
-- Support: https://www.debian.org/support
-- 
-- Unit alsstrt.service has begun starting up.
Sep 24 21:29:35 msi-deb6 systemd[1]: alsstrt.service: Main process exited, code=exited, status=1/FAILURE
Sep 24 21:29:35 msi-deb6 systemd[1]: Failed to start Plays-Soundfile.
-- Subject: Unit alsstrt.service has failed
-- Defined-By: systemd
-- Support: https://www.debian.org/support
-- 
-- Unit alsstrt.service has failed.
-- 
-- The result is failed.
Sep 24 21:29:35 msi-deb6 systemd[1]: alsstrt.service: Unit entered failed state.
Sep 24 21:29:35 msi-deb6 systemd[1]: alsstrt.service: Failed with result 'exit-code'.
Sep 24 21:30:39 msi-deb6 kernel: nouveau 0000:01:00.0: DRM: resuming kernel object tree...
Sep 24 21:30:39 msi-deb6 kernel: nouveau 0000:01:00.0: priv: HUB0: 10ecc0 ffffffff (1e40822c)
Sep 24 21:30:39 msi-deb6 kernel: nouveau 0000:01:00.0: DRM: resuming client object trees...
Sep 24 21:30:44 msi-deb6 kernel: nouveau 0000:01:00.0: DRM: evicting buffers...
Sep 24 21:30:44 msi-deb6 kernel: nouveau 0000:01:00.0: DRM: waiting for kernel channels to go idle...
Sep 24 21:30:44 msi-deb6 kernel: nouveau 0000:01:00.0: DRM: suspending client object trees...
Sep 24 21:30:44 msi-deb6 kernel: nouveau 0000:01:00.0: DRM: suspending kernel object tree...
Sep 24 21:32:05 msi-deb6 systemd[1]: Configuration file /etc/

Wie bereits erwähnt, die oben erwähnten scripte laufen bei zwei Maschinen mit Debian9. Interessant hierbei ist folgendes:

Code: Alles auswählen

[msi-deb6]> journalctl | grep "failed"
Sep 23 23:22:29 msi-deb6 kernel: ACPI Error: Method parse/execution failed [\_SB.PCI0.LPCB.EC._REG] (Node ffff9095670c1be0), AE_NOT_EXIST (20160831/psparse-543)
Sep 23 23:22:29 msi-deb6 kernel: ACPI Error: Method parse/execution failed [\_SB.PCI0.LPCB.EC._REG] (Node ffff9095670c1be0), AE_NOT_EXIST (20160831/psparse-543)
Sep 23 23:22:33 msi-deb6 kernel: ACPI Error: Method parse/execution failed [\_SB.PCI0.PEG0.PEGP.DD02._BCL] (Node ffff9095670f00f0), AE_NOT_FOUND (20160831/psparse-543)
Sep 23 23:22:35 msi-deb6 systemd-udevd[351]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 1' failed with exit code 99.
Sep 23 23:22:35 msi-deb6 systemd-udevd[355]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 0' failed with exit code 99.

Hat jemand ne idee?
Gruß xoric

[smutbert]

Es würde vielleicht helfen, wenn du das Skript herzeigst und etwas mehr über das System verrätst, zB
- ob Pulseaudio installiert ist oder nicht
- was

Code: Alles auswählen

$ aplay -l

ausgibt
- ob das Skript funktioniert, wenn du es selbst aufrufst, statt von systemd aufrufen zu lassen

(Wenn du zB über alsa abspielst, könnte der Unterschied in der Hardware liegen - als default wird Gerät 0 von Soundkarte 0 verwendet, aber das existiert nicht immer.)

[xoric]

Hallo,
hier das Script:

Code: Alles auswählen

#! /bin/sh
### BEGIN INIT INFO
# Provides:          Stop-snd
# Short-Description: Plays Startup- & Shutdownsoundfile
### END INIT INFO

DESC="Plays Soudfile on boot and shutdown"
NAME=alsstrt-stp
shutdownsndfile="/usr/share/sounds/shutdown.ogg"

# Function that starts the soundfile on shutdown
#   if soundfile is present and card alive plays the file 
  [ -r "$shutdownsndfile" -a -d /proc/asound/card0 ] || exit 0
  ogg123 -q --audio-buffer 4096 "$shutdownsndfile" >/dev/null 2>&1

Wie bereits gesagt, wird das obige Script direkt über Konsole gestartet läuft es Problemlos.

Code: Alles auswählen

[msi-deb6]> aplay -l
**** Liste der Hardware-Geräte (PLAYBACK) ****
Karte 0: HDMI [HDA Intel HDMI], Gerät 3: HDMI 0 [HDMI 0]
  Sub-Geräte: 1/1
  Sub-Gerät #0: subdevice #0
Karte 0: HDMI [HDA Intel HDMI], Gerät 7: HDMI 1 [HDMI 1]
  Sub-Geräte: 1/1
  Sub-Gerät #0: subdevice #0
Karte 0: HDMI [HDA Intel HDMI], Gerät 8: HDMI 2 [HDMI 2]
  Sub-Geräte: 1/1
  Sub-Gerät #0: subdevice #0
Karte 1: PCH [HDA Intel PCH], Gerät 0: ALC892 Analog [ALC892 Analog]
  Sub-Geräte: 1/1
  Sub-Gerät #0: subdevice #0
Karte 1: PCH [HDA Intel PCH], Gerät 1: ALC892 Digital [ALC892 Digital]
  Sub-Geräte: 1/1
  Sub-Gerät #0: subdevice #0

Ich habe statt card0 card1 eingetragen, mit dem gleichen Ergebnis. Auch andere Sound-dateien können über systemd nicht "abgespielt" werden, während ein direktes "abspielen" möglich ist, d.h wenn diese über eine Script-datei gestartet werden.

Gruß xoric

[smutbert]

Wenn du die Ausgabeumleitung entfernst, sollte man im journal die Fehlermeldung sehen, die ogg123 liefert.

Hast du das Skript als normaler Benutzer oder als root getestet? (ich hatte einmal den Fall, dass root keinen Zugriff auf die Soundkarte(n) hatte, kann mich aber nicht mehr an die Ursache erinnern...)

[scientific]

Der Sound soll anzeigen, dass gdm fertig ist?
Wenn ja, würd ich die Start-Unit probehalber mal nach

Code: Alles auswählen

 /var/lib/gdm3/.config/systemd/user/default.target.wants/

schieben.

//EDIT:
Noch eine Idee, bevor du die Unit in die User-Konfiguration von gdm3 schiebst:
Ich gehe immer noch davon aus, dass du gdm3 im Einsatz hast.
Füge deiner Unit noch im [Service]-Abschnitt die Zeile

Code: Alles auswählen

User=Debian-gdm

hinzu. Dann wird die Unit als User Debian-gdm ausgeführt. Damit sollte beim Einsatz von Pulseaudio ebenfalls Sound möglich sein.

Lg scientific

[xoric]

Hallo,
@smutbert:

Wenn du die Ausgabeumleitung entfernst, sollte man im journal die Fehlermeldung sehen, die ogg123 liefert.

Werde ich testen, danke für den Hinweis.

Hast du das Skript als normaler Benutzer oder als root getestet? (ich hatte einmal den Fall, dass root keinen Zugriff auf die Soundkarte(n) hatte, kann mich aber nicht mehr an die Ursache erinnern...)

Beides! In meinem alten Jessie, geht root nicht (wie es sein sollte). In Stretch auf dieser Maschine gehen beide user (root und "normal"). Is' mir ein Rätsel warum, unter root dürfte es nicht gehen. Ein Fehler in Stretch?
@ scientific:

Der Sound soll anzeigen, dass gdm fertig ist?

Eigentlich nicht! Der Sound läuft nebenbei (habe ich von Knoppix).

Wenn ja, würd ich die Start-Unit probehalber mal nach

Habe ich gemacht, nicht in das von dir empfohlenene Verzeichnis, doch eins, was schon eingebunden ist. Hat nicht geklappt.

Dann wird die Unit als User Debian-gdm ausgeführt. Damit sollte beim Einsatz von Pulseaudio ebenfalls Sound möglich sein.

Habe ich nicht für nötig erachtet, da root den Sound beim manuellen starten abspielt.

Ich werde die Vorschläge testen. Das erste, was mir ins Auge gestochen ist.

Code: Alles auswählen

[msi-deb6]> journalctl | grep "failed"
Sep 23 23:22:29 msi-deb6 kernel: ACPI Error: Method parse/execution failed [\_SB.PCI0.LPCB.EC._REG] (Node ffff9095670c1be0), AE_NOT_EXIST (20160831/psparse-543)
Sep 23 23:22:29 msi-deb6 kernel: ACPI Error: Method parse/execution failed [\_SB.PCI0.LPCB.EC._REG] (Node ffff9095670c1be0), AE_NOT_EXIST (20160831/psparse-543)
Sep 23 23:22:33 msi-deb6 kernel: ACPI Error: Method parse/execution failed [\_SB.PCI0.PEG0.PEGP.DD02._BCL] (Node ffff9095670f00f0), AE_NOT_FOUND (20160831/psparse-543)
Sep 23 23:22:35 msi-deb6 systemd-udevd[351]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 1' failed with exit code 99.
Sep 23 23:22:35 msi-deb6 systemd-udevd[355]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 0' failed with exit code 99.

scheint ein Bug zu sein, (laut google/metager). Vielleicht anderen Kernel probieren? Z.B. aus Backports?
LG xoric

[scientific]

/run ist doch mittlerweile ein flüchtiges Verzeichnis... Wenn du dort was reinschreibst, überlebt das ja einen reboot nicht.

Probier ein Verzeichnis in /var/lib fürs abspeichern vom Alsastatus.

Versteh ich dich richtig? Kenne knoppix nicht aus praktischer Erfahrung.
Während die Maschine bootet, düdelt sie ab vorhandensein des Soundsystems dahin, bis der Loginmanager erscheint?

Lg scientific

[scientific]

Ich frage mich grad ob Knoppix systemd und pulseaudio verwendet, oder initv und alsa...

lg scientific

[scientific]

So... Ich brauch das zwar nicht, fands aber eine schöne Herausforderung...

Bin hier fündig geworden:
https://www.reddit.com/r/raspberry_pi/c ... d_systemd/

Das funktioniert zwar nicht ganz (auf Debian). Darum hab ichs mal angepasst.

Code: Alles auswählen

systemctl cat test.service 
# /etc/systemd/system/test.service
[Unit]
Description=Boot Sound
Wants=sound.target
After=sound.target

[Service]
Type=simple
RemainAfterExit=yes
ExecStart=/usr/bin/aplay -D plughw:1 /boot/login.wav
ExecStop=/usr/bin/aplay -D plughw:1 /boot/logout.wav

[Install]
WantedBy=multi-user.target

In der Debug-Shell spielt aplay auf dem Device plughw:1 bei mir den Sound ab!
Bei mir ist hw:0 ein nicht verwendeter HDMI-Ausgang und hw:1 die Analoge Soundkarte des Laptops.

Diese Unit von Gnome aus gestartet tut nix.
Aber mit

Code: Alles auswählen

systemctl enable test.service

wird sie aktiviert und spielt einen Sound beim Boote gleich nach dem sound.target ab. Und beim Runterfahren wird logout.wav abgespielt.

Während einer Gnome-Session (bzw. während ein Pulseaudio sich das Soundgerät gekrallt hat) kommt natürlich nix aus den Lautsprechern, wenn man dieses Service startet.

lg scientific

[xoric]

Hallo,
ich hab leider keine Zeit gehabt zu testen.
@scientific:

/run ist doch mittlerweile ein flüchtiges Verzeichnis... Wenn du dort was reinschreibst, überlebt das ja einen reboot nicht.

ich habe verschiedene Verzeichnisse getestet, auch in /usr/local/bin/ , fruchtlos. Auch andere Sound-Dateien haben nicht finktioniert.

Versteh ich dich richtig? Kenne knoppix nicht aus praktischer Erfahrung.
Während die Maschine bootet, düdelt sie ab vorhandensein des Soundsystems dahin, bis der Loginmanager erscheint?

Knoppix verwendet initv und bootet über ein script, welches jede Hardware einzeln auswählt, fragt mich aber nicht warum. Klaus Knopper macht dies wohl deswegen, weil Knoppix ein Live-System ist. Die Sound-Datei wird gestartet und, währenddessen das System gebootet. Lustiges gimix *grins*

Ich frage mich grad ob Knoppix systemd und pulseaudio verwendet, oder initv und alsa...

zu dem Zeitpunkt, (ich glaube es war Koppix7.6) war es intitv und alsa. In Jessie ging das Script noch in der alten Version. In Stretch wo nur noch systemd läuft, musste ich nach dem Upgrade auf systemd protieren, was geklappt hat. Auch ein Stretch in der Neuinstallation auf der VM funktioniert. Der MSI GE60 2QD Apache will nicht, dort kommen die besagten Fehlermeldungen.
Danke für den Link, das Script ist besser als meins. Soweit ichs beurteilen kann. Die Frage wäre, ob das Script auch .ogg Dateien abspielt. Der Entscheidende punkt wäre "wants=sound.target" und "after=sound.target" ich werds mal testen.
Wenn man den Sound beim Abmelden in Gnome/Kde etc. ausschaltet, klappts.
vielen Dank und LG
xoric

[scientific]

Mir ist es nicht gelungen, mit ogg123 von der debug-shell sound rauszukriegen. Mit aplay schon. Angeblich müsste man oggq23 auch das Alsadevice zuweisen. plughw:1 tat aber nicht. Device nicht gefunden.

Warum muss es unbedingt ein ogg-vorbis sein? Konvertier es nach wav und spiels mit aplay ab...

[smutbert]

jetzt erst fällt es mir wie Schuppen von den Augen...

Code: Alles auswählen

ogg123 -q --audio-buffer 4096 "$shutdownsndfile" >/dev/null 2>&1

spielt ja vom default-device ab, dh von hw:0,0 und genau das existiert nicht, weil bei dir hw:0 der HDMI-Ausgang ist, der klassischerweise die Geräte 3 und 7 (hw:0,3 und hw:0,7) und in deinem Fall zusätzlich 8 belegt.
Ob es da zusätzlich noch Probleme gibt, ähnlich scientifics Test in der debug-shell, dass zB die Alsaplugins wie plug(hw) noch nicht zur Verfügung stehen oder nicht gefunden werden oder ähnliches, weiß ich nicht.
Als normaler Benutzer funktioniert das Skript, weil sich dann Pulseaudio sebst zum default-"Device" von Alsa macht und root greift möglicherweise auf die Pulseaudio-Instanz des Nutzers zurück (eigene startet er normalerweise keine).

Demzufolge würde ich es einmal so probieren:

Code: Alles auswählen

export ALSA_CARD=PCH
ogg123 -q --audio-buffer 4096 "$shutdownsndfile"

oder gleich mit sox

Code: Alles auswählen

AUDIODEV=hw:PCH /usr/bin/play "$shutdownsndfile"

Mit PCH verwende ich hier in beiden Fällen den Namen statt der Nummer der Soundkarte, weil letztere sich sogar von Systemstart zu Systemstart ändern kann.


edit:
Hast du an alsa-utils irgendetwas gedreht? Ich meine diese Meldungen

Code: Alles auswählen

systemd-udevd[351]: Process '/usr/sbin/alsactl -E HOME=/run/alsa restore 1' failed with exit code 99.

Zuerst habe ich gedacht, dass du selbst ein zusätzliches Skript oä zum Wiederherstellen der Lautstärkeeinstellungen startest, aber das ist wohl nicht der Fall?
Das müsste dann von »/lib/udev/rules.d/90-alsa-restore.rules« kommen, aber der Sinn erschließt sich mir noch nicht, weil es dafür doch ohnehin eine eigene systemd-unit gibt.
Ich bin mir nur ziemlich sicher, dass diese Meldungen nichts mit dem Problem zu tun haben.

[xoric]

export ALSA_CARD=PCH

Das wars!
@smutbert perfekt, der Tipp hat die Lösung gebracht. Jetzt läufts. Er hat tatsächlich die Soundkarte nicht gefunden! Super Lösung. Danke!

Ich werde aber die nächsten Tage die anderen Vorschläge testen. Vorallem mit dem anderen Script von scientific. Dieser ist eleganter als meine Lösung, die ich einfach von initv übertragen hatte.

.Vielen Dank für eure Mühe
LG
xoric

P.S.
Es muss nicht ogg sein, wav dateien tuns auch. Ich hatte diese im Netz in den Formaten mp3, wav und ogg gefunden. Also eher zufällig die ogg dateien verwendet.

edit:

Hast du an Debianalsa-utils irgendetwas gedreht? Ich meine diese Meldungen

Nein. Das System habe ich neu installiert. Du hast recht, nachdem das Problem gelöst ist, auf jeden fall. Im Forum gibt es einen ähnlichen Thread:
viewtopic.php?f=13&t=166820&hilit=ACPI+ ... ion+failed
Danach liegt das Problem woanders. Einige recherchen deuteten auf einen Bug. Solange der Rechner zur Zufriedenheit läuft, is' es unwichtig.