...
Checking and processing content protection from fragmentCollector thread
2019 Jun 18 13:08:44.455920 arrisxg1v4 WPEWebProcess[16069]: [HHH]Comcast DRM Agnostic CENC system ID found!
2019 Jun 18 13:08:44.455947 arrisxg1v4 WPEWebProcess[16069]: _extractWVContentMetadataFromPssh:669 content meta data length : 1692
2019 Jun 18 13:08:44.455967 arrisxg1v4 WPEWebProcess[16069]: [HHH]Playready system ID found!
2019 Jun 18 13:08:44.456003 arrisxg1v4 WPEWebProcess[16069]: [HHH]Widevine system ID found!
2019 Jun 18 13:08:44.456023 arrisxg1v4 WPEWebProcess[16069]: _extractKeyIdFromPssh:602 wv keyid: 0cc84940-1541-ef5d-cc5f-1f5317cb417e keyIdlen: 36
2019 Jun 18 13:08:44.456034 arrisxg1v4 WPEWebProcess[16069]: _extractKeyIdFromPssh:642 KeyId : 0cc84940-1541-ef5d-cc5f-1f5317cb417e
...
2019 Jun 18 13:08:44.456177 arrisxg1v4 WPEWebProcess[16069]: [HHH]Comcast DRM Agnostic CENC system ID found!
2019 Jun 18 13:08:44.456204 arrisxg1v4 WPEWebProcess[16069]: _extractWVContentMetadataFromPssh:669 content meta data length : 1692
2019 Jun 18 13:08:44.456227 arrisxg1v4 WPEWebProcess[16069]: [HHH]Playready system ID found!
2019 Jun 18 13:08:44.456263 arrisxg1v4 WPEWebProcess[16069]: [HHH]Widevine system ID found!
2019 Jun 18 13:08:44.456281 arrisxg1v4 WPEWebProcess[16069]: _extractKeyIdFromPssh:602 wv keyid: 0cc84940-1541-ef5d-cc5f-1f5317cb417e keyIdlen: 36
2019 Jun 18 13:08:44.456292 arrisxg1v4 WPEWebProcess[16069]: _extractKeyIdFromPssh:642 KeyId : 0cc84940-1541-ef5d-cc5f-1f5317cb417e
...
2019 Jun 18 13:08:44.456303 arrisxg1v4 WPEWebProcess[16069]: PrivateStreamAbstractionMPD::StreamSelection 3687 > Media[audio] enabled
2019 Jun 18 13:08:44.456346 arrisxg1v4 WPEWebProcess[16069]: PrivateInstanceAAMP::SendEventAsync:797 event type 5
2019 Jun 18 13:08:44.456368 arrisxg1v4 WPEWebProcess[16069]: PrivateInstanceAAMP::SendEventAsync:797 event type 1
Prints indicating playback start position, mpd duration
2019 Jun 18 13:08:44.456513 arrisxg1v4 WPEWebProcess[16069]: SkipFragments:1643 Enter : Type[0] timeLineIndex 0 fragmentRepeatCount 0 skipTime 13.000000
2019 Jun 18 13:08:44.456538 arrisxg1v4 WPEWebProcess[16069]: SkipFragments:1710 [video] newPTS 40530.433711
2019 Jun 18 13:08:44.456554 arrisxg1v4 WPEWebProcess[16069]: SkipFragments:1714 [video] mFirstPTS 0.000000 -> 40530.433711
2019 Jun 18 13:08:44.456571 arrisxg1v4 WPEWebProcess[16069]: SkipFragments:1768 Exit :Type[0] timeLineIndex 0 fragmentRepeatCount 6 fragmentDescriptor.Number 779651997 fragmentTime 12.012000
2019 Jun 18 13:08:44.456590 arrisxg1v4 WPEWebProcess[16069]: SkipFragments:1643 Enter : Type[1] timeLineIndex 0 fragmentRepeatCount 0 skipTime 13.000000
2019 Jun 18 13:08:44.456626 arrisxg1v4 WPEWebProcess[16069]: SkipFragments:1710 [audio] newPTS 40528.449911
2019 Jun 18 13:08:44.456641 arrisxg1v4 WPEWebProcess[16069]: SkipFragments:1768 Exit :Type[1] timeLineIndex 5 fragmentRepeatCount 0 fragmentDescriptor.Number 779651996 fragmentTime 10.016000
2019 Jun 18 13:08:44.456657 arrisxg1v4 WPEWebProcess[16069]: Init:2682 offsetFromStart(13.000000) seekPosition(12.012000)
2019 Jun 18 13:08:44.458665 arrisxg1v4 WPEWebProcess[16069]: aamp: sending metadata event and duration update 28.000000
...
2019 Jun 18 13:08:44.458737 arrisxg1v4 WPEWebProcess[16069]: UpdateRefreshPlaylistInterval(): maxRefreshPlaylistIntervalSecs (4.032000)
2019 Jun 18 13:08:44.458782 arrisxg1v4 WPEWebProcess[16069]: TuneHelper:3810 Updated seek_pos_seconds 12.012000
Creating Gstreamer pipeline
Code Block |
---|
language | bash |
---|
theme | Midnight |
---|
title | Creating Gstreamer pipeline |
---|
|
1613139308:107 : [AAMP-PLAYER]CreatePipeline(): Creating gstreamer pipeline
1613139308:107 : [AAMP-PLAYER]AAMPGstPlayerPipeline buffering_enabled 1
1613139308:107 : [AAMP-PLAYER]AAMPGstPlayer::Configure 2363 > Closing stream 0 old format = 0, new format = 2
1613139308:107 : [AAMP-PLAYER]AAMPGstPlayer::Configure 2363 > Closing stream 1 old format = 0, new format = 2
1613139308:107 : [AAMP-PLAYER]AAMPGstPlayer::TearDownStream: exit mediaType = 0
1613139308:107 : [AAMP-PLAYER]AAMPGstPlayer_SetupStream - using playbin
1613139308:116 : [AAMP-PLAYER]AAMPGstPlayer_SetupStream - using westerossink
1613139308:127 : [AAMP-PLAYER]playbin flags1: 0x617
1613139308:127 : [AAMP-PLAYER]AAMPGstPlayer::TearDownStream: exit mediaType = 1
1613139308:127 : [AAMP-PLAYER]AAMPGstPlayer_SetupStream - using playbin
1613139308:128 : [AAMP-PLAYER]playbin flags1: 0x617
1613139308:128 : [AAMP-PLAYER]AAMPGstPlayerPipeline NULL -> READY (pending PAUSED) |
DRM session creation "keysystem is" indicates which DRM is selected
Code Block |
---|
language | bash |
---|
theme | Midnight |
---|
title | Checking and processing content protection from fragmentCollector thread |
---|
|
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]aamp ipv4=1 enabled
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]aamp ipv4=1 enabled
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]aamp url:3,3,0,0.000000,https://content.uplynk.com/224ac8717e714b68831997ab6cea4015.mpd
Mar 18 05:35:42 HP40ARDK WPEFramework[6790]: 11:05:42:174 INFO av_sync_destroy:198: begin
Mar 18 05:35:42 HP40ARDK WPEFramework[6790]: 11:05:42:174 INFO tsync_send_video_stop:112: video stop
Mar 18 05:35:42 HP40ARDK WPEFramework[6790]: 11:05:42:177 INFO av_sync_destroy:212: done
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]HttpRequestEnd: 3,3,200,0.2310,0.2302,0.0702,0.2293,0.0287,0.1787,0.1788,0.0000,8442,287,https://content.uplynk.com/224ac8717e714b68831997ab6cea4015.mpd
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]ClearPlaylistCache:145 : cache size 1
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER][InsertToPlaylistCache][76] Inserted. url https://content.uplynk.com/224ac8717e714b68831997ab6cea4015.mpd
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]PrivateStreamAbstractionMPD::Init:3724 - MPD duration str PT9M56.479999S val 596 seconds
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]PrivateStreamAbstractionMPD::GetPeriodStartTime:3326 - MPD periodIndex 0 periodStart 0.000000
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]PrivateStreamAbstractionMPD::GetPeriodDuration:3358 - MPD periodIndex:0 periodDuration 596.479000
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]GetPeriodEndTime:3437 : Period startTime required to calculate period duration not present in MPD
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]PrivateStreamAbstractionMPD::GetPeriodEndTime:3445 - MPD periodIndex:0 periodEndTime 596.479000
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]Selected Period index 0, id c-0-000-146
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]GetBestAudioTrackByLanguage: aamp->language en, aamp->noExplicitUserLanguageSelection false, aamp->preferredLanguages "en"
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]PrivateStreamAbstractionMPD::GetDesiredCodecIndex 1051 > SelectedRepIndex : 0 ,selectedCodecType : 2, selectedRepBandwidth: 24860
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]PrivateStreamAbstractionMPD::StreamSelection 5590 > lang[en] AudioType[2]
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]IsIframeTrack:5191 - skipping name SupplementalProperty
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]IsIframeTrack:5191 - skipping name InbandEventStream
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]IsIframeTrack:5191 - skipping name SupplementalProperty
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]IsIframeTrack:5191 - skipping name InbandEventStream
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]PrivateStreamAbstractionMPD::StreamSelection 5852 > Media[video] Adaptation set[2] RepIdx[-1] TrackCnt[1]
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]CreateDrmHelper:2948 (video) got schemeID empty at ContentProtection node-0
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]CreateDrmHelper:3009 (video) Created DRM helper for UUID edef8ba9-79d6-4ace-a3c8-27dcd51d21ed and best to use
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]PrivateStreamAbstractionMPD::StreamSelection 5865 > Media[video] enabled
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]PrivateStreamAbstractionMPD::StreamSelection() 5766 Audio Track - lang:en, group:main, name:0, codec:mp4a.40.5, bandwidth:24860
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]PrivateStreamAbstractionMPD::StreamSelection 5852 > Media[audio] Adaptation set[0] RepIdx[0] TrackCnt[2]
|
Code Block |
---|
language | bash |
---|
theme | Midnight |
---|
title | DRM session creation "keysystem is" indicates which DRM is selected |
---|
|
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]QueueProtectionEvent:1656 Queueing protection event for type(0) keysystem(edef8ba9-79d6-4ace-a3c8-27dcd51d21ed) initData(0xac08b548) initDataSize(114)
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]createDrmSession:918 StreamType :0 keySystem is com.widevine.alpha
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]getDrmSession:1035 Selected slot 1 for keyId 0x6132303038633166343735663439313739616366366230613531636162633938
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]AAMPOCDMSessionAdapter :: enter
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]initAampDRMSystem :: enter
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]CreateDrmHelper:2948 (audio) got schemeID empty at ContentProtection node-0
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]initAampDRMSystem :: exit
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]AAMPOCDMSessionAdapter :: exit
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]getDrmSession:1115 Created new DrmSession for DrmSystemId com.widevine.alpha
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]generateAampDRMSession:91: at 0xac0abf18, with 0xac0611c0, (nil) |
...
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]CreateDrmHelper:3009 (audio) Created DRM helper for UUID edef8ba9-79d6-4ace-a3c8-27dcd51d21ed |
...
and best to use
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]processOCDMChallenge:145: at 0xac0abf18, with 0xac0611c0, (nil)
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16[ 1160.165234@1]s [TEE] OEMCrypto_GetOEMPublicCertificate: Provisioning method = 2.
[ 1160.171989@1]s [TEE] OEMCrypto_GetOEMPublicCertificate: Provisioning method = 2. |
Creating Gstreamer pipeline
FragmentCollector downloading and injecting init headers
Code Block |
---|
language | bash |
---|
theme | Midnight |
---|
title | FragmentCollector downloading and injecting init headers | Creating Gstreamer pipeline |
---|
|
1613139308:1071613139307:613 : [AAMP-PLAYER]PrivateStreamAbstractionMPD::Init:4281 - fetch initialization fragments
1613139307:614CreatePipeline(): Creating gstreamer pipeline
1613139308:107 : [AAMP-PLAYER]aamp url:2,7,1,http://cpetestutility.stb.r53.xcal.tv/VideoTestStream/dash/de_init.m4s
1613139307:614AAMPGstPlayerPipeline buffering_enabled 1
1613139308:107 : [AAMP-PLAYER]aamp url:2,6,0,http://cpetestutility.stb.r53.xcal.tv/VideoTestStream/dash/480p_init.m4s
1613139307:858AAMPGstPlayer::Configure 2363 > Closing stream 0 old format = 0, new format = 2
1613139308:107 : [AAMP-PLAYER]HttpRequestEnd: 2,6,200,0.2440,0.2442,0.0002,0.2441,0.0002,0.0002,0.0003,0.0000,811,288,http://cpetestutility.stb.r53.xcal.tv/VideoTestStream/dash/480p_init.m4s
1613139308:106AAMPGstPlayer::Configure 2363 > Closing stream 1 old format = 0, new format = 2
1613139308:107 : [AAMP-PLAYER]HttpRequestEnd: 2,7,200,0.4920,0.4918,0.2455,0.4916,0.0001,0.0000,0.2457,0.0000,741,286,http://cpetestutility.stb.r53.xcal.tv/VideoTestStream/dash/de_init.m4s |
Gstreamer layer detects encryption for Audio and Video and suitable Decryptor plugin and initialized
Code Block |
---|
language | bash |
---|
theme | Midnight |
---|
title | Gstreamer layer detects encryption for Audio and Video and suitable Decryptor plugin and initialized |
---|
|
Mar 18 05:35:44 HP40ARDK WPEWebProcess[16788]AAMPGstPlayer::TearDownStream: exit mediaType = 0
1613139308:107 : [AAMP-PLAYER]AAMPGstPlayer_SendPendingEventsSetupStream pushing- protection event! mediatype: 1
Mar 18 05:35:44 HP40ARDK WPEWebProcess[16788]using playbin
1613139308:116 : [AAMP-PLAYER]SettingAAMPGstPlayer_SetupStream PlayReady- asusing preferredwesterossink drm
Mar 18 05:35:44 HP40ARDK WPEWebProcess[16788]1613139308:127 : [AAMP-PLAYER]playbin flags1: 0x617
1613139308:127 : [AAMP-PLAYER]AAMPGstPlayer::TearDownStream: settingexit aampmediaType instance= for aampwidevinedecryptor21 decryptor
Mar 18 05:35:44 HP40ARDK WPEFramework[6790]: gst_qtdemux_handle
1613139308:127 : [AAMP-PLAYER]AAMPGstPlayer_SetupStream - using playbin
1613139308:128 : [AAMP-PLAYER]playbin flags1: 0x617
1613139308:128 : [AAMP-PLAYER]AAMPGstPlayerPipeline NULL -> READY (pending PAUSED) |
DRM session creation "keysystem is" indicates which DRM is selected
Code Block |
---|
language | bash |
---|
theme | Midnight |
---|
title | DRM session creation "keysystem is" indicates which DRM is selected |
---|
|
_sink_event:2320 - aamp_override - enabled = 0, player = 1, rate 1.000000
Mar 18 05:35:44 HP40ARDK WPEFramework[6790]: (WPEWebProcess:16788): GStreamer-WARNING **: ../../gstreamer-1.10.4/gst/gstpad.c:5079:store_sticky_event:<typefind:sink> Sticky event misordering, got 'segment' before 'caps'
Mar 18 05:35:4442 HP40ARDK WPEFrameworkWPEWebProcess[679016788]: (WPEWebProcess:16788): GStreamer-WARNING **: ../../gstreamer-1.10.4/gst/gstpad.c:5079:store_sticky_event:<decodebin3:sink> Sticky event misordering, got 'segment' before 'caps'[AAMP-PLAYER]QueueProtectionEvent:1656 Queueing protection event for type(0) keysystem(edef8ba9-79d6-4ace-a3c8-27dcd51d21ed) initData(0xac08b548) initDataSize(114)
Mar 18 05:35:4442 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]Setting PlayReady as preferred drmcreateDrmSession:918 StreamType :0 keySystem is com.widevine.alpha
Mar 18 05:35:4442 HP40ARDK WPEFrameworkWPEWebProcess[679016788]: ** (WPEWebProcess:16788): WARNING **: ####### gst_aampwidevinedecryptor_init : 90 ####[AAMP-PLAYER]getDrmSession:1035 Selected slot 1 for keyId 0x6132303038633166343735663439313739616366366230613531636162633938
Mar 18 05:35:4442 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]AAMPGstPlayerAAMPOCDMSessionAdapter setting aamp instance for aampwidevinedecryptor3 decryptor:: enter
Mar 18 05:35:4442 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]createDrmSession:918 StreamType :1 keySystem is com.widevine.alphainitAampDRMSystem :: enter
Mar 18 05:35:4442 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]getDrmSessionCreateDrmHelper:9972948 Session created/inprogress with same keyID 0x6237336265306534616239653433613238336531663130316336373836303832 at slot 2(audio) got schemeID empty at ContentProtection node-0
Mar 18 05:35:4442 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]getDrmSessioninitAampDRMSystem ::1075 Foundexit drm
Mar session READY with same keyID 0x6237336265306534616239653433613238336531663130316336373836303832 - Reusing drm session18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]AAMPOCDMSessionAdapter :: exit
Mar 18 05:35:4442 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]createDrmSessiongetDrmSession:9181115 Created StreamTypenew :0DrmSession keySystemfor isDrmSystemId com.widevine.alpha |
2019 Jun 18 13:08:44.570753 arrisxg1v4 WPEWebProcess[16069]: AAMPGstPlayer_SendPendingEvents pushing protection event! mediatype: 1
2019 Jun 18 13:08:44.572607 arrisxg1v4 WPEWebProcess[16069]: Setting WideWine as preferred drm
2019 Jun 18 13:08:44.575963 arrisxg1v4 WPEWebProcess[16069]: AAMPGstPlayer setting aamp instance for aampwidevinedecryptor2 decryptor
...
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]generateAampDRMSession:91: at 0xac0abf18, with 0xac0611c0, (nil)
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]CreateDrmHelper:3009 (audio) Created DRM helper for UUID edef8ba9-79d6-4ace-a3c8-27dcd51d21ed |
...
and best to use
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]processOCDMChallenge:145: at 0xac0abf18, with 0xac0611c0, (nil)
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16[ 1160.165234@1]s [TEE] OEMCrypto_GetOEMPublicCertificate: Provisioning method = 2.
[ 1160.171989@1]s [TEE] OEMCrypto_GetOEMPublicCertificate: Provisioning method = 2.
788]: [86B blob data]
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]processOCDMChallenge destUrl = http://widevine-proxy.appspot.com/proxy |
FragmentCollector downloading and injecting init headersFragmentCollector proceeds with fragment download/injection
Code Block |
---|
language | bash |
---|
theme | Midnight |
---|
title | FragmentCollector proceeds with fragment download/injectiondownloading and injecting init headers |
---|
|
1613139307:6131613139308:151 : [AAMP-PLAYER]fragment injector started. track audio
1613139308:151 : [AAMP-PLAYER]fragment injector started. track video
1613139308:158PrivateStreamAbstractionMPD::Init:4281 - fetch initialization fragments
1613139307:614 : [AAMP-PLAYER]aamp: ready to collect fragments. mpd 0x9d75f0
1613139308:158 : [AAMP-PLAYER]MPD has 1 periods current period index 0
1613139308:158 : [AAMP-PLAYER]PushNextFragment:1811 Type[1] update startTime to 0
1613139308:158 url:2,7,1,http://cpetestutility.stb.r53.xcal.tv/VideoTestStream/dash/de_init.m4s
1613139307:614 : [AAMP-PLAYER]aamp url:02,16,10,http://cpetestutility.stb.r53.xcal.tv/VideoTestStream/dash/de480p_001init.mp3m4s
16131393081613139307:158858 : [AAMP-PLAYER]PushNextFragmentHttpRequestEnd:1811 Type[0] update startTime to 0
1613139308:158 : [AAMP-PLAYER]aamp url:0,0,0, 2,6,200,0.2440,0.2442,0.0002,0.2441,0.0002,0.0002,0.0003,0.0000,811,288,http://cpetestutility.stb.r53.xcal.tv/VideoTestStream/dash/480p_001.m4sinit.m4s
1613139308:106 : [AAMP-PLAYER]HttpRequestEnd: 2,7,200,0.4920,0.4918,0.2455,0.4916,0.0001,0.0000,0.2457,0.0000,741,286,http://cpetestutility.stb.r53.xcal.tv/VideoTestStream/dash/de_init.m4s |
Gstreamer layer detects encryption for Audio and Video and suitable Decryptor plugin and initializedDRM license request in progress
Code Block |
---|
language | bash |
---|
theme | Midnight |
---|
title | DRM license request in progressGstreamer layer detects encryption for Audio and Video and suitable Decryptor plugin and initialized |
---|
|
Mar 18 05:35:4244 HP40ARDK WPEWebProcessWPEFramework[167886790]: [AAMP-PLAYER]generateAampDRMSession:91: at 0xac0abf18, with 0xac0611c0, (nil) ** (WPEWebProcess:16788): WARNING **: ####### gst_aampwidevinedecryptor_init : 90 ####
Mar 18 05:35:4244 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]CreateDrmHelper:3009 (audio) Created DRM helper for UUID edef8ba9-79d6-4ace-a3c8-27dcd51d21ed and best to useSending segment event for mediaType[1]. start 0 stop 18446744073709551615 rate 1.000000 applied_rate 1.000000
Mar 18 05:35:4244 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]processOCDMChallenge:145: at 0xac0abf18, with 0xac0611c0, (nil)AAMPGstPlayer_SendPendingEvents pushing protection event! mediatype: 1
Mar 18 05:35:4244 HP40ARDK WPEWebProcess[16[ 1160.165234@1]s [TEE] OEMCrypto_GetOEMPublicCertificate: Provisioning method = 2.
[ 1160.171989@1]s [TEE] OEMCrypto_GetOEMPublicCertificate: Provisioning method = 2.
788]: [86B blob data]16788]: [AAMP-PLAYER]Setting PlayReady as preferred drm
Mar 18 05:35:4244 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]processOCDMChallenge destUrl = http://widevine-proxy.appspot.com/proxyAAMPGstPlayer setting aamp instance for aampwidevinedecryptor2 decryptor
Mar 18 05:35:4244 HP40ARDK WPEWebProcessWPEFramework[167886790]: [AAMP-PLAYER]acquireLicense:1186 Request to generate license challenge to the aampDRMSession(CDM)
Mar 18gst_qtdemux_handle_sink_event:2320 - aamp_override - enabled = 0, player = 1, rate 1.000000
Mar 18 05:35:4244 HP40ARDK WPEFramework[6790]: (WPEWebProcess[16788]: [AAMP-PLAYER]aampGenerateKeyRequest:198: at 0xac0abf18, with 0xac0611c0, 0xac0a3ff0:16788): GStreamer-WARNING **: ../../gstreamer-1.10.4/gst/gstpad.c:5079:store_sticky_event:<typefind:sink> Sticky event misordering, got 'segment' before 'caps'
Mar 18 05:35:4244 HP40ARDK WPEFramework[6790]: (WPEWebProcess[:16788]): [AAMP-PLAYER]destination url is http://widevine-proxy.appspot.com/proxyGStreamer-WARNING **: ../../gstreamer-1.10.4/gst/gstpad.c:5079:store_sticky_event:<decodebin3:sink> Sticky event misordering, got 'segment' before 'caps'
Mar 18 05:35:4244 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]acquireLicense:1263 Request License from the Drm Server https://content.uplynk.com/wvSetting PlayReady as preferred drm
Mar 18 05:35:44 HP40ARDK WPEFramework[6790]: ** (WPEWebProcess:16788): WARNING **: ####### gst_aampwidevinedecryptor_init : 90 ####
Mar 18 05:35:4244 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]AAMPGstPlayer setting aamp ipv4=1 enabledinstance for aampwidevinedecryptor3 decryptor
Mar 18 05:35:4244 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]getLicense:668 Sending license request to server : https://content.uplynk.com/wv createDrmSession:918 StreamType :1 keySystem is com.widevine.alpha
Mar 18 05:35:44 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]getDrmSession:997 Session created/inprogress with same keyID 0x6237336265306534616239653433613238336531663130316336373836303832 at slot 2
Mar 18 05:35:4244 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]getLicensegetDrmSession:7681075 DRMFound Sessiondrm Managersession ReceivedREADY licensewith datasame fromkeyID server;0x6237336265306534616239653433613238336531663130316336373836303832 Curl- totalReusing timedrm session
Mar = 0.4 |
2019 Jun 18 13:08:44.745282 arrisxg1v4 WPEWebProcess[16069]: generateAampDRMSession :: sessionId : ksidE173EC32
2019 Jun 18 13:08:44.745336 arrisxg1v4 WPEWebProcess[16069]: destination url is https://mds.ccp.xcal.tv
2019 Jun 18 13:08:44.745364 arrisxg1v4 WPEWebProcess[16069]: createDrmSession:1045 [HHH]contentMetaData length=1692
2019 Jun 18 13:08:44.745424 arrisxg1v4 WPEWebProcess[16069]: createDrmSession:1078 MDS server spcific conent metadata found in initdata
2019 Jun 18 13:08:44.745480 arrisxg1v4 WPEWebProcess[16069]: createDrmSession:1108 access token is available
2019 Jun 18 13:08:44.745555 arrisxg1v4 WPEWebProcess[16069]: [HHH] Before calling SecClient_AcquireLicense-----------
2019 Jun 18 13:08:44.745569 arrisxg1v4 WPEWebProcess[16069]: destinationURL is mds.ccp.xcal.tv
2019 Jun 18 13:08:44.745582 arrisxg1v4 WPEWebProcess[16069]: MoneyTrace[trace-id=e5de25f4-b903-42ee-a872-3f6b95a3b29f;parent-id=2473532010524596290;span-id=1560863324745]
2019 Jun 18 13:08:44.745594 arrisxg1v4 WPEWebProcess[16069]: keySystem is com.widevine.alpha
2019 Jun 18 13:08:44.765810 arrisxg1v4 WPEWebProcess[16069]: AAMPGstPlayer Found --> brcmvideodecoder = 0xb232ee78
2019 Jun 18 13:08:44.766483 arrisxg1v4 Receiver[15906]: Thread-15906 [XREApplication] - xre transaction complete: 1ca60ae4-00ba-4dd3-9293-9c48207edcdb,1088
2019 Jun 18 13:08:44.768226 arrisxg1v4 WPEWebProcess[16069]: createDrmSession:821 systemId is edef8ba9-79d6-4ace-a3c8-27dcd51d21ed
2019 Jun 18 13:08:44.768247 arrisxg1v4 WPEWebProcess[16069]: createDrmSession:838 [HHH]systemId is Widevine
2019 Jun 18 13:08:44.768266 arrisxg1v4 WPEWebProcess[16069]: keysystem is com.widevine.alpha
2019 Jun 18 13:08:44.768290 arrisxg1v4 WPEWebProcess[16069]: _extractKeyIdFromPssh:602 wv keyid: 0cc84940-1541-ef5d-cc5f-1f5317cb417e keyIdlen: 36
2019 Jun 18 13:08:44.768309 arrisxg1v4 WPEWebProcess[16069]: _extractKeyIdFromPssh:642 KeyId : 0cc84940-1541-ef5d-cc5f-1f5317cb417e
2019 Jun 18 13:08:44.768329 arrisxg1v4 WPEWebProcess[16069]: createDrmSession:876 Session created/inprogress with same keyID 0cc84940-1541-ef5d-cc5f-1f5317cb417e at slot 1, can reuse same for video
18 05:35:44 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]createDrmSession:918 StreamType :0 keySystem is com.widevine.alpha |
FragmentCollector proceeds with fragment download/injection
Code Block |
---|
language | bash |
---|
theme | Midnight |
---|
title | FragmentCollector proceeds with fragment download/injection |
---|
|
1613139308:151 : [AAMP-PLAYER]fragment injector started. track audio
1613139308:151 : [AAMP-PLAYER]fragment injector started. track video
1613139308:158 : [AAMP-PLAYER]aamp: ready to collect fragments. mpd 0x9d75f0
1613139308:158 : [AAMP-PLAYER]MPD has 1 periods current period index 0
1613139308:158 : [AAMP-PLAYER]PushNextFragment:1811 Type[1] update startTime to 0
1613139308:158 : [AAMP-PLAYER]aamp url:0,1,1,http://cpetestutility.stb.r53.xcal.tv/VideoTestStream/dash/de_001.mp3
1613139308:158 : [AAMP-PLAYER]PushNextFragment:1811 Type[0] update startTime to 0
1613139308:158 : [AAMP-PLAYER]aamp url:0,0,0,http://cpetestutility.stb.r53.xcal.tv/VideoTestStream/dash/480p_001.m4s |
DRM license request in progressLicense acquisition success
Code Block |
---|
language | bash |
---|
theme | Midnight |
---|
title | License acquisition successDRM license request in progress |
---|
|
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]getLicensegenerateAampDRMSession:91:769 acquireLicenseat SUCCESS!0xac0abf18, licensewith request attempt 1; response code : http 2000xac0611c0, (nil)
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]HttpRequestEndCreateDrmHelper: 1,0,200,0.3520,0.3522,0.0352,0.1695,0.0043,0.1409,0.1410,0.0000,713,144,https://content.uplynk.com/wv3009 (audio) Created DRM helper for UUID edef8ba9-79d6-4ace-a3c8-27dcd51d21ed and best to use
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]handleLicenseResponse:1349 license acquisition completedprocessOCDMChallenge:145: at 0xac0abf18, with 0xac0611c0, (nil)
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]processLicenseResponse:1397 Updating the license response to the aampDRMSession(CDM)[16[ 1160.165234@1]s [TEE] OEMCrypto_GetOEMPublicCertificate: Provisioning method = 2.
[ 1160.171989@1]s [TEE] OEMCrypto_GetOEMPublicCertificate: Provisioning method = 2.
788]: [86B blob data]
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]aampDRMProcessKey:229: at 0xac0abf18, with 0xac0611c0, 0xac0a3ff0processOCDMChallenge destUrl = http://widevine-proxy.appspot.com/proxy
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]Calling opencdm_session_update, key length=713acquireLicense:1186 Request to generate license challenge to the aampDRMSession(CDM)
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]keyUpdateOCDMaampGenerateKeyRequest:178198: at 0xac0abf18, with 0xac0611c0, 0xac0a3ff0
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]keysUpdatedOCDM:192: at 0xac0abf18, with 0xac0611c0, 0xac0a3ff0destination url is http://widevine-proxy.appspot.com/proxy
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]Key Status updatedacquireLicense:1263 Request License from the Drm Server https://content.uplynk.com/wv
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]processKey: Key Usable!aamp ipv4=1 enabled
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]getLicense:668 Sending DRMMetaDat] license request to server : https://content.uplynk.com/wv
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]getLicense:768 DRM Session Manager Received license data from server; Curl total time = 0.4 |
License acquisition success
Code Block |
---|
language | bash |
---|
theme | Midnight |
---|
title | License acquisition success |
---|
|
PrivateInstanceAAMP::SendEventAsync:2656 Failed to send event type 25
Mar 18 05:35:42 HP40ARDK WPEFrameworkWPEWebProcess[679016788]: http://cpetestutility.stb.r53.xcal.tv/players/version10/js/src/Mediaplayer.js:914:32: CONSOLE LOG AAMP: (state) playback state changed: {"state":2}[AAMP-PLAYER]getLicense:769 acquireLicense SUCCESS! license request attempt 1; response code : http 200
Mar 18 05:35:42 HP40ARDK WPEFrameworkWPEWebProcess[679016788]: http://cpetestutility.stb.r53.xcal.tv/players/version10/js/src/Mediaplayer.js:932:40: CONSOLE LOG State not expected[AAMP-PLAYER]HttpRequestEnd: 1,0,200,0.3520,0.3522,0.0352,0.1695,0.0043,0.1409,0.1410,0.0000,713,144,https://content.uplynk.com/wv
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]handleLicenseResponse:1349 license acquisition completed
Mar 18 05:35:42 HP40ARDK WPEFrameworkWPEWebProcess[679016788]: http://cpetestutility.stb.r53.xcal.tv/players/version10/js/src/Mediaplayer.js:914:32: CONSOLE LOG AAMP: (state) playback state changed: {"state":3}[AAMP-PLAYER]processLicenseResponse:1397 Updating the license response to the aampDRMSession(CDM)
Mar 18 05:35:42 HP40ARDK WPEFrameworkWPEWebProcess[679016788]: http://cpetestutility.stb.r53.xcal.tv/players/version10/js/src/Mediaplayer.js:932:40: CONSOLE LOG State not expected[AAMP-PLAYER]aampDRMProcessKey:229: at 0xac0abf18, with 0xac0611c0, 0xac0a3ff0
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]SendDRMMetaData name = value = 0Calling opencdm_session_update, key length=713
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]PrivateStreamAbstractionMPDkeyUpdateOCDM:178:StreamSelection 5865 > Media[audio] enabled |
...
at 0xac0abf18, with 0xac0611c0, 0xac0a3ff0
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]keysUpdatedOCDM:192: at 0xac0abf18, with 0xac0611c0, 0xac0a3ff0
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]Key Status updated
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]processKey: Key Usable!
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]Sending DRMMetaDat]
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]PrivateInstanceAAMP::SendEventAsync:2656 Failed to send event type 25
Mar 18 05:35:42 HP40ARDK WPEFramework[6790]: http://cpetestutility.stb.r53.xcal.tv/players/version10/js/src/Mediaplayer.js:914:32: CONSOLE LOG AAMP: (state) playback state changed: {"state":2}
Mar 18 05:35:42 HP40ARDK WPEFramework[6790]: http://cpetestutility.stb.r53.xcal.tv/players/version10/js/src/Mediaplayer.js:932:40: CONSOLE LOG State not expected
Mar 18 05:35:42 HP40ARDK WPEFramework[6790]: http://cpetestutility.stb.r53.xcal.tv/players/version10/js/src/Mediaplayer.js:914:32: CONSOLE LOG AAMP: (state) playback state changed: {"state":3}
Mar 18 05:35:42 HP40ARDK WPEFramework[6790]: http://cpetestutility.stb.r53.xcal.tv/players/version10/js/src/Mediaplayer.js:932:40: CONSOLE LOG State not expected
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]SendDRMMetaData name = value = 0
Mar 18 05:35:42 HP40ARDK WPEWebProcess[16788]: [AAMP-PLAYER]PrivateStreamAbstractionMPD::StreamSelection 5865 > Media[audio] enabled |
Finally tune succeeded and tune time print will have the statistics
...