Versions Compared

Key

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

...

New flash video|Error downloading segment|onPlayStateChanged|DRM Init error|Network down|Segment took too long to download|BufferLevel |Error while parsing media file|onMediaWarning|Event onMediaFailed|onMediaError|onMediaError Event timed out: PLAYERREADY|\"handler\":2\,|type -|XRE<Operator UI App>_NR_STATUS|Skip
onLoadFinished notification, load not finished yet|onXREReadyon<Operator UI App>Ready|state load|aamp play to end|entering AAMPGstPlayer_EndOfStreamReached|GST_MESSAGE_EOS|onMediaEnded|AAMPGstPlayer_OnGstPtsErrorCb|EXT-X-DISCONTINUITY|discontinuous buffer|CURL error|BAD URL|Sending error AAMP|native rec|/lib/rdk/runXRErun<Operator UI App>:
line|RDKBROWSER_RENDER_PROCESS_CRASHED|IP_AAMP_TUNETIME|\"handler\":2\}|Failed to create PlayReady DRM Session|aamp rew to beginning|Could not match URL, not appending eac3|XMLHttpRequest cannot load|AAMPGstPlayerPipeline|drm_Decrypt failed|video tune failed|Power Old State|rdk_xre<Operator UI App>_sleep|XRE<Operator UI App>_NR_EXIT|got
First |AAMPGstPlayer|MyFlashAccessAdapter|Segment doesn't starts with|HangDetector|EXT-X-CUE|onAd|aamp eas manifest detected|ScheduleRetune|Discard ES Type|aamp_tune|\[AAMP_JS\]|WebProcess is unresponsive|video tune aborted|video tune|aamp changing profile|x-reason|RetryHandler|Buffer is running low|Trying
to dispose element|Pipeline is not in playing|NotifyEOS|acquireLicense failed|acquisition failure|eDRM_KEY_ACQUSITION_TIMEOUT|seq gap|aamp warn - bad index|notifying aamp discontinuity|stopping injection|EOS received|AAMPGstPlayer_OnGstBufferUnderflowCb|AAMPGstPlayer::Discontinuity|HTTP RESPONSE
CODE|onAdComplete|onAdStart|onAdProgress|onAdBreakComplete|encrypted to clear|clear to encrypted|AAMPLogNetworkError|AAMPLogABRInfo|AAMPLogNetworkLatency|switching to|seek_pos_seconds|Playback has been stalled|Period ID changed from|_M_range_check|PTS error|CreateDRMSession|Invalid source buffer size
specified|No decoder available for type|aamp_stop|setrate

...

Code Block
languagebash
themeMidnightcollapsetrue
[AAMP-PLAYER] aamp-cli> stop
1615821315:601 : [AAMP-PLAYER]PLAYER[0] aamp_stop PlayerState=8
1615821315:602 : [AAMP-PLAYER]FOREGROUND PLAYER[0] Stopping Playback at Position '18885'.

