VDR kommt nach XBMC Exit manchmal nicht hoch (softhddevice/vdr-frontend DBus Problem)

maec21 · Dec 18th 2013

Hi,

seit meinem Update auf 2.0.3 funktioniert nach einem XBMC Exit die Aktivierung des softhddevice manchmal nicht mehr. Das Verhalten kann ich nicht forcieren, manchmal bleibt einfach Bild und Ton dunkel bzw. weg. DBus scheint irgendetwas nicht mehr laden zu können:

Code

Error org.freedesktop.DBus.Error.NoReply: Did not receive a reply. Possible causes include: the remote application did not send a reply, the message bus security policy blocked the reply, the reply timeout expired, or the network connection was broken.

Ich bin jetzt sogar auf Testing (2.0.4) gegangen, dort tritt aber das gleiche Problem auf. Das Ändern der Reihenfolge der Plugins in der order.conf hat in keiner Konstellation eine Verbeserung gebracht.

Hier meine Infos/Logs:

/var/log/upstart/vdr-frontend.log

Code

wait-for-job-state stop/waiting
wait-for-job-state stop/waiting
wait-for-job-state stop/waiting
method return sender=:1.69 -> dest=:1.72 reply_serial=2
int32 900
string "SoftHdDevice already detached"
wait-for-job-state (vdr-frontendvdr) stop/killed, process 1038
wait-for-job-state stop/waiting
wait-for-job-state stop/waiting
Error org.freedesktop.DBus.Error.NoReply: Did not receive a reply. Possible causes include: the remote application did not send a reply, the message bus security policy blocked the reply, the reply timeout expired, or the network connection was broken.
wait-for-job-state stop/waiting
wait-for-job-state stop/waiting
wait-for-job-state stop/waiting

Display More

/var/log/syslog

Code

