Versions Compared

Old Version 5

changes.mady.by.user Ashraf Bhanu Kothapeta

Saved on

compared with

New Version 6

changes.mady.by.user Ashraf Bhanu Kothapeta

Saved on

Key

  • This line was added.
  • This line was removed.
  • Formatting was changed.

...

Code Block
languagebash
themeMidnight
[AAMPCLI] AAMP_EVENT_STATE_CHANGED: INITIALIZING (1)1619616813:6371620191772:173 : [AAMP-PLAYER]DRMcreateDrmSession:916 StreamType Selected: PlayReady
1619616813:6370 keySystem is com.widevine.alpha
1620191772:173 : [AAMP-PLAYER]DRM prefs
1619616813:637getDrmSession:1033  Selected slot 0 for keyId 0x7368616B615F63656332663634616137383930613131
1620191772:173 : [AAMP-PLAYER]{ 1077efec-c0b2-4d02-ace3-3c1e52e2fb4b, 1 }
1619616813:637AAMPOCDMSessionAdapter :: enter
1620191772:173 : [AAMP-PLAYER]{ 9a04f079-9840-4286-ab92-e65be0885f95, 4 }
1619616813:637initAampDRMSystem :: enter
Trying to open an OCDM connection @ /tmp/ocdm
1620191772:175 : [AAMP-PLAYER]{ edef8ba9-79d6-4ace-a3c8-27dcd51d21ed, 2 }

2019 Jun 18 22:25:20.440576 pacexi5 WPEWebProcess[6625]: TheDRMListener::TheDRMListener:117 AveDrm[0x193f40]Listner[0x22d818]Track[0]
2019 Jun 18 22:25:20.440598 pacexi5 WPEWebProcess[6625]: AveDrm::SetMetaData:365[0x193f40]Track[0] drmState:0
2019 Jun 18 22:25:20.440609 pacexi5 WPEWebProcess[6625]: SetMetadata:931: Created new AveDrmManager[763557531d09355a3331750aab7382daeea56725] .Track[0].Total Sz=1
2019 Jun 18 22:25:20.463579 pacexi5 runAppManager.sh[5611]: [MyFlashAccessAdapter][0x236c00] Constructor
2019 Jun 18 22:25:20.476126 pacexi5 runAppManager.sh[5611]: DRMManager_CreateDRMMetadata calling created source/DRMInterface.cpp
2019 Jun 18 22:25:20.481279 pacexi5 runAppManager.sh[5611]: [Initialize_Stage2][0x236c00]MyFlashAccessAdapter Initialize Stage 2 with encryption Algorithm: AES-CBC
2019 Jun 18 22:25:20.481679 pacexi5 runAppManager.sh[5611]: 33528 createDRMDecryptionContext_FromDrmMetadataEx calling new DRMCreateDecryptionSessionOperation DRMInterface.cpp
2019 Jun 18 22:25:20.481975 pacexi5 runAppManager.sh[5611]: machineID: NTczZWI2YTBjN2ExNDNiM2YzNzM4MmQ1ZWQ2MjBjOWI=
2019 Jun 18 22:25:20.488720 pacexi5 runAppManager.sh[5611]: 33528 OemGlobalStateStoreSPI::IOemGlobalStateStore::getDeviceInfo
2019 Jun 18 22:25:20.489057 pacexi5 runAppManager.sh[5611]: 33528 OemDeviceBindingSPI::getDeviceInfo Line 156
2019 Jun 18 22:25:20.489324 pacexi5 runAppManager.sh[5611]: [98B blob data]
2019 Jun 18 22:25:20.489630 pacexi5 runAppManager.sh[5611]: BRCM_RI_SecureStore_Read reading /opt/persistent/adobe/drm/deviceBinding.txt in size 8000
...
2019 Jun 18 22:25:20.459925 pacexi5 WPEWebProcess[6625]: AveDrm::AcquireKey:637[0x193f40] drmState:1 Track[0]

Player level tune initialization and Gstreamer pipeline creation for the playback.

