Wiedergabe hängt regelmäßig

Max2Play Home › Forums › Max2Play Add-ons › Wiedergabe hängt regelmäßig

Viewing 5 posts - 1 through 5 (of 5 total)
  • Back to forum
    Posted in: Max2Play Add-ons
  • desteny premium
    5. Mai 2021 at 8:24 #51192

    Guten Morgen,

    ich habe häufig (alle 1-3 Tage) das Problem, dass mit der Wiedergabe über Airplay (LMS+SQLiteplayer) immer kurz hängt/kratzt alle 1-3 Sekunden. Ebenfalls hängt es bei direktwiedergabe eines Radios über das LMS Webinterface.
    Hab einen RPi 4 + Beocreate und das Problem bestand bei allen Versionen inkl. der aktuellen Beta. Abhilfe schafft nur – aber immer – ein gesamter Neustart des RPi’s.
    Meine speziellen Änderungen: Asoundconfig so geändert, dass ich zwei mono-Kanäle habe.

    Habe auch in die Logs geguckt aber es wird kein Ereignis Protokolliert was hier auffällig wäre – meiner Meinung nach.
    Da meine Meinung gerne auch mal falsch sein kann;

    welche weitere Daten und Logs (mit Pfaden bitte) muss ich denn angeben, um euch eine Chance zu geben, das Problem nachzuvollziehen?

    LG

    Liebe Grüße

    MarioM Moderator
    6. Mai 2021 at 13:48 #51194

    Hallo desteny,

    Ich könnte mir vorstellen, dass es entweder an einer instabilen Internetverbindung, deinen Anpassungen in der asoundconfig oder der Stromversorgung liegt. Bitte teste nach Möglichkeit die Wiedergabe für ein paar Tage mit einer Standardkonfiguration. Hast du den Pi per WLAN oder LAN-Kabel mit dem Internet verbunden? Welches Netzteil verwendest du? Nutzt du neben dem Squeezebox Server noch andere Max2Play Plugins?

    Falls du keine umfangreichen Änderungen im System vorgenommen hast, könntest du auch nochmal versuchen, ein frisches Max2Play Buster Image auf die SD-Karte zu brennen und dann lediglich den Squeezebox Server mit dem Airplay Plugin installieren.
    Wenn die Probleme dann immer noch auftauchen, hilft uns sicherlich die Squeezebox Server Log-Datei. Diese kannst du hier gerne posten, sobald sich die Wiedergabe erneut aufgehängt hat.

    desteny premium
    12. Mai 2021 at 8:08 #51236

    Guten Morgen,

    also habe grade die Wiedergabe nach ein paar Tagen der abstinenz gestartet.
    Die Wiedergabe funktioniert wie folgt grade, egal wie oft ich das Lied neustarte oder mein iPhone neu mit einem der Player verbinde:

    2Sek Musik, 0,5Sek Krzzzz/Wiederholungsschleife, 0,5 Sek Musik, 0,5 Sek Krzzz/Wiederholungsschleife, 2 Sek Musik, usw -> in Endlosschleife, die Zeitangaben variieren, aber sind jedoch immer unter 5 Sekunden.
    Raspi 4 ist via. LAN direkt an die Fritzbox angeschlossen. DSL Telekom 250er Leitung – ohne Probleme. Als Netzteil habe ich ein Netzteil HDR-100-24N von Meanwell -> 100W also.

    Das Problem habe ich seit über einem Jahr und trotz 3x neue Images draufgezogen. Zeitweilig hatte ich das Problem nicht mehr, als ich (Multi)Shairport genutzt habe.
    Das Problem tritt also nur bei Squezlite + LMS auf.

    [21-05-12 08:01:54.7202] Plugins::ShairTunes2W::Plugin::handleSocketConnect (477) New connection from: 192.168.20.28