Dec 18 16:57:33 vdr vdr: [1112] executing command '/usr/share/vdr/menuorg-appswitcher standalone=yes app=xbmc &> /dev/null '
Dec 18 16:57:33 vdr kernel: [55.991608] init: vdr-frontend main process (1644) killed by TERM signal
Dec 18 16:57:33 vdr vdr: [1520][softhddev]SetPlayMode: 0
Dec 18 16:57:33 vdr vdr: [1520][softhddev]SetVideoDisplayFormat: 1 [softhddev]GetSpuDecoder:
Dec 18 16:57:33 vdr vdr: [1520][softhddev]SetPlayMode: 1
Dec 18 16:57:33 vdr vdr: video: fatal i/o error
Dec 18 16:57:33 vdr vdr: [1906] TS buffer on device 1 thread ended (pid=1112, tid=1906)
Dec 18 16:57:33 vdr vdr: [1904] buffer stats: 63168 (1%) used
Dec 18 16:57:33 vdr vdr: [1904] receiver on device 1 thread ended (pid=1112, tid=1904)
Dec 18 16:57:35 vdr kernel: [58.113996] Bluetooth: Core ver 2.16
Dec 18 16:57:35 vdr kernel: [58.114012] NET: Registered protocol family 31
Dec 18 16:57:35 vdr kernel: [58.114014] Bluetooth: HCI device and connection manager initialized
Dec 18 16:57:35 vdr kernel: [58.114016] Bluetooth: HCI socket layer initialized
Dec 18 16:57:35 vdr kernel: [58.114018] Bluetooth: L2CAP socket layer initialized
Dec 18 16:57:35 vdr kernel: [58.114022] Bluetooth: SCO socket layer initialized
Dec 18 16:57:35 vdr kernel: [58.129939] Bluetooth: RFCOMM TTY layer initialized
Dec 18 16:57:35 vdr kernel: [58.129944] Bluetooth: RFCOMM socket layer initialized
Dec 18 16:57:35 vdr kernel: [58.129945] Bluetooth: RFCOMM ver 1.11
Dec 18 16:57:39 vdr vdr: [1519] loading /var/lib/vdr/plugins/xvdr/allowed_hosts.conf
Dec 18 16:57:39 vdr vdr: [1519] XVDR: Client 127.0.0.1:9918 with ID 0 connected.
Dec 18 16:57:39 vdr vdr: [2176] XVDR: Welcome client 'XVDR Client' with protocol version '5'
Dec 18 16:57:39 vdr vdr: [2176] XVDR: Preferred language: deu,ger / type: 1
Dec 18 16:57:39 vdr vdr: [2176] XVDR: Channellist filter:
Dec 18 16:57:39 vdr vdr: [2176] XVDR: Free To Air channels: Yes
Dec 18 16:57:39 vdr vdr: [2176] XVDR: Only native language: No
Dec 18 16:57:39 vdr vdr: [2176] XVDR: Enabled CaIDs: 
Dec 18 16:57:39 vdr vdr: [2176] XVDR: Setting channel update method: 3
Dec 18 16:57:39 vdr vdr: [2176] XVDR: Connected to wirbelscan plugin ...
Dec 18 16:57:39 vdr vdr: [2176] XVDR: wirbelscan plugin version: 0.0.7
Dec 18 16:57:39 vdr vdr: [2176] XVDR: Connected to wirbelscan plugin ...
Dec 18 16:57:39 vdr vdr: [2176] XVDR: wirbelscan plugin version: 0.0.7
Dec 18 16:57:49 vdr vdr: [1519] XVDR: Checking for channel updates ...
Dec 18 16:57:49 vdr vdr: [1519] XVDR: Client 0: 42 channels, no change
Dec 18 16:57:49 vdr vdr: [1519] XVDR: Done.
Dec 18 16:57:49 vdr vdr: [1519] XVDR: Client with ID 0 seems to be disconnected, removing from client list
Dec 18 16:57:51 vdr LCDd: sock_send: socket write error
Dec 18 16:57:54 vdr XBMC: XBMC exit with exit status , , ENV: TERM=linux#012PATH=/usr/local/sbin:/usr/local/bin:/usr/bin:/usr/sbin:/sbin:/bin#012PWD=/#012JOB=xbmc#012RESULT=ok#012SHLVL=1#012HOME=/var/lib/vdr#012UPSTART_INSTANCE=#012UPSTART_EVENTS=stopped#012UPSTART_JOB=xbmc-exit#012INSTANCE=#012DISPLAY=:1#012_=/usr/bin/env.
Dec 18 16:57:54 vdr /usr/bin/signal-event.real[2214]: processing signal reset-display-rate
Dec 18 16:57:54 vdr /usr/bin/signal-event.real[2214]: processing action /usr/share/yavdr/events/reset-display-rate/10_reset-display-rate
reset-display-rate
Dec 18 16:57:55 vdr /usr/bin/signal-event.real[2214]: finished processing signal reset-display-rate
Dec 18 16:57:55 vdr vdr-frontend[2249]: acip-wakeup.time.old hatte Wert: Thu Dec 19 05:55:00 2013
Dec 18 16:57:55 vdr vdr-frontend[2249]: vergleiche mit jetzt: Wed Dec 18 15:57:55 2013
Dec 18 16:57:55 vdr vdr-frontend[2249]: assuming manual start
Dec 18 16:57:55 vdr vdr: [2207] dbus2vdr: use of deprecated interface: 'List' should be called with the interface 'de.tvdr.vdr.pluginmanager'!
Dec 18 16:57:55 vdr vdr-frontend[2249]: watching "MCE IR Keyboard/Mouse (nuvoton-cir)": /dev/input/event3
Dec 18 16:57:55 vdr vdr-frontend[2249]: started udev monitoring of input devices
Dec 18 16:57:55 vdr vdr-frontend[2249]: conntected to Lirc-Socket on /var/run/lirc/lircd
Dec 18 17:05:02 vdr CRON[3560]: (root) CMD (command -v debian-sa1 > /dev/null && debian-sa1 1 1) etc/cron.hourly)

Display More

/etc/vdr/plugins/order.conf

Code