Code Block
languagebash
themeMidnight
1613144307:322 : [AAMP-PLAYER]CreatePipeline(): Creating gstreamer pipeline 1613144307:322 : [AAMP-PLAYER]AAMPGstPlayerPipeline buffering_enabled 1 1613144317:586 : [AAMP-PLAYER]PrivateInstanceAAMP::ConfigureDashParallelFragmentDownload:8112 DASH Paraller Frag DL Config [1] 1613144317:586 : [AAMP-PLAYER]PrivateInstanceAAMP::ConfigureRetuneForGSTInternalError:8168 GST Internal Stream Error Retune Config [1] 1613144317:586 : [AAMP-PLAYER]Enabling Westeros Sink 1613144317:587 : [AAMP-PLAYER]FOREGROUND PLAYER[0] aamp_tune: attempt: 1 format: HLS URL: http://devimages.apple.com/iphone/samples/bipbop/bipbopall.m3u8

Fragment request start point and fragment decryption; pipeline state change to playing after decrypted data sent to gstreamer.

initAampDRMSystem :: exit
 EDID Num of Resolution .......9
1620191772:197 : [AAMP-PLAYER]SetResolution:253 Resolution : width 1920 height:1080
1620191772:197 : [AAMP-PLAYER]SetHDMIStatus : detected HDCP version 1.4
1620191772:197 : [AAMP-PLAYER]AAMPOCDMSessionAdapter :: exit
1620191772:197 : [AAMP-PLAYER]getDrmSession:1113 Created new DrmSession for DrmSystemId com.widevine.alpha
1620191772:197 : [AAMP-PLAYER]generateAampDRMSession:91: at 0xaed94e20, with 0xaed94da0, (nil)
Essos Info: ../../git/essos/essos-resmgr.cpp:1997 audio decoder 0 assigned to pid 21264
PID = 21264, inited = 0
1620191772:300 : [AAMP-PLAYER]parsePssh:76 WV Version: 0, Keyid indicator byte not found using default logic
1620191772:402 : [AAMP-PLAYER]processOCDMChallenge:145: at 0xaed94e20, with 0xaed94da0, (nil)
1620191772:402 : [AAMP-PLAYER]processOCDMChallenge challenge = 0:Type
1620191772:402 : [AAMP-PLAYER]processOCDMChallenge destUrl = http://widevine-proxy.appspot.com/proxy
1620191772:403 : [AAMP-PLAYER]acquireLicense:1184 Request to generate license challenge to the aampDRMSession(CDM)
1620191772:403 : [AAMP-PLAYER]aampGenerateKeyRequest:198: at 0xaed94e20, with 0xaed94da0, 0xaed9bd20
1620191772:403 : [AAMP-PLAYER]destination url is http://widevine-proxy.appspot.com/proxy
1620191772:403 : [AAMP-PLAYER]acquireLicense:1261 Request License from the Drm Server http://widevine-proxy.appspot.com/proxy
1620191772:403 : [AAMP-PLAYER]getLicense:666 Sending license request to server : http://widevine-proxy.appspot.com/proxy
1620191773:713 : [AAMP-PLAYER]HttpRequestEnd: 0,0,200,1.6630,1.6626,0.0001,1.4487,0.0001,0.0001,0.0002,0.0000,177868,324,https://storage.googleapis.com/shaka-demo-assets/angel-one-widevine-hls/v-0240p-0400k-libx264-s2.mp4
1620191773:713 : [AAMP-PLAYER]GetDesiredProfileBasedOnCache currBW:2193558 NwBW=3500779 currProf:3 desiredProf:3
1620191774:214 : [AAMP-PLAYER]GetDesiredProfileBasedOnCache currBW:2193558 NwBW=3500779 currProf:3 desiredProf:3
1620191774:214 : [AAMP-PLAYER]GetDesiredProfileOnSteadyState buffer:8.000000 currProf:3 nwBW:3500779
1620191774:214 : [AAMP-PLAYER]Setting Video timeout to :10000 8.000000
1620191774:214 : [AAMP-PLAYER]Setting Audio timeout to :10000 8.000000
1620191774:714 : [AAMP-PLAYER]GetDesiredProfileBasedOnCache currBW:2193558 NwBW=3500779 currProf:3 desiredProf:3
1620191774:714 : [AAMP-PLAYER]GetDesiredProfileOnSteadyState buffer:8.000000 currProf:3 nwBW:3500779
1620191774:714 : [AAMP-PLAYER]Setting Video timeout to :10000 8.000000
1620191774:714 : [AAMP-PLAYER]Setting Audio timeout to :10000 8.000000
1620191775:136 : [AAMP-PLAYER]getLicense:766 DRM Session Manager Received license data from server; Curl total time  = 2.7
1620191775:136 : [AAMP-PLAYER]getLicense:767 acquireLicense SUCCESS! license request attempt 1; response code : http 200
1620191775:136 : [AAMP-PLAYER]HttpRequestEnd: 1,0,200,2.7330,2.7330,1.5653,1.9726,1.5114,0.0000,1.5654,0.0000,1237,155,http://widevine-proxy.appspot.com/proxy
1620191775:137 : [AAMP-PLAYER]handleLicenseResponse:1347 license acquisition completed


