Bild friertnach Softstandby ein

[Anskar]

Habe das 12160 Image installiert.
Erst-Assi durchlaufen lassen, und keinerlei Sachen eingespielt.
Image ist jungfräulich.
Habe einmal bei ARD auf Standby geschaltet und wieder an, da ist alles OK gewesen.
Habe dann gleich wieder auf Standby geschaltet und wieder an, da tritt folgendes Problem auf, nach Softstandby friert das Bild ein.
Dabei fällt mir auf das beim einschalten das Bild kurz da ist aber kein Ton und dann friert auch schon das Bild ein und beim Versuch Umzuschalten gibt es Dauerspinner.
Getestet auch mit HDMU 12170 und da das gleiche.
Beim HDMU 12140 tritt es auch schon auf.

Beim 12072 tritt dieses Problem nicht auf.

morly hat mir gestern Abend bestätigt das da ein Fehler vorliegt, hatte selbst dieses auch.

Hier mal der Auszug vom log wenn es passiert:

KEY: 74 - STANDBY
****         9216 1 ****
[SEM] UP
KEY_PRESS - 74 1
++++            0 ms ++++
leave standby
playing 1:0:1:6DCA:44D:1:C00000:0:0:0:
KEY_RELEASE - 74 00 1 1 CAUSE=Timeout
[__evStart]
[__evSeekableStatusChanged]
not pauseable.
not pauseable.
not pauseable.
RemovePopup, id = ZapError
allocate channel.. 044d:0001
opening frontend 0
----          182 ms ----
[SEM] DOWN
frontend successfully opened
(0)tune
RotorCmd ffffffff, lastRotorCmd ffffffff
prepare_sat System 0 Freq 11836500 Pol 0 SR 27500000 INV 2 FEC 3 orbpos 192 system 0 modulation 1 pilot 2, rolloff 0
tuning to 1236 mhz
OURSTATE: tuning
allocate Channel: res 0
[eDVBCIInterfaces] addPMTHandler 1:0:1:6DCA:44D:1:C00000:0:0:0:
allocate demux
[SEC] invalidate current switch params
[SEC] setVoltage 2
[SEC] sleep 10ms
[SEC] setTone 1
[SEC] sleep 10ms
[SEC] update current switch params
[SEC] startTuneTimeout 5000
[SEC] setFrontend 1
setting frontend 0
(0)fe event: status 0, inversion off, m_tuning 1
[SEC] sleep 500ms
(0)fe event: status 1f, inversion off, m_tuning 2
OURSTATE: ok
[eDVBLocalTimerHandler] channel 0x1861dc8 running
[eEPGCache] channel 0x1861dc8 running
[EPGC] next update in 2 sec
stop release channel timer
eventNewProgramInfo 0 0
have 1 video stream(s) (0065), and 1 audio stream(s) (0066), and the pcr pid is 0065, and the text pid is 0068
allocate demux
TuxTxt cache cleared
decoder state: play, vpid=101, apid=102
DMX_SET_PES_FILTER(0x65) - pcr - ok
DMX_SET_PES_FILTER(0x66) - audio - ok
AUDIO_SET_BYPASS(1) - ok
AUDIO_PLAY - ok
Video Device: /dev/dvb/adapter0/video0
demux device: /dev/dvb/adapter0/demux0
VIDEO_SET_STREAMTYPE 0 - ok
DMX_SET_PES_FILTER(0x65) - video - ok
VIDEO_PLAY - ok
DMX_SET_PES_FILTER(0x68) - ttx - ok
TuxTxt cache cleared
TuxTxt: initialized
TuxTxt service started 68
TuxTxt running thread...(068)
VIDEO_CONTINUE - ok
VIDEO_SLOWMOTION(0) - ok
VIDEO_FAST_FORWARD(0) - ok
AUDIO_CONTINUE - ok
disable teletext subtitles page ffffffffffffffff (und)
[__evUpdatedInfo]
[writeChannelName]
vfd display text: Das Erste
[showCrypted]
[showDolby]
[showMp3]
[eDVBCAService] new service 1:0:1:6DCA:44D:1:C00000:0:0:0:
[eDVBCAService] add demux 0 to slot 0 service 1:0:1:6DCA:44D:1:C00000:0:0:0:
[__evUpdatedEventInfo]
[__evUpdatedEventInfo]
[__evUpdatedEventInfo]
RemovePopup, id = ZapError
[eDVBLocalTimerHandler] diff is 0
[eDVBLocalTimerHandler] diff < 120 .. use Transponder Time
[eDVBLocalTimerHandler] not changed
VIDEO_GET_EVENT - ok
unhandled DVBAPI Video Event 9
VIDEO_GET_EVENT - ok
unhandled DVBAPI Video Event 5
VIDEO_GET_EVENT - ok
[__evVideoSizeChanged]
VIDEO_GET_EVENT - ok
use pmtpid 0064 for service_id 6dca
[EPGC] start caching events(1397676542)
[Dish] tuning failed
eventNewProgramInfo 0 0
have 1 video stream(s) (0065), and 3 audio stream(s) (0066, 0067, 006a), and the pcr pid is 0065, and the text pid is 0068
decoder state: play, vpid=101, apid=102
[__evUpdatedInfo]
[writeChannelName]
vfd display text: Das Erste
[showCrypted]
[showDolby]
[showMp3]
sdt update done!
[__evUpdatedEventInfo]
[__evUpdatedEventInfo]
KEY: 03 - 2BUTTON
****        34922 1 ****
[SEM] UP
KEY_PRESS - 03 1
++++            1 ms ++++
KEY_RELEASE - 03 00 1 1 CAUSE=Timeout
warning, skin is missing element servicename in <class 'Screens.InfoBarGenerics.NumberZap'>
----          180 ms ----
[SEM] DOWN
playing 1:0:1:6D66:437:1:C00000:0:0:0:
[eDVBCAService] free slot 0 demux 0 for service 1:0:1:6DCA:44D:1:C00000:0:0:0:
[eDVBCAService] free service 1:0:1:6DCA:44D:1:C00000:0:0:0:
decoder state: play, vpid=-1, apid=-1
DEMUX_STOP - pcr - ok
DEMUX_STOP - video - ok
VIDEO_STOP - main thread is non-idle! display spinner!