firstplugin
secondplugin
*lastplugin
-thirdplugin
-fourthplugin
*anotherlastplugin


softhddevice
*dynamite
-dvbhddevice
-dvbsddevice
-pvr350
-dummydevice
-xineliboutput
lcdproc
-graphtftng
-xine
-targavfd

Display More

VDR Übersicht

Code

**************************************
*           VDR Übersicht            *
**************************************


VDR   : 2.0.4-1yavdr0~0.5
Kernel: 3.2.0-57-generic
ABI   : vdr-abi-2.0.0-yavdr1
XBMC  : 2:12.2~git20130502.1706-frodo-0precise


Plugins:
( N = Native Plugin       )
( D = Debian Plugin       )
( - = Deaktiviert         )
--------------------------------------
D burn
  Package: vdr-plugin-burn
  Version: 0.2.2-4yavdr10~precise
D channellists
  Package: vdr-plugin-channellists
  Version: 0.0.5-0yavdr2~precise
D dbus2vdr
  Package: vdr-plugin-dbus2vdr
  Version: 20131027103016testing-0yavdr0~precise
- dummydevice
  Package: vdr-plugin-dummydevice
  Version: 1.0.3-0yavdr22~precise
- dvbhddevice
  Package: vdr-plugin-dvbhddevice
  Version: 2.0.4-1yavdr0~0.5
D dynamite
  Package: vdr-plugin-dynamite
  Version: 20131027103028testing-0yavdr0~precise
D conflictcheckonly
  Package: vdr-plugin-epgsearch
  Version: 1.0.1.beta5~git20130911-0yavdr2~precise
D epgsearch
  Package: vdr-plugin-epgsearch
  Version: 1.0.1.beta5~git20130911-0yavdr2~precise
D epgsearchonly
  Package: vdr-plugin-epgsearch
  Version: 1.0.1.beta5~git20130911-0yavdr2~precise
D quickepgsearch
  Package: vdr-plugin-epgsearch
  Version: 1.0.1.beta5~git20130911-0yavdr2~precise
D extrecmenu
  Package: vdr-plugin-extrecmenu
  Version: 1.2.3-git20131022-0yavdr0~precise
D femon
  Package: vdr-plugin-femon
  Version: 2.0.0-0yavdr4~precise
D lcdproc
  Package: vdr-plugin-lcdproc
  Version: 0.0.10-jw9+git20130918-0yavdr1~precise
D live
  Package: vdr-plugin-live
  Version: 0.3.0+git20130915-3yavdr1~precise
D markad
  Package: vdr-plugin-markad
  Version: 0.1.4.git20131115-0yavdr0~precise
D menuorg
  Package: vdr-plugin-menuorg
  Version: 0.5.1-4yavdr4~precise
D restfulapi
  Package: vdr-plugin-restfulapi
  Version: 20131027103045testing-0yavdr0~precise
D scheduler
  Package: vdr-plugin-scheduler
  Version: 0.1.6-0yavdr1~precise
D softhddevice
  Package: vdr-plugin-softhddevice
  Version: 1
D streamdev-server
  Package: vdr-plugin-streamdev-server
  Version: 0.6.1.git20131129-0yavdr0~precise
D systeminfo
  Package: vdr-plugin-systeminfo
  Version: 0.1.2-1yavdr36~precise
D text2skin
  Package: vdr-plugin-text2skin
  Version: 1.3.2+git20130504-0yavdr3~precise
D undelete
  Package: vdr-plugin-undelete
  Version: 0.0.6-60yavdr4~precise
D vdrmanager
  Package: vdr-plugin-vdrmanager
  Version: 0.9-3yavdr4~precise
D wirbelscan
  Package: vdr-plugin-wirbelscan
  Version: 0.0.7-3yavdr18~precise
- xineliboutput
  Package: vdr-plugin-xineliboutput
  Version: 1.0.7+cvs20130117-1yavdr6~precise
- xine
  Package: vdr-plugin-xine
  Version: 0.9.4-13yavdr4~precise
