Code:
16:13:33 T:1074937856 DEBUG: Keyboard: scancode: 1c, sym: 000d, unicode: 0000, modifier: 0
16:13:33 T:1074937856 DEBUG: OnKey: return (f00d) pressed, action is Select
16:13:33 T:1264161856 DEBUG: [script.tvcatchup] *******************onClick***************************
16:13:33 T:1264161856 DEBUG: [script.tvcatchup] 3561
16:13:33 T:1264161856 NOTICE: Playing stream url: rtmp://84.234.23.213/tvcatchup-130/_definst_/userID=851656/accessKey=52217523Q851656L83R33521T-01c3fb9696b73e9e1a6ac2e0272e0749-4fd0d32d/device=web/sdp=itv1hd.sdp/itv1hd_480p.stream app=tvcatchup-130/_definst_/userID=851656/accessKey=52217523Q851656L83R33521T-01c3fb9696b73e9e1a6ac2e0272e0749-4fd0d32d/device=web/sdp=itv1hd.sdp swfurl=http://images-cache.tvcatchup.com/NEW/flash/TvCatchupWebPlayerAD9.swf tcurl=rtmp://84.234.23.213/tvcatchup-130/_definst_/userID=851656/accessKey=52217523Q851656L83R33521T-01c3fb9696b73e9e1a6ac2e0272e0749-4fd0d32d/device=web/sdp=itv1hd.sdp pageurl=http://www.tvcatchup.com/watch.html?c=83 playpath=itv1hd_480p.stream live=1
16:13:34 T:1074937856 DEBUG: CPlayerCoreFactory::GetPlayers(rtmp://84.234.23.213/tvcatchup-130/_definst_/userID=851656/accessKey=52217523Q851656L83R33521T-01c3fb9696b73e9e1a6ac2e0272e0749-4fd0d32d/device=web/sdp=itv1hd.sdp/itv1hd_480p.stream app=tvcatchup-130/_definst_/userID=851656/accessKey=52217523Q851656L83R33521T-01c3fb9696b73e9e1a6ac2e0272e0749-4fd0d32d/device=web/sdp=itv1hd.sdp swfurl=http://images-cache.tvcatchup.com/NEW/flash/TvCatchupWebPlayerAD9.swf tcurl=rtmp://84.234.23.213/tvcatchup-130/_definst_/userID=851656/accessKey=52217523Q851656L83R33521T-01c3fb9696b73e9e1a6ac2e0272e0749-4fd0d32d/device=web/sdp=itv1hd.sdp pageurl=http://www.tvcatchup.com/watch.html?c=83 playpath=itv1hd_480p.stream live=1)
16:13:34 T:1074937856 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
16:13:34 T:1074937856 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
16:13:34 T:1074937856 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
16:13:34 T:1074937856 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/rtmp/mms/udp
16:13:34 T:1074937856 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
16:13:34 T:1074937856 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
16:13:34 T:1074937856 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
16:13:34 T:1074937856 DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: streams
16:13:34 T:1074937856 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: flv/aacp/sdp
16:13:34 T:1074937856 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: mp2
16:13:34 T:1074937856 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
16:13:34 T:1074937856 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdfile
16:13:34 T:1264161856 DEBUG: [script.tvcatchup] *******************onAction***************************
16:13:34 T:1264161856 DEBUG: [script.tvcatchup] 7
16:13:34 T:1264161856 DEBUG: [script.tvcatchup] 61453
16:13:34 T:1074937856 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
16:13:34 T:1074937856 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
16:13:34 T:1074937856 DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
16:13:34 T:1074937856 DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
16:13:34 T:1074937856 DEBUG: CPlayerCoreFactory::GetPlayers: adding videodefaultplayer (4)
16:13:34 T:1074937856 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=0
16:13:34 T:1074937856 DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
16:13:34 T:1074937856 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
16:13:34 T:1074937856 DEBUG: CPlayerCoreFactory::GetPlayers: adding player: OMXPlayer (4)
16:13:34 T:1074937856 DEBUG: CPlayerCoreFactory::GetPlayers: added 2 players
16:13:34 T:1074937856 NOTICE: COMXPlayer: Opening: rtmp://84.234.23.213/tvcatchup-130/_definst_/userID=851656/accessKey=52217523Q851656L83R33521T-01c3fb9696b73e9e1a6ac2e0272e0749-4fd0d32d/device=web/sdp=itv1hd.sdp/itv1hd_480p.stream app=tvcatchup-130/_definst_/userID=851656/accessKey=52217523Q851656L83R33521T-01c3fb9696b73e9e1a6ac2e0272e0749-4fd0d32d/device=web/sdp=itv1hd.sdp swfurl=http://images-cache.tvcatchup.com/NEW/flash/TvCatchupWebPlayerAD9.swf tcurl=rtmp://84.234.23.213/tvcatchup-130/_definst_/userID=851656/accessKey=52217523Q851656L83R33521T-01c3fb9696b73e9e1a6ac2e0272e0749-4fd0d32d/device=web/sdp=itv1hd.sdp pageurl=http://www.tvcatchup.com/watch.html?c=83 playpath=itv1hd_480p.stream live=1
16:13:34 T:1074937856 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED
16:13:34 T:1074937856 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
16:13:34 T:1074937856 DEBUG: LinuxRendererGL: Cleaning up GL resources
16:13:34 T:1210995776 NOTICE: Thread COMXPlayer start, auto delete: false
16:13:34 T:1210995776 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.clock input port 80 output port 81
16:13:34 T:1210995776 NOTICE: OMXClock using video as reference
16:13:34 T:1210995776 DEBUG: OMXClock::OMXStart
16:13:34 T:1210995776 NOTICE: Creating InputStream
16:13:34 T:1210995776 DEBUG: SECTION:LoadDLL(librtmp.so.0)
16:13:34 T:1210995776 DEBUG: Loading: librtmp.so.0
16:13:34 T:1074937856 DEBUG: ------ Window Init (DialogBusy.xml) ------
16:13:34 T:1210995776 INFO: CDVDInputStreamRTMP: Using external libRTMP
16:13:34 T:1210995776 INFO: Parsing...
16:13:34 T:1210995776 INFO: Parsed protocol: 0
16:13:34 T:1210995776 INFO: Parsed host : 84.234.23.213
16:13:34 T:1210995776 INFO: Parsed app : tvcatchup-130/_definst_
16:13:34 T:1210995776 INFO: RTMP_Connect1, ... connected, handshaking
16:13:34 T:1210995776 INFO: HandShake: Type Answer : 03
16:13:34 T:1210995776 INFO: HandShake: Server Uptime : 96850052
16:13:34 T:1210995776 INFO: HandShake: FMS Version : 3.0.1.1
16:13:34 T:1210995776 INFO: HandShake: Handshaking finished....
16:13:34 T:1210995776 INFO: RTMP_Connect1, handshaked
16:13:34 T:1210995776 INFO: Invoking connect
16:13:34 T:1210995776 INFO: HandleServerBW: server BW = 2500000
16:13:34 T:1210995776 INFO: HandleClientBW: client BW = 2500000 2
16:13:34 T:1210995776 INFO: HandleCtrl, received ctrl. type: 0, len: 6
16:13:34 T:1210995776 INFO: HandleCtrl, Stream Begin 0
16:13:34 T:1210995776 INFO: HandleChangeChunkSize, received: chunk size change to 512
16:13:34 T:1210995776 INFO: RTMP_ClientPacket, received: invoke 261 bytes
16:13:34 T:1210995776 INFO: (object begin)
16:13:34 T:1210995776 INFO: Property: <Name: no-name., STRING: _result>
16:13:34 T:1210995776 INFO: Property: <Name: no-name., NUMBER: 1.00>
16:13:34 T:1210995776 INFO: Property: <Name: no-name., OBJECT>
16:13:34 T:1210995776 INFO: (object begin)
16:13:34 T:1210995776 INFO: Property: <Name: fmsVer, STRING: FMS/3,5,7,7009>
16:13:34 T:1210995776 INFO: Property: <Name: capabilities, NUMBER: 31.00>
16:13:34 T:1210995776 INFO: Property: <Name: mode, NUMBER: 1.00>
16:13:34 T:1210995776 INFO: (object end)
16:13:34 T:1210995776 INFO: Property: <Name: no-name., OBJECT>
16:13:34 T:1210995776 INFO: (object begin)
16:13:34 T:1210995776 INFO: Property: <Name: level, STRING: status>
16:13:34 T:1210995776 INFO: Property: <Name: code, STRING: NetConnection.Connect.Success>
16:13:34 T:1210995776 INFO: Property: <Name: description, STRING: Connection succeeded.>
16:13:34 T:1210995776 INFO: Property: <Name: data, OBJECT>
16:13:34 T:1210995776 INFO: (object begin)
16:13:34 T:1210995776 INFO: Property: <Name: version, STRING: 3,5,7,7009>
16:13:34 T:1210995776 INFO: (object end)
16:13:34 T:1210995776 INFO: Property: <Name: clientid, NUMBER: 861799362.00>
16:13:34 T:1210995776 INFO: Property: <Name: objectEncoding, NUMBER: 0.00>
16:13:34 T:1210995776 INFO: (object end)
16:13:34 T:1210995776 INFO: Previous line repeats 1 times.
16:13:34 T:1210995776 INFO: HandleInvoke, server invoking <_result>
16:13:34 T:1210995776 INFO: HandleInvoke, received result for method call <connect>
16:13:34 T:1210995776 INFO: sending ctrl. type: 0x0003
16:13:34 T:1210995776 INFO: Invoking createStream
16:13:34 T:1210995776 INFO: FCSubscribe: itv1hd_480p.stream
16:13:34 T:1210995776 INFO: Invoking FCSubscribe
16:13:34 T:1210995776 INFO: RTMP_ClientPacket, received: invoke 29 bytes
16:13:34 T:1210995776 INFO: (object begin)
16:13:34 T:1210995776 INFO: Property: <Name: no-name., STRING: _result>
16:13:34 T:1210995776 INFO: Property: <Name: no-name., NUMBER: 2.00>
16:13:34 T:1210995776 INFO: Property: NULL
16:13:34 T:1210995776 INFO: Property: <Name: no-name., NUMBER: 1.00>
16:13:34 T:1210995776 INFO: (object end)
16:13:34 T:1210995776 INFO: HandleInvoke, server invoking <_result>
16:13:34 T:1210995776 INFO: HandleInvoke, received result for method call <createStream>
16:13:34 T:1210995776 INFO: SendPlay, seekTime=0, stopTime=0, sending play: itv1hd_480p.stream
16:13:34 T:1210995776 INFO: Invoking play
16:13:34 T:1210995776 INFO: sending ctrl. type: 0x0003
16:13:34 T:1210995776 INFO: RTMP_ClientPacket, received: invoke 151 bytes
16:13:34 T:1210995776 INFO: (object begin)
16:13:34 T:1210995776 INFO: Property: <Name: no-name., STRING: onFCSubscribe>
16:13:34 T:1210995776 INFO: Property: <Name: no-name., NUMBER: 0.00>
16:13:34 T:1210995776 INFO: Property: NULL
16:13:34 T:1210995776 INFO: Property: <Name: no-name., OBJECT>
16:13:34 T:1210995776 INFO: (object begin)
16:13:34 T:1210995776 INFO: Property: <Name: level, STRING: status>
16:13:34 T:1210995776 INFO: Property: <Name: code, STRING: NetStream.Play.Start>
16:13:34 T:1210995776 INFO: Property: <Name: description, STRING: FCSubscribe to stream itv1hd_480p.stream.>
16:13:34 T:1210995776 INFO: Property: <Name: clientid, NUMBER: 861799362.00>
16:13:34 T:1210995776 INFO: (object end)
16:13:34 T:1210995776 INFO: Previous line repeats 1 times.
16:13:34 T:1210995776 INFO: HandleInvoke, server invoking <onFCSubscribe>
16:13:35 T:1210995776 INFO: RTMP_ClientPacket, received: invoke 149 bytes
16:13:35 T:1210995776 INFO: (object begin)
16:13:35 T:1210995776 INFO: Property: <Name: no-name., STRING: onStatus>
16:13:35 T:1210995776 INFO: Property: <Name: no-name., NUMBER: 0.00>
16:13:35 T:1210995776 INFO: Property: NULL
16:13:35 T:1210995776 INFO: Property: <Name: no-name., OBJECT>
16:13:35 T:1210995776 INFO: (object begin)
16:13:35 T:1210995776 INFO: Property: <Name: level, STRING: status>
16:13:35 T:1210995776 INFO: Property: <Name: code, STRING: NetStream.Play.PublishNotify>
16:13:35 T:1210995776 INFO: Property: <Name: description, STRING: itv1hd_480p.stream is now published.>
16:13:35 T:1210995776 INFO: Property: <Name: clientid, NUMBER: 861799362.00>
16:13:35 T:1210995776 INFO: (object end)
16:13:35 T:1210995776 INFO: Previous line repeats 1 times.
16:13:35 T:1210995776 INFO: HandleInvoke, server invoking <onStatus>
16:13:35 T:1210995776 INFO: HandleInvoke, onStatus: NetStream.Play.PublishNotify
16:13:35 T:1210995776 DEBUG: OMXClock::OMXReset 0x00000003
16:13:35 T:1210995776 NOTICE: OMXClock using video as reference
16:13:35 T:1210995776 ERROR: COMXCoreComponent::SetConfig - OMX.broadcom.clock failed with omx_err(0x80001005)
16:13:35 T:1210995776 ERROR: OMXClock::OMXReset error setting OMX_IndexConfigTimeClockState
16:13:35 T:1210995776 NOTICE: Creating Demuxer
16:13:35 T:1210995776 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/avcodec-53-arm.so)
16:13:35 T:1210995776 DEBUG: Loading: /opt/xbmc-bcm/xbmc-bin/lib/xbmc/system/players/dvdplayer/avcodec-53-arm.so
16:13:35 T:1210995776 DEBUG: SECTION:LoadDLL(special://xbmcbin/system/players/dvdplayer/avformat-53-arm.so)
16:13:35 T:1210995776 DEBUG: Loading: /opt/xbmc-bcm/xbmc-bin/lib/xbmc/system/players/dvdplayer/avformat-53-arm.so
16:13:41 T:1074937856 INFO: LIRC Initialize: using: /dev/lircd
16:13:41 T:1074937856 DEBUG: Failed to connect to LIRC. Retry in 10s.
16:13:43 T:1210995776 INFO: HandleCtrl, received ctrl. type: 0, len: 6
16:13:43 T:1210995776 INFO: HandleCtrl, Stream Begin 1
16:13:43 T:1210995776 INFO: RTMP_ClientPacket, received: invoke 146 bytes
16:13:43 T:1210995776 INFO: (object begin)
16:13:43 T:1210995776 INFO: Property: <Name: no-name., STRING: onStatus>
16:13:43 T:1210995776 INFO: Property: <Name: no-name., NUMBER: 0.00>
16:13:43 T:1210995776 INFO: Property: NULL
16:13:43 T:1210995776 INFO: Property: <Name: no-name., OBJECT>
16:13:43 T:1210995776 INFO: (object begin)
16:13:43 T:1210995776 INFO: Property: <Name: level, STRING: status>
16:13:43 T:1210995776 INFO: Property: <Name: code, STRING: NetStream.Play.Reset>
16:13:43 T:1210995776 INFO: Property: <Name: description, STRING: Playing and resetting itv1hd_480p.stream.>
16:13:43 T:1210995776 INFO: Property: <Name: clientid, NUMBER: 861799362.00>
16:13:43 T:1210995776 INFO: (object end)
16:13:43 T:1210995776 INFO: Previous line repeats 1 times.
16:13:43 T:1210995776 INFO: HandleInvoke, server invoking <onStatus>
16:13:43 T:1210995776 INFO: HandleInvoke, onStatus: NetStream.Play.Reset
16:13:43 T:1210995776 INFO: RTMP_ClientPacket, received: invoke 181 bytes
16:13:43 T:1210995776 INFO: (object begin)
16:13:43 T:1210995776 INFO: Property: <Name: no-name., STRING: onStatus>
16:13:43 T:1210995776 INFO: Property: <Name: no-name., NUMBER: 0.00>
16:13:43 T:1210995776 INFO: Property: NULL
16:13:43 T:1210995776 INFO: Property: <Name: no-name., OBJECT>
16:13:43 T:1210995776 INFO: (object begin)
16:13:43 T:1210995776 INFO: Property: <Name: level, STRING: status>
16:13:43 T:1210995776 INFO: Property: <Name: code, STRING: NetStream.Play.Start>
16:13:43 T:1210995776 INFO: Property: <Name: description, STRING: Started playing itv1hd_480p.stream.>
16:13:43 T:1210995776 INFO: Property: <Name: clientid, NUMBER: 861799362.00>
16:13:43 T:1210995776 INFO: Property: <Name: isFastPlay, BOOLEAN: FALSE>
16:13:43 T:1210995776 INFO: Property: <Name: timecodeOffset, STRING: 1738899L>
16:13:43 T:1210995776 INFO: (object end)
16:13:43 T:1210995776 INFO: Previous line repeats 1 times.
16:13:43 T:1210995776 INFO: HandleInvoke, server invoking <onStatus>
16:13:43 T:1210995776 INFO: HandleInvoke, onStatus: NetStream.Play.Start
16:13:43 T:1210995776 INFO: RTMP_ClientPacket, received: notify 44 bytes
16:13:43 T:1210995776 INFO: (object begin)
16:13:43 T:1210995776 INFO: Property: <Name: no-name., STRING: onStatus>
16:13:43 T:1210995776 INFO: Property: <Name: no-name., OBJECT>
16:13:43 T:1210995776 INFO: (object begin)
16:13:43 T:1210995776 INFO: Property: <Name: code, STRING: NetStream.Data.Start>
16:13:43 T:1210995776 INFO: (object end)
16:13:43 T:1210995776 INFO: Previous line repeats 1 times.
16:13:43 T:1210995776 INFO: RTMP_ClientPacket, received: notify 738 bytes
16:13:43 T:1210995776 INFO: (object begin)
16:13:43 T:1210995776 INFO: Property: <Name: no-name., STRING: onMetaData>
16:13:43 T:1210995776 INFO: Property: <Name: no-name., OBJECT>
16:13:43 T:1210995776 INFO: (object begin)
16:13:43 T:1210995776 INFO: Property: <Name: trackinfo, OBJECT>
16:13:43 T:1210995776 INFO: (object begin)
16:13:43 T:1210995776 INFO: Property: <Name: no-name., OBJECT>
16:13:43 T:1210995776 INFO: (object begin)
16:13:43 T:1210995776 INFO: Property: <Name: type, STRING: video>
16:13:43 T:1210995776 INFO: Property: <Name: profile-level-id, STRING: 4d001f>
16:13:43 T:1210995776 INFO: Property: <Name: sprop-parameter-se, STRING: J00AH5WwFAFuwEQAAAMABAAAAwDDgQAATEtAAAgCyL3vg7QRCNw=,KO48gA==>
16:13:43 T:1210995776 INFO: Property: <Name: description, STRING: {H264CodecConfigInfo: codec:H264, profile:Main, level:3.1, frameSize:1280x720, displaySize:1280x720, frameRate:24.0, PAR:1:1}>
16:13:43 T:1210995776 INFO: (object end)
16:13:43 T:1210995776 INFO: Previous line repeats 1 times.
16:13:43 T:1210995776 INFO: Property: <Name: rtpsessioninfo, OBJECT>
16:13:43 T:1210995776 INFO: (object begin)
16:13:43 T:1210995776 INFO: Property: <Name: connectiondata, STRING: IN IP4 0.0.0.0>
16:13:43 T:1210995776 INFO: Property: <Name: name, STRING: WowzaMediaServer>
16:13:43 T:1210995776 INFO: Property: <Name: origin, STRING: - 1238062085 1238062085 IN IP4 127.0.0.1>
16:13:43 T:1210995776 INFO: Property: <Name: timing, STRING: 0 0>
16:13:43 T:1210995776 INFO: Property: <Name: protocolversion, STRING: 0>
16:13:43 T:1210995776 INFO: Property: <Name: attributes, OBJECT>
16:13:43 T:1210995776 INFO: (object begin)
16:13:43 T:1210995776 INFO: Property: <Name: range, STRING: npt=now->
16:13:43 T:1210995776 INFO: (object end)
16:13:43 T:1210995776 INFO: Previous line repeats 1 times.
16:13:43 T:1210995776 INFO: Property: <Name: videocodecid, STRING: avc1>
16:13:43 T:1210995776 INFO: Property: <Name: width, NUMBER: 1280.00>
16:13:43 T:1210995776 INFO: Property: <Name: height, NUMBER: 720.00>
16:13:43 T:1210995776 INFO: Property: <Name: frameWidth, NUMBER: 1280.00>
16:13:43 T:1210995776 INFO: Property: <Name: frameHeight, NUMBER: 720.00>
16:13:43 T:1210995776 INFO: Property: <Name: displayWidth, NUMBER: 1280.00>
16:13:43 T:1210995776 INFO: Property: <Name: displayHeight, NUMBER: 720.00>
16:13:43 T:1210995776 INFO: Property: <Name: framerate, NUMBER: 24.00>
16:13:43 T:1210995776 INFO: Property: <Name: audiochannels, NUMBER: 2.00>
16:13:43 T:1210995776 INFO: Property: <Name: audiosamplerate, NUMBER: 48000.00>
16:13:43 T:1210995776 INFO: Property: <Name: audiocodecid, STRING: mp4a>
16:13:43 T:1210995776 INFO: (object end)
16:13:43 T:1210995776 INFO: Previous line repeats 1 times.
16:13:43 T:1210995776 NOTICE: Metadata:
16:13:43 T:1210995776 NOTICE: trackinfo:
16:13:43 T:1210995776 NOTICE: type video
16:13:43 T:1210995776 NOTICE: profile-level-id 4d001f
16:13:43 T:1210995776 NOTICE: sprop-parameter-sets J00AH5WwFAFuwEQAAAMABAAAAwDDgQAATEtAAAgCyL3vg7QRCNw=,KO48gA==
16:13:43 T:1210995776 NOTICE: description {H264CodecConfigInfo: codec:H264, profile:Main, level:3.1, frameSize:1280x720, displaySize:1280x720, frameRate:24.0, PAR:1:1}
16:13:43 T:1210995776 NOTICE: rtpsessioninfo:
16:13:43 T:1210995776 NOTICE: connectiondata IN IP4 0.0.0.0
16:13:43 T:1210995776 NOTICE: name WowzaMediaServer
16:13:43 T:1210995776 NOTICE: origin - 1238062085 1238062085 IN IP4 127.0.0.1
16:13:43 T:1210995776 NOTICE: timing 0 0
16:13:43 T:1210995776 NOTICE: protocolversion 0
16:13:43 T:1210995776 NOTICE: attributes:
16:13:43 T:1210995776 NOTICE: range npt=now-
16:13:43 T:1210995776 NOTICE: videocodecid avc1
16:13:43 T:1210995776 NOTICE: width 1280.00
16:13:43 T:1210995776 NOTICE: height 720.00
16:13:43 T:1210995776 NOTICE: frameWidth 1280.00
16:13:43 T:1210995776 NOTICE: frameHeight 720.00
16:13:43 T:1210995776 NOTICE: displayWidth 1280.00
16:13:43 T:1210995776 NOTICE: displayHeight 720.00
16:13:43 T:1210995776 NOTICE: framerate 24.00
16:13:43 T:1210995776 NOTICE: audiochannels 2.00
16:13:43 T:1210995776 NOTICE: audiosamplerate 48000.00
16:13:43 T:1210995776 NOTICE: audiocodecid mp4a
16:13:43 T:1074937856 DEBUG: SECTION:UnloadDelayed(DLL: special://xbmcbin/system/ImageLib-arm.so)
16:13:43 T:1074937856 DEBUG: Unloading: ImageLib-arm.so
16:13:43 T:1210995776 DEBUG: Open - probing detected format [flv]
16:13:44 T:1210995776 DEBUG: Open - avformat_find_stream_info starting
16:13:44 T:1210995776 INFO: ignoring too small audio packet: size: 0
16:13:50 T:1210995776 DEBUG: ffmpeg[482E5440]: [flv] Estimating duration from bitrate, this may be inaccurate
16:13:50 T:1210995776 DEBUG: Open - av_find_stream_info finished
16:13:50 T:1210995776 INFO: ffmpeg[482E5440]: Input #0, flv, from 'rtmp://84.234.23.213/tvcatchup-130/_definst_/userID=851656/accessKey=52217523Q851656L83R33521T-01c3fb9696b73e9e1a6ac2e0272e0749-4fd0d32d/device=web/sdp=itv1hd.sdp/itv1hd_480p.stream app=tvcatchup-130/_definst_/userID=851656/accessKey=52217523Q851656L83R33521T-01c3fb9696b73e9e1a6ac2e0272e0749-4fd0d32d/device=web/sdp=itv1hd.sdp swfurl=http://images-cache.tvcatchup.com/NEW/flash/TvCatchupWebPlayerAD9.swf tcurl=rtmp://84.234.23.213/tvcatchup-130/_definst_/userID=851656/accessKey=52217523Q851656L83R33521T-01c3fb9696b73e9e1a6ac2e0272e0749-4fd0d32d/device=web/sdp=itv1hd.sdp pageurl=http://www.tvcatchup.com/watch.html?c=83 playpath=itv1hd_480p.stream live=1':
16:13:50 T:1210995776 INFO: ffmpeg[482E5440]: Duration: N/A, start: 0.000000, bitrate: N/A
16:13:50 T:1210995776 INFO: ffmpeg[482E5440]: Stream #0:0: Video: h264 (Main), yuv420p, 1280x720 [SAR 1:1 DAR 16:9], 25 tbr, 1k tbn, 48 tbc
16:13:50 T:1210995776 INFO: ffmpeg[482E5440]: Stream #0:1: Audio: aac, 48000 Hz, stereo, s16
16:13:50 T:1210995776 NOTICE: Opening video stream: 0 source: 256
16:13:50 T:1210995776 DEBUG: OMXClock::OMXStop
16:13:50 T:1210995776 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.video_decode input port 130 output port 131
16:13:50 T:1210995776 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.video_render input port 90 output port 90
16:13:50 T:1210995776 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.video_scheduler input port 10 output port 11
16:13:50 T:1210995776 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.video_decode) - port(130), nBufferCountMin(1), nBufferCountActual(60), nBufferSize(81920), nBufferAlignmen(16)
16:13:50 T:1210995776 DEBUG: COMXVideo::Open - decoder_component(0x0x46ca2e8), input_port(0x82), output_port(0x83) deinterlace 0 hdmiclocksync 1
16:13:50 T:1210995776 INFO: OMXPlayerVideo::OpenDecoder : Video codec omx-h264 width 1280 height 720 profile 77 fps 25.000000
16:13:50 T:1210995776 INFO: OMXPlayerVideo::OpenDecoder fps: 25.000000 hdmi_ntsc_freqs 0
16:13:50 T:1210995776 DEBUG: OMXClock::OMXReset 0x00000003
16:13:50 T:1210995776 NOTICE: OMXClock using video as reference
16:13:50 T:1210995776 NOTICE: Creating video thread
16:13:50 T:1210995776 DEBUG: OMXClock::OMXSetSpeed fake 1
16:13:50 T:1210995776 DEBUG: OMXClock::OMXSetSpeed real 1
16:13:50 T:1283298368 NOTICE: Thread COMXPlayerVideo start, auto delete: false
16:13:50 T:1210995776 NOTICE: Opening audio stream: 1 source: 256
16:13:50 T:1210995776 NOTICE: Creating audio thread
16:13:50 T:1210995776 DEBUG: OMXClock::OMXSetSpeed fake 1
16:13:50 T:1210995776 DEBUG: OMXClock::OMXSetSpeed real 1
16:13:50 T:1292670016 NOTICE: Thread COMXPlayerAudio start, auto delete: false
16:13:50 T:1210995776 DEBUG: OMXClock::OMXStop
16:13:50 T:1210995776 DEBUG: OMXClock::OMXReset 0x00000003
16:13:50 T:1210995776 NOTICE: OMXClock using video as reference
16:13:50 T:1210995776 DEBUG: CDVDPlayer::SetCaching - caching state 2
16:13:50 T:1210995776 DEBUG: OMXClock::OMXSetSpeed fake 0
16:13:50 T:1210995776 DEBUG: OMXClock::OMXSetSpeed real 0
16:13:50 T:1292670016 DEBUG: COMXPlayerAudio - CDVDMsg::PLAYER_SETSPEED
16:13:50 T:1283298368 DEBUG: COMXPlayerVideo - CDVDMsg::GENERAL_SYNCHRONIZE
16:13:50 T:1283298368 INFO: COMXPlayerVideo - Stillframe left, switching to normal playback
16:13:50 T:1283298368 DEBUG: VDec : setStartTime 0.360000
16:13:50 T:1283298368 DEBUG: Output - change configuration. 1920x1080. framerate: 25.00. format: BYPASS
16:13:50 T:1292670016 DEBUG: OMXClock::OMXStop
16:13:50 T:1292670016 DEBUG: OMXClock::OMXReset 0x00000003
16:13:50 T:1292670016 NOTICE: OMXClock using video as reference
16:13:50 T:1283298368 NOTICE: Display resolution ADJUST : 1920x1080 @ 25.00 - Full Screen (29) (weight: 0.000)
16:13:50 T:1074937856 DEBUG: Activating window ID: 12005
16:13:50 T:1074937856 DEBUG: ------ Window Deinit (/home/pi/.xbmc/addons/script.tvcatchup/resources/skins/Default/720p/script-tvcatchup-main.xml) ------
16:13:50 T:1074937856 DEBUG: CWinSystemGLES::SetFullScreen
16:13:50 T:1292670016 DEBUG: OMXClock::OMXStop
16:13:50 T:1292670016 DEBUG: RemoveActiveDevice - Removing device 2
16:13:50 T:1292670016 DEBUG: SetActiveDevice - SetActiveDevice from 0 to 2
16:13:50 T:1292670016 DEBUG: RemoveActiveDevice - Removing device 0
16:13:50 T:1292670016 INFO: CPCMRemap: Configured speaker layout: 2.0
16:13:50 T:1292670016 INFO: CPCMRemap: I channel map: FL,FR
16:13:50 T:1292670016 DEBUG: pcm->nPortIndex : 0
16:13:50 T:1292670016 DEBUG: pcm->eNumData : 0
16:13:50 T:1292670016 DEBUG: pcm->eEndian : 1
16:13:50 T:1292670016 DEBUG: pcm->bInterleaved : 1
16:13:50 T:1292670016 DEBUG: pcm->nBitPerSample : 16
16:13:50 T:1292670016 DEBUG: pcm->ePCMMode : 0
16:13:50 T:1292670016 DEBUG: pcm->nChannels : 2
16:13:50 T:1292670016 DEBUG: pcm->nSamplingRate : 48000
16:13:50 T:1292670016 DEBUG: OMX_AUDIO_ChannelLF
16:13:50 T:1292670016 DEBUG: OMX_AUDIO_ChannelRF
16:13:50 T:1292670016 DEBUG: pcm->nPortIndex : 0
16:13:50 T:1292670016 DEBUG: pcm->eNumData : 0
16:13:50 T:1292670016 DEBUG: pcm->eEndian : 1
16:13:50 T:1292670016 DEBUG: pcm->bInterleaved : 1
16:13:50 T:1292670016 DEBUG: pcm->nBitPerSample : 16
16:13:50 T:1292670016 DEBUG: pcm->ePCMMode : 0
16:13:50 T:1292670016 DEBUG: pcm->nChannels : 2
16:13:50 T:1292670016 DEBUG: pcm->nSamplingRate : 48000
16:13:50 T:1292670016 DEBUG: OMX_AUDIO_ChannelLF
16:13:50 T:1074937856 DEBUG: CWinEGLPlatformRaspberryPI::DestroyWindow()
16:13:50 T:1292670016 DEBUG: OMX_AUDIO_ChannelRF
16:13:50 T:1292670016 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_render input port 100 output port 100
16:13:50 T:1074937856 NOTICE: CWinEGLPlatformRaspberryPI::SetDisplayResolution set HDMI mode (2,1,33)=0
16:13:50 T:1292670016 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_decode input port 120 output port 121
16:13:50 T:1292670016 DEBUG: COMXCoreComponent::Initialize OMX.broadcom.audio_mixer input port 232 output port 231
16:13:50 T:1283298368 WARNING: CRenderManager::FlipPage - timeout waiting for flip to complete
16:13:50 T:1292670016 DEBUG: COMXCoreComponent::AllocInputBuffers component(OMX.broadcom.audio_decode) - port(120), nBufferCountMin(4), nBufferCountActual(62), nBufferSize(6144), nBufferAlignmen(16)
16:13:50 T:1292670016 DEBUG: COMXAudio::Initialize Ouput bps 16 samplerate 48000 channels 2 buffer size 384000 bytes per second 192000
16:13:50 T:1292670016 DEBUG: COMXAudio::Initialize Input bps 16 samplerate 48000 channels 2 buffer size 384000 bytes per second 192000
16:13:50 T:1292670016 DEBUG: COMXAudio::Initialize device hdmi passthrough 0 hwdecode 0 external clock 1
16:13:50 T:1292670016 INFO: Audio codec channels 2 samplerate 48000 bitspersample 16
16:13:50 T:1292670016 DEBUG: OMXClock::OMXReset 0x00000003
16:13:50 T:1292670016 NOTICE: OMXClock using audio as reference
16:13:50 T:1210995776 DEBUG: COMXPlayer::HandleMessages - player started 2
16:13:50 T:1292670016 DEBUG: ADec : setStartTime 0.000000
16:13:50 T:1292670016 DEBUG: pcm->nPortIndex : 232
16:13:50 T:1292670016 DEBUG: pcm->eNumData : 0
16:13:50 T:1292670016 DEBUG: pcm->eEndian : 1
16:13:50 T:1292670016 DEBUG: pcm->bInterleaved : 1
16:13:50 T:1292670016 DEBUG: pcm->nBitPerSample : 16
16:13:50 T:1127650368 DEBUG: tvservice_callback(8,1,33)
16:13:50 T:1074937856 DEBUG: CWinEGLPlatformRaspberryPI::SetDisplayResolution 1920x1080->1920x1080
16:13:50 T:1292670016 DEBUG: pcm->ePCMMode : 0
16:13:50 T:1292670016 DEBUG: pcm->nChannels : 2
16:13:50 T:1292670016 DEBUG: pcm->nSamplingRate : 48000
16:13:50 T:1292670016 DEBUG: OMX_AUDIO_ChannelLF
16:13:50 T:1292670016 DEBUG: OMX_AUDIO_ChannelRF
16:13:50 T:1292670016 DEBUG: pcm->nPortIndex : 100
16:13:50 T:1292670016 DEBUG: pcm->eNumData : 0
16:13:50 T:1292670016 DEBUG: pcm->eEndian : 1
16:13:50 T:1292670016 DEBUG: pcm->bInterleaved : 1
16:13:50 T:1292670016 DEBUG: pcm->nBitPerSample : 16
16:13:50 T:1292670016 DEBUG: pcm->ePCMMode : 0
16:13:50 T:1292670016 DEBUG: pcm->nChannels : 2
16:13:50 T:1292670016 DEBUG: pcm->nSamplingRate : 48000
16:13:50 T:1292670016 DEBUG: OMX_AUDIO_ChannelLF
16:13:50 T:1292670016 DEBUG: OMX_AUDIO_ChannelRF
16:13:50 T:1210995776 DEBUG: COMXPlayer::HandleMessages - player started 1
16:13:50 T:1210995776 DEBUG: CDVDPlayer::SetCaching - caching state 3
16:13:50 T:1210995776 DEBUG: OMXClock::OMXSetSpeed fake 1
16:13:50 T:1210995776 DEBUG: OMXClock::OMXSetSpeed real 1
16:13:50 T:1074937856 DEBUG: CWinEGLPlatformRaspberryPI::SetDisplayResolution(1920x1080) (1920x1080)
16:13:50 T:1292670016 DEBUG: COMXPlayerAudio - CDVDMsg::PLAYER_SETSPEED
16:13:50 T:1292670016 DEBUG: COMXPlayerAudio - CDVDMsg::GENERAL_RESYNC(21000.000000, 1)
16:13:50 T:1283298368 DEBUG: COMXPlayerVideo - CDVDMsg::GENERAL_RESYNC(171000.000000, 0)
16:13:50 T:1283298368 DEBUG: VDec : setStartTime 0.171000
16:13:50 T:1074937856 DEBUG: EGL extensions: EGL_KHR_image EGL_KHR_image_base EGL_KHR_image_pixmap EGL_KHR_vg_parent_image EGL_KHR_gl_texture_2D_image EGL_KHR_gl_texture_cubemap_image EGL_KHR_lock_surface
16:13:50 T:1074937856 NOTICE: EGL window and context creation complete
16:13:50 T:1074937856 INFO: GLES: Maximum texture width: 2048
16:13:50 T:1074937856 DEBUG: CRenderManager::UpdateDisplayLatency - Latency set to 0 msec
16:13:50 T:1292670016 DEBUG: OMXClock::OMXAudioBufferStart
16:13:50 T:1074937856 DEBUG: ------ Window Init (VideoFullScreen.xml) ------
16:13:50 T:1074937856 INFO: Loading skin file: VideoFullScreen.xml
16:13:51 T:1283298368 WARNING: CRenderManager::FlipPage - timeout waiting for previous frame
16:13:51 T:1292670016 WARNING: Previous line repeats 2 times.
16:13:51 T:1292670016 DEBUG: OMXClock::OMXAudioBufferStop
16:13:51 T:1292670016 DEBUG: OMXClock::OMXSetSpeed fake 1
16:13:51 T:1292670016 DEBUG: OMXClock::OMXSetSpeed real 1
16:13:51 T:1283298368 WARNING: CRenderManager::FlipPage - timeout waiting for previous frame
16:13:51 T:1292670016 INFO: COMXPlayerAudio - Switching to normal playback
16:13:51 T:1283298368 WARNING: CRenderManager::FlipPage - timeout waiting for previous frame
16:13:51 T:1210995776 DEBUG: CDVDPlayer::SetCaching - caching state 0
16:13:51 T:1283298368 WARNING: CRenderManager::FlipPage - timeout waiting for previous frame
16:13:51 T:1074937856 INFO: LIRC Initialize: using: /dev/lircd
16:13:51 T:1074937856 DEBUG: Failed to connect to LIRC. Retry in 10s.
16:13:51 T:1283298368 WARNING: CRenderManager::FlipPage - timeout waiting for previous frame
16:13:51 T:1074937856 WARNING: Previous line repeats 1 times.
16:13:51 T:1074937856 NOTICE: Using GL_TEXTURE_2D
16:13:51 T:1074937856 DEBUG: GL: Requested render method: 0
16:13:51 T:1074937856 NOTICE: GL: Using BYPASS render method
16:13:51 T:1074937856 NOTICE: GL: NPOT texture support detected
16:13:51 T:1074937856 DEBUG: CGUIInfoManager::SetCurrentMovie(rtmp://84.234.23.213/tvcatchup-130/_definst_/userID=851656/accessKey=52217523Q851656L83R33521T-01c3fb9696b73e9e1a6ac2e0272e0749-4fd0d32d/device=web/sdp=itv1hd.sdp/itv1hd_480p.stream app=tvcatchup-130/_definst_/userID=851656/accessKey=52217523Q851656L83R33521T-01c3fb9696b73e9e1a6ac2e0272e0749-4fd0d32d/device=web/sdp=itv1hd.sdp swfurl=http://images-cache.tvcatchup.com/NEW/flash/TvCatchupWebPlayerAD9.swf tcurl=rtmp://84.234.23.213/tvcatchup-130/_definst_/userID=851656/accessKey=52217523Q851656L83R33521T-01c3fb9696b73e9e1a6ac2e0272e0749-4fd0d32d/device=web/sdp=itv1hd.sdp pageurl=http://www.tvcatchup.com/watch.html?c=83 playpath=itv1hd_480p.stream live=1)
16:13:51 T:1283298368 WARNING: CRenderManager::FlipPage - timeout waiting for flip to complete
16:13:52 T:1283298368 WARNING: CRenderManager::FlipPage - timeout waiting for previous frame
16:13:52 T:1074937856 WARNING: Previous line repeats 1 times.
16:13:52 T:1074937856 DEBUG: CAnnouncementManager - Announcement: OnPlay from xbmc
16:13:52 T:1074937856 DEBUG: GOT ANNOUNCEMENT, type: 1, from xbmc, message OnPlay
16:13:52 T:1074937856 DEBUG: ------ Window Deinit (DialogBusy.xml) ------
16:13:56 T:1283298368 WARNING: CRenderManager::FlipPage - timeout waiting for flip to complete
16:13:58 T:1283298368 INFO: COMXPlayerVideo - Stillframe detected, switching to forced 25.000000 fps
16:13:58 T:1283298368 INFO: COMXPlayerVideo - Stillframe left, switching to normal playback
16:13:59 T:1283298368 INFO: COMXPlayerVideo - Stillframe detected, switching to forced 25.000000 fps
16:14:01 T:1283298368 INFO: COMXPlayerVideo - Stillframe left, switching to normal playback
16:14:01 T:1074937856 INFO: LIRC Initialize: using: /dev/lircd
16:14:01 T:1074937856 DEBUG: Failed to connect to LIRC. Retry in 10s.
16:14:05 T:1283298368 WARNING: CRenderManager::FlipPage - timeout waiting for flip to complete
bbc one+two worked fine, just froze on itv hd. i'm pretty sure this is not tvcatchup plugin's fault... Sam (raspbmc dev) is using xbmc 12 alpha builds which are obviously unstable, but i though some logging might be helpful.