1615821315:602 : [AAMP-PLAYER][AAMP_JS] SendEventSync(type=14)(state=0)
1615821315:602 : [AAMP-PLAYER]AAMP_EVENT_STATE_CHANGED: 0
1615821315:602 : [AAMP-PLAYER]PrivateInstanceAAMP::BlockUntilGstreamerWantsData interrupted. mDownloadsEnabled:0 mTrackInjectionBlocked:0
1615821315:602 : [AAMP-PLAYER]WaitForCachedFragmentAvailable muxed aborted
1615821315:602 : [AAMP-PLAYER]fragment injector done. track muxed
1615821315:602 : [AAMP-PLAYER]RunFetchLoop:5473: fragment collector done. track muxed
1615821315:602 : [AAMP-PLAYER]StopWaitForPlaylistRefresh:7118 track [muxed]
1615821315:602 : [AAMP-PLAYER]StopWaitForPlaylistRefresh:7118 track [muxed]
1615821315:603 : [AAMP-PLAYER]TeardownStream:4580 mProgressReportFromProcessDiscontinuity:0 mDiscontinuityTuneOperationId:0 newTune:1
1615821315:603 : [AAMP-PLAYER]StopWaitForPlaylistRefresh:7118 track [muxed]
1615821315:603 : [AAMP-PLAYER]StopWaitForPlaylistRefresh:7118 track [muxed]
1615821315:604 : [AAMP-PLAYER]entering AAMPGstPlayer_Stop keepLastFrame 0
1615821315:605 : [AAMP-PLAYER]AAMPGstPlayer::Stop 2703 > Remove periodicProgressCallbackIdleTaskId 12
1615821315:605 : [AAMP-PLAYER]AAMPGstPlayer::DisconnectCallbacks: video_dec  0x724079c8 type_check 1
1615821315:623 : [AAMP-PLAYER]AAMPGstPlayerPipeline PLAYING -> PAUSED (pending NULL)
1615821315:670 : [AAMP-PLAYER]AAMPGstPlayerPipeline PAUSED -> READY (pending NULL)
1615821315:672 : [AAMP-PLAYER]AAMPGstPlayer::Stop: Pipeline state set to null
1615821315:673 : [AAMP-PLAYER]AAMPGstPlayer::TearDownStream: exit mediaType = 0
1615821315:675 : [AAMP-PLAYER]AAMPGstPlayer::TearDownStream: exit mediaType = 1
1615821315:675 : [AAMP-PLAYER]AAMPGstPlayer::TearDownStream: exit mediaType = 2
1615821315:675 : [AAMP-PLAYER]DestroyPipeline(): Destroying gstreamer pipeline
1615821315:676 : [AAMP-PLAYER]exiting AAMPGstPlayer_Stop
[AAMP-PLAYER] aamp-cli> 


...

AAMP Stopping previous playback


Code Block
languagebash
themeMidnight
1613143701:288 : [AAMP-PLAYER]entering AAMPGstPlayer_Stop keepLastFrame 0

...

 1613143701:288 : [AAMP-PLAYER]AAMPGstPlayer::Stop 2546 > Remove periodicProgressCallbackIdleTaskId 15

...

 1613143701:288 : [AAMP-PLAYER]AAMPGstPlayer::DisconnectCallbacks: video_dec

...

 0x708051c0 type_check 1

...

 1613143701:290 : [AAMP-PLAYER]AAMPGstPlayerPipeline PLAYING -> PAUSED (pending NULL)

...

 1613143701:458 : [AAMP-PLAYER]AAMPGstPlayerPipeline PAUSED -> READY (pending NULL)

...

 1613143701:459 : [AAMP-PLAYER]AAMPGstPlayer::Stop: Pipeline state set to null

...

 1613143701:461 : [AAMP-PLAYER]AAMPGstPlayer::TearDownStream: exit mediaType = 0

...

 1613143701:462 : [AAMP-PLAYER]AAMPGstPlayer::TearDownStream: exit mediaType = 1

...

 1613143701:462 : [AAMP-PLAYER]AAMPGstPlayer::TearDownStream: exit mediaType = 2

...

 1613143701:463 : [AAMP-PLAYER]DestroyPipeline(): Destroying gstreamer pipeline

...

 1613143701:463 : [AAMP-PLAYER]exiting AAMPGstPlayer_Stop


New tune request reaching AAMP


Code Block
languagebash
themeMidnight
http://devimages.apple.com/iphone/samples/bipbop/bipbopall.m3u8

...

 1613142994:132 : [AAMP-PLAYER]PrivateInstanceAAMP::ConfigureDashParallelFragmentDownload:8112 DASH Paraller Frag DL Config [1]

...

 1613142994:132 : [AAMP-PLAYER]PrivateInstanceAAMP::ConfigureRetuneForGSTInternalError:8168 GST Internal Stream Error Retune Config [1]