D xvdr
  Package: vdr-plugin-xvdr
  Version: 0.9.9.git20131104-0yavdr1~precise
D yaepghd
  Package: vdr-plugin-yaepghd
  Version: 0.0.5pre1+git20130414-1yavdr4~precise


Addon Packages:
--------------------------------------
vdr-addon-acpiwakeup (0.0.10-2yavdr2~precise)
vdr-addon-avahi-mounter (20131206183239stable-0yavdr0~precise)
vdr-addon-lifeguard (0.0.4-3yavdr0~precise)
vdr-genindex (0.1.3-1ubuntu1)
vdr-markad (0.1.4.git20131115-0yavdr0~precise)
vdr-skin-anthra-1920-fst (20130420-0yavdr0~precise)
vdr-skin-anthra-1920-ost (20130413-1yavdr0~precise)
vdr-skins-anthra (20100904-4yavdr1~precise)


More Packages:
--------------------------------------
linux-firmware-yavdr (1.16-1yavdr0~precise)
vdrsymbols-ttf (20080905-7yavdr0~precise)
yavdr-base (20131209092033stable-0yavdr0~precise)
yavdr-i18n (20120927012007stable-0yavdr0~precise)
yavdr-plymouth-theme (20120927012042stable-0yavdr0~precise)
yavdr-remote (20130905102255stable-0yavdr0~precise)
yavdr-utils (20131211131912stable-0yavdr0~precise)
yavdr-webfrontend (20130905102307stable-0yavdr0~precise)
xbmc (2:12.2~git20130502.1706-frodo-0precise)
xbmc-addon-xvdr (0.9.8~git201304291220-7yavdr0)
xbmc-bin (2:12.2~git20130502.1706-frodo-0precise)

Display More

Grüße,
Wolfgang

Razorblade · Feb 4th 2014

Ich habe das gleiche Problem vermehrt bei einem Systemstart (nutze gar kein XBMC).

vdr-frontend startet dann andauernd durch:

Code

[   43.935735] init: vdr-frontend main process (1700) terminated with status 1
[   43.935835] init: vdr-frontend main process ended, respawning
[   70.015794] init: vdr-frontend main process (1791) terminated with status 1
[   70.015895] init: vdr-frontend main process ended, respawning
[   96.048570] init: vdr-frontend main process (1987) terminated with status 1
[   96.048688] init: vdr-frontend main process ended, respawning
[  122.062597] init: vdr-frontend main process (2022) terminated with status 1
[  122.062723] init: vdr-frontend main process ended, respawning
[  148.095675] init: vdr-frontend main process (2216) terminated with status 1
[  148.095801] init: vdr-frontend main process ended, respawning
[  174.106604] init: vdr-frontend main process (2250) terminated with status 1
[  174.106748] init: vdr-frontend main process ended, respawning
[  200.143572] init: vdr-frontend main process (2444) terminated with status 1
[  200.143671] init: vdr-frontend main process ended, respawning
[  226.154506] init: vdr-frontend main process (2478) terminated with status 1
[  226.154630] init: vdr-frontend main process ended, respawning
[  252.182666] init: vdr-frontend main process (2672) terminated with status 1

Display More

usw

im /var/log/upstart/vdr-frontend.log steht dann:

Code

Traceback (most recent call last):
  File "<stdin>", line 436, in <module>
  File "<stdin>", line 180, in __init__
  File "<stdin>", line 54, in manualstart
  File "/usr/lib/python2.7/dist-packages/dbus/proxies.py", line 70, in __call__
    return self._proxy_method(*args, **keywords)
  File "/usr/lib/python2.7/dist-packages/dbus/proxies.py", line 145, in __call__
    **keywords)
  File "/usr/lib/python2.7/dist-packages/dbus/connection.py", line 651, in call_blocking
    message, timeout)