Eine Bitte an die Kathrein UFS 910 Besitzer, testet das bitte bei Euch auch mal.
Vielleicht ist es möglich das Image zu benennen ab wann das Auftritt.
Werde jetzt nochmal das 12171 testen.

Da morly etwas wenig Zeit hat bitte ich doch die Spezialisten das zu fixen, danke.

MfG

Auch beim HDMU 12171 Image tritt das Problem nach 3. Standby/einschalten auf .

MfG

[morly]

Häng uns noch ein log an wenn es nicht passiert - zum Vergleichen,
komm gerade nicht an die Box

[Anskar]

Nicht passiert von einem NOK Image oder vom 12072?

MfG

[morly]

beim selben Image wo der Fehler passiert - nur aber eben für den Fall, wo das Prob nicht auftritt

[Anskar]

Hier das log, ZDF HD /Standby/ Einschalten/Ton-Bild OK/ Umschalten auf Das Erste HD Ok.
Test erfolgt gleich nach Start von HDMU 12171, Standby/Einschalten beim ersten Versuch OK.
Aber beim 3. Versuch auch wieder NOK.

#Log file from Morlys SH4 STB Admin Tool from: Fr Apr 18 2014, 14:31:48

KEY: 74 - STANDBY
****        32359 1 ****
[SEM] UP
KEY_PRESS - 74 1
++++            7 ms ++++
KEY_RELEASE - 74 00 1 1 CAUSE=Timeout
----          181 ms ----
[SEM] DOWN
enter standby
[eDVBCAService] free slot 0 demux 0 for service 1:0:19:2B66:3F3:1:C00000:0:0:0:
[eDVBCAService] free service 1:0:19:2B66:3F3:1:C00000:0:0:0:
decoder state: play, vpid=-1, apid=-1
DEMUX_STOP - pcr - ok
DEMUX_STOP - video - ok
VIDEO_STOP - ok
AUDIO_STOP - ok
DEMUX_STOP - audio - ok
AUDIO_CONTINUE - ok
DEMUX_STOP - ttx - ok
TuxTxt stopped service 17f2
cleaning up
TuxTxt cache cleared
start release channel timer
main thread is non-idle! display spinner!
eDBoxLCD::getInstance
eDBoxLCD::setLCDBrightness
[DVBCAHandler] no more services
release cached channel (timer timeout)
[eDVBLocalTimerHandler] remove channel 0x1c54650
[eEPGCache] remove channel 0x1c54650
stop release channel timer
KEY: 74 - STANDBY
****         9396 1 ****
[SEM] UP
KEY_PRESS - 74 1
++++            0 ms ++++
leave standby
KEY_RELEASE - 74 00 1 1 CAUSE=Timeout
playing 1:0:19:2B66:3F3:1:C00000:0:0:0:
----          179 ms ----
[SEM] DOWN
[__evStart]
[__evSeekableStatusChanged]
not pauseable.
not pauseable.
not pauseable.
RemovePopup, id = ZapError
allocate channel.. 03f3:0001
(0)tune
RotorCmd ffffffff, lastRotorCmd ffffffff
prepare_sat System 1 Freq 11361000 Pol 0 SR 22000000 INV 2 FEC 2 orbpos 192 system 1 modulation 2 pilot 2, rolloff 0
tuning to 1611 mhz
OURSTATE: tuning
allocate Channel: res 0
[eDVBCIInterfaces] addPMTHandler 1:0:19:2B66:3F3:1:C00000:0:0:0:
allocate demux
eDBoxLCD::getInstance
eDBoxLCD::setLCDBrightness
HOTPLUG connection!
hotplug: ACTION=add
complete ACTION=add
[SEC] invalidate current switch params
HOTPLUG connection lost!
hotplug: {'ACTION': 'add', 'PHYSDEVPATH': '-', 'DEVPATH': '/devices/virtual/bdi/0:17'}
couldn't read model:  [Errno 2] No such file or directory: '/sys/block/0:1/device/model'
set sequence pos 3
set sequence pos 3
[SEC] update current switch params
[SEC] startTuneTimeout 5000
[SEC] setFrontend 1
setting frontend 0
(0)fe event: status 0, inversion off, m_tuning 1
(0)fe event: status 1f, inversion off, m_tuning 2
OURSTATE: ok
[eDVBLocalTimerHandler] channel 0x1cab208 running
[eEPGCache] channel 0x1cab208 running
[EPGC] next update in 56 min
stop release channel timer
eventNewProgramInfo 0 0
have 1 video stream(s) (17de), and 1 audio stream(s) (17e8), and the pcr pid is 17de, and the text pid is 17f2
allocate demux
TuxTxt cache cleared
decoder state: play, vpid=6110, apid=6120
DMX_SET_PES_FILTER(0x17de) - pcr - ok
DMX_SET_PES_FILTER(0x17e8) - audio - ok
AUDIO_SET_BYPASS(1) - ok
AUDIO_PLAY - ok
Video Device: /dev/dvb/adapter0/video0
demux device: /dev/dvb/adapter0/demux0
VIDEO_SET_STREAMTYPE 1 - ok
DMX_SET_PES_FILTER(0x17de) - video - ok
VIDEO_PLAY - ok
DMX_SET_PES_FILTER(0x17f2) - ttx - ok
TuxTxt cache cleared
TuxTxt: initialized
TuxTxt service started 17f2
TuxTxt running thread...(17f2)
VIDEO_CONTINUE - ok
VIDEO_SLOWMOTION(0) - ok
VIDEO_FAST_FORWARD(0) - ok
AUDIO_CONTINUE - ok
disable teletext subtitles page ffffffffffffffff (und)
[__evUpdatedInfo]
[writeChannelName]
vfd display text: ZDF HD          
[showCrypted]
[showDolby]
[showMp3]
[eDVBCAService] new service 1:0:19:2B66:3F3:1:C00000:0:0:0:
[eDVBCAService] add demux 0 to slot 0 service 1:0:19:2B66:3F3:1:C00000:0:0:0:
[__evUpdatedEventInfo]
[__evUpdatedEventInfo]
[__evUpdatedEventInfo]
RemovePopup, id = ZapError
[SEC] sleep 500ms
VIDEO_GET_EVENT - ok
unhandled DVBAPI Video Event 9
use pmtpid 17d4 for service_id 2b66
VIDEO_GET_EVENT - ok
unhandled DVBAPI Video Event 5
VIDEO_GET_EVENT - ok
[__evVideoSizeChanged]
VIDEO_GET_EVENT - ok
eventNewProgramInfo 0 0
dvb subtitle  PID 17f3 with wrong subtitling type (24)... force 0x10!!
have 1 video stream(s) (17de), and 4 audio stream(s) (17e8, 17e9, 17eb, 17ea), and the pcr pid is 17de, and the text pid is 17f2
decoder state: play, vpid=6110, apid=6120
dvb subtitle  PID 17f3 with wrong subtitling type (24)... force 0x10!!
[__evUpdatedInfo]
[writeChannelName]
vfd display text: ZDF HD          
[showCrypted]
[showDolby]
[showMp3]
sdt update done!
[Dish] tuning failed
[__evUpdatedEventInfo]
[__evUpdatedInfo]
[writeChannelName]
vfd display text: ZDF HD          
[showCrypted]
[showDolby]
[showMp3]
[eDVBLocalTimerHandler] diff is 0
[eDVBLocalTimerHandler] diff < 120 .. use Transponder Time
[eDVBLocalTimerHandler] not changed
KEY: 02 - 1BUTTON
****        25586 1 ****
[SEM] UP
KEY_PRESS - 02 1
++++            0 ms ++++
KEY_RELEASE - 02 00 1 1 CAUSE=Timeout
----          181 ms ----
[SEM] DOWN
warning, skin is missing element servicename in <class 'Screens.InfoBarGenerics.NumberZap'>
[Skin] SKIN ERROR in screen 'SimpleSummary' widget 'widget': {./skin.xml}: source 'parent.ServiceEvent' was not found in screen 'SimpleSummary'!. Please contact the skin's author!
[Skin] SKIN ERROR in screen 'SimpleSummary' widget 'widget': {./skin.xml}: source 'parent.ServiceEvent' was not found in screen 'SimpleSummary'!. Please contact the skin's author!
[Skin] SKIN ERROR in screen 'SimpleSummary' widget 'widget': {./skin.xml}: source 'parent.menu' was not found in screen 'SimpleSummary'!. Please contact the skin's author!
playing 1:0:19:283D:3FB:1:C00000:0:0:0:
[eDVBCAService] free slot 0 demux 0 for service 1:0:19:2B66:3F3:1:C00000:0:0:0:
[eDVBCAService] free service 1:0:19:2B66:3F3:1:C00000:0:0:0:
decoder state: play, vpid=-1, apid=-1
DEMUX_STOP - pcr - ok
DEMUX_STOP - video - ok
VIDEO_STOP - ok
AUDIO_STOP - ok
DEMUX_STOP - audio - ok
AUDIO_CONTINUE - ok
DEMUX_STOP - ttx - ok
TuxTxt stopped service 17f2
cleaning up
TuxTxt cache cleared
start release channel timer
libpng warning: iCCP: known incorrect sRGB profile
accel alloc failed