[21-05-12 08:01:54.7217] Plugins::ShairTunes2W::Plugin::createListenPort (398) Created listener on port 43437
[21-05-12 08:01:54.7256] Plugins::ShairTunes2W::Plugin::conn_handle_request (759) DACP-ID: 79D1C18B7F80C2D8, Active Remote: 1459602536
[21-05-12 08:01:54.7343] Plugins::ShairTunes2W::Plugin::conn_handle_request (759) DACP-ID: 79D1C18B7F80C2D8, Active Remote: 1459602536
[21-05-12 08:01:54.7555] Plugins::ShairTunes2W::Plugin::conn_handle_request (759) DACP-ID: 79D1C18B7F80C2D8, Active Remote: 1459602536
[21-05-12 08:01:54.8594] Plugins::ShairTunes2W::Plugin::conn_handle_request (832) decode command: $VAR1 = 'host';
$VAR2 = '192.168.20.28';
$VAR3 = 'socket';
$VAR4 = 33281;
$VAR5 = 'fmtp';
$VAR6 = '96 352 0 16 40 10 14 2 255 0 0 44100';
$VAR7 = 'cport';
$VAR8 = '54718';
$VAR9 = 'tport';
$VAR10 = '63892';
$VAR11 = 'latencies';
$VAR12 = '1000:2000:f';
$VAR13 = 'codec';
$VAR14 = 'mp3:320';
$VAR15 = 'iv';
$VAR16 = '81777bb981b11b1ac422c4fb50186290';
$VAR17 = 'key';
$VAR18 = 'fbca516b039c8abca816872a846288e8';
[21-05-12 08:01:54.8983] Plugins::ShairTunes2W::Plugin::conn_handle_request (850) Helper output: shairport_helper: VERSION: 0.203.4
[21-05-12 08:01:54.8995] Plugins::ShairTunes2W::Plugin::conn_handle_request (861) launched decoder: Proc::Background=HASH(0x5a4fa70) on ports: 50992/57201/38013/59357, http port: 43437
[21-05-12 08:01:54.9090] Plugins::ShairTunes2W::Plugin::conn_handle_request (898) Playing url: airplay://192.168.20.251:59357/17219_stream.mp3
[21-05-12 08:01:54.9431] Plugins::ShairTunes2W::Plugin::conn_handle_request (908) Record from 0, 0
[21-05-12 08:01:54.9785] Plugins::ShairTunes2W::Plugin::conn_handle_request (917) Flush up to 15125, 2592636167
[21-05-12 08:01:55.4393] Plugins::ShairTunes2W::Plugin::handleHelperOut (561) From helper: play
[21-05-12 08:01:57.0502] Plugins::ShairTunes2W::Plugin::conn_handle_request (759) DACP-ID: 79D1C18B7F80C2D8, Active Remote: 1459602536
[21-05-12 08:01:57.0597] Plugins::ShairTunes2W::Plugin::mDNSlistener (1084) Found remote: 79D1C18B7F80C2D8, 192.168.20.28:51570
[21-05-12 08:01:57.6905] Plugins::ShairTunes2W::Plugin::handleCoverConnect (508) New cover proxy connection from 192.168.20.200
[21-05-12 08:01:57.6936] Plugins::ShairTunes2W::Plugin::handleCoverRequest (517) Image proxy request: GET /05d387666da54dbb8b8f88316a09816a/cover_192x192_p.jpeg HTTP/1.1
[21-05-12 08:01:57.6944] Plugins::ShairTunes2W::Plugin::handleCoverRequest (517) Image proxy request: Host: 192.168.20.251:43437
[21-05-12 08:01:57.6957] Plugins::ShairTunes2W::Plugin::handleCoverRequest (517) Image proxy request: User-Agent: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:88.0) Gecko/20100101 Firefox/88.0
[21-05-12 08:01:57.6965] Plugins::ShairTunes2W::Plugin::handleCoverRequest (517) Image proxy request: Accept: image/webp,*/*
[21-05-12 08:01:57.6973] Plugins::ShairTunes2W::Plugin::handleCoverRequest (517) Image proxy request: Accept-Language: de,en-US;q=0.7,en;q=0.3
[21-05-12 08:01:57.6981] Plugins::ShairTunes2W::Plugin::handleCoverRequest (517) Image proxy request: Accept-Encoding: gzip, deflate
[21-05-12 08:01:57.6987] Plugins::ShairTunes2W::Plugin::handleCoverRequest (517) Image proxy request: DNT: 1
[21-05-12 08:01:57.6994] Plugins::ShairTunes2W::Plugin::handleCoverRequest (517) Image proxy request: Connection: keep-alive
[21-05-12 08:01:57.7002] Plugins::ShairTunes2W::Plugin::handleCoverRequest (517) Image proxy request: Referer: http://192.168.20.251:9000/
[21-05-12 08:01:57.7052] Plugins::ShairTunes2W::Plugin::handleCoverRequest (517) Image proxy request: Cookie: Squeezebox-expandPlayerControl=false; Squeezebox-expanded-MY_MUSIC=1; Squeezebox-expanded-FAVORITES=1; Squeezebox-expanded-PLUGINS=1; Squeezebox-expanded-RADIO=1; Squeezebox-player=b8%3A26%3Aeb%3Ac1%3A71%3Af0; Squeezebox-enableHiDPI=1.5; Squeezebox-playersettings=null; Squeezebox-advancedsettings=null; Squeezebox-expanded-updatePlugins=1; Squeezebox-expanded-activePlugins=1; Squeezebox-expanded-inactivePlugins=1; Squeezebox-expanded-otherPlugins0=1; Squeezebox-expanded-PLUGIN_MY_APPS_MODULE_NAME=0; Squeezebox-albumView=
[21-05-12 08:01:57.7057] Plugins::ShairTunes2W::Plugin::handleCoverRequest (517) Image proxy request: 
[21-05-12 08:01:57.7078] Plugins::ShairTunes2W::Plugin::handleCoverRequest (545) Coverart sent 49324 over 49324
[21-05-12 08:01:58.6554] Plugins::ShairTunes2W::Plugin::handleCoverConnect (508) New cover proxy connection from 192.168.20.200
[21-05-12 08:01:58.6562] Plugins::ShairTunes2W::Plugin::handleCoverRequest (517) Image proxy request: GET /05d387666da54dbb8b8f88316a09816a/cover.jpeg HTTP/1.1
[21-05-12 08:01:58.6566] Plugins::ShairTunes2W::Plugin::handleCoverRequest (517) Image proxy request: Host: 192.168.20.251:43437
[21-05-12 08:01:58.6572] Plugins::ShairTunes2W::Plugin::handleCoverRequest (517) Image proxy request: User-Agent: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:88.0) Gecko/20100101 Firefox/88.0
[21-05-12 08:01:58.6576] Plugins::ShairTunes2W::Plugin::handleCoverRequest (517) Image proxy request: Accept: image/webp,*/*
[21-05-12 08:01:58.6580] Plugins::ShairTunes2W::Plugin::handleCoverRequest (517) Image proxy request: Accept-Language: de,en-US;q=0.7,en;q=0.3
[21-05-12 08:01:58.6584] Plugins::ShairTunes2W::Plugin::handleCoverRequest (517) Image proxy request: Accept-Encoding: gzip, deflate
[21-05-12 08:01:58.6587] Plugins::ShairTunes2W::Plugin::handleCoverRequest (517) Image proxy request: DNT: 1
[21-05-12 08:01:58.6590] Plugins::ShairTunes2W::Plugin::handleCoverRequest (517) Image proxy request: Connection: keep-alive
[21-05-12 08:01:58.6594] Plugins::ShairTunes2W::Plugin::handleCoverRequest (517) Image proxy request: Referer: http://192.168.20.251:9000/
[21-05-12 08:01:58.6619] Plugins::ShairTunes2W::Plugin::handleCoverRequest (517) Image proxy request: Cookie: Squeezebox-expandPlayerControl=false; Squeezebox-expanded-MY_MUSIC=1; Squeezebox-expanded-FAVORITES=1; Squeezebox-expanded-PLUGINS=1; Squeezebox-expanded-RADIO=1; Squeezebox-player=b8%3A26%3Aeb%3Ac1%3A71%3Af0; Squeezebox-enableHiDPI=1.5; Squeezebox-playersettings=null; Squeezebox-advancedsettings=null; Squeezebox-expanded-updatePlugins=1; Squeezebox-expanded-activePlugins=1; Squeezebox-expanded-inactivePlugins=1; Squeezebox-expanded-otherPlugins0=1; Squeezebox-expanded-PLUGIN_MY_APPS_MODULE_NAME=0; Squeezebox-albumView=
[21-05-12 08:01:58.6671] Plugins::ShairTunes2W::Plugin::handleCoverRequest (517) Image proxy request: 
[21-05-12 08:01:58.6683] Plugins::ShairTunes2W::Plugin::handleCoverRequest (545) Coverart sent 49324 over 49324

    Zugleich noch ein Auszug aus dem Syslog:

    