dbus.exceptions.DBusException: org.freedesktop.DBus.Error.NoReply: Did not receive a reply. Possible causes include: the remote application did not send a reply, the message bus security policy blocked the reply, the reply timeout expired, or the network connection was broken.
Error org.freedesktop.DBus.Error.NoReply: Did not receive a reply. Possible causes include: the remote application did not send a reply, the message bus security policy blocked the reply, the reply timeout expired, or the network connection was broken.
Error org.freedesktop.DBus.Error.NoReply: Did not receive a reply. Possible causes include: the remote application did not send a reply, the message bus security policy blocked the reply, the reply timeout expired, or the network connection was broken.
wait-for-job-state stop/waiting
wait-for-job-state stop/waiting
wait-for-job-state stop/waiting

Display More

vdr scheint währenddessen zu laufen (komme aufs admin-gui, dort steht "VDR backend: running").

Gibt es evtl Probleme mit dem dbus-plugin? (dbus2vdr output sieht allerdings identisch aus zwischen normalen Start und einem Fehlerhaften)

mini73 · Feb 5th 2014

Moin!

Eine Lösung kann ich leider nicht geben, aber ich hatte auch manchmal solche Zeilen im syslog:

Code

Dec 18 16:57:33 vdr vdr: video: fatal i/o error

Wenn die kamen, dann war softhddevice in einem Zustand, der nicht mehr vernünftig auflösbar war.

Wie sehen eure Einstellungen zu ClearOnSwitch bei softhddevice aus? Wenn auf 1, dann bitte mal auf 0 stellen.
Ich hatte das Gefühl, dass es dann besser bei mir läuft. Mittlerweile hab ich aber ein ganz anderes Setup, was den Wechsel zwischen softhddevice und xbmc betrifft, deshalb kann ich in die Richtung nicht wirklich testen.

Lars.

Razorblade · Feb 5th 2014

Ja ClearOnSwitch habe ich auf "1" werde ich mal auf "0" stellen und beobachten.
Diese fatal i/o error habe ich auch manchmal im Log, aber anscheinend nicht zu dem Zeitpunkt zu dem das Problem auftritt.

FJe · Feb 6th 2014

moin,

hatte mal ein dbus-Problem , das ganz andere Ursachen hatte, schaut mal auf Euer .dbus-Dir, ob da alles korrekt ist.

bye
frank

Razorblade · Feb 6th 2014

Hmm, ich hatte wohl mit ClearOnSwitch mal rumgespielt, aber es war jetzt (auch während das Problem schon mehrfach auftrat) bereits auf "0" gesetzt, daran liegt es also nicht

Wegen dbus, unter yavdr liegt das vdr user home in /var/lib/vdr
Dort existiert gar kein .dbus ... sollte es?

mini73 · Feb 6th 2014

Nein, das hat nur was mit dem Sessionbus zu tun, der ist bei yavdr nicht aktiv.

Lars

Razorblade · Feb 10th 2014

Noch Vorschläge was ich beim nächsten mal nachgucken/probieren soll wenn es auftritt?

Bis jetzt behlfe ich mir mit einem "service vdr restart" (service vdr-frontend restart hilft nicht!)

mini73 · Feb 10th 2014

Die Ausgaben von softhddevice im syslog sind interessant und evtl. noch /var/log/upstart/vdr-frontend.log.
Im letzteren sind leider keine Zeitstempel, weshalb die Zuordnung da etwas schwierig ist.

Einfaches Kanalwechseln hilft auch nicht?
Kommt bei "Ok" die Kanalinfo? Geht das vdr-OSD in irgend einer Form?

Lars.

Razorblade · Feb 10th 2014

im vdr-frontend.log stand nur die DBus Meldung, die ich schon gepostet hatte. Es kommt gar nicht erst ein vdr OSD, es wird nichtmal ein Hintergrundbild im X angezeigt, einfach nur schwarz.
Laut Prozessliste scheinen aber sowohl X als auch vdr zu laufen.

X.log und syslog waren auch unauffällig, werde aber beim nächsten mal wenns passiert nochmal genauer nachschauen.

VDR kommt nach XBMC Exit manchmal nicht hoch (softhddevice/vdr-frontend DBus Problem)

Participate now!

Share

Tags