ERROR: accelAlloc failed
[__evStart]
[__evSeekableStatusChanged]
not pauseable.
not pauseable.
not pauseable.
RemovePopup, id = ZapError
[eDVBLocalTimerHandler] remove channel 0x1cab208
[eEPGCache] remove channel 0x1cab208
allocate channel.. 03fb:0001
(0)tune
RotorCmd ffffffff, lastRotorCmd ffffffff
prepare_sat System 1 Freq 11493750 Pol 0 SR 22000000 INV 2 FEC 2 orbpos 192 system 1 modulation 2 pilot 2, rolloff 0
tuning to 1743 mhz
OURSTATE: tuning
allocate Channel: res 0
[eDVBCIInterfaces] addPMTHandler 1:0:19:283D:3FB:1:C00000:0:0:0:
allocate demux
[SEC] invalidate current switch params
set sequence pos 3
set sequence pos 3
[SEC] update current switch params
[SEC] startTuneTimeout 5000
[SEC] setFrontend 1
setting frontend 0
(0)fe event: status 0, inversion off, m_tuning 1
(0)fe event: status 1f, inversion off, m_tuning 2
OURSTATE: ok
[eDVBLocalTimerHandler] channel 0x1cab208 running
[eEPGCache] channel 0x1cab208 running
[EPGC] next update in 2 sec
stop release channel timer
[__evUpdatedEventInfo]
[__evUpdatedEventInfo]
[__evUpdatedEventInfo]
RemovePopup, id = ZapError
[SEC] sleep 500ms
[eDVBLocalTimerHandler] diff is 0
[eDVBLocalTimerHandler] diff < 120 .. use Transponder Time
[eDVBLocalTimerHandler] not changed
use pmtpid 13ec for service_id 283d
eventNewProgramInfo 0 0