Player level tune initialization and Gstreamer pipeline creation for the playback.

Code Block
languagebash
themeMidnight
1613144307:322 : [AAMP-PLAYER]CreatePipeline(): Creating gstreamer pipeline 1613144307:322
Code Block
languagebash
themeMidnight
1619616814:160 : [AAMP-PLAYER]PrivateStreamAbstractionMPD::Init:4203 - fetch initialization fragments
1619616814:160 : [AAMP-PLAYER][AAMP_JS] SendEventSync(type=14)(state=2)
[AAMPCLI] AAMP_EVENT_STATE_CHANGED: INITIALIZED (2)1619616814:161 : [AAMP-PLAYER][AAMP_JS] SendEventSync(type=14)(state=3)
[AAMPCLI] AAMP_EVENT_STATE_CHANGED: PREPARING (3)1619616814:161 : [AAMP-PLAYER][AAMP_JS] SendEventSync(type=9)
...
1619616814:683 : [AAMP-PLAYER]AAMPGstPlayerPipeline NULL -> READY (pending PAUSED)
1619616814:688buffering_enabled 1 1613144317:586 : [AAMP-PLAYER]Found source for audio
westeros (sink) version 1.01.23
1619616814:705PrivateInstanceAAMP::ConfigureDashParallelFragmentDownload:8112 DASH Paraller Frag DL Config [1] 1613144317:586 : [AAMP-PLAYER]bus_sync_handle: video_dec  0x7533cbd8 type_check 1

(aamp-cli:23893): GLib-GObject-WARNING **: g_object_set_valist: object class 'GstWesterosSink' has no property named 'report_decode_errors'

(aamp-cli:23893): GLib-GObject-WARNING **: ../../glib-2.48.2/gobject/gsignal.c:2517: signal 'buffer-underflow-callback' is invalid for instance '0x7533cbd8' of type 'GstWesterosSink'

(aamp-cli:23893): GLib-GObject-WARNING **: ../../glib-2.48.2/gobject/gsignal.c:2517: signal 'pts-error-callback' is invalid for instance '0x7533cbd8' of type 'GstWesterosSink'

(aamp-cli:23893): GLib-GObject-WARNING **: ../../glib-2.48.2/gobject/gsignal.c:2517: signal 'decode-error-callback' is invalid for instance '0x7533cbd8' of type 'GstWesterosSink'
1619616814:709PrivateInstanceAAMP::ConfigureRetuneForGSTInternalError:8168 GST Internal Stream Error Retune Config [1] 1613144317:586 : [AAMP-PLAYER]Enabling Westeros Sink 1613144317:587 : [AAMP-PLAYER]FOREGROUND PLAYER[0] aamp_tune: attempt: 1 format: HLS URL: http://devimages.apple.com/iphone/samples/bipbop/bipbopall.m3u8


Fragment request start point and fragment decryption; pipeline state change to playing after decrypted data sent to gstreamer.