...

 1613142994:132 : [AAMP-PLAYER]Enabling Westeros Sink

...

 1613142994:132 : [AAMP-PLAYER]FOREGROUND PLAYER[0] aamp_tune: attempt: 1 format: HLS URL: http://devimages.apple.com/iphone/samples/bipbop/bipbopall.m3u8

...

 1613142994:132 : [AAMP-PLAYER]TeardownStream:4530 mProgressReportFromProcessDiscontinuity:0 mDiscontinuityTuneOperationId:0 newTune:1

AAMP requesting Manifest


Code Block
languagebash
themeMidnight
1613144318:975 : [AAMP-PLAYER]aamp url:3,9,3,http://devimages.apple.com/iphone/samples/bipbop/gear4/prog_index.m3u8


Manifest response


Code Block
languagebash
themeMidnight
1613144319:842 : [AAMP-PLAYER]HttpRequestEnd: 3,9,200,0.8670,0.8675,0.0001,0.8671,0.0001,0.0001,0.0002,0.0000,7019,286,http://devimages.apple.com/iphone/samples/bipbop/gear4/prog_index.m3u8


Manifest parsing, and the below print indicates duration of the playback


Code Block
languagebash
themeMidnight
1613142996:700 : [AAMP-PLAYER]Found source for video

...

 1613142996:700 : [AAMP-PLAYER]GetGstCaps:443 Unknown format 11

...

 1613142996:705 : [AAMP-PLAYER]bus_sync_handler: Received GST_MESSAGE_ASYNC_DONE message

...

 1613142996:705 : [AAMP-PLAYER]AAMPGstPlayerPipeline READY -> PAUSED (pending VOID_PENDING)

...

 1613142996:705 : [AAMP-PLAYER]TSProcessor[0x1207fa0]reset:2162 - reset video demux 0x11ff758

...

 1613142996:705 : [AAMP-PLAYER]msg type: async-done

...

 1613142996:705 : [AAMP-PLAYER]TSProcessor[0x1207fa0]reset:2168 - reset audio demux 0x12012b8

...

 1613142996:706 : [AAMP-PLAYER]aamp url:0,0,0,http://devimages.apple.com/iphone/samples/bipbop/gear4/fileSequence0.ts


DRM Initialization and Key acquisition

...


Code Block
languagebash
themeMidnight
[AAMPCLI] AAMP_EVENT_STATE_CHANGED: INITIALIZING (1)1619616813:637 : [AAMP-PLAYER]DRM Selected: PlayReady
1619616813:637 : [AAMP-PLAYER]DRM prefs
1619616813:637 : [AAMP-PLAYER]{ 1077efec-c0b2-4d02-ace3-3c1e52e2fb4b, 1 }
1619616813:637 : [AAMP-PLAYER]{ 9a04f079-9840-4286-ab92-e65be0885f95, 4 }
1619616813:637 : [AAMP-PLAYER]{ edef8ba9-79d6-4ace-a3c8-27dcd51d21ed, 2 }

2019 Jun 18 22:25:20.440609 440576 pacexi5 WPEWebProcess[6625]: TheDRMListener: SetMetadata:931: Created new AveDrmManager[763557531d09355a3331750aab7382daeea56725] .TheDRMListener:117 AveDrm[0x193f40]Listner[0x22d818]Track[0].Total Sz=1
2019 Jun 18 22:25:20.463579 pacexi5 runAppManager.sh[5611]: [MyFlashAccessAdapter][0x236c00] Constructor440598 pacexi5 WPEWebProcess[6625]: AveDrm::SetMetaData:365[0x193f40]Track[0] drmState:0
2019 Jun 18 22:25:20.476126 pacexi5 runAppManager.sh[5611]: DRMManager_CreateDRMMetadata calling created source/DRMInterface.cpp440609 pacexi5 WPEWebProcess[6625]: SetMetadata:931: Created new AveDrmManager[763557531d09355a3331750aab7382daeea56725] .Track[0].Total Sz=1
2019 Jun 18 22:25:20.481279 463579 pacexi5 runAppManager.sh[5611]: [Initialize_Stage2MyFlashAccessAdapter][0x236c00] MyFlashAccessAdapter 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.