dvb subtitle  PID 13f1 with wrong subtitling type (24)... force 0x10!!
Rds PID 13f4 detected ? ! ?
have 1 video stream(s) (13ed), and 3 audio stream(s) (13ee, 13ef, 13f2), and the pcr pid is 13ed, and the text pid is 13f0
allocate demux
TuxTxt cache cleared
decoder state: play, vpid=5101, apid=5102
DMX_SET_PES_FILTER(0x13ed) - pcr - ok
DMX_SET_PES_FILTER(0x13ee) - audio - ok
AUDIO_SET_BYPASS(1) - ok
AUDIO_PLAY - ok
Video Device: /dev/dvb/adapter0/video0
demux device: /dev/dvb/adapter0/demux0
VIDEO_SET_STREAMTYPE 1 - ok
DMX_SET_PES_FILTER(0x13ed) - video - ok
VIDEO_PLAY - ok
DMX_SET_PES_FILTER(0x13f0) - ttx - ok
TuxTxt cache cleared
TuxTxt: initialized
TuxTxt service started 13f0
VIDEO_CONTINUE - ok
VIDEO_SLOWMOTION(0) - ok
VIDEO_FAST_FORWARD(0) - ok
AUDIO_CONTINUE - ok
disable teletext subtitles page ffffffffffffffff (und)
TuxTxt running thread...(13f0)
dvb subtitle  PID 13f1 with wrong subtitling type (24)... force 0x10!!
Rds PID 13f4 detected ? ! ?
[__evUpdatedInfo]
[writeChannelName]
vfd display text: Das Erste HD    
[showCrypted]
[showDolby]
[showMp3]
[eDVBCAService] new service 1:0:19:283D:3FB:1:C00000:0:0:0:
[eDVBCAService] add demux 0 to slot 0 service 1:0:19:283D:3FB:1:C00000:0:0:0:
[Dish] tuning failed
VIDEO_GET_EVENT - ok
unhandled DVBAPI Video Event 9
[__evUpdatedInfo]
[writeChannelName]
vfd display text: Das Erste HD    
[showCrypted]
[showDolby]
[showMp3]
[__evUpdatedEventInfo]
sdt update done!