Code Block
languagebash
themeMidnight
1620191769:864 : [AAMP-PLAYER]fragment injector started. track video
1620191769:864 : [AAMP-PLAYER]TrackState::FetchInitFragment:6836 [audio] first encrypted init-fragment is NULL! fragmentEncrypted-0
1620191769:864 : [AAMP-PLAYER]TrackState::FetchInitFragmentHelper:6996 [video] init-fragment = https://storage.googleapis.com/shaka-demo-assets/angel-one-widevine-hls/v-0240p-0400k-libx264-init.mp4
1620191769:864 : [AAMP-PLAYER]aamp url:2,6,0,0.000000,https://storage.googleapis.com/shaka-demo-assets/angel-one-widevine-hls/v-0240p-0400k-libx264-init.mp4
1620191769:864 : [AAMP-PLAYER]PrivateInstanceAAMP::SendEventAsync:2651 event type  14
[AAMPCLI] type 'help' for list of available commands
[AAMPCLI] aamp-cli> 1620191769:864 : [AAMP-PLAYER]Found source for video
1619616814:711fragment injector started. track audio
1620191769:864 : [AAMP-PLAYER]bus_sync_handler: Received GST_MESSAGE_ASYNC_DONE message
1619616814:712[AAMP_JS] SendEventSync(type=14)(state=4)
...
1620191775:238 : [AAMP-PLAYER]AAMPGstPlayerPipeline READY -> PAUSED (pending VOID_PENDING)
...
16196168151620191775:239 45 : [AAMP-PLAYER][AAMP_JS] SendEventAsync(type=26)
1619616815: 45 : [AAMP-PLAYER]NotifyFirstBufferProcessed:7932 : seek pos 0.000
1619616815: 46 : [AAMP-PLAYER]NotifyFirstBufferProcessed:7932 : seek pos 0.000
1619616815: 46 : [AAMP-PLAYER][AAMP_JS] SendEventSync(type=14)(state=8)
[AAMPCLI] AAMP_EVENT_STATE_CHANGED: PLAYING (8)[AAMPCLI] AAMP_EVENT_TUNED1619616815: 46 : [AAMP-PLAYER]aamp: - sent tune event on Tune Completion.
1619616815: 46 : [AAMP-PLAYER]Querying video decoder for handlemsg type: async-done
westeros-sink: source change event

(aamp-cli:21264): GLib-GObject-WARNING **: g_object_get_valist: object class 'GstWesterosSink' has no property named 'buffered_bytes'
westeros-sink: frame size 320x240

(aamp-cli:21264): GLib-GObject-WARNING **: g_object_get_valist: object class 'GstWesterosSink' has no property named 'buffered_bytes'
sent session info: type 1 sessionId 0 to video server

(aamp-cli:2389321264): GLib-GObject-WARNING **: g_object_get_valist: object class 'GstWesterosSink' has no property named 'videodecoderbuffered_bytes'
16196168151620191775:270 46 : [AAMP-PLAYER]video decoder handle received (nil) for video_dec 0x7533cbd8
[AAMPCLI] AAMP_EVENT_CC_HANDLE_RECEIVED CCHandle=0[AAMPCLI] AAMP_EVENT_PROGRESS
	Duration=900000.000000
	position=0.000000
	start=0.000000
	end=900000.000000
	currRate=1.000000
	BufferedDuration=2000.000000
	PTS=-11619616815: 46 buffering_timeout: Set pipeline state to PLAYING - buffering_timeout_cnt 99  bytes 0  frames 24
1620191775:282 : [AAMP-PLAYER]IdleCallbackbus_sync_handler:629 current 14, periodicProgressCallbackIdleTaskId 15
1619616815: 62Received GST_MESSAGE_ASYNC_DONE message
1620191775:284 : [AAMP-PLAYER]msg type: async-done
16196168151620191775: 62286 : [AAMP-PLAYER]AAMPGstPlayerPipeline PAUSED -> PLAYING (pending VOID_PENDING)

...

Code Block
languagebash
themeMidnight
16196168141620191772:804150 : [AAMP-PLAYER]Sending segment event for mediaType[1]. start 0 stop 18446744073709551615 rate 1.000000 applied_rate 1.000000 mediaType[0]. start 0 stop 18446744073709551615 rate 1.000000 applied_rate 1.000000
1620191772:151 : [AAMP-PLAYER]IsoBmffProcessor::pushInitSegment() 332 [audio] Push init fragment
1620191772:153 : [AAMP-PLAYER]Setting PlayReady as preferred drm
gst_qtdemux_handle_sink_event:2320 - aamp_override - enabled = 0, player = 1, rate  1.000000 
16196168141620191772:805153 : [AAMP-PLAYER]Sending segment event for mediaType[01]. start 0 stop 18446744073709551615 rate 1.000000 applied_rate 1.000000
1619616814:805 : [AAMP-PLAYER]bus_sync_handler: Received GST_MESSAGE_ASYNC_DONE message


Finally tune succeeded and tune time print will have the statistics

...