Problem mit VOX NOW und librtmp

DerBaer

Hi,

habe ein Problem mit VOX NOW (Frodo und Eden | xbmcbuntu). Meine Frau schaut gerne "Shopping Queen", aber leider funktionieren die aktuellsten Videos meistens nicht und xbmc startet sich neu. Nach ein, zwei Tagen gehen die Folgen aber dann.

Nun kenne ich die Problematik mit der rtmplib und habe mir die inoffizielle Version 2.5 mit Handshake Version 10 Support geholt. Leider startet sich xbmc trotzdem neu. Die Logdatei meldet, dass der Client Handshake 6 gesendet, der Server aber mit 10 geantwortet hat.

Es ist wohl so, dass es die Version 2.5 auch zuerst mit 6 versucht. Zum Versuch mit 10 kommt es dann durch den Crash nicht mehr. Das ist aber nur eine Vermutung, es kann auch sein, dass die neue rtmplib für den Handshake 10 vom Addon anders angesprochen werden muss.

Kann mir jemand helfen?

Muggi

Hi

also mein XBMC (Openelec) startet zwar nicht neu, aber das gleiche Problem mit der SHOPPING QUEEN und dadurch extrem reduzierten WAF.

Hier mal ein Auszug aus dem Logfile:

Code

20:05:34 T:140133151332096  NOTICE: Thread CDVDPlayer start, auto delete: false
20:05:34 T:140133151332096  NOTICE: Creating InputStream
20:05:34 T:140133151332096 WARNING: HandShake: Type mismatch: client sent 6, server answered 9
20:05:34 T:140133151332096   ERROR: rtmp server sent error
20:05:34 T:140133151332096   ERROR: rtmp server requested close
20:05:34 T:140133151332096   ERROR: CDVDPlayer::OpenInputStream - error opening [rtmpe://cp119913.edgefcs.net/ondemand/ swfVfy=1 playpath=voxnow/videos app=voxnow/_definst_ pageUrl=http://www.voxnow.de/p/ tcUrl=rtmpe://cp119913.edgefcs.net/ondemand/ swfUrl=http://www.voxnow.de/includes/vodplayer.swf]
20:05:34 T:140133151332096  NOTICE: CDVDPlayer::OnExit()
20:05:34 T:140133151332096  NOTICE: CDVDPlayer::OnExit() deleting input stream
20:05:34 T:140134458591040   ERROR: Playlist Player: skipping unplayable item: 0, path [plugin://plugin.video.vox.now/?urlV=%2Fshopping-queen%2Fgruppe-duesseldorf-tag-2-verena.php%3Ffilm_id%3D97901%26amp%3Bplayer%3D1%26amp%3Bseason%3D0&vidN=Gruppe+D%26uuml%3Bsseldorf%3A+Tag+2+%2F+Verena]
20:05:34 T:140134458591040  NOTICE: CDVDPlayer::CloseFile()
20:05:34 T:140134458591040 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
20:05:34 T:140134458591040  NOTICE: DVDPlayer: waiting for threads to exit
#

Alles anzeigen

DerBaer

Bei dir steht client sent 6, server answered 9.

Das sollte eigentlich mit der Standard librtmp funktionieren. Vielleicht gibt es wirklich ein Problem im Addon selbst. Das neustarten passiert bei mir nur in Frodo, in Eden gehts einfach nicht.

Vielleicht schaut der Entwickler hier mal rein. Ich habe auch einen Kommentar im offiziellen Blog zum Addon hinterlassen.

MX-26

Also ich habe ein ganz ähnliches Problem bei mir hauptsächlich RTL NOW

Zuerst vll ATV2 Eden und Addons auf V1.85

Das hier trat bei u.a. beim Alles was zählt, DSDS und Ich bin ein Star... auf

Code

15:58:46 T:145244160  NOTICE: ------DebugOutput showVideo--
15:58:46 T:145244160  NOTICE: ['rtmpe:', '', 'cp119913.edgefcs.net', 'ondemand', 'rtlnow', 'videos', '50', 'V_255773_B2TV_E88563_80087_h264-mq-show_275e78c09ff2f7de92999ac8701b5f2c.f4v?auth=daEarc4bYblbBb5dKc1ckdzdRdRa6cJbgd3-bq8SUN-vga-Lzs&aifp=v001&slist=rtlnow', 'videos', '50', 'V_255773_B2TV_E88563_80087_h264-mq-show_275e78c09ff2f7de92999ac8701b5f2c.f4v']
15:58:46 T:145244160  NOTICE: playPath -- rtlnow/videos
15:58:46 T:145244160  NOTICE: rtmpe://cp119913.edgefcs.net/ondemand/ swfVfy=1 playpath=rtlnow/videos app=rtlnow/_definst_ pageUrl=http://rtl-now.rtl.de/p/ tcUrl=rtmpe://cp119913.edgefcs.net/ondemand/ swfUrl=http://rtl-now.rtl.de/includes/vodplayer.swf
15:58:46 T:145244160  NOTICE: ------------
15:58:47 T:125001728  NOTICE: DVDPlayer: Opening: rtmpe://cp119913.edgefcs.net/ondemand/ swfVfy=1 playpath=rtlnow/videos app=rtlnow/_definst_ pageUrl=http://rtl-now.rtl.de/p/ tcUrl=rtmpe://cp119913.edgefcs.net/ondemand/ swfUrl=http://rtl-now.rtl.de/includes/vodplayer.swf
15:58:47 T:125001728 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
15:58:47 T:145244160  NOTICE: Creating InputStream
15:58:47 T:145244160 WARNING: HandShake: Type mismatch: client sent 6, server answered 9
15:58:47 T:145244160   ERROR: rtmp server sent error
15:58:47 T:145244160   ERROR: rtmp server requested close
15:58:47 T:145244160   ERROR: CDVDPlayer::OpenInputStream - error opening [rtmpe://cp119913.edgefcs.net/ondemand/ swfVfy=1 playpath=rtlnow/videos app=rtlnow/_definst_ pageUrl=http://rtl-now.rtl.de/p/ tcUrl=rtmpe://cp119913.edgefcs.net/ondemand/ swfUrl=http://rtl-now.rtl.de/includes/vodplayer.swf]
15:58:47 T:145244160  NOTICE: CDVDPlayer::OnExit()
15:58:47 T:145244160  NOTICE: CDVDPlayer::OnExit() deleting input stream
15:58:47 T:125001728   ERROR: Playlist Player: skipping unplayable item: 0, path [plugin://plugin.video.rtl.now/?urlV=/ich-bin-ein-star-holt-mich-hier-raus/tag-2.php?film_id=97847&amp;player=1&amp;season=7&vidN=Tag+2]
15:58:47 T:125001728  NOTICE: CDVDPlayer::CloseFile()
15:58:47 T:125001728 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
15:58:47 T:125001728  NOTICE: DVDPlayer: waiting for threads to exit
15:58:47 T:125001728  NOTICE: DVDPlayer: finished waiting

Alles anzeigen

So nun zu meinen Beobachtungen

konnte das Beispiel mit ShoppinQueen eben auch feststellen, die aktuelle Folge geht nicht, die 2 Tage alte hingegen läuft.
Bei Alles was zählt ist es ähnlich
Bei den DSDS und Ich bin ein Start erkenne ich einfach keine Systematik zu 90% wollen sie nicht laufen aund dann manchmal ohne Grund läuft doch eine.

Bsp. seit Tagen bekomme ich "ich bin ein Star .." nicht zum laufen gerade eine alte Folge angewählt und dann läuft Sie doch
trotzdem gabs folgenden Eintrag im Log

Code

20:43:23 T:143187968  NOTICE: ------DebugOutput showVideo--
20:43:23 T:143187968  NOTICE: ['rtmpe:', '', 'fms-fra8.rtl.de', 'rtlnow', '50', 'V_255773_B2TV_E88563_80087_h264-mq-show_275e78c09ff2f7de92999ac8701b5f2c.f4v']
20:43:23 T:143187968  NOTICE: playPath -- mp4:50/V_255773_B2TV_E88563_80087_h264-mq-show_275e78c09ff2f7de92999ac8701b5f2c.f4v
20:43:23 T:143187968  NOTICE: rtmpe://fms-fra8.rtl.de/rtlnow/ swfVfy=1 playpath=mp4:50/V_255773_B2TV_E88563_80087_h264-mq-show_275e78c09ff2f7de92999ac8701b5f2c.f4v app=rtlnow/_definst_ pageUrl=http://rtl-now.rtl.de/p/ tcUrl=rtmpe://fms-fra8.rtl.de/rtlnow/ swfUrl=http://rtl-now.rtl.de/includes/vodplayer.swf
20:43:23 T:143187968  NOTICE: ------------
20:43:23 T:107446272  NOTICE: DVDPlayer: Opening: rtmpe://fms-fra8.rtl.de/rtlnow/ swfVfy=1 playpath=mp4:50/V_255773_B2TV_E88563_80087_h264-mq-show_275e78c09ff2f7de92999ac8701b5f2c.f4v app=rtlnow/_definst_ pageUrl=http://rtl-now.rtl.de/p/ tcUrl=rtmpe://fms-fra8.rtl.de/rtlnow/ swfUrl=http://rtl-now.rtl.de/includes/vodplayer.swf
20:43:23 T:107446272 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
20:43:23 T:144777216  NOTICE: Creating InputStream
20:43:24 T:144777216  NOTICE: Creating Demuxer
20:43:43 T:144777216  NOTICE: Metadata:
[...]
20:43:51 T:157024256 WARNING: CRenderManager::Configure - timeout waiting for previous frame
20:43:51 T:157024256  NOTICE: Display resolution DESKTOP : 1280x720 (12)
20:43:51 T:107446272  NOTICE: Using GL_TEXTURE_2D
20:43:51 T:107446272  NOTICE: GL: Using CoreVideoRef RGBA render method
20:43:51 T:107446272  NOTICE: GL: NPOT texture support detected
20:43:51 T:107446272 WARNING: CreateLoader - Unsupported protocol(rtmpe) in rtmpe://fms-fra8.rtl.de/rtlnow/ swfvfy=1 playpath=mp4:50/v_255773_b2tv_e88563_80087_h264-mq-show_275e78c09ff2f7de92999ac8701b5f2c.f4v app=rtlnow/_definst_ pageurl=http://rtl-now.rtl.de/p/ tcurl=rtmpe://fms-fra8.rtl.de/rtlnow/ swfurl=http://rtl-now.rtl.de/includes/vodplayer.tbn
20:43:51 T:107446272 WARNING: CreateLoader - Unsupported protocol(rtmpe) in rtmpe://fms-fra8.rtl.de/rtlnow/ swfvfy=1 playpath=mp4:50/v_255773_b2tv_e88563_80087_h264-mq-show_275e78c09ff2f7de92999ac8701b5f2c.f4v app=rtlnow/_definst_ pageurl=http://rtl-now.rtl.de/p/ tcurl=rtmpe://fms-fra8.rtl.de/rtlnow/ swfurl=http://rtl-now.rtl.de/includes/movie.tbn

Alles anzeigen

Wer weiß Rat?

DerBaer

Hm, momentan gehen bei mir alle Folgen von SQ.

Ein Test bei RTL mit der aktuellen Folge von "Ich bin ein Star - Hol mich hier raus" führte zuerst zu einem Crash. Im nächsten Versuch ging es dann.

Crashlog:

Code

13:03:28 T:2777955136  NOTICE: ------DebugOutput showVideo--
13:03:28 T:2777955136  NOTICE: ['rtmpe:', '', 'cp119913.edgefcs.net', 'ondemand', 'rtlnow', 'videos', '50', 'V_257299_B3JI_E88567_80974_h264-mq-show_836a5d52e5cbe92b6fbd8af212fbd5ce.f4v?auth=daEbhdXa0b.a_aabGaGbfdBapdncbcLbpcD-bq9.Iq-vga-LAv&aifp=v001&slist=rtlnow', 'videos', '50', 'V_257299_B3JI_E88567_80974_h264-mq-show_836a5d52e5cbe92b6fbd8af212fbd5ce.f4v']
13:03:28 T:2777955136  NOTICE: playPath -- rtlnow/videos
13:03:28 T:2777955136  NOTICE: rtmpe://cp119913.edgefcs.net/ondemand/ swfVfy=1 playpath=rtlnow/videos app=rtlnow/_definst_ pageUrl=http://rtl-now.rtl.de/p/ tcUrl=rtmpe://cp119913.edgefcs.net/ondemand/ swfUrl=http://rtl-now.rtl.de/includes/vodplayer.swf
13:03:28 T:2777955136  NOTICE: ------------
13:03:28 T:3007543104  NOTICE: DVDPlayer: Opening: rtmpe://cp119913.edgefcs.net/ondemand/ swfVfy=1 playpath=rtlnow/videos app=rtlnow/_definst_ pageUrl=http://rtl-now.rtl.de/p/ tcUrl=rtmpe://cp119913.edgefcs.net/ondemand/ swfUrl=http://rtl-now.rtl.de/includes/vodplayer.swf
13:03:28 T:3007543104 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
13:03:28 T:2777955136  NOTICE: Thread CDVDPlayer start, auto delete: false
13:03:28 T:2777955136  NOTICE: Creating InputStream
13:03:28 T:2777955136 WARNING: HandShake: Type mismatch: client sent 6, server answered 10

Log vom funktionierenden Versuch:

Code

13:04:57 T:2825026368  NOTICE: ------DebugOutput showVideo--
13:04:57 T:2825026368  NOTICE: ['rtmpe:', '', 'fms-fra16.rtl.de', 'rtlnow', '50', 'V_257299_B3JI_E88567_80974_h264-mq-show_836a5d52e5cbe92b6fbd8af212fbd5ce.f4v']
13:04:57 T:2825026368  NOTICE: playPath -- mp4:50/V_257299_B3JI_E88567_80974_h264-mq-show_836a5d52e5cbe92b6fbd8af212fbd5ce.f4v
13:04:57 T:2825026368  NOTICE: rtmpe://fms-fra16.rtl.de/rtlnow/ swfVfy=1 playpath=mp4:50/V_257299_B3JI_E88567_80974_h264-mq-show_836a5d52e5cbe92b6fbd8af212fbd5ce.f4v app=rtlnow/_definst_ pageUrl=http://rtl-now.rtl.de/p/ tcUrl=rtmpe://fms-fra16.rtl.de/rtlnow/ swfUrl=http://rtl-now.rtl.de/includes/vodplayer.swf
13:04:57 T:2825026368  NOTICE: ------------
13:04:57 T:3007326016  NOTICE: DVDPlayer: Opening: rtmpe://fms-fra16.rtl.de/rtlnow/ swfVfy=1 playpath=mp4:50/V_257299_B3JI_E88567_80974_h264-mq-show_836a5d52e5cbe92b6fbd8af212fbd5ce.f4v app=rtlnow/_definst_ pageUrl=http://rtl-now.rtl.de/p/ tcUrl=rtmpe://fms-fra16.rtl.de/rtlnow/ swfUrl=http://rtl-now.rtl.de/includes/vodplayer.swf
13:04:57 T:3007326016 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
13:04:57 T:2825026368  NOTICE: Thread CDVDPlayer start, auto delete: false
13:04:57 T:2825026368  NOTICE: Creating InputStream
13:05:01 T:2825026368  NOTICE: Creating Demuxer
13:05:01 T:2825026368  NOTICE: Metadata:
13:05:01 T:2825026368  NOTICE:   duration          	2675.82
13:05:01 T:2825026368  NOTICE:   moovPosition      	40.00
13:05:01 T:2825026368  NOTICE:   width             	512.00
13:05:01 T:2825026368  NOTICE:   height            	288.00
13:05:01 T:2825026368  NOTICE:   videocodecid      	avc1
13:05:01 T:2825026368  NOTICE:   audiocodecid      	mp4a
13:05:01 T:2825026368  NOTICE:   avcprofile        	77.00
13:05:01 T:2825026368  NOTICE:   avclevel          	21.00
13:05:01 T:2825026368  NOTICE:   aacaot            	2.00
13:05:01 T:2825026368  NOTICE:   videoframerate    	25.00
13:05:01 T:2825026368  NOTICE:   audiosamplerate   	44100.00
13:05:01 T:2825026368  NOTICE:   audiochannels     	2.00
13:05:01 T:2825026368  NOTICE: trackinfo:
13:05:01 T:2825026368  NOTICE:   length            	6689500.00
13:05:01 T:2825026368  NOTICE:   timescale         	2500.00
13:05:01 T:2825026368  NOTICE: sampledescription:
13:05:01 T:2825026368  NOTICE:   sampletype        	avc1
13:05:01 T:2825026368  NOTICE:   length            	6689500.00
13:05:01 T:2825026368  NOTICE:   timescale         	2500.00
13:05:01 T:2825026368  NOTICE: sampledescription:
13:05:01 T:2825026368  NOTICE:   length            	118003712.00
13:05:01 T:2825026368  NOTICE:   timescale         	44100.00
13:05:01 T:2825026368  NOTICE: sampledescription:
13:05:01 T:2825026368  NOTICE:   sampletype        	mp4a
13:05:01 T:2825026368  NOTICE: Opening video stream: 0 source: 256
13:05:01 T:2825026368  NOTICE: Creating video codec with codec id: 28
13:05:01 T:2825026368  NOTICE: CDVDVideoCodecFFmpeg::Open() Creating VDPAU(512x288, 28)
13:05:01 T:2825026368  NOTICE: vdp_device = 0x00000001 vdp_st = 0x00000000
13:05:01 T:2825026368  NOTICE: VDPAU Decoder capabilities:
13:05:01 T:2825026368  NOTICE: name      	level macbs width height
13:05:01 T:2825026368  NOTICE: ------------------------------------
13:05:01 T:2825026368  NOTICE: MPEG1         	0  8192  2048  2048
13:05:01 T:2825026368  NOTICE: MPEG2_SIMPLE  	3  8192  2048  2048
13:05:01 T:2825026368  NOTICE: MPEG2_MAIN    	3  8192  2048  2048
13:05:01 T:2825026368  NOTICE: H264_MAIN    	41  8192  2048  2048
13:05:01 T:2825026368  NOTICE: H264_HIGH    	41  8192  2048  2048
13:05:01 T:2825026368  NOTICE: VC1_SIMPLE    	1  8190  2048  2048
13:05:01 T:2825026368  NOTICE: VC1_MAIN      	2  8190  2048  2048
13:05:01 T:2825026368  NOTICE: VC1_ADVANCED  	4  8190  2048  2048
13:05:01 T:2825026368  NOTICE: MPEG4_PART2_ASP   5  8192  2048  2048
13:05:01 T:2825026368  NOTICE: ------------------------------------
13:05:01 T:2825026368  NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_NOISE_REDUCTION
13:05:01 T:2825026368  NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_SHARPNESS
13:05:01 T:2825026368  NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_DEINTERLACE_TEMPORAL
13:05:01 T:2825026368  NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_DEINTERLACE_TEMPORAL_SPATIAL
13:05:01 T:2825026368  NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_INVERSE_TELECINE
13:05:01 T:2825026368  NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_HIGH_QUALITY_SCALING_L1
13:05:01 T:2825026368  NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 (VDPAU acceleration)
13:05:01 T:2825026368  NOTICE: Creating video thread
13:05:01 T:2800610112  NOTICE: Thread CDVDPlayerVideo start, auto delete: false
13:05:01 T:2800610112  NOTICE: running thread: video_thread
13:05:01 T:2825026368  NOTICE: Opening audio stream: 1 source: 256
13:05:01 T:2825026368  NOTICE: Finding audio codec for: 86018
13:05:01 T:2825026368  NOTICE: Creating audio thread
13:05:01 T:2792217408  NOTICE: Thread CDVDPlayerAudio start, auto delete: false

Alles anzeigen

Jetzt mitmachen!