May 12 08:00:14 Musikserver systemd[1]: Created slice User Slice of UID 1000.
May 12 08:00:14 Musikserver systemd[1]: Starting User Runtime Directory /run/user/1000...
May 12 08:00:14 Musikserver systemd[1]: Started User Runtime Directory /run/user/1000.
May 12 08:00:14 Musikserver systemd[1]: Starting User Manager for UID 1000...
May 12 08:00:14 Musikserver systemd[16792]: Listening on GnuPG cryptographic agent and passphrase cache.
May 12 08:00:14 Musikserver systemd[16792]: Listening on GnuPG cryptographic agent and passphrase cache (restricted).
May 12 08:00:14 Musikserver systemd[16792]: Listening on GnuPG network certificate management daemon.
May 12 08:00:14 Musikserver systemd[16792]: Listening on Sound System.
May 12 08:00:14 Musikserver systemd[16792]: Reached target Timers.
May 12 08:00:14 Musikserver systemd[16792]: Listening on GnuPG cryptographic agent and passphrase cache (access for web browsers).
May 12 08:00:14 Musikserver systemd[16792]: Reached target Paths.
May 12 08:00:14 Musikserver systemd[16792]: Listening on GnuPG cryptographic agent (ssh-agent emulation).
May 12 08:00:14 Musikserver systemd[16792]: Starting D-Bus User Message Bus Socket.
May 12 08:00:14 Musikserver systemd[16792]: Listening on D-Bus User Message Bus Socket.
May 12 08:00:14 Musikserver systemd[16792]: Reached target Sockets.
May 12 08:00:14 Musikserver systemd[16792]: Reached target Basic System.
May 12 08:00:14 Musikserver systemd[16792]: Reached target Default.
May 12 08:00:14 Musikserver systemd[16792]: Startup finished in 207ms.
May 12 08:00:14 Musikserver systemd[1]: Started User Manager for UID 1000.
May 12 08:00:14 Musikserver systemd[1]: Started Session c24 of user pi.
May 12 08:00:14 Musikserver systemd[16792]: Starting Sound Service...
May 12 08:00:15 Musikserver systemd[1]: session-c24.scope: Succeeded.
May 12 08:00:15 Musikserver dbus-daemon[365]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.81' (uid=1000 pid=16816 comm="/usr/bin/pulseaudio --daemonize=no ")
May 12 08:00:15 Musikserver systemd[1]: Starting RealtimeKit Scheduling Policy Service...
May 12 08:00:15 Musikserver dbus-daemon[365]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1'
May 12 08:00:15 Musikserver systemd[1]: Started RealtimeKit Scheduling Policy Service.
May 12 08:00:15 Musikserver rtkit-daemon[16825]: Successfully called chroot.
May 12 08:00:15 Musikserver rtkit-daemon[16825]: Successfully dropped privileges.
May 12 08:00:15 Musikserver rtkit-daemon[16825]: Successfully limited resources.
May 12 08:00:15 Musikserver rtkit-daemon[16825]: Running.
May 12 08:00:15 Musikserver rtkit-daemon[16825]: Watchdog thread running.
May 12 08:00:15 Musikserver rtkit-daemon[16825]: Canary thread running.
May 12 08:00:15 Musikserver systemd[16792]: Started D-Bus User Message Bus.
May 12 08:00:15 Musikserver systemd[16792]: Started Sound Service.
May 12 08:00:25 Musikserver systemd[1]: Stopping User Manager for UID 1000...
May 12 08:00:25 Musikserver systemd[16792]: Stopping Sound Service...
May 12 08:00:25 Musikserver systemd[16792]: Stopped target Default.
May 12 08:00:25 Musikserver systemd[16792]: Stopping D-Bus User Message Bus...
May 12 08:00:25 Musikserver systemd[16792]: dbus.service: Succeeded.
May 12 08:00:25 Musikserver systemd[16792]: Stopped D-Bus User Message Bus.
May 12 08:00:25 Musikserver systemd[16792]: pulseaudio.service: Succeeded.
May 12 08:00:25 Musikserver systemd[16792]: Stopped Sound Service.
May 12 08:00:25 Musikserver systemd[16792]: Stopped target Basic System.
May 12 08:00:25 Musikserver systemd[16792]: Stopped target Timers.
May 12 08:00:25 Musikserver systemd[16792]: Stopped target Sockets.
May 12 08:00:25 Musikserver systemd[16792]: gpg-agent.socket: Succeeded.
May 12 08:00:25 Musikserver systemd[16792]: Closed GnuPG cryptographic agent and passphrase cache.
May 12 08:00:25 Musikserver systemd[16792]: gpg-agent-browser.socket: Succeeded.
May 12 08:00:25 Musikserver systemd[16792]: Closed GnuPG cryptographic agent and passphrase cache (access for web browsers).
May 12 08:00:25 Musikserver systemd[16792]: gpg-agent-ssh.socket: Succeeded.
May 12 08:00:25 Musikserver systemd[16792]: Closed GnuPG cryptographic agent (ssh-agent emulation).
May 12 08:00:25 Musikserver systemd[16792]: gpg-agent-extra.socket: Succeeded.
May 12 08:00:25 Musikserver systemd[16792]: Closed GnuPG cryptographic agent and passphrase cache (restricted).
May 12 08:00:25 Musikserver systemd[16792]: dirmngr.socket: Succeeded.
May 12 08:00:25 Musikserver systemd[16792]: Closed GnuPG network certificate management daemon.
May 12 08:00:25 Musikserver systemd[16792]: dbus.socket: Succeeded.
May 12 08:00:25 Musikserver systemd[16792]: Closed D-Bus User Message Bus Socket.
May 12 08:00:25 Musikserver systemd[16792]: Stopped target Paths.
May 12 08:00:25 Musikserver systemd[16792]: pulseaudio.socket: Succeeded.
May 12 08:00:25 Musikserver systemd[16792]: Closed Sound System.
May 12 08:00:25 Musikserver systemd[16792]: Reached target Shutdown.
May 12 08:00:25 Musikserver systemd[16792]: systemd-exit.service: Succeeded.
May 12 08:00:25 Musikserver systemd[16792]: Started Exit the Session.
May 12 08:00:25 Musikserver systemd[16792]: Reached target Exit the Session.
May 12 08:00:25 Musikserver systemd[1]: [email protected]: Succeeded.
May 12 08:00:25 Musikserver systemd[1]: Stopped User Manager for UID 1000.
May 12 08:00:25 Musikserver systemd[1]: Stopping User Runtime Directory /run/user/1000...
May 12 08:00:25 Musikserver systemd[16062]: run-user-1000.mount: Succeeded.
May 12 08:00:25 Musikserver systemd[1]: run-user-1000.mount: Succeeded.
May 12 08:00:25 Musikserver systemd[1]: [email protected]: Succeeded.
May 12 08:00:25 Musikserver systemd[1]: Stopped User Runtime Directory /run/user/1000.
May 12 08:00:25 Musikserver systemd[1]: Removed slice User Slice of UID 1000.

    Vielleicht verschafft das ganze ja einen Überblick.
    Ich starte nun den PI neu und es wird danach wieder einen Tag oder zwei völlig normal funktionieren.

    MarioM Moderator
    18. Mai 2021 at 13:32 #51257

    Hallo desteny,

    bitte entschuldige die späte Antwort. Hast du bereits den Bugfix für Shairtunes2 im Squeezebox Server Plugin installiert? Bitte teste auch mal die Wiedergabe über ein Internetradio oder andere Streamingservices, damit wir das Problem besser eingrenzen können.

    Edit: Falls wir keine Lösung finden, wäre vlt. ein Workaround über crontab einen automatischen Neustart des System alle 2-3 Tage einzurichten.

    • This reply was modified 2 years, 11 months ago by MarioM.
    desteny premium
    19. Mai 2021 at 7:49 #51267

    Guten Morgen,

    alles gut. Lieber spät als nie 🙂
    Den Bugfix habe ich grade installiert. Keine Änderung.

    Interessanterweise hängt es grade auch, wenn ich einen Internetstream wiedergebe (also direkt in LMS ausgewählt unter Radios).
    Ich habe einen Neustart täglich schon eingerichtet. Manchmal (so wie jetzt) muss ich den trotzdem per Hand neustarten.

    Habe grade mal den Log auf Debug gestellt. Wenn ich was finde, poste ich es.

Viewing 5 posts - 1 through 5 (of 5 total)

You must be logged in to reply to this topic.

Register here