[EPGC] start caching events(1397824282)
VIDEO_GET_EVENT - ok
unhandled DVBAPI Video Event 5
VIDEO_GET_EVENT - ok
[__evVideoSizeChanged]
VIDEO_GET_EVENT - ok
[__evUpdatedInfo]
[writeChannelName]
vfd display text: Das Erste HD    
[showCrypted]
[showDolby]
[showMp3]
[EPGC] nownext finished(1397824291)

MfG

[Anskar]

Kurze Zwischenfrage, gibt es neue Erkenntnisse?

Wenn es dann mal gefixt ist, könntet Ihr das bitte hier im Thema mitteilen ?

MfG

[santa]

Derzeit sind wir alle im osterstress, im Log ist nichts erkennbar was Rückschlüsse ziehen lässt, wird also etwas länger dauern.
Du kannst bitte noch mal weitere Images testen, also rückwärts wenn noch vorhanden und sagen bei welchem image es ok war und ab welchem nicht mehr.
Umsoweniger Revisionen dazwischen liegen um so leichter für uns.

[santa]

@anskar:
habe mal ufs910 angeworfen mit altem 211 kernel, teste mal bitte dann mit dem Image gegen.

[Anskar]

Mach ich morgen früh mal santa.
Auch habe ich fast alle Images von 12072 bis aktuell.
Da es bei 12140 schon nicht geht brauch ich dann nur rückwärts testen.
Wie geschrieben morgen , hab bis eben im Haus geschafft.

MfG

[Schaagi]

Hallo

Dieser Fehler ist mir bisher nicht aufgefallen, da ich nie Soft-Standby benutze. Ich habe im Moment
das Image 12140 installiert und im Setup mal auf Standby gestellt.
Bei ARD HD friert nach dem 3. Mal das Bild ein und der Dauer-Spinner läuft. Hilft dann nur, die Kathi
auszuschalten.

Werde mal das neueste Image (12176) testen und berichten.


- - - Aktualisiert - - -

Habe mal das neueste Image (12176) getestet. Auch hier das selbe Symptom. Hat also nichts mit
dem Kernel zu tun.

Gruss Schaagi