...


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:688 : [AAMP-PLAYER]Found source for audio
westeros (sink) version 1.01.23
1619616814:705 : [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:709 : [AAMP-PLAYER]Found source for video
1619616814:711 : [AAMP-PLAYER]bus_sync_handler: Received GST_MESSAGE_ASYNC_DONE message
1619616814:712 : [AAMP-PLAYER]AAMPGstPlayerPipeline READY -> PAUSED (pending VOID_PENDING)
...
1619616815: 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 handle

(aamp-cli:23893): GLib-GObject-WARNING **: g_object_get_valist: object class 'GstWesterosSink' has no property named 'videodecoder'
1619616815: 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 : [AAMP-PLAYER]IdleCallback:629 current 14, periodicProgressCallbackIdleTaskId 15
1619616815: 62 : [AAMP-PLAYER]msg type: async-done
1619616815: 62 : [AAMP-PLAYER]AAMPGstPlayerPipeline PAUSED -> PLAYING (pending VOID_PENDING)


To confirm send segment data during tune ( mediaType[0] : Video / mediaType[1] : Audio )

...


Code Block
languagebash
themeMidnight
1619616814:804 : [AAMP-PLAYER]Sending segment event for mediaType[1]. start 0 stop 18446744073709551615 rate 1.000000 applied_rate 1.000000
gst_qtdemux_handle_sink_event:2320 - aamp_override - enabled = 0, player = 1, rate  1.000000 
1619616814:805 : [AAMP-PLAYER]Sending segment event for mediaType[0]. 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


Code Block
languagebash
themeMidnight
1613144321:704 : [AAMP-PLAYER]AAMPGstPlayer_OnFirstVideoFrameCallback. got First Video Frame
1613144321:704 : [AAMP-PLAYER]FOREGROUND PLAYER[0] IP_AAMP_TUNETIME:4,0,1613144317587,4,1383,0,1388,868,0,0,0,0,0,0,0,0,0,0,2306,1644,0,737777,0,0,0,0,2256,0,0,0,0,0,0,0,3991,4117,2,10,1,0,0
1613144321:704 : [AAMP-PLAYER]AAMP=

...

><Operator UI App>: 3895,7147870,0,1387,869,0,167,1383,868,1644,1694,0,1,1801000,0,7147870,7149257,7150126,7150126,7151820,7151987,10,1,0,-1763381592
1613144321:704 : [AAMP-PLAYER]AAMP=

...

><Operator UI App>: 3895,7147870,0,1387,869,0,167,1383,868,1644,1694,0,1,1801000,0,7147870,7149257,7150126,7150126,7151820,7151987,10,1,0,-1763381592
1613144321:704 : [AAMP-PLAYER]Anomaly evt:2 msg:Tune attempt#1. VOD:HLS/Clear URL:http://devimages.apple.com/iphone/samples/bipbop/bipbopall.m3u8
1613144321:704 : [AAMP-PLAYER]PrivateInstanceAAMP::SendEventAsync:2592 event type  26
1613144321:704 : [AAMP-PLAYER][AAMP_JS] SendEventSync(type=26)
1613144321:704 : [AAMP-PLAYER][AAMP_JS] SendEventSync(type=14)(state=8)
1613144321:704 : [AAMP-PLAYER]AAMP_EVENT_STATE_CHANGED: 8
1613144321:704 : [AAMP-PLAYER]AAMP_EVENT_TUNED
1613144321:704 : [AAMP-PLAYER]aamp: - sent tune event on Tune Completion.