This thread has been locked.
If you have a related question, please click the "Ask a related question" button in the top right corner. The newly created question will be automatically linked to this question.
HI Ashwani,
How could i output codec engine and dmai debug infomation in Android?Now ,i am working intergating gstreamer into android.And,i encounter some error.
I tried add
export CE_DEBUG 3
export DMAI_DEBUG 3
in init.rc.
BUT,it is no use...
Thanks!
Best Regards
Hi kelvin,
In OMX to redirect DMAI & CE messages to logcat you must use the logwrapper:
1 - edit init.rc and export the two variables at the top:
export CE_DEBUG=3
export DMAI_DEBUG=2
2 - start the mediaserver service with the logwrapper, e.g.:
service media /system/bin/logwrapper /system/bin/mediaserver
That's it.
and in gstreamer:
export CE_DEBUG=3
export DMAI_DEBUG=2
Thanks, Ashwani. Is that documented somewhere? Would be great to add a link to the doc (or your explanation itself!) to the CE_DEBUG wiki article.
There's already a "usage for WinCE" section, it would be natural to add a "usage for Android" section as well.
Chris
HI Ashwani,
Thanks!The debug info comes!
But i can not find some error.Here is log:
I/dalvikvm( 1043): Jit: resizing JitTable from 4096 to 8192
D/dalvikvm( 1131): GC_EXTERNAL_ALLOC freed 5154 objects / 254008 bytes in 30ms
I/ActivityManager( 1043): Starting activity: Intent { act=android.intent.action.MAIN cat=[android.intent.category.
LAUNCHER] flg=0x10200000 cmp=com.android.music/.MusicBrowserActivity }
I/ActivityManager( 1043): Starting activity: Intent { act=android.intent.action.PICK dat= typ=vnd.android.cursor.d
ir/artistalbum flg=0x4000000 cmp=com.android.music/.ArtistAlbumBrowserActivity (has extras) }
I/AudioService( 1043): Remote Control registerMediaButtonEventReceiver() for ComponentInfo{com.android.music/c
om.android.music.MediaButtonIntentReceiver}
I/ActivityManager( 1043): Displayed activity com.android.music/.ArtistAlbumBrowserActivity: 440 ms (total 495 ms)
I/ActivityManager( 1043): Starting activity: Intent { act=android.intent.action.PICK dat= typ=vnd.android.cursor.d
ir/track cmp=com.android.music/.TrackBrowserActivity (has extras) }
D/dalvikvm( 1043): GREF has increased to 301
V/GstMediaScanner( 1211): MediaScanner extractAlbumArt 51
D/MediaPlayerService( 964): SF does not support mpeg2 Audio formate (.aac) file so play with PV
E/MetadataRetrieverClient( 964): create gst metadata retriever...
V/GstMetadataRetriever( 964): GstMetadataRetriever constructor
V/GstMetadataRetrieverDriver( 964): constructor
V/GstMetadataRetrieverDriver( 964): persist.gst.debug property 0
V/GstMetadataRetrieverDriver( 964): persist.gst.trace property /dev/console
V/GstMetadataRetrieverDriver( 964): route the trace to /dev/console
V/GstMetadataRetrieverDriver( 964): gstreamer init check
V/GstMetadataRetriever( 964): GstMetadataRetriever constructor exit
V/GstMetadataRetriever( 964): GstMetadataRetriever setMode mode=1
V/GstMetadataRetriever( 964): GstMetadataRetriever::setMode video protection already deactivated
V/GstMetadataRetriever( 964): GstMetadataRetriever setDataSource fd=15 offset=0 lenght=1602218
I/GstMetadataRetrieverDriver( 964): create source from fd 15 offset 0 lenght 1602218
V/GstMetadataRetrieverDriver( 964): dup(fd) old 15 new 16
V/GstMetadataRetrieverDriver( 964): create pipeline
V/GstMetadataRetrieverDriver( 964): pipeline creation: pipeline0
V/GstMetadataRetrieverDriver( 964): persist.gst.verbose property = 0
V/GstMetadataRetrieverDriver( 964): prepareSync
0:00:00.016662000 964 WARN typefind gst_type_find_get_extension:706 failed to query peer uri
V/GstMetadataRetrieverDriver( 964): receive GST_MESSAGE_ASYNC_DONE
V/GstMetadataRetriever( 964): GstMetadataRetriever setDataSource OK
V/GstMetadataRetriever( 964): GstMetadataRetriever extractAlbumArt
V/GstMetadataRetrieverDriver( 964): getAlbumArt try to get image from tags
E/MetadataRetrieverClient( 964): failed to extract an album art
V/GstMetadataRetriever( 964): GstMetadataRetriever destructor
V/GstMetadataRetrieverDriver( 964): quit
V/GstMetadataRetrieverDriver( 964): flush bus messages
V/GstMetadataRetrieverDriver( 964): free pipeline pipeline0
V/GstMetadataRetrieverDriver( 964): set pipeline state to NULL: 1 (0:Failure, 1:Success, 2:Async, 3:NO_PREROLL)
V/GstMetadataRetrieverDriver( 964): destructor
V/GstMediaScanner( 1211): MediaScanner extractAlbumArt 51
D/MediaPlayerService( 964): SF does not support mpeg2 Audio formate (.aac) file so play with PV
E/MetadataRetrieverClient( 964): create gst metadata retriever...
V/GstMetadataRetriever( 964): GstMetadataRetriever constructor
V/GstMetadataRetrieverDriver( 964): constructor
V/GstMetadataRetrieverDriver( 964): persist.gst.debug property 0
V/GstMetadataRetrieverDriver( 964): persist.gst.trace property /dev/console
V/GstMetadataRetrieverDriver( 964): route the trace to /dev/console
V/GstMetadataRetrieverDriver( 964): gstreamer init check
V/GstMetadataRetriever( 964): GstMetadataRetriever constructor exit
V/GstMetadataRetriever( 964): GstMetadataRetriever setMode mode=1
V/GstMetadataRetriever( 964): GstMetadataRetriever::setMode video protection already deactivated
V/GstMetadataRetriever( 964): GstMetadataRetriever setDataSource fd=15 offset=0 lenght=1602218
I/GstMetadataRetrieverDriver( 964): create source from fd 15 offset 0 lenght 1602218
V/GstMetadataRetrieverDriver( 964): dup(fd) old 15 new 16
V/GstMetadataRetrieverDriver( 964): create pipeline
V/GstMetadataRetrieverDriver( 964): pipeline creation: pipeline1
V/GstMetadataRetrieverDriver( 964): persist.gst.verbose property = 0
V/GstMetadataRetrieverDriver( 964): prepareSync
0:00:00.010406000 964 WARN typefind gst_type_find_get_extension:706 failed to query peer uri
V/GstMetadataRetrieverDriver( 964): receive GST_MESSAGE_ASYNC_DONE
V/GstMetadataRetriever( 964): GstMetadataRetriever setDataSource OK
V/GstMetadataRetriever( 964): GstMetadataRetriever extractAlbumArt
V/GstMetadataRetrieverDriver( 964): getAlbumArt try to get image from tags
E/MetadataRetrieverClient( 964): failed to extract an album art
V/GstMetadataRetriever( 964): GstMetadataRetriever destructor
V/GstMetadataRetrieverDriver( 964): quit
V/GstMetadataRetrieverDriver( 964): flush bus messages
V/GstMetadataRetrieverDriver( 964): free pipeline pipeline1
V/GstMetadataRetrieverDriver( 964): set pipeline state to NULL: 1 (0:Failure, 1:Success, 2:Async, 3:NO_PREROLL)
V/GstMetadataRetrieverDriver( 964): destructor
D/dalvikvm( 1237): GC_FOR_MALLOC freed 3149 objects / 198216 bytes in 34ms
I/ActivityManager( 1043): Displayed activity com.android.music/.TrackBrowserActivity: 670 ms (total 670 ms)
D/MediaPlayerService( 964): SF does not support mpeg2 Audio formate (.aac) file so play with PV
E/MediaPlayerService( 964): Create GST Player ...
V/GstPlayer( 964): GstPlayer constructor
V/GstDriver( 964): constructor
V/GstDriver( 964): persist.gst.debug property 0
V/GstDriver( 964): persist.gst.trace property /dev/console
V/GstDriver( 964): route the trace to /dev/console
V/GstDriver( 964): gstreamer init check
V/GstPlayer( 964): GstPlayer send GstDriver Setup
V/GstDriver( 964): create playbin2
V/GstDriver( 964): playbin2 creation: playbin25
V/GstDriver( 964): persist.gst.verbose property = 0
V/GstDriver( 964): set up mainloop
V/GstDriver( 964): register bus callback
V/GstDriver( 964): add autovideosink to playbin
E/GstDriver( 964): Can't create autoaudioink
V/GstDriver( 964): add autovideosink to playbin
V/GstDriver( 964): add autoaudioink to playbin
I/GstPlayer( 964): GstPlayer setDataSource(15, 0, 1602218)
I/GstDriver( 964): create source from fd 15 offset 0 lenght 1602218
V/GstDriver( 964): dup(fd) old 15 new 19
E/GstDriver( 964): Pipeline not initialized
V/GstPlayer( 964): GstPlayer prepareAsync
V/GstDriver( 964): prepareAsync
V/GstDriver( 964): nd 0x80405a70 : sd 0x804058b0
V/GstDriver( 964): create and register appsrc callbacks
I/GST-dbg ( 964): 0:00:37.958618000 964 0x942c8 WARN typefind external/gstreamer/plugins/elem
ents/gsttypefindelement.c:706:gst_type_find_get_extension:<typefind> failed to query peer uri
V/GstDriver( 964): enter main loop
V/GstDriver( 964): bus receive message STATE_CHANGED old 1 new 2 pending 3
262967:59:30.941851000 964 WARN typefind gst_type_find_get_extension:706 failed to query peer uri
V/GstDriver( 964): bus receive message STATE_CHANGED
@0,606,140us: [+4 T:0x0000b470 S:0x40305f24] OG - Global_init> This program was built with the following packages:
@0,606,719us: [+4 T:0x0000b470 S:0x40305f24] OG - package gnu.targets.arm.rtsv5T (/home/kelvin/mitnick/DM3730/
ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/gnu/targets/arm/rtsv5T/) [1, 0, 0, 0]
@0,609,039us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.c6accel (/home/kelvin/mitnick/DM3730/ibox/dsp/ti-
dvsdk_dm3730-evm_4_01_00_09/c6accel_1_01_00_02/soc/packages/ti/c6accel/) [1, 0, 0]
@0,609,069us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.codecs.aachedec (/home/kelvin/mitnick/DM3730/
ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/aachedec/) [1, 0, 0]
@0,609,100us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.codecs.deinterlacer (/home/kelvin/mitnick/DM3
730/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/deinterlacer/) [1, 0
, 0]
@0,609,130us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.codecs.g711dec (/home/kelvin/mitnick/DM3730/i
box/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/g711dec/) [1, 0, 0]
@0,609,161us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.codecs.g711enc (/home/kelvin/mitnick/DM3730/i
box/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/g711enc/) [1, 0, 0]
@0,609,191us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.codecs.h264enc (/home/kelvin/mitnick/DM3730/i
box/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/h264enc/) [1, 0, 0]
@0,609,588us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.codecs.jpegdec (/home/kelvin/mitnick/DM3730/i
box/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/jpegdec/) [1, 0, 0]
@0,609,619us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.codecs.jpegenc (/home/kelvin/mitnick/DM3730/i
box/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/jpegenc/) [1, 0, 0]
@0,609,649us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.codecs.mpeg2dec (/home/kelvin/mitnick/DM3730/
ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/mpeg2dec/) [1, 0, 0]
@0,609,680us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.codecs.mpeg4enc (/home/kelvin/mitnick/DM3730/
ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/mpeg4enc/) [1, 0, 0]
@0,609,680us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.linuxutils.sdma (/home/kelvin/mitnick/DM3730/
ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/linuxutils_2_25_05_11/packages/ti/sdo/linuxutils/sdma/) [1, 0, 0]
@0,609,710us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.linuxutils.cmem (/home/kelvin/mitnick/DM3730/
ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/linuxutils_2_25_05_11/packages/ti/sdo/linuxutils/cmem/) [2, 2, 0]
@0,609,741us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.fc.global (/home/kelvin/mitnick/DM3730/ibox/d
sp/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/fc/global/) [1, 0, 0]
@0,945,770us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.fc.scpy (/home/kelvin/mitnick/DM3730/ibox/dsp
/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/fc/scpy/) [1, 0, 0]
@0,945,861us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.ce.global (/home/kelvin/mitnick/DM3730/ibox/d
sp/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/global/) [1, 0, 0]
@0,945,892us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.xdais.dm (/home/kelvin/mitnick/DM3730/ibox/dsp/ti
-dvsdk_dm3730-evm_4_01_00_09/xdais_6_26_00_02/packages/ti/xdais/dm/) [1, 0, 5]
@0,945,892us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.utils.trace (/home/kelvin/mitnick/DM3730/ibox
/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/utils/trace/) [1, 0, 0]
@0,945,922us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.ce.utils.xdm (/home/kelvin/mitnick/DM3730/ibo
x/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/utils/xdm/) [1, 0, 2]
@0,945,953us: [+4 T:0x0000b470 S:0x40305f24] OG - package dsplink.gpp (/home/kelvin/mitnick/DM3730/ibox/dsp/ti
-dvsdk_dm3730-evm_4_01_00_09/dsplink_1_65_00_02/dsplink/gpp/) [5, 0, 0]
@0,945,983us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.bios.power (/home/kelvin/mitnick/DM3730/ibox/dsp/
ti-dvsdk_dm3730-evm_4_01_00_09/local-power-manager_1_24_02_09/packages/ti/bios/power/) [1, 1, 1]
@0,946,014us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.xdais (/home/kelvin/mitnick/DM3730/ibox/dsp/ti-dv
sdk_dm3730-evm_4_01_00_09/xdais_6_26_00_02/packages/ti/xdais/) [1, 2.0, 1]
@0,946,044us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.ce.node (/home/kelvin/mitnick/DM3730/ibox/dsp
/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/node/) [1, 0, 0]
@0,946,075us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.fc.memutils (/home/kelvin/mitnick/DM3730/ibox
/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/fc/memutils/) [1, 0, 0]
@0,946,105us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.fc.utils (/home/kelvin/mitnick/DM3730/ibox/ds
p/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/fc/utils/) [1, 0, 2]
@0,946,105us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.fc.dman3 (/home/kelvin/mitnick/DM3730/ibox/ds
p/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/fc/dman3/) [1, 0, 4]
@0,946,136us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.fc.acpy3 (/home/kelvin/mitnick/DM3730/ibox/ds
p/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/fc/acpy3/) [1, 0, 4]
@0,946,166us: [+4 T:0x0000b470 S:0x40305f24] OG - package gnu.targets (/home/kelvin/mitnick/DM3730/ibox/dsp/ti
-dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/gnu/targets/) [1, 0, 1]
@0,946,197us: [+4 T:0x0000b470 S:0x40305f24] OG - package gnu.targets.arm (/home/kelvin/mitnick/DM3730/ibox/ds
p/ti-dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/gnu/targets/arm/) [1, 0, 0, 0]
@0,946,228us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.catalog.arm (/home/kelvin/mitnick/DM3730/ibox/dsp
/ti-dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/ti/catalog/arm/) [1, 0, 1, 0]
@0,946,258us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.catalog (/home/kelvin/mitnick/DM3730/ibox/dsp/ti-
dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/ti/catalog/) [1, 0, 0]
@0,946,289us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.catalog.c6000 (/home/kelvin/mitnick/DM3730/ibox/d
sp/ti-dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/ti/catalog/c6000/) [1, 0, 0, 0]
@0,946,624us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.platforms.evm3530 (/home/kelvin/mitnick/DM3730/ib
ox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/ti/platforms/evm3530/) [1, 0, 0]
@1,282,043us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.ce.osal (/home/kelvin/mitnick/DM3730/ibox/dsp
/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/osal/) [2, 0, 2]
@1,282,104us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.ce.ipc (/home/kelvin/mitnick/DM3730/ibox/dsp/
ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/ipc/) [2, 0, 1]
@1,282,135us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.ce.osal.linux (/home/kelvin/mitnick/DM3730/ib
ox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/osal/linux/) [2, 0, 1]
@1,282,165us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.ce.ipc.dsplink (/home/kelvin/mitnick/DM3730/i
box/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/ipc/dsplink/) [2, 0, 1]
@1,282,196us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.ce.alg (/home/kelvin/mitnick/DM3730/ibox/dsp/
ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/alg/) [1, 0, 1]
@1,282,226us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.ce (/home/kelvin/mitnick/DM3730/ibox/dsp/ti-d
vsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/) [1, 0, 6]
@1,282,226us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.ce.universal (/home/kelvin/mitnick/DM3730/ibo
x/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/universal/) [1, 0, 0]
@1,282,257us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.c6accel.ce (/home/kelvin/mitnick/DM3730/ibox/dsp/
ti-dvsdk_dm3730-evm_4_01_00_09/c6accel_1_01_00_02/soc/packages/ti/c6accel/ce/) [1, 0, 0]
@1,282,287us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.ce.audio1 (/home/kelvin/mitnick/DM3730/ibox/d
sp/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/audio1/) [1, 0, 1]
@1,282,318us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.codecs.aachedec.ce (/home/kelvin/mitnick/DM37
30/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/aachedec/ce/) [1, 0,
0]
@1,282,348us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.codecs.deinterlacer.ce (/home/kelvin/mitnick/
DM3730/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/deinterlacer/ce/)
[1, 0, 0]
@1,282,379us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.ce.speech1 (/home/kelvin/mitnick/DM3730/ibox/
dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/speech1/) [1, 0, 1]
@1,282,409us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.codecs.g711dec.ce (/home/kelvin/mitnick/DM373
0/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/g711dec/ce/) [1, 0, 0]
@1,282,440us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.codecs.g711enc.ce (/home/kelvin/mitnick/DM373
0/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/g711enc/ce/) [1, 0, 0]
@1,282,470us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.ce.video2 (/home/kelvin/mitnick/DM3730/ibox/d
sp/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/video2/) [1, 0, 2]
@1,282,470us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.codecs.h264dec (/home/kelvin/mitnick/DM3730/i
box/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/h264dec/) []
@1,282,501us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.codecs.h264dec.ce (/home/kelvin/mitnick/DM373
0/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/h264dec/ce/) []
@1,618,164us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.ce.video1 (/home/kelvin/mitnick/DM3730/ibox/d
sp/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/video1/) [1, 0, 2]
@1,618,194us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.codecs.h264enc.ce (/home/kelvin/mitnick/DM373
0/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/h264enc/ce/) [1, 0, 0]
@1,618,225us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.ce.image1 (/home/kelvin/mitnick/DM3730/ibox/d
sp/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/image1/) [1, 0, 1]
@1,618,255us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.codecs.jpegdec.ce (/home/kelvin/mitnick/DM373
0/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/jpegdec/ce/) [1, 0, 0]
@1,618,286us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.codecs.jpegenc.ce (/home/kelvin/mitnick/DM373
0/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/jpegenc/ce/) [1, 0, 0]
@1,618,316us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.codecs.mpeg2dec.ce (/home/kelvin/mitnick/DM37
30/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/mpeg2dec/ce/) [1, 0,
0]
@1,618,835us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.codecs.mpeg4dec (/home/kelvin/mitnick/DM3730/
ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/mpeg4dec/) []
@1,618,865us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.codecs.mpeg4dec.ce (/home/kelvin/mitnick/DM37
30/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/mpeg4dec/ce/) []
@1,618,896us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.codecs.mpeg4enc.ce (/home/kelvin/mitnick/DM37
30/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/mpeg4enc/ce/) [1, 0,
0]
@1,618,927us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.ce.speech (/home/kelvin/mitnick/DM3730/ibox/d
sp/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/speech/) [1, 0, 2]
@1,618,957us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.ce.audio (/home/kelvin/mitnick/DM3730/ibox/ds
p/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/audio/) [1, 0, 2]
@1,618,957us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.ce.video (/home/kelvin/mitnick/DM3730/ibox/ds
p/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/video/) [1, 0, 3]
@1,618,988us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.ce.image (/home/kelvin/mitnick/DM3730/ibox/ds
p/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/image/) [1, 0, 3]
@1,619,018us: [+4 T:0x0000b470 S:0x40305f24] OG - package ti.sdo.dmai (/home/kelvin/mitnick/DM3730/ibox/dsp/ti
-dvsdk_dm3730-evm_4_01_00_09/dmai_2_20_00_14/packages/ti/sdo/dmai/) [1, 0, 0]
@1,619,049us: [+4 T:0x0000b470 S:0x40305f24] OG - package gstticodecplugin_dm3730 (/home/kelvin/mitnick/DM3730
/ibox/dsp/gstreamer-ti/src/gstticodecplugin_dm3730/) []
@1,619,689us: [+0 T:0x0000b470 S:0x40305f24] OG - Global_atexit> enter (fxn=0x81651019)
@1,619,720us: [+0 T:0x0000b470 S:0x40305f24] OG - Global_atexit> enter (fxn=0x81650899)
@1,619,750us: [+0 T:0x0000b470 S:0x40305efc] OM - Memory_alloc> Enter(0x4)
@1,619,781us: [+0 T:0x0000b470 S:0x40305efc] OM - Memory_alloc> return (0xa8180)
@1,620,452us: [+0 T:0x0000b470 S:0x40305f1c] OG - Global_atexit> enter (fxn=0x8164f3e1)
@1,620,483us: [+0 T:0x0000b470 S:0x40305efc] OM - Memory_alloc> Enter(0x4)
@1,620,513us: [+0 T:0x0000b470 S:0x40305efc] OM - Memory_alloc> return (0xa81c0)
@1,620,544us: [+0 T:0x0000b470 S:0x40305f1c] OG - Global_atexit> enter (fxn=0x8164e7f1)
@1,955,810us: [+0 T:0x0000b470 S:0x40305f1c] OG - Global_atexit> enter (fxn=0x81650285)
@1,957,519us: [+0 T:0x0000b470 S:0x40305f14] ti.sdo.ce.osal.Sem - Sem_create> count: 0
@1,957,580us: [+0 T:0x0000b470 S:0x40305efc] OM - Memory_alloc> Enter(0x8)
@1,957,611us: [+0 T:0x0000b470 S:0x40305efc] OM - Memory_alloc> return (0x56ed0)
@1,957,611us: [+0 T:0x0000b470 S:0x40305f14] ti.sdo.ce.osal.Sem - Leaving Sem_create> sem[0x56ed0]
@1,957,641us: [+0 T:0x0000b470 S:0x40305f14] ti.sdo.ce.osal.Sem - Sem_create> count: 0
@1,957,672us: [+0 T:0x0000b470 S:0x40305efc] OM - Memory_alloc> Enter(0x8)
@1,957,702us: [+0 T:0x0000b470 S:0x40305efc] OM - Memory_alloc> return (0x56ee0)
@1,957,733us: [+0 T:0x0000b470 S:0x40305f14] ti.sdo.ce.osal.Sem - Leaving Sem_create> sem[0x56ee0]
@1,957,733us: [+0 T:0x0000b470 S:0x40305efc] OM - Memory_alloc> Enter(0x4)
@1,957,763us: [+0 T:0x0000b470 S:0x40305efc] OM - Memory_alloc> return (0x56ef0)
@1,957,794us: [+0 T:0x0000b470 S:0x40305ef4] OT - Thread_create> Enter (fxn=0x8164dc65, attrs=0x0)
@1,957,824us: [+0 T:0x0000b470 S:0x40305edc] OM - Memory_alloc> Enter(0x58)
@1,957,824us: [+0 T:0x0000b470 S:0x40305edc] OM - Memory_alloc> return (0x58328)
@1,957,977us: [+0 T:0x0000b470 S:0x40305ef4] OT - Thread_create> Exit (task=0x58328)
@1,958,007us: [+0 T:0x0000b470 S:0x40305f14] OG - Global_atexit> enter (fxn=0x8164e239)
@1,958,038us: [+0 T:0x0000b470 S:0x40305f1c] OG - Global_atexit> enter (fxn=0x8164d105)
@1,958,068us: [+0 T:0x0000b470 S:0x40305f24] OG - Global_atexit> enter (fxn=0x8164eb19)
@1,959,930us: [+0 T:0x0000b470 S:0x40305f04] ti.sdo.ce.alg - ALG_init> Enter
@1,959,960us: [+0 T:0x0000b470 S:0x40305f04] ti.sdo.ce.alg - ALG_init> Exit
@1,959,991us: [+0 T:0x0000b470 S:0x40305f24] OG - Global_atexit> enter (fxn=0x8164ace1)
@1,960,021us: [+0 T:0x0000b470 S:0x40305f04] OM - Memory_alloc> Enter(0x4)
@1,960,021us: [+0 T:0x0000b470 S:0x40305f04] OM - Memory_alloc> return (0x584c8)
@1,960,052us: [+0 T:0x0000b470 S:0x40305f24] OG - Global_atexit> enter (fxn=0x81650581)
@1,961,151us: [+6 T:0x0000b470 S:0x40305f14] CE - Engine_init> CE debugging on (CE_DEBUG=3; allowed CE_DEBUG level
s: 1=min, 2=good, 3=max)
@1,961,181us: [+0 T:0x0000b470 S:0x40305f04] OG - Global_atexit> enter (fxn=0x81648a1d)
@1,961,212us: [+0 T:0x0000b470 S:0x40305ee4] OM - Memory_alloc> Enter(0x4)
@1,961,242us: [+0 T:0x0000b470 S:0x40305ee4] OM - Memory_alloc> return (0x5fa00)
@1,961,273us: [+0 T:0x0000b470 S:0x40305ee4] OM - Memory_alloc> Enter(0x4)
@1,961,273us: [+0 T:0x0000b470 S:0x40305ee4] OM - Memory_alloc> return (0x5fa10)
@1,961,303us: [+0 T:0x0000b470 S:0x40305ee4] OM - Memory_alloc> Enter(0x4)
@1,961,334us: [+0 T:0x0000b470 S:0x40305ee4] OM - Memory_alloc> return (0x5fa20)
@1,961,944us: [+0 T:0x0000b470 S:0x40305f24] CS - Server_init()
@1,961,975us: [+0 T:0x0000b470 S:0x40305f24] CS - Server_init> Global_useLinkArbiter = 0
@1,962,005us: [+0 T:0x0000b470 S:0x40305f14] OG - Global_atexit> enter (fxn=0x81646ea5)
@1,963,165us: [+2 T:0x0000b470 S:0x40305f3c] ti.sdo.dmai - [Dmai] Dmai log level set to '2'. Note that calling CER
untime_init after this point may cause unexpected change to DMAI tracing behavior.
@1,971,374us: [+1 T:0x00058388 S:0x40706e6c] OP - daemon> thread created.
@1,971,435us: [+0 T:0x00058388 S:0x40706e54] OP - getCmd_d> Enter (proc=0x40706eac)
@1,971,466us: [+0 T:0x00058388 S:0x40706e34] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x56ed0] timeout[0xfffffff
f]
V/GstDriver( 964): get unhandled message on bus src stream-status
V/GstDriver( 964): get unhandled message on bus src stream-status
D/GstPlayer( 964): [1322], DEBUG audioflinger_wrapper.cpp:74, audioflinger_device_create(): Create AudioTrack s
uccessfully
262967:59:32.403613000 964 WARN playsink element_has_property:894 has volume property, but property is of typ
e gfloat and we expected it to be of type gdouble
I/GST-dbg ( 964): 0:00:39.421051000 964 0xc2f98 WARN playsink external/gst-plugins-base/gst/p
layback/gstplaysink.c:894:element_has_property:<audiosink-actual-sink-audioflinger> has volume property, but prope
rty is of type gfloat and we expected it to be of type gdouble
@2,088,806us: [+0 T:0x00121fc0 S:0x40906d8c] CE - Engine_open> Enter('codecServer', 0x0, 0x40906dd4)
@2,088,897us: [+0 T:0x00121fc0 S:0x40906d74] OM - Memory_alloc> Enter(0x34)
@2,088,928us: [+0 T:0x00121fc0 S:0x40906d74] OM - Memory_alloc> return (0x100348)
@2,088,958us: [+0 T:0x00121fc0 S:0x40906cfc] CE - rserverOpen('/system/ti-dsp/cs.x64P'), count = 0
@2,088,989us: [+0 T:0x00121fc0 S:0x40906cc4] OP - Processor_create> Enter(imageName='/system/ti-dsp/cs.x64P', link
Cfg='(null)', attrs=0x40906d48)
@2,089,294us: [+0 T:0x00121fc0 S:0x40906cac] OM - Memory_alloc> Enter(0x24)
@2,089,324us: [+0 T:0x00121fc0 S:0x40906cac] OM - Memory_alloc> return (0xbe28)
@2,089,355us: [+0 T:0x00121fc0 S:0x40906ca4] OP - doCmd> Enter (cmdId=1, proc=0xbe28)
@2,089,385us: [+0 T:0x00121fc0 S:0x40906c94] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x56ed0]
@2,089,416us: [+0 T:0x00121fc0 S:0x40906c94] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x56ed0]
@2,089,447us: [+0 T:0x00121fc0 S:0x40906c84] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x56ee0] timeout[0xfffffff
f]
@2,089,477us: [+0 T:0x00058388 S:0x40706e34] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x56ed0] status[0]
@2,425,292us: [+0 T:0x00058388 S:0x40706e54] OP - getCmd_d> Exit (result=1)
@2,425,323us: [+0 T:0x00058388 S:0x40706e3c] OP - Processor_create_d> Enter(proc=0xbe28)
@2,425,354us: [+0 T:0x00058388 S:0x40706e1c] ti.sdo.ce.ipc.Power - Power_on> Enter(handle=0xbe44)
@2,425,384us: [+2 T:0x00058388 S:0x40706e1c] ti.sdo.ce.ipc.Power - Power_on> Opening Local Power Manager for the D
SP on /dev/lpm0...
@2,425,445us: [+2 T:0x00058388 S:0x40706e1c] ti.sdo.ce.ipc.Power - Power_on> Turning on DSP power...
@2,425,598us: [+2 T:0x00058388 S:0x40706e1c] ti.sdo.ce.ipc.Power - Power_on> return (0)
@2,425,628us: [+2 T:0x00058388 S:0x40706e3c] OP - Processor_create_d> Initializing DSP PROC...
@2,425,659us: [+2 T:0x00058388 S:0x40706dcc] OP - Processor_create_d> Using DspLink config data for entry #0 [serv
er '/system/ti-dsp/cs.x64P']
@2,425,689us: [+0 T:0x00058388 S:0x40706db4] OM - Memory_alloc> Enter(0x230)
@2,425,720us: [+0 T:0x00058388 S:0x40706db4] OM - Memory_alloc> return (0xfc9c0)
@2,425,750us: [+2 T:0x00058388 S:0x40706dcc] OP - Processor_create_d> Adding DSP segment #0 to Link configuration:
name='DDR2', startAddress=0x87a00000, sizeInBytes=0x600000, shared=1, syncd=0
@2,425,781us: [+2 T:0x00058388 S:0x40706dcc] OP - Processor_create_d> Adding DSP segment #1 to Link configuration:
name='DSPLINKMEM', startAddress=0x85901000, sizeInBytes=0xff000, shared=1, syncd=0
@2,425,811us: [+2 T:0x00058388 S:0x40706dcc] OP - Processor_create_d> Adding DSP segment #2 to Link configuration:
name='RESET_VECTOR', startAddress=0x85900000, sizeInBytes=0x1000, shared=1, syncd=0
@2,425,842us: [+2 T:0x00058388 S:0x40706dcc] OP - Processor_create_d> Adding DSP segment #3 to Link configuration:
name='L4PER', startAddress=0x49000000, sizeInBytes=0x100000, shared=0, syncd=0
@2,425,872us: [+2 T:0x00058388 S:0x40706dcc] OP - Processor_create_d> Adding DSP segment #4 to Link configuration:
name='IRAM', startAddress=0x5c7f8000, sizeInBytes=0x8000, shared=1, syncd=0
@2,425,903us: [+2 T:0x00058388 S:0x40706dcc] OP - Processor_create_d> Adding DSP segment #5 to Link configuration:
name='L1DSRAM', startAddress=0x5cf04000, sizeInBytes=0x10000, shared=1, syncd=0
@2,425,933us: [+2 T:0x00058388 S:0x40706dcc] OP - Processor_create_d> Adding DSP segment #6 to Link configuration:
name='L1PSRAM', startAddress=0x5ce00000, sizeInBytes=0x4000, shared=1, syncd=0
@2,425,964us: [+2 T:0x00058388 S:0x40706dcc] OP - Processor_create_d> Adding DSP segment #7 to Link configuration:
name='DDRALGHEAP', startAddress=0x85a00000, sizeInBytes=0x2000000, shared=0, syncd=0
@2,425,994us: [+2 T:0x00058388 S:0x40706dcc] OP - Processor_create_d> Adding DSP segment #8 to Link configuration:
name='L4CORE', startAddress=0x48000000, sizeInBytes=0x1000000, shared=0, syncd=0
@2,426,025us: [+2 T:0x00058388 S:0x40706dcc] OP - Processor_create_d> Found 'CMEM' entry, adjusting base and size
according to CMEM_getBlock()
@2,426,055us: [+0 T:0x00058388 S:0x40706dcc] OP - Processor_create_d> Setting CMEM base to 0x84700000, size to 0x1
200000
@2,426,086us: [+2 T:0x00058388 S:0x40706dcc] OP - Processor_create_d> Adding DSP segment #9 to Link configuration:
name='CMEM', startAddress=0x84700000, sizeInBytes=0x1200000, shared=0, syncd=0
@2,426,116us: [+2 T:0x00058388 S:0x40706dcc] OP - Processor_create_d> DODSPCTRL was=0; now=0
@2,426,116us: [+3 T:0x00058388 S:0x40706ddc] OP - LINKCFG_Object generated for PROC_setup(0x81677e60) ...
@2,426,147us: [+3 T:0x00058388 S:0x40706ddc] OP - linkCfg->gppObject->
@2,426,177us: [+3 T:0x00058388 S:0x40706ddc] OP - name = "ARM9"
@2,426,208us: [+3 T:0x00058388 S:0x40706ddc] OP - maxMsgqs = 0x82
@2,426,208us: [+3 T:0x00058388 S:0x40706ddc] OP - maxChnlQueue = 0x10
@2,426,239us: [+3 T:0x00058388 S:0x40706ddc] OP - poolTableId = 0xffffffff
@2,761,444us: [+3 T:0x00058388 S:0x40706ddc] OP - numPools = 0x0
@2,761,474us: [+3 T:0x00058388 S:0x40706ddc] OP -
@2,761,505us: [+3 T:0x00058388 S:0x40706ddc] OP - linkCfg->dspConfigs[0]->dspObject->
@2,761,505us: [+3 T:0x00058388 S:0x40706ddc] OP - name = "OMAP3530"
@2,761,535us: [+3 T:0x00058388 S:0x40706ddc] OP - dspArch = 0x2
@2,761,566us: [+3 T:0x00058388 S:0x40706ddc] OP - loaderName = "COFF"
@2,761,596us: [+3 T:0x00058388 S:0x40706ddc] OP - autoStart = FALSE
@2,761,596us: [+3 T:0x00058388 S:0x40706ddc] OP - execName = "DEFAULT.OUT"
@2,761,627us: [+3 T:0x00058388 S:0x40706ddc] OP - doDspCtrl = DSP_BootMode_Boot_NoPwr
@2,761,657us: [+3 T:0x00058388 S:0x40706ddc] OP - resumeAddr = 0x85900020
@2,761,688us: [+3 T:0x00058388 S:0x40706ddc] OP - resetVector = 0x85900000
@2,761,688us: [+3 T:0x00058388 S:0x40706ddc] OP - resetCodeSize = 0x1000
@2,761,718us: [+3 T:0x00058388 S:0x40706ddc] OP - maduSize = 0x1
@2,761,749us: [+3 T:0x00058388 S:0x40706ddc] OP - cpuFreq = 0x6ddd0
@2,761,779us: [+3 T:0x00058388 S:0x40706ddc] OP - endian = 0x3
@2,761,779us: [+3 T:0x00058388 S:0x40706ddc] OP - wordSwap = 0x0
@2,761,810us: [+3 T:0x00058388 S:0x40706ddc] OP - memTableId = 0x0
@2,761,840us: [+3 T:0x00058388 S:0x40706ddc] OP - memEntries = 0xa
@2,761,871us: [+3 T:0x00058388 S:0x40706ddc] OP - linkDrvId = 0x0
@2,761,871us: [+3 T:0x00058388 S:0x40706ddc] OP - arg1 = 0xffffffff
@2,761,901us: [+3 T:0x00058388 S:0x40706ddc] OP - arg2 = 0xffffffff
@2,761,932us: [+3 T:0x00058388 S:0x40706ddc] OP - arg3 = 0x0
@2,761,962us: [+3 T:0x00058388 S:0x40706ddc] OP - arg4 = 0x0
@2,761,962us: [+3 T:0x00058388 S:0x40706ddc] OP - arg5 = 0xffffffff
@2,761,993us: [+3 T:0x00058388 S:0x40706ddc] OP -
@2,762,023us: [+3 T:0x00058388 S:0x40706ddc] OP - linkCfg->dspConfigs[0]->linkDrvObjects->
@2,762,023us: [+3 T:0x00058388 S:0x40706ddc] OP - name = "SHMDRV"
@2,762,054us: [+3 T:0x00058388 S:0x40706ddc] OP - hshkPollCount = 0x989680
@2,762,084us: [+3 T:0x00058388 S:0x40706ddc] OP - memEntry = 0x1
@2,762,115us: [+3 T:0x00058388 S:0x40706ddc] OP - ipsTableId = 0x0
@2,762,115us: [+3 T:0x00058388 S:0x40706ddc] OP - numIpsEntries = 0x1
@2,762,145us: [+3 T:0x00058388 S:0x40706ddc] OP - poolTableId = 0x0
@2,762,176us: [+3 T:0x00058388 S:0x40706ddc] OP - numPools = 0x1
@2,762,207us: [+3 T:0x00058388 S:0x40706ddc] OP - dataTableId = 0x0
@2,762,207us: [+3 T:0x00058388 S:0x40706ddc] OP - numDataDrivers = 0x1
@2,762,237us: [+3 T:0x00058388 S:0x40706ddc] OP - mqtId = 0x0
@2,762,268us: [+3 T:0x00058388 S:0x40706ddc] OP - ringIoTableId = 0x0
@2,762,268us: [+3 T:0x00058388 S:0x40706ddc] OP - mplistTableId = 0x0
@2,762,298us: [+3 T:0x00058388 S:0x40706ddc] OP - mpcsTableId = 0x0
@2,762,329us: [+3 T:0x00058388 S:0x40706ddc] OP -
@2,762,359us: [+3 T:0x00058388 S:0x40706ddc] OP - linkCfg->dspConfigs[0]->memTables[0][i].
@2,762,359us: [+3 T:0x00058388 S:0x40706ddc] OP - entry #0:
@2,762,390us: [+3 T:0x00058388 S:0x40706ddc] OP - entry = 0x0
@2,762,420us: [+3 T:0x00058388 S:0x40706ddc] OP - name = "DDR2"
@2,762,451us: [+3 T:0x00058388 S:0x40706ddc] OP - physAddr = 0x87a00000
@2,762,451us: [+3 T:0x00058388 S:0x40706ddc] OP - dspVirtAddr = 0x87a00000
@2,762,481us: [+3 T:0x00058388 S:0x40706ddc] OP - gppVirtAddr = 0xffffffff
@2,762,512us: [+3 T:0x00058388 S:0x40706ddc] OP - size = 0x600000
@2,762,542us: [+3 T:0x00058388 S:0x40706ddc] OP - shared = TRUE
@2,762,542us: [+3 T:0x00058388 S:0x40706ddc] OP - syncd = FALSE
@2,762,573us: [+3 T:0x00058388 S:0x40706ddc] OP - entry #1:
@2,762,603us: [+3 T:0x00058388 S:0x40706ddc] OP - entry = 0x1
@2,762,634us: [+3 T:0x00058388 S:0x40706ddc] OP - name = "DSPLINKMEM"
@2,762,634us: [+3 T:0x00058388 S:0x40706ddc] OP - physAddr = 0x85901000
@2,762,664us: [+3 T:0x00058388 S:0x40706ddc] OP - dspVirtAddr = 0x85901000
@3,097,595us: [+3 T:0x00058388 S:0x40706ddc] OP - gppVirtAddr = 0xffffffff
@3,097,625us: [+3 T:0x00058388 S:0x40706ddc] OP - size = 0xff000
@3,097,656us: [+3 T:0x00058388 S:0x40706ddc] OP - shared = TRUE
@3,097,686us: [+3 T:0x00058388 S:0x40706ddc] OP - syncd = FALSE
@3,097,717us: [+3 T:0x00058388 S:0x40706ddc] OP - entry #2:
@3,097,717us: [+3 T:0x00058388 S:0x40706ddc] OP - entry = 0x2
@3,097,747us: [+3 T:0x00058388 S:0x40706ddc] OP - name = "RESET_VECTOR"
@3,097,778us: [+3 T:0x00058388 S:0x40706ddc] OP - physAddr = 0x85900000
@3,097,808us: [+3 T:0x00058388 S:0x40706ddc] OP - dspVirtAddr = 0x85900000
@3,097,808us: [+3 T:0x00058388 S:0x40706ddc] OP - gppVirtAddr = 0xffffffff
@3,097,839us: [+3 T:0x00058388 S:0x40706ddc] OP - size = 0x1000
@3,097,869us: [+3 T:0x00058388 S:0x40706ddc] OP - shared = TRUE
@3,097,900us: [+3 T:0x00058388 S:0x40706ddc] OP - syncd = FALSE
@3,097,900us: [+3 T:0x00058388 S:0x40706ddc] OP - entry #3:
@3,097,930us: [+3 T:0x00058388 S:0x40706ddc] OP - entry = 0x3
@3,097,961us: [+3 T:0x00058388 S:0x40706ddc] OP - name = "L4PER"
@3,097,961us: [+3 T:0x00058388 S:0x40706ddc] OP - physAddr = 0x49000000
@3,097,991us: [+3 T:0x00058388 S:0x40706ddc] OP - dspVirtAddr = 0x49000000
@3,098,022us: [+3 T:0x00058388 S:0x40706ddc] OP - gppVirtAddr = 0xffffffff
@3,098,052us: [+3 T:0x00058388 S:0x40706ddc] OP - size = 0x100000
@3,098,052us: [+3 T:0x00058388 S:0x40706ddc] OP - shared = FALSE
@3,098,083us: [+3 T:0x00058388 S:0x40706ddc] OP - syncd = FALSE
@3,098,114us: [+3 T:0x00058388 S:0x40706ddc] OP - entry #4:
@3,098,114us: [+3 T:0x00058388 S:0x40706ddc] OP - entry = 0x4
@3,098,144us: [+3 T:0x00058388 S:0x40706ddc] OP - name = "IRAM"
@3,098,175us: [+3 T:0x00058388 S:0x40706ddc] OP - physAddr = 0x5c7f8000
@3,098,205us: [+3 T:0x00058388 S:0x40706ddc] OP - dspVirtAddr = 0x107f8000
@3,098,205us: [+3 T:0x00058388 S:0x40706ddc] OP - gppVirtAddr = 0xffffffff
@3,098,236us: [+3 T:0x00058388 S:0x40706ddc] OP - size = 0x8000
@3,098,266us: [+3 T:0x00058388 S:0x40706ddc] OP - shared = TRUE
@3,098,297us: [+3 T:0x00058388 S:0x40706ddc] OP - syncd = FALSE
@3,098,297us: [+3 T:0x00058388 S:0x40706ddc] OP - entry #5:
@3,098,327us: [+3 T:0x00058388 S:0x40706ddc] OP - entry = 0x5
@3,098,358us: [+3 T:0x00058388 S:0x40706ddc] OP - name = "L1DSRAM"
@3,098,358us: [+3 T:0x00058388 S:0x40706ddc] OP - physAddr = 0x5cf04000
@3,098,388us: [+3 T:0x00058388 S:0x40706ddc] OP - dspVirtAddr = 0x10f04000
@3,098,419us: [+3 T:0x00058388 S:0x40706ddc] OP - gppVirtAddr = 0xffffffff
@3,098,449us: [+3 T:0x00058388 S:0x40706ddc] OP - size = 0x10000
@3,098,449us: [+3 T:0x00058388 S:0x40706ddc] OP - shared = TRUE
@3,098,480us: [+3 T:0x00058388 S:0x40706ddc] OP - syncd = FALSE
@3,098,510us: [+3 T:0x00058388 S:0x40706ddc] OP - entry #6:
@3,098,510us: [+3 T:0x00058388 S:0x40706ddc] OP - entry = 0x6
@3,098,541us: [+3 T:0x00058388 S:0x40706ddc] OP - name = "L1PSRAM"
@3,098,571us: [+3 T:0x00058388 S:0x40706ddc] OP - physAddr = 0x5ce00000
@3,098,602us: [+3 T:0x00058388 S:0x40706ddc] OP - dspVirtAddr = 0x10e00000
@3,098,602us: [+3 T:0x00058388 S:0x40706ddc] OP - gppVirtAddr = 0xffffffff
@3,098,632us: [+3 T:0x00058388 S:0x40706ddc] OP - size = 0x4000
@3,098,663us: [+3 T:0x00058388 S:0x40706ddc] OP - shared = TRUE
@3,098,693us: [+3 T:0x00058388 S:0x40706ddc] OP - syncd = FALSE
@3,098,693us: [+3 T:0x00058388 S:0x40706ddc] OP - entry #7:
@3,098,724us: [+3 T:0x00058388 S:0x40706ddc] OP - entry = 0x7
@3,098,754us: [+3 T:0x00058388 S:0x40706ddc] OP - name = "DDRALGHEAP"
@3,098,754us: [+3 T:0x00058388 S:0x40706ddc] OP - physAddr = 0x85a00000
@3,098,785us: [+3 T:0x00058388 S:0x40706ddc] OP - dspVirtAddr = 0x85a00000
@3,433,990us: [+3 T:0x00058388 S:0x40706ddc] OP - gppVirtAddr = 0xffffffff
@3,434,020us: [+3 T:0x00058388 S:0x40706ddc] OP - size = 0x2000000
@3,434,020us: [+3 T:0x00058388 S:0x40706ddc] OP - shared = FALSE
@3,434,051us: [+3 T:0x00058388 S:0x40706ddc] OP - syncd = FALSE
@3,434,082us: [+3 T:0x00058388 S:0x40706ddc] OP - entry #8:
@3,434,112us: [+3 T:0x00058388 S:0x40706ddc] OP - entry = 0x8
@3,434,112us: [+3 T:0x00058388 S:0x40706ddc] OP - name = "L4CORE"
@3,434,143us: [+3 T:0x00058388 S:0x40706ddc] OP - physAddr = 0x48000000
@3,434,173us: [+3 T:0x00058388 S:0x40706ddc] OP - dspVirtAddr = 0x48000000
@3,434,204us: [+3 T:0x00058388 S:0x40706ddc] OP - gppVirtAddr = 0xffffffff
@3,434,204us: [+3 T:0x00058388 S:0x40706ddc] OP - size = 0x1000000
@3,434,234us: [+3 T:0x00058388 S:0x40706ddc] OP - shared = FALSE
@3,434,265us: [+3 T:0x00058388 S:0x40706ddc] OP - syncd = FALSE
@3,434,265us: [+3 T:0x00058388 S:0x40706ddc] OP - entry #9:
@3,434,295us: [+3 T:0x00058388 S:0x40706ddc] OP - entry = 0x9
@3,434,326us: [+3 T:0x00058388 S:0x40706ddc] OP - name = "CMEM"
@3,434,356us: [+3 T:0x00058388 S:0x40706ddc] OP - physAddr = 0x84700000
@3,434,356us: [+3 T:0x00058388 S:0x40706ddc] OP - dspVirtAddr = 0x84700000
@3,434,387us: [+3 T:0x00058388 S:0x40706ddc] OP - gppVirtAddr = 0xffffffff
@3,434,417us: [+3 T:0x00058388 S:0x40706ddc] OP - size = 0x1200000
@3,434,448us: [+3 T:0x00058388 S:0x40706ddc] OP - shared = FALSE
@3,434,448us: [+3 T:0x00058388 S:0x40706ddc] OP - syncd = FALSE
@3,434,478us: [+3 T:0x00058388 S:0x40706ddc] OP -
@3,434,509us: [+3 T:0x00058388 S:0x40706ddc] OP - linkCfg->dspConfigs[0]->ipsTables[0][i].
@3,434,539us: [+3 T:0x00058388 S:0x40706ddc] OP - entry #0:
@3,434,539us: [+3 T:0x00058388 S:0x40706ddc] OP - name = "IPS"
@3,434,570us: [+3 T:0x00058388 S:0x40706ddc] OP - numIpsEvents = 0x20
@3,434,600us: [+3 T:0x00058388 S:0x40706ddc] OP - memEntry = 0x1
@3,434,600us: [+3 T:0x00058388 S:0x40706ddc] OP - gppIntId = 0x1a
@3,434,631us: [+3 T:0x00058388 S:0x40706ddc] OP - dspIntId = 0x37
@3,434,661us: [+3 T:0x00058388 S:0x40706ddc] OP - dspIntVectorId = 0x5
@3,434,692us: [+3 T:0x00058388 S:0x40706ddc] OP - arg1 = 0x2faf080
@3,434,692us: [+3 T:0x00058388 S:0x40706ddc] OP - arg2 = 0x0
@3,434,722us: [+3 T:0x00058388 S:0x40706ddc] OP -
@3,434,753us: [+3 T:0x00058388 S:0x40706ddc] OP - linkCfg->dspConfigs[0]->poolTables[0][i].
@3,434,783us: [+3 T:0x00058388 S:0x40706ddc] OP -
@3,434,783us: [+3 T:0x00058388 S:0x40706ddc] OP - linkCfg->dspConfigs[0]->dataTables[0][i].
@3,434,814us: [+3 T:0x00058388 S:0x40706ddc] OP - entry #0:
@3,434,844us: [+3 T:0x00058388 S:0x40706ddc] OP - name = "ZCPYDATA"
@3,434,844us: [+3 T:0x00058388 S:0x40706ddc] OP - baseChnlId = 0x0
@3,434,875us: [+3 T:0x00058388 S:0x40706ddc] OP - numChannels = 0x10
@3,434,906us: [+3 T:0x00058388 S:0x40706ddc] OP - maxBufSize = 0x4000
@3,434,936us: [+3 T:0x00058388 S:0x40706ddc] OP - memEntry = 0x1
@3,434,936us: [+3 T:0x00058388 S:0x40706ddc] OP - poolId = 0x0
@3,434,967us: [+3 T:0x00058388 S:0x40706ddc] OP - queuePerChnl = 0x1
@3,434,997us: [+3 T:0x00058388 S:0x40706ddc] OP - ipsId = 0x0
@3,435,028us: [+3 T:0x00058388 S:0x40706ddc] OP - ipsEventNo = 0x1
@3,435,028us: [+3 T:0x00058388 S:0x40706ddc] OP - arg1 = 0x0
@3,435,058us: [+3 T:0x00058388 S:0x40706ddc] OP - arg2 = 0x0
@3,435,089us: [+3 T:0x00058388 S:0x40706ddc] OP -
@3,435,089us: [+3 T:0x00058388 S:0x40706ddc] OP - linkCfg->dspConfigs[0]->mqtObjects->
@3,435,119us: [+3 T:0x00058388 S:0x40706ddc] OP - name = "ZCPYMQT"
@3,435,150us: [+3 T:0x00058388 S:0x40706ddc] OP - memEntry = 0x1
@3,435,180us: [+3 T:0x00058388 S:0x40706ddc] OP - maxMsgSize = 0xffffffff
@3,435,180us: [+3 T:0x00058388 S:0x40706ddc] OP - ipsId = 0x0
@3,435,211us: [+3 T:0x00058388 S:0x40706ddc] OP - ipsEventNo = 0x0
@3,770,233us: [+3 T:0x00058388 S:0x40706ddc] OP - arg1 = 0x0
@3,770,294us: [+3 T:0x00058388 S:0x40706ddc] OP - arg2 = 0x0
@3,770,324us: [+3 T:0x00058388 S:0x40706ddc] OP -
@3,770,355us: [+3 T:0x00058388 S:0x40706ddc] OP - linkCfg->dspConfigs[0]->ringIoObjects->
@3,770,385us: [+3 T:0x00058388 S:0x40706ddc] OP - name = "RINGIOTABLE"
@3,770,385us: [+3 T:0x00058388 S:0x40706ddc] OP - memEntry = 0x1
@3,770,416us: [+3 T:0x00058388 S:0x40706ddc] OP - maxEntries = 0x40
@3,770,446us: [+3 T:0x00058388 S:0x40706ddc] OP - ipsId = 0x0
@3,770,477us: [+3 T:0x00058388 S:0x40706ddc] OP - ipsEventNo = 0x2
@3,770,477us: [+3 T:0x00058388 S:0x40706ddc] OP -
@3,770,507us: [+3 T:0x00058388 S:0x40706ddc] OP - linkCfg->dspConfigs[0]->mplistObjects->
@3,770,538us: [+3 T:0x00058388 S:0x40706ddc] OP - name = "MPLISTTABLE"
@3,770,538us: [+3 T:0x00058388 S:0x40706ddc] OP - memEntry = 0x1
@3,770,568us: [+3 T:0x00058388 S:0x40706ddc] OP - maxEntries = 0x40
@3,770,599us: [+3 T:0x00058388 S:0x40706ddc] OP - ipsId = 0xffffffff
@3,770,629us: [+3 T:0x00058388 S:0x40706ddc] OP - ipsEventNo = 0xffffffff
@3,770,629us: [+3 T:0x00058388 S:0x40706ddc] OP -
@3,770,660us: [+3 T:0x00058388 S:0x40706ddc] OP - linkCfg->dspConfigs[0]->mpcsObjects->
@3,770,690us: [+3 T:0x00058388 S:0x40706ddc] OP - name = "MPCS"
@3,770,721us: [+3 T:0x00058388 S:0x40706ddc] OP - memEntry = 0x1
@3,770,721us: [+3 T:0x00058388 S:0x40706ddc] OP - maxEntries = 0x100
@3,770,751us: [+3 T:0x00058388 S:0x40706ddc] OP - ipsId = 0xffffffff
@3,770,782us: [+3 T:0x00058388 S:0x40706ddc] OP - ipsEventNo = 0xffffffff
@3,773,284us: [+2 T:0x00058388 S:0x40706e3c] OP - Processor_create_d> Attaching to DSP PROC...
@3,777,191us: [+2 T:0x00058388 S:0x40706e3c] OP - Processor_create_d> Opening MSGQ pool...
@3,777,435us: [+2 T:0x00058388 S:0x40706e3c] OP - Processor_create_d> Loading /system/ti-dsp/cs.x64P on DSP (1 arg
s)...
@4,284,851us: [+2 T:0x00058388 S:0x40706e3c] OP - Processor_create_d> Starting DSP PROC...
@4,303,771us: [+2 T:0x00058388 S:0x40706e3c] OP - Processor_create_d> Opening remote transport...
@4,304,504us: [+0 T:0x00058388 S:0x40706e24] ti.sdo.ce.ipc.Power - Power_connect> Enter (handle=0x100380)
@4,304,565us: [+2 T:0x00058388 S:0x40706e24] ti.sdo.ce.ipc.Power - Power_connect> Calling LPM_connect to connect t
o the DSP power handler...
@4,304,656us: [+0 T:0x00058388 S:0x40706e24] ti.sdo.ce.ipc.Power - Power_connect> return (0)
@4,304,718us: [+2 T:0x00058388 S:0x40706e3c] OP - Processor_create_d> return (1)
@4,304,748us: [+0 T:0x00058388 S:0x40706e5c] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x56ee0]
@4,304,809us: [+0 T:0x00121fc0 S:0x40906c84] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x56ee0] status[0]
@4,304,840us: [+0 T:0x00121fc0 S:0x40906ca4] OP - doCmd> Exit (result=1)
@4,304,870us: [+0 T:0x00121fc0 S:0x40906cc4] OP - Processor_create> return (0xbe28)
@4,304,901us: [+0 T:0x00121fc0 S:0x40906cfc] CE - rserverOpen('/system/ti-dsp/cs.x64P'): 0x81678aa4 done.
@4,304,931us: [+0 T:0x00121fc0 S:0x40906d34] OM - Memory_alloc> Enter(0x29)
@4,304,962us: [+0 T:0x00121fc0 S:0x40906d34] OM - Memory_alloc> return (0x100478)
@4,304,992us: [+0 T:0x00121fc0 S:0x40906d2c] OC - Comm_create> Enter(queueName='codecServer_964_0', queue=0x100358
, attrs=0x0)
@4,305,023us: [+0 T:0x00121fc0 S:0x40906d14] OM - Memory_alloc> Enter(0x4)
@4,305,023us: [+0 T:0x00121fc0 S:0x40906d14] OM - Memory_alloc> return (0x1004a8)
@4,305,328us: [+0 T:0x00121fc0 S:0x40906d2c] OC - Comm_create> return (0x1004a8)
@4,305,358us: [+0 T:0x00121fc0 S:0x40906d2c] OM - Memory_free> Enter(0x100478, 0x29)
@4,305,389us: [+0 T:0x00121fc0 S:0x40906d2c] OM - Memory_free> return (0x1)
@4,305,419us: [+0 T:0x00121fc0 S:0x40906d2c] OC - Comm_alloc> Enter(poolId=0x0, msg=0x100364, size=1592)
@4,305,480us: [+0 T:0x00121fc0 S:0x40906d2c] OC - Comm_alloc> msg=0x40a17880, returning (0)
@4,305,480us: [+0 T:0x00121fc0 S:0x40906d04] OC - Comm_locate> Enter(queueName='rmsq', queue=0x100354)
@4,305,633us: [+0 T:0x00058388 S:0x40706e5c] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x56ee0]
@4,305,725us: [+0 T:0x00058388 S:0x40706e54] OP - getCmd_d> Enter (proc=0x40706eac)
@4,305,725us: [+0 T:0x00058388 S:0x40706e34] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x56ed0] timeout[0xfffffff
f]
@4,305,847us: [+0 T:0x00121fc0 S:0x40906d04] OC - Comm_locate> return (0)
@4,305,877us: [+0 T:0x00121fc0 S:0x40906d24] CE - checkServer(0x100348)
@4,305,908us: [+0 T:0x00121fc0 S:0x40906ccc] OC - Comm_put> Enter(queue=0x0, msg=0x40a17880)
@4,305,969us: [+0 T:0x00121fc0 S:0x40906ccc] OC - Comm_put> return (0)
@4,305,999us: [+0 T:0x00121fc0 S:0x40906cc4] OC - Comm_get> Enter(queue=0x10000, msg=0x40906d44, timeout=-1)
@4,306,091us: [+0 T:0x00121fc0 S:0x40906cc4] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@4,306,121us: [+0 T:0x00121fc0 S:0x40906d4c] CE - rmsInit> RMS initialized(0x100348); CE_DEBUG on, setting DSP tra
ce mask to *+01234567,GT_prefix=12345,GT_time=3
@4,306,152us: [+0 T:0x00121fc0 S:0x40906d24] CE - Engine_setTrace> Enter(engine=0x100348, mask='*+01234567,GT_pref
ix=12345,GT_time=3')
@4,306,243us: [+1 T:0x00121fc0 S:0x40906d24] CE - Engine_setTrace> Requesting DSP set trace ...
@4,306,274us: [+0 T:0x00121fc0 S:0x40906cf4] OC - Comm_put> Enter(queue=0x0, msg=0x40a17880)
@4,306,304us: [+0 T:0x00121fc0 S:0x40906cf4] OC - Comm_put> return (0)
@4,306,335us: [+0 T:0x00121fc0 S:0x40906cec] OC - Comm_get> Enter(queue=0x10000, msg=0x40906d6c, timeout=-1)
@4,308,349us: [+0 T:0x00121fc0 S:0x40906cec] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@4,308,410us: [+0 T:0x00121fc0 S:0x40906d24] CE - Engine_setTrace> return(0)
@4,308,410us: [+4 T:0x00121fc0 S:0x40906d8c] CE - Engine_open> engine->server = 0x81678aa4
@4,308,441us: [+0 T:0x00121fc0 S:0x40906cfc] OC - Comm_put> Enter(queue=0x0, msg=0x40a17880)
@4,308,502us: [+0 T:0x00121fc0 S:0x40906cfc] OC - Comm_put> return (0)
@4,308,532us: [+0 T:0x00121fc0 S:0x40906cf4] OC - Comm_get> Enter(queue=0x10000, msg=0x40906d88, timeout=-1)
@4,308,624us: [+0 T:0x00121fc0 S:0x40906cf4] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
[DSP] @0x000002cc:[T:0x00000000] server - main> Welcome to DSP server's main().
[DSP] @0,008,262tk: [+0 T:0x87c2d334 S:0x87c312a4] OG - Global_setSpecialTrace> enter(mask='*+01234567,GT_prefix=1
2345,GT_time=3')
[DSP] @0,008,341tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - Global_setSpecialTrace> This program was built with the fo
llowing packages:
[DSP] @0,008,404tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.targets.rts6000 (/home/kelvin/mitnick/DM373
0/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/ti/targets/rts6000/) [1, 0, 0, 0]
[DSP] @0,008,501tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.c6accel (/home/kelvin/mitnick/DM3730/ibox/d
sp/ti-dvsdk_dm3730-evm_4_01_00_09/c6accel_1_01_00_02/soc/packages/ti/c6accel/) [1, 0, 0]
[DSP] @0,008,589tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.codecs.aachedec (/home/kelvin/mitnick/D
M3730/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/aachedec/) [1, 0,
0]
[DSP] @0,008,688tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.codecs.deinterlacer (/home/kelvin/mitni
ck/DM3730/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/deinterlacer/)
[1, 0, 0]
[DSP] @0,008,789tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.codecs.g711dec (/home/kelvin/mitnick/DM
3730/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/g711dec/) [1, 0, 0]
[DSP] @0,008,888tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.codecs.g711enc (/home/kelvin/mitnick/DM
3730/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/g711enc/) [1, 0, 0]
[DSP] @0,008,987tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.codecs.h264enc (/home/kelvin/mitnick/DM
3730/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/h264enc/) [1, 0, 0]
[DSP] @0,009,085tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.codecs.jpegdec (/home/kelvin/mitnick/DM
3730/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/jpegdec/) [1, 0, 0]
[DSP] @0,009,183tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.codecs.jpegenc (/home/kelvin/mitnick/DM
3730/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/jpegenc/) [1, 0, 0]
[DSP] @0,009,281tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.codecs.mpeg2dec (/home/kelvin/mitnick/D
M3730/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/mpeg2dec/) [1, 0,
0]
[DSP] @0,009,381tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.codecs.mpeg4enc (/home/kelvin/mitnick/D
M3730/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/mpeg4enc/) [1, 0,
0]
[DSP] @0,009,479tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.fc.global (/home/kelvin/mitnick/DM3730/
ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/fc/global/) [1, 0, 0]
[DSP] @0,009,575tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.utils.trace (/home/kelvin/mitnick/DM373
0/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/utils/trace/) [1, 0, 0]
[DSP] @0,009,674tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.xdais (/home/kelvin/mitnick/DM3730/ibox/dsp
/ti-dvsdk_dm3730-evm_4_01_00_09/xdais_6_26_00_02/packages/ti/xdais/) [1, 2.0, 1]
[DSP] @0,009,759tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.rtdx (/home/kelvin/mitnick/DM3730/ibox/dsp/
ti-dvsdk_dm3730-evm_4_01_00_09/dspbios_5_41_03_17/packages/ti/rtdx/) [2, 0, 0, 5]
[DSP] @0,009,845tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.psl (/home/kelvin/mitnick/DM3730/ibox/dsp/t
i-dvsdk_dm3730-evm_4_01_00_09/dspbios_5_41_03_17/packages/ti/psl/) [5, 0, 0, 0]
[DSP] @0,009,930tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.pmi (/home/kelvin/mitnick/DM3730/ibox/dsp/t
i-dvsdk_dm3730-evm_4_01_00_09/dspbios_5_41_03_17/packages/ti/pmi/) [1, 0, 0, 0]
[DSP] @0,010,016tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.pscl (/home/ke@4,981,933us: [+0 T:0x00121fc
0 S:0x40906cfc] OC - Comm_put> Enter(queue=0x0, msg=0x40a17880)
@4,981,994us: [+0 T:0x00121fc0 S:0x40906cfc] OC - Comm_put> return (0)
@4,982,025us: [+0 T:0x00121fc0 S:0x40906cf4] OC - Comm_get> Enter(queue=0x10000, msg=0x40906d88, timeout=-1)
@4,982,147us: [+0 T:0x00121fc0 S:0x40906cf4] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
lvin/mitnick/DM3730/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/dspbios_5_41_03_17/packages/ti/pscl/) [1, 0, 0, 0]
[DSP] @0,010,119tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.bios (/home/kelvin/mitnick/DM3730/ibox/dsp/
ti-dvsdk_dm3730-evm_4_01_00_09/dspbios_5_41_03_17/packages/ti/bios/) [5, 2, 5, 28]
[DSP] @0,010,206tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.fc.dskt2 (/home/kelvin/mitnick/DM3730/i
box/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/fc/dskt2/) [1, 0, 4]
[DSP] @0,010,302tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.fc.dman3 (/home/kelvin/mitnick/DM3730/i
box/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/fc/dman3/) [1, 0, 4]
[DSP] @0,010,398tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.ce.global (/home/kelvin/mitnick/DM3730/
ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/global/) [1, 0, 0]
[DSP] @0,010,492tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.xdais.dm (/home/kelvin/mitnick/DM3730/ibox/
dsp/ti-dvsdk_dm3730-evm_4_01_00_09/xdais_6_26_00_02/packages/ti/xdais/dm/) [1, 0, 5]
[DSP] @0,010,579tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.ce.utils.xdm (/home/kelvin/mitnick/DM37
30/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/utils/xdm/) [1, 0, 2]
[DSP] @0,010,676tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.ce.node (/home/kelvin/mitnick/DM3730/ib
ox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/node/) [1, 0, 0]
[DSP] @0,010,768tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.ce.ipc.dsplink.dsp (/home/kelvin/mitnic
k/DM3730/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/ipc/dsplink/dsp/) [2,
0, 1]
[DSP] @0,010,868tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.fc.memutils (/home/kelvin/mitnick/DM373
0/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/fc/memutils/) [1, 0, 0]
[DSP] @0,010,966tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.fc.acpy3 (/home/kelvin/mitnick/DM3730/i
box/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/framework-components_2_25_03_07/packages/ti/sdo/fc/acpy3/) [1, 0, 4]
[DSP] @0,011,062tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package dsplink.dsp (/home/kelvin/mitnick/DM3730/ibox/
dsp/ti-dvsdk_dm3730-evm_4_01_00_09/dsplink_1_65_00_02/dsplink/dsp/) [1, 4, 0]
[DSP] @0,011,147tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.bios.utils (/home/kelvin/mitnick/DM3730/ibo
x/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/biosutils_1_02_02/packages/ti/bios/utils/) [2, 0, 2, 02]
[DSP] @0,011,238tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.catalog.c6000 (/home/kelvin/mitnick/DM3730/
ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/ti/catalog/c6000/) [1, 0, 0, 0]
[DSP] @0,011,331tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.catalog (/home/kelvin/mitnick/DM3730/ibox/d
sp/ti-dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/ti/catalog/) [1, 0, 0]
[DSP] @0,011,420tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.catalog.arm (/home/kelvin/mitnick/DM3730/ib
ox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/ti/catalog/arm/) [1, 0, 1, 0]
[DSP] @0,011,512tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.platforms.evm3530 (/home/kelvin/mitnick/DM3
730/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/xdctools_3_16_03_36/packages/ti/platforms/evm3530/) [1, 0, 0]
[DSP] @0,011,607tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.ce.osal (/home/kelvin/mitnick/DM3730/ib
ox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/osal/) [2, 0, 2]
[DSP] @0,011,699tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.ce.osal.bios (/home/kelvin/mitnick/DM37
30/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/osal/bios/) [2, 0, 1]
[DSP] @0,011,795tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.ce.ipc (/home/kelvin/mitnick/DM3730/ibo
x/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packag@5,319,763us: [+0 T:0x00121fc0 S:0x40906cfc] OC
- Comm_put> Enter(queue=0x0, msg=0x40a17880)
@5,319,854us: [+0 T:0x00121fc0 S:0x40906cfc] OC - Comm_put> return (0)
@5,319,885us: [+0 T:0x00121fc0 S:0x40906cf4] OC - Comm_get> Enter(queue=0x10000, msg=0x40906d88, timeout=-1)
@5,320,159us: [+0 T:0x00121fc0 S:0x40906cf4] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
es/ti/sdo/ce/ipc/) [2, 0, 1]
[DSP] @0,011,887tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.ce.ipc.bios (/home/kelvin/mitnick/DM373
0/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/ipc/bios/) [2, 0, 1]
[DSP] @0,011,981tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.ce.alg (/home/kelvin/mitnick/DM3730/ibo
x/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/alg/) [1, 0, 1]
[DSP] @0,012,073tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.ce (/home/kelvin/mitnick/DM3730/ibox/ds
p/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/) [1, 0, 6]
[DSP] @0,012,161tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.ce.bioslog (/home/kelvin/mitnick/DM3730
/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/bioslog/) [1, 0, 1]
[DSP] @0,012,256tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.ce.universal (/home/kelvin/mitnick/DM37
30/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/universal/) [1, 0, 0]
[DSP] @0,012,352tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.c6accel.ce (/home/kelvin/mitnick/DM3730/ibo
x/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/c6accel_1_01_00_02/soc/packages/ti/c6accel/ce/) [1, 0, 0]
[DSP] @0,012,443tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.ce.audio1 (/home/kelvin/mitnick/DM3730/
ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/audio1/) [1, 0, 1]
[DSP] @0,012,537tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.codecs.aachedec.ce (/home/kelvin/mitnic
k/DM3730/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/aachedec/ce/) [
1, 0, 0]
[DSP] @0,012,638tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.codecs.deinterlacer.ce (/home/kelvin/mi
tnick/DM3730/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/deinterlace
r/ce/) [1, 0, 0]
[DSP] @0,012,742tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.ce.speech1 (/home/kelvin/mitnick/DM3730
/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/speech1/) [1, 0, 1]
[DSP] @0,012,837tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.codecs.g711dec.ce (/home/kelvin/mitnick
/DM3730/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/g711dec/ce/) [1,
0, 0]
[DSP] @0,012,938tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.codecs.g711enc.ce (/home/kelvin/mitnick
/DM3730/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/g711enc/ce/) [1,
0, 0]
[DSP] @0,013,039tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.ce.video2 (/home/kelvin/mitnick/DM3730/
ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/video2/) [1, 0, 2]
[DSP] @0,013,132tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.codecs.h264dec (/home/kelvin/mitnick/DM
3730/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/h264dec/) []
[DSP] @0,013,228tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.codecs.h264dec.ce (/home/kelvin/mitnick
/DM3730/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/h264dec/ce/) []
[DSP] @0,013,326tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.ce.video1 (/home/kelvin/mitnick/DM3730/
ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/video1/) [1, 0, 2]
[DSP] @0,013,420tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.codecs.h264enc.ce (/home/kelvin/mitnick
/DM3730/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/h264enc/ce/) [1,
0, 0]
[DSP] @0,013,520tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.ce.image1 (/home/kelvin/mitnick/DM3730/
ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codec-engine_2_26_01_09/packages/ti/sdo/ce/image1/) [1, 0, 1]
[DSP] @0,013,614tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.codecs.jpegdec.ce (/home/kelvin/mitnick
/DM@5,657,775us: [+0 T:0x00121fc0 S:0x40906cfc] OC - Comm_put> Enter(queue=0x0, msg=0x40a17880)
@5,657,836us: [+0 T:0x00121fc0 S:0x40906cfc] OC - Comm_put> return (0)
@5,657,867us: [+0 T:0x00121fc0 S:0x40906cf4] OC - Comm_get> Enter(queue=0x10000, msg=0x40906d88, timeout=-1)
@5,657,989us: [+0 T:0x00121fc0 S:0x40906cf4] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
3730/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/jpegdec/ce/) [1, 0,
0]
[DSP] @0,013,715tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.codecs.jpegenc.ce (/home/kelvin/mitnick
/DM3730/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/jpegenc/ce/) [1,
0, 0]
[DSP] @0,013,816tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.codecs.mpeg2dec.ce (/home/kelvin/mitnic
k/DM3730/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/mpeg2dec/ce/) [
1, 0, 0]
[DSP] @0,013,918tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.codecs.mpeg4dec (/home/kelvin/mitnick/D
M3730/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/mpeg4dec/) []
[DSP] @0,014,014tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.codecs.mpeg4dec.ce (/home/kelvin/mitnic
k/DM3730/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/mpeg4dec/ce/) [
]
[DSP] @0,014,112tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.codecs.mpeg4enc.ce (/home/kelvin/mitnic
k/DM3730/ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/codecs/mpeg4enc/ce/) [
1, 0, 0]
[DSP] @0,014,214tk: [+4 T:0x87c2d334 S:0x87c312a4] OG - package ti.sdo.server.cs (/home/kelvin/mitnick/DM3730/
ibox/dsp/ti-dvsdk_dm3730-evm_4_01_00_09/codecs-omap3530_4_01_00_00/packages/ti/sdo/server/cs/) [1, 0, 0]
[DSP] @0,014,311tk: [+0 T:0x87c2d334 S:0x87c312a4] OG - Global_setSpecialTrace> return
[DSP] @0,015,054tk: [+0 T:0x87c2d334 S:0x87c312f4] CR - processRmsCmd(0x859048a8, 4056): cmd = 5
[DSP] @0,015,125tk: [+0 T:0x87c2d334 S:0x87c312f4] CR - remote time = 0x0, trace buffer size = 4032
[DSP] @2,119,863tk: [+0 T:0x87c2d334 S:0x87c312f4] CR - processRmsCmd(0x859048a8, 4056): cmd = 5
[DSP] @2,119,922tk: [+0 T:0x87c2d334 S:0x87c312f4] CR - remote time = 0x0, trace buffer size = 4032
[DSP] @3,175,691tk: [+0 T:0x87c2d334 S:0x87c312f4] CR - processRmsCmd(0x859048a8, 4056): cmd = 5
[DSP] @3,175,750tk: [+0 T:0x87c2d334 S:0x87c312f4] CR - remote time = 0x0, trace buffer size = 4032
[DSP] @4,231,976tk: [+0 T:0x87c2d334 S:0x87c312f4] CR - processRmsCmd(0x859048a8, 4056): cmd = 5
[DSP] @4,232,033tk: [+0 T:0x87c2d334 S:0x87c312f4] CR - remote time = 0x0, trace buffer size = 4032
@5,995,208us: [+0 T:0x00121fc0 S:0x40906d2c] CE - Engine_fwriteTrace> returning count [14825]
@5,995,269us: [+0 T:0x00121fc0 S:0x40906d34] CE - Engine_initFromServer(0x100348)
@5,995,300us: [+0 T:0x00121fc0 S:0x40906d0c] CE - Engine_getNumServerAlgs(0x100348 0x40906d98)
@5,995,330us: [+0 T:0x00121fc0 S:0x40906cdc] OC - Comm_put> Enter(queue=0x0, msg=0x40a17880)
@5,995,391us: [+0 T:0x00121fc0 S:0x40906cdc] OC - Comm_put> return (0)
@5,995,422us: [+0 T:0x00121fc0 S:0x40906cd4] OC - Comm_get> Enter(queue=0x10000, msg=0x40906d54, timeout=-1)
@5,995,544us: [+0 T:0x00121fc0 S:0x40906cd4] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@5,995,574us: [+0 T:0x00121fc0 S:0x40906d0c] CE - Engine_getNumServerAlgs number of server algs = 12
@5,995,605us: [+0 T:0x00121fc0 S:0x40906d0c] CE - Engine_getNumServerAlgs exit 0
@5,995,635us: [+2 T:0x00121fc0 S:0x40906d34] CE - Engine_initFromServer> Number of remote algs statically configur
ed in engine: 12
@5,995,666us: [+2 T:0x00121fc0 S:0x40906d34] CE - Engine_initFromServer> Number of statically configured remote al
gs = number of server algs: 12
@5,995,697us: [+0 T:0x00121fc0 S:0x40906d34] CE - Engine_initFromServer> Returning 0
@5,995,697us: [+0 T:0x00121fc0 S:0x40906d8c] CE - Engine_open> return(1049416)
@5,997,314us: [+0 T:0x00121fc0 S:0x40906ca4] ti.sdo.ce.audio1.AUDDEC1 - AUDDEC1_create> Enter (engine=0x100348, na
me='aachedec', params=0x40906e30)
@5,997,375us: [+0 T:0x00121fc0 S:0x40906c74] CV - VISA_create(0x100348, 'aachedec', 0x40906e30, 0x488, 'ti.sdo.ce.
audio1.IAUDDEC1')
@5,997,406us: [+0 T:0x00121fc0 S:0x40906b64] CV - VISA_create2(0x100348, 'aachedec', 0x40906e30, 0x10, 0x488, 'ti.
sdo.ce.audio1.IAUDDEC1')
@5,997,436us: [+0 T:0x00121fc0 S:0x40906b4c] OM - Memory_alloc> Enter(0x34)
@5,997,467us: [+0 T:0x00121fc0 S:0x40906b4c] OM - Memory_alloc> return (0x100580)
@5,997,497us: [+0 T:0x00121fc0 S:0x40906b4c] OM - Memory_alloc> Enter(0x4)
@5,997,528us: [+0 T:0x00121fc0 S:0x40906b4c] OM - Memory_alloc> return (0x1005b8)
@5,997,528us: [+0 T:0x00121fc0 S:0x40906b44] OC - Comm_alloc> Enter(poolId=0x0, msg=0x1005b8, size=488)
@5,997,589us: [+0 T:0x00121fc0 S:0x40906b44] OC - Comm_alloc> msg=0x40a18880, returning (0)
@5,997,619us: [+0 T:0x00121fc0 S:0x40906b1c] CE - Engine_createNode(0x100348, 'aachedec', 488, 0x40906e30, 0x10, 0
x40906be4)
@5,997,650us: [+0 T:0x00121fc0 S:0x40906acc] CE - Engine> allocNode Enter(engine=0x100348, impId='aachedec')
@5,997,680us: [+0 T:0x00121fc0 S:0x40906ab4] OM - Memory_alloc> Enter(0x20)
@5,997,711us: [+0 T:0x00121fc0 S:0x40906ab4] OM - Memory_alloc> return (0x100478)
@5,997,741us: [+0 T:0x00121fc0 S:0x40906acc] CE - Engine> allocNode(). Calling (Comm_create(gppfromnode_964_1, 0x1
00480, NULL)
@5,997,772us: [+0 T:0x00121fc0 S:0x40906aac] OC - Comm_create> Enter(queueName='gppfromnode_964_1', queue=0x100480
, attrs=0x0)
@5,997,772us: [+0 T:0x00121fc0 S:0x40906a94] OM - Memory_alloc> Enter(0x4)
@5,997,802us: [+0 T:0x00121fc0 S:0x40906a94] OM - Memory_alloc> return (0x1005c8)
@5,998,229us: [+0 T:0x00121fc0 S:0x40906aac] OC - Comm_create> return (0x1005c8)
@5,998,260us: [+0 T:0x00121fc0 S:0x40906afc] OC - Comm_put> Enter(queue=0x0, msg=0x40a17880)
@5,998,321us: [+0 T:0x00121fc0 S:0x40906afc] OC - Comm_put> return (0)
@5,998,352us: [+0 T:0x00121fc0 S:0x40906af4] OC - Comm_get> Enter(queue=0x10000, msg=0x40906b74, timeout=-1)
@6,333,953us: [+0 T:0x00121fc0 S:0x40906af4] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@6,333,984us: [+0 T:0x00121fc0 S:0x40906afc] OC - Comm_put> Enter(queue=0x0, msg=0x40a17880)
@6,334,045us: [+0 T:0x00121fc0 S:0x40906afc] OC - Comm_put> return (0)
@6,334,075us: [+0 T:0x00121fc0 S:0x40906af4] OC - Comm_get> Enter(queue=0x10000, msg=0x40906b74, timeout=-1)
@6,334,350us: [+0 T:0x00121fc0 S:0x40906af4] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@6,334,381us: [+4 T:0x00121fc0 S:0x40906b1c] CE - Engine_createNode> created node(stdIn=0x2, stdOut=0x10001, msgq=
0x1005c8, algName='aachedec', rmsNode=0x87c31dc8, algHandle=0x87c31eb8)
@6,334,411us: [+0 T:0x00121fc0 S:0x40906a8c] OC - Comm_put> Enter(queue=0x0, msg=0x40a17880)
@6,334,442us: [+0 T:0x00121fc0 S:0x40906a8c] OC - Comm_put> return (0)
@6,334,472us: [+0 T:0x00121fc0 S:0x40906a84] OC - Comm_get> Enter(queue=0x10000, msg=0x40906b18, timeout=-1)
@6,334,747us: [+0 T:0x00121fc0 S:0x40906a84] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
[DSP] @5,286,873tk: [+0 T:0x87c2d334 S:0x87c312f4] CR - processRmsCmd(0x859048a8, 4056): cmd = 17
[DSP] @5,296,033tk: [+0 T:0x87c2d334 S:0x87c312f4] CR - processRmsCmd(0x859048a8, 4056): cmd = 0
[DSP] @5,296,102tk: [+0 T:0x87c2d334 S:0x87c311dc] OM - Memory_alloc> Enter(size=0x18)
[DSP] @5,296,165tk: [+0 T:0x87c2d334 S:0x87c311dc] OM - Memory_alloc> return (0x87c31dc8)
[DSP] @5,296,218tk: [+0 T:0x87c2d334 S:0x87c311dc] OM - Memory_alloc> Enter(size=0xb)
[DSP] @5,296,264tk: [+0 T:0x87c2d334 S:0x87c311dc] OM - Memory_alloc> return (0x87c31de0)
[DSP] @5,296,323tk: [+0 T:0x87c2d334 S:0x87c311a4] OM - Memory_alloc> Enter(size=0x20)
[DSP] @5,296,370tk: [+0 T:0x87c2d334 S:0x87c311a4] OM - Memory_alloc> return (0x87c31df0)
[DSP] @5,296,423tk: [+0 T:0x87c2d334 S:0x87c31174] OM - Memory_alloc> Enter(size=0x24)
[DSP] @5,296,469tk: [+0 T:0x87c2d334 S:0x87c31174] OM - Memory_alloc> return (0x87c31e10)
[DSP] @5,296,564tk: [+0 T:0x87c2d334 S:0x87c3118c] ti.sdo.ce.audio1.AUDDEC1 - AUDDEC1_create> Enter (engine=0x0, n
ame='aachedec', params=0x859048c0)
[DSP] @5,296,649tk: [+0 T:0x87c2d334 S:0x87c31154] CV - VISA_create(0x0, 'aachedec', 0x859048c0, 0x488, 'ti.sdo.ce
.audio1.IAUDDEC1')
[DSP] @5,296,723tk: [+0 T:0x87c2d334 S:0x87c31034] CV - VISA_create2(0x0, 'aachedec', 0x859048c0, 0x10, 0x488, 'ti
.sdo.ce.audio1.IAUDDEC1')
[DSP] @5,296,811tk: [+0 T:0x87c2d334 S:0x87c30fd4] CE - Engine_open> Enter('local', 0x87c31024, 0x1e8)
[DSP] @5,296,870tk: [+0 T:0x87c2d334 S:0x87c30fb4] OM - Memory_alloc> Enter(size=0x34)
[DSP] @5,296,917tk: [+0 T:0x87c2d334 S:0x87c30fb4] OM - Memory_alloc> return (0x87c31e80)
[DSP] @5,296,987tk: [+4 T:0x87c2d334 S:0x87c30fd4] CE - Engine_open> engine->server = 0x0
[DSP] @5,297,037tk: [+0 T:0x87c2d334 S:0x87c30fd4] CE - Engine_open> return(-2017255808)
[DSP] @5,297,115tk: [+0 T:0x87c2d334 S:0x87c31014] OM - Memory_alloc> Enter(size=0x34)
[DSP] @5,297,162tk: [+0 T:0x87c2d334 S:0x87c31014] OM - Memory_alloc> return (0x87c31eb8)
[DSP] @5,297,217tk: [+0 T:0x87c2d334 S:0x87c30fec] ti.sdo.ce.alg.Algorithm - Algorithm_create> Enter(fxns=0x87b484
c4, idma3Fxns=0x0, iresFxns=0x0, params=0x859048c0, attrs=0x87c31138)
[DSP] @5,297,309tk: [+0 T:0x87c2d334 S:0x87c30fcc] OM - Memory_alloc> Enter(size=0x10)
[DSP] @5,297,356tk: [+0 T:0x87c2d334 S:0x87c30fcc] OM - Memory_alloc> return (0x87c31ef0)
[DSP] @5,302,211tk: [+0 T:0x87c2d334 S:0x87c30fec] ti.sdo.ce.alg.Algorithm - Algorithm_create> return (0x87c31ef0)
[DSP] @5,302,308tk: [+5 T:0x87c2d334 S:0x87c31034] CV - VISA_create> local codec created (name='aachedec', handle=
0x87c31ef0)
[DSP] @5,302,383tk: [+0 T:0x87c2d334 S:0x87c3118c] ti.sdo.ce.audio1.AUDDEC1 - AUDDEC1_create> return (0x87c31eb8)
[DSP] @5,302,463tk: [+4 T:0x87c2d334 S:0x87c3114c] OT - Thread_create > name: "aachedec#0", pri: -1, stack size:
18432, stack seg: 0
[DSP] @6,345,265tk: [+0 T:0x87c2d334 S:0x87c312f4] CR - processRmsCmd(0x859048a8, 4056): cmd = 1
[DSP] @6,346,521tk: [+0 T:0x87c2d334 S:0x87c312f4] CR - processRmsCmd(0x859048a8, 4056): cmd = 5
[DSP] @6,346,580tk: [+0 T:0x87c2d334 S:0x87c312f4] CR - remote time = 0x0, trace buffer size = 4032
@6,671,905us: [+0 T:0x00121fc0 S:0x40906abc] CE - Engine_fwriteTrace> returning count [3105]
@6,671,966us: [+2 T:0x00121fc0 S:0x40906b1c] CE - Engine_createNode> Returning 0x100478
@6,671,997us: [+5 T:0x00121fc0 S:0x40906b64] CV - VISA_create> remote codec created (name='aachedec', localQueueID
=0x10001, remoteQueueID=0x0002)
@6,672,027us: [+0 T:0x00121fc0 S:0x40906ca4] ti.sdo.ce.audio1.AUDDEC1 - AUDDEC1_create> return (0x100580)
@6,672,058us: [+0 T:0x00121fc0 S:0x40906c6c] ti.sdo.ce.audio1.AUDDEC1 - AUDDEC1_control> Enter (handle=0x100580, i
d=1, dynParams=0x40906e40 (size=0x8), status=0x40906d20 (size=0xc0)
@6,672,088us: [+4 T:0x00121fc0 S:0x40906c2c] CV - VISA_getMaxMsgSize(0x100580): returning 0x1000
@6,672,119us: [+5 T:0x00121fc0 S:0x40906c2c] CV - VISA_allocMsg> Allocating message for messageId=0x00020000
@6,672,149us: [+0 T:0x00121fc0 S:0x40906c14] CV - VISA_call(visa=0x100580, msg=0x40a18880): messageId=0x00020000,
command=0x1
@6,672,180us: [+0 T:0x00121fc0 S:0x40906bdc] OC - Comm_put> Enter(queue=0x2, msg=0x40a18880)
@6,672,241us: [+0 T:0x00121fc0 S:0x40906bdc] OC - Comm_put> return (0)
@6,672,271us: [+0 T:0x00121fc0 S:0x40906bd4] OC - Comm_get> Enter(queue=0x10001, msg=0x40906c8c, timeout=-1)
@6,672,637us: [+0 T:0x00121fc0 S:0x40906bd4] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@6,672,668us: [+0 T:0x00121fc0 S:0x40906b6c] OC - Comm_put> Enter(queue=0x0, msg=0x40a17880)
@6,672,729us: [+0 T:0x00121fc0 S:0x40906b6c] OC - Comm_put> return (0)
@6,672,729us: [+0 T:0x00121fc0 S:0x40906b64] OC - Comm_get> Enter(queue=0x10000, msg=0x40906bf8, timeout=-1)
@6,673,004us: [+0 T:0x00121fc0 S:0x40906b64] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
[DSP] @7,402,147tk: [+5 T:0x87c322e4 S:0x87c36aac] CN - NODE> 0x87c31df0(aachedec#0) call(algHandle=0x87c31eb8, ms
g=0x85905880); messageId=0x00020000
[DSP] @7,402,245tk: [+0 T:0x87c322e4 S:0x87c3689c] ti.sdo.ce.audio1.AUDDEC1 - AUDDEC1_control> Enter (handle=0x87c
31eb8, id=1, dynParams=0x859058b4 (size=0x8), status=0x859058bc (size=0xc0)
[DSP] @7,402,363tk: [+5 T:0x87c322e4 S:0x87c3687c] CV - VISA_enter(visa=0x87c31eb8): algHandle = 0x87c31ef0
[DSP] @7,402,434tk: [+0 T:0x87c322e4 S:0x87c3685c] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x87c31
ef0)
[DSP] @7,402,507tk: [+0 T:0x87c322e4 S:0x87c3685c] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit
[DSP] @7,402,577tk: [+5 T:0x87c322e4 S:0x87c3687c] CV - VISA_exit(visa=0x87c31eb8): algHandle = 0x87c31ef0
[DSP] @7,402,643tk: [+0 T:0x87c322e4 S:0x87c3685c] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x87c
31ef0)
[DSP] @7,402,709tk: [+0 T:0x87c322e4 S:0x87c3685c] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit
[DSP] @7,402,765tk: [+0 T:0x87c322e4 S:0x87c3689c] ti.sdo.ce.audio1.AUDDEC1 - AUDDEC1_control> Exit (handle=0x87c3
1eb8, retVal=0x0)
[DSP] @7,402,835tk: [+5 T:0x87c322e4 S:0x87c36aac] CN - NODE> returned from call(algHandle=0x87c31eb8, msg=0x85905
880); messageId=0x00020000
[DSP] @7,403,670tk: [+0 T:0x87c2d334 S:0x87c312f4] CR - processRmsCmd(0x859048a8, 4056): cmd = 5
[DSP] @7,403,730tk: [+0 T:0x87c2d334 S:0x87c312f4] CR - remote time = 0x0, trace buffer size = 4032
@6,673,706us: [+0 T:0x00121fc0 S:0x40906b9c] CE - Engine_fwriteTrace> returning count [1471]
@6,673,736us: [+0 T:0x00121fc0 S:0x40906c14] CV - VISA_call Completed: messageId=0x00020000, command=0x1, return(s
tatus=0)
@6,673,767us: [+5 T:0x00121fc0 S:0x40906c1c] CV - VISA_freeMsg(0x100580, 0x40a18880): Freeing message with message
Id=0x00020000
@7,009,399us: [+0 T:0x00121fc0 S:0x40906c6c] ti.sdo.ce.audio1.AUDDEC1 - AUDDEC1_control> Exit (handle=0x100580, re
tVal=0x0)
@7,009,460us: [+0 T:0x00121fc0 S:0x40906c6c] ti.sdo.ce.audio1.AUDDEC1 - AUDDEC1_control> Enter (handle=0x100580, i
d=5, dynParams=0x40906e40 (size=0x8), status=0x40906d20 (size=0xc0)
@7,009,490us: [+4 T:0x00121fc0 S:0x40906c2c] CV - VISA_getMaxMsgSize(0x100580): returning 0x1000
@7,009,521us: [+5 T:0x00121fc0 S:0x40906c2c] CV - VISA_allocMsg> Allocating message for messageId=0x00020001
@7,009,552us: [+0 T:0x00121fc0 S:0x40906c14] CV - VISA_call(visa=0x100580, msg=0x40a18880): messageId=0x00020001,
command=0x1
@7,009,582us: [+0 T:0x00121fc0 S:0x40906bdc] OC - Comm_put> Enter(queue=0x2, msg=0x40a18880)
@7,009,643us: [+0 T:0x00121fc0 S:0x40906bdc] OC - Comm_put> return (0)
@7,009,674us: [+0 T:0x00121fc0 S:0x40906bd4] OC - Comm_get> Enter(queue=0x10001, msg=0x40906c8c, timeout=-1)
@7,010,040us: [+0 T:0x00121fc0 S:0x40906bd4] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@7,010,101us: [+0 T:0x00121fc0 S:0x40906b6c] OC - Comm_put> Enter(queue=0x0, msg=0x40a17880)
@7,010,131us: [+0 T:0x00121fc0 S:0x40906b6c] OC - Comm_put> return (0)
@7,010,223us: [+0 T:0x00121fc0 S:0x40906b64] OC - Comm_get> Enter(queue=0x10000, msg=0x40906bf8, timeout=-1)
@7,010,284us: [+0 T:0x00121fc0 S:0x40906b64] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
[DSP] @8,456,631tk: [+5 T:0x87c322e4 S:0x87c36aac] CN - NODE> 0x87c31df0(aachedec#0) call(algHandle=0x87c31eb8, ms
g=0x85905880); messageId=0x00020001
[DSP] @8,456,724tk: [+0 T:0x87c322e4 S:0x87c3689c] ti.sdo.ce.audio1.AUDDEC1 - AUDDEC1_control> Enter (handle=0x87c
31eb8, id=5, dynParams=0x859058b4 (size=0x8), status=0x859058bc (size=0xc0)
[DSP] @8,456,822tk: [+5 T:0x87c322e4 S:0x87c3687c] CV - VISA_enter(visa=0x87c31eb8): algHandle = 0x87c31ef0
[DSP] @8,456,881tk: [+0 T:0x87c322e4 S:0x87c3685c] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x87c31
ef0)
[DSP] @8,456,941tk: [+0 T:0x87c322e4 S:0x87c3685c] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit
[DSP] @8,456,998tk: [+5 T:0x87c322e4 S:0x87c3687c] CV - VISA_exit(visa=0x87c31eb8): algHandle = 0x87c31ef0
[DSP] @8,457,063tk: [+0 T:0x87c322e4 S:0x87c3685c] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x87c
31ef0)
[DSP] @8,457,126tk: [+0 T:0x87c322e4 S:0x87c3685c] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit
[DSP] @8,457,178tk: [+0 T:0x87c322e4 S:0x87c3689c] ti.sdo.ce.audio1.AUDDEC1 - AUDDEC1_control> Exit (handle=0x87c3
1eb8, retVal=0x0)
[DSP] @8,457,244tk: [+5 T:0x87c322e4 S:0x87c36aac] CN - NODE> returned from call(algHandle=0x87c31eb8, msg=0x85905
880); messageId=0x00020001
[DSP] @8,458,137tk: [+0 T:0x87c2d334 S:0x87c312f4] CR - processRmsCmd(0x859048a8, 4056): cmd = 5
[DSP] @8,458,195tk: [+0 T:0x87c2d334 S:0x87c312f4] CR - remote time = 0x0, trace buffer size = 4032
@7,010,955us: [+0 T:0x00121fc0 S:0x40906b9c] CE - Engine_fwriteTrace> returning count [1471]
@7,010,986us: [+0 T:0x00121fc0 S:0x40906c14] CV - VISA_call Completed: messageId=0x00020001, command=0x1, return(s
tatus=0)
@7,011,016us: [+5 T:0x00121fc0 S:0x40906c1c] CV - VISA_freeMsg(0x100580, 0x40a18880): Freeing message with message
Id=0x00020001
@7,011,047us: [+0 T:0x00121fc0 S:0x40906c6c] ti.sdo.ce.audio1.AUDDEC1 - AUDDEC1_control> Exit (handle=0x100580, re
tVal=0x0)
@7,011,077us: [+2 T:0x00121fc0 S:0x40906cc4] ti.sdo.dmai - [Adec1] Codec requires buffer sizes in 3840 and out 819
2
@7,011,291us: [+0 T:0x00121fc0 S:0x40906d2c] OM - Memory_alloc> Enter(0x1c980)
@7,011,352us: [+0 T:0x00121fc0 S:0x40906cec] OM - Memory_contigAlloc> Enter(size=117120, align=-1, cached=FALSE, h
eap=FALSE)
@7,011,444us: [+4 T:0x00121fc0 S:0x40906cec] OM - Memory_contigAlloc> CMEM_alloc(117120) = 0x40a88000.
@7,011,474us: [+4 T:0x00121fc0 S:0x40906cec] OM - Memory_contigAlloc> CMEM_getPhys(0x40a88000) = 0x84700000.
@7,346,893us: [+1 T:0x00121fc0 S:0x40906ca4] OM - Memory__addContigBuf> Enter(virtAddr=0x40a88000, size=117120, ph
ysAddr=0x84700000)
@7,346,923us: [+1 T:0x00121fc0 S:0x40906ca4] OM - Memory__addContigBuf> creating new contigBuf object
@7,346,954us: [+0 T:0x00121fc0 S:0x40906c8c] OM - Memory_alloc> Enter(0x10)
@7,346,984us: [+0 T:0x00121fc0 S:0x40906c8c] OM - Memory_alloc> return (0x101070)
@7,347,015us: [+1 T:0x00121fc0 S:0x40906ca4] OM - Memory__addContigBuf> returning: cb->phys=0x84700000, cb->size=1
17120, cb->virt=0x40a88000
@7,347,045us: [+0 T:0x00121fc0 S:0x40906cec] OM - Memory_contigAlloc> return (0x40a88000)
@7,347,045us: [+0 T:0x00121fc0 S:0x40906d2c] OM - Memory_alloc> return (0x40a88000)
@7,347,076us: [+0 T:0x00121fc0 S:0x40906d1c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x40a88000, size
=117120)
@7,347,106us: [+1 T:0x00121fc0 S:0x40906cec] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x40a88000, size=1171
20)
@7,347,137us: [+1 T:0x00121fc0 S:0x40906cec] OM - Memory__getPhysicalAddress> found in cb(Sc=0x40a88000, Ec=0x40aa
4980, Ss=0x40a88000, Es=0x40aa4980, PSc=0x84700000)
@7,347,167us: [+1 T:0x00121fc0 S:0x40906cec] OM - Memory__getPhysicalAddress> returning physAddr=0x84700000
@7,347,198us: [+0 T:0x00121fc0 S:0x40906d1c] OM - Memory_getBufferPhysicalAddress> return (0x84700000)
@7,347,229us: [+2 T:0x00121fc0 S:0x40906d44] ti.sdo.dmai - [Buffer] Alloc Buffer of size 117120 at 0x40a88000 (0x8
4700000 phys)
@7,348,052us: [+2 T:0x00121fc0 S:0x40906d5c] ti.sdo.dmai - [BufTab] Allocating BufTab for 2 buffers
@7,348,114us: [+0 T:0x00121fc0 S:0x40906d1c] OM - Memory_alloc> Enter(0x2000)
@7,348,144us: [+0 T:0x00121fc0 S:0x40906cdc] OM - Memory_contigAlloc> Enter(size=8192, align=-1, cached=FALSE, hea
p=FALSE)
@7,348,236us: [+4 T:0x00121fc0 S:0x40906cdc] OM - Memory_contigAlloc> CMEM_alloc(8192) = 0x40aa5000.
@7,348,266us: [+4 T:0x00121fc0 S:0x40906cdc] OM - Memory_contigAlloc> CMEM_getPhys(0x40aa5000) = 0x8471d000.
@7,348,297us: [+1 T:0x00121fc0 S:0x40906c94] OM - Memory__addContigBuf> Enter(virtAddr=0x40aa5000, size=8192, phys
Addr=0x8471d000)
@7,348,327us: [+1 T:0x00121fc0 S:0x40906c94] OM - Memory__addContigBuf> creating new contigBuf object
@7,348,358us: [+0 T:0x00121fc0 S:0x40906c7c] OM - Memory_alloc> Enter(0x10)
@7,348,358us: [+0 T:0x00121fc0 S:0x40906c7c] OM - Memory_alloc> return (0x101668)
@7,348,388us: [+1 T:0x00121fc0 S:0x40906c94] OM - Memory__addContigBuf> returning: cb->phys=0x8471d000, cb->size=8
192, cb->virt=0x40aa5000
@7,348,419us: [+0 T:0x00121fc0 S:0x40906cdc] OM - Memory_contigAlloc> return (0x40aa5000)
@7,348,449us: [+0 T:0x00121fc0 S:0x40906d1c] OM - Memory_alloc> return (0x40aa5000)
@7,348,480us: [+0 T:0x00121fc0 S:0x40906d0c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x40aa5000, size
=8192)
@7,348,510us: [+1 T:0x00121fc0 S:0x40906cdc] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x40aa5000, size=8192
)
@7,348,510us: [+1 T:0x00121fc0 S:0x40906cdc] OM - Memory__getPhysicalAddress> found in cb(Sc=0x40aa5000, Ec=0x40aa
7000, Ss=0x40aa5000, Es=0x40aa7000, PSc=0x8471d000)
@7,348,541us: [+1 T:0x00121fc0 S:0x40906cdc] OM - Memory__getPhysicalAddress> returning physAddr=0x8471d000
@7,348,571us: [+0 T:0x00121fc0 S:0x40906d0c] OM - Memory_getBufferPhysicalAddress> return (0x8471d000)
@7,348,602us: [+2 T:0x00121fc0 S:0x40906d34] ti.sdo.dmai - [Buffer] Alloc Buffer of size 8192 at 0x40aa5000 (0x847
1d000 phys)
@7,348,632us: [+0 T:0x00121fc0 S:0x40906d1c] OM - Memory_alloc> Enter(0x2000)
@7,348,663us: [+0 T:0x00121fc0 S:0x40906cdc] OM - Memory_contigAlloc> Enter(size=8192, align=-1, cached=FALSE, hea
p=FALSE)
@7,348,693us: [+4 T:0x00121fc0 S:0x40906cdc] OM - Memory_contigAlloc> CMEM_alloc(8192) = 0x40aa8000.
@7,348,724us: [+4 T:0x00121fc0 S:0x40906cdc] OM - Memory_contigAlloc> CMEM_getPhys(0x40aa8000) = 0x84720000.
@7,684,387us: [+1 T:0x00121fc0 S:0x40906c94] OM - Memory__addContigBuf> Enter(virtAddr=0x40aa8000, size=8192, phys
Addr=0x84720000)
@7,684,448us: [+1 T:0x00121fc0 S:0x40906c94] OM - Memory__addContigBuf> creating new contigBuf object
@7,684,478us: [+0 T:0x00121fc0 S:0x40906c7c] OM - Memory_alloc> Enter(0x10)
@7,684,478us: [+0 T:0x00121fc0 S:0x40906c7c] OM - Memory_alloc> return (0x1016c0)
@7,684,509us: [+1 T:0x00121fc0 S:0x40906c94] OM - Memory__addContigBuf> returning: cb->phys=0x84720000, cb->size=8
192, cb->virt=0x40aa8000
@7,684,539us: [+0 T:0x00121fc0 S:0x40906cdc] OM - Memory_contigAlloc> return (0x40aa8000)
@7,684,570us: [+0 T:0x00121fc0 S:0x40906d1c] OM - Memory_alloc> return (0x40aa8000)
@7,684,600us: [+0 T:0x00121fc0 S:0x40906d0c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x40aa8000, size
=8192)
@7,684,631us: [+1 T:0x00121fc0 S:0x40906cdc] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x40aa8000, size=8192
)
@7,684,631us: [+1 T:0x00121fc0 S:0x40906cdc] OM - Memory__getPhysicalAddress> found in cb(Sc=0x40aa8000, Ec=0x40aa
a000, Ss=0x40aa8000, Es=0x40aaa000, PSc=0x84720000)
@7,684,661us: [+1 T:0x00121fc0 S:0x40906cdc] OM - Memory__getPhysicalAddress> returning physAddr=0x84720000
@7,684,692us: [+0 T:0x00121fc0 S:0x40906d0c] OM - Memory_getBufferPhysicalAddress> return (0x84720000)
@7,684,722us: [+2 T:0x00121fc0 S:0x40906d34] ti.sdo.dmai - [Buffer] Alloc Buffer of size 8192 at 0x40aa8000 (0x847
20000 phys)
@7,685,119us: [+0 T:0x00121fc0 S:0x40906d9c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x40a88000, size
=4)
@7,685,180us: [+1 T:0x00121fc0 S:0x40906d6c] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x40a88000, size=4)
@7,685,211us: [+1 T:0x00121fc0 S:0x40906d6c] OM - Memory__getPhysicalAddress> found in cb(Sc=0x40a88000, Ec=0x40aa
4980, Ss=0x40a88000, Es=0x40a88004, PSc=0x84700000)
@7,685,241us: [+1 T:0x00121fc0 S:0x40906d6c] OM - Memory__getPhysicalAddress> returning physAddr=0x84700000
@7,685,272us: [+0 T:0x00121fc0 S:0x40906d9c] OM - Memory_getBufferPhysicalAddress> return (0x84700000)
@7,685,272us: [+2 T:0x00121fc0 S:0x40906dc4] ti.sdo.dmai - [Buffer] Set user pointer 0x40a88000 (physical 0x847000
00)
@7,685,424us: [+0 T:0x00121fc0 S:0x40906bf4] ti.sdo.ce.audio1.AUDDEC1 - AUDDEC1_process> Enter (handle=0x100580, i
nBufs=0x40906d54, outBufs=0x40906c90, inArgs=0x40906e38, outArgs=0x40906e18)
@7,685,485us: [+4 T:0x00121fc0 S:0x40906b84] CV - VISA_getMaxMsgSize(0x100580): returning 0x1000
@7,685,485us: [+5 T:0x00121fc0 S:0x40906b84] CV - VISA_allocMsg> Allocating message for messageId=0x00020002
@7,685,546us: [+0 T:0x00121fc0 S:0x40906b6c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x40a88000, size
=3840)
@7,685,546us: [+1 T:0x00121fc0 S:0x40906b3c] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x40a88000, size=3840
)
@7,685,577us: [+1 T:0x00121fc0 S:0x40906b3c] OM - Memory__getPhysicalAddress> found in cb(Sc=0x40a88000, Ec=0x40aa
4980, Ss=0x40a88000, Es=0x40a88f00, PSc=0x84700000)
@7,685,607us: [+1 T:0x00121fc0 S:0x40906b3c] OM - Memory__getPhysicalAddress> returning physAddr=0x84700000
@7,685,638us: [+0 T:0x00121fc0 S:0x40906b6c] OM - Memory_getBufferPhysicalAddress> return (0x84700000)
@7,685,668us: [+0 T:0x00121fc0 S:0x40906b6c] OM - Memory_getBufferPhysicalAddress> Enter(virtAddr=0x40aa5000, size
=8192)
@7,685,699us: [+1 T:0x00121fc0 S:0x40906b3c] OM - Memory__getPhysicalAddress> Enter(virtAddr=0x40aa5000, size=8192
)
@7,685,729us: [+1 T:0x00121fc0 S:0x40906b3c] OM - Memory__getPhysicalAddress> found in cb(Sc=0x40aa5000, Ec=0x40aa
7000, Ss=0x40aa5000, Es=0x40aa7000, PSc=0x8471d000)
@7,685,760us: [+1 T:0x00121fc0 S:0x40906b3c] OM - Memory__getPhysicalAddress> returning physAddr=0x8471d000
@7,685,791us: [+0 T:0x00121fc0 S:0x40906b6c] OM - Memory_getBufferPhysicalAddress> return (0x8471d000)
@8,022,369us: [+0 T:0x00121fc0 S:0x40906b9c] CV - VISA_call(visa=0x100580, msg=0x40a18880): messageId=0x00020002,
command=0x0
@8,022,430us: [+0 T:0x00121fc0 S:0x40906b64] OC - Comm_put> Enter(queue=0x2, msg=0x40a18880)
@8,022,521us: [+0 T:0x00121fc0 S:0x40906b64] OC - Comm_put> return (0)
@8,022,552us: [+0 T:0x00121fc0 S:0x40906b5c] OC - Comm_get> Enter(queue=0x10001, msg=0x40906c0c, timeout=-1)
@8,027,801us: [+0 T:0x00121fc0 S:0x40906b5c] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@8,027,954us: [+0 T:0x00121fc0 S:0x40906af4] OC - Comm_put> Enter(queue=0x0, msg=0x40a17880)
@8,028,045us: [+0 T:0x00121fc0 S:0x40906af4] OC - Comm_put> return (0)
@8,028,076us: [+0 T:0x00121fc0 S:0x40906aec] OC - Comm_get> Enter(queue=0x10000, msg=0x40906b80, timeout=-1)
@8,028,259us: [+0 T:0x00121fc0 S:0x40906aec] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
[DSP] @11,621,995tk: [+5 T:0x87c322e4 S:0x87c36aac] CN - NODE> 0x87c31df0(aachedec#0) call(algHandle=0x87c31eb8, m
sg=0x85905880); messageId=0x00020002
[DSP] @11,622,100tk: [+0 T:0x87c322e4 S:0x87c368dc] OM - Memory_cacheInv> Enter(addr=0x84700000, sizeInBytes=3840)
[DSP] @11,622,168tk: [+0 T:0x87c322e4 S:0x87c368dc] OM - Memory_cacheInv> return
[DSP] @11,622,212tk: [+0 T:0x87c322e4 S:0x87c368dc] OM - Memory_cacheInv> Enter(addr=0x8471d000, sizeInBytes=8192)
[DSP] @11,622,281tk: [+0 T:0x87c322e4 S:0x87c368dc] OM - Memory_cacheInv> return
[DSP] @11,622,331tk: [+0 T:0x87c322e4 S:0x87c3689c] ti.sdo.ce.audio1.AUDDEC1 - AUDDEC1_process> Enter (handle=0x87
c31eb8, inBufs=0x87c36944, outBufs=0x87c36a08, inArgs=0x85905a38, outArgs=0x85905a48)
[DSP] @11,622,439tk: [+5 T:0x87c322e4 S:0x87c3687c] CV - VISA_enter(visa=0x87c31eb8): algHandle = 0x87c31ef0
[DSP] @11,622,499tk: [+0 T:0x87c322e4 S:0x87c3685c] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Enter(alg=0x87c3
1ef0)
[DSP] @11,622,560tk: [+0 T:0x87c322e4 S:0x87c3685c] ti.sdo.ce.alg.Algorithm - Algorithm_activate> Exit
[DSP] @11,636,778tk: [+5 T:0x87c322e4 S:0x87c3687c] CV - VISA_exit(visa=0x87c31eb8): algHandle = 0x87c31ef0
[DSP] @11,637,088tk: [+0 T:0x87c322e4 S:0x87c3685c] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Enter(alg=0x87
c31ef0)
[DSP] @11,637,183tk: [+0 T:0x87c322e4 S:0x87c3685c] ti.sdo.ce.alg.Algorithm - Algorithm_deactivate> Exit
[DSP] @11,637,242tk: [+0 T:0x87c322e4 S:0x87c3689c] ti.sdo.ce.audio1.AUDDEC1 - AUDDEC1_process> Exit (handle=0x87c
31eb8, retVal=0x0)
[DSP] @11,637,337tk: [+0 T:0x87c322e4 S:0x87c368dc] OM - Memory_cacheWb> Enter(addr=0x8471d000, sizeInBytes=8192)
[DSP] @11,637,551tk: [+0 T:0x87c322e4 S:0x87c368dc] OM - Memory_cacheWb> return
[DSP] @11,637,608tk: [+5 T:0x87c322e4 S:0x87c36aac] CN - NODE> returned from call(algHandle=0x87c31eb8, msg=0x8590
5880); messageId=0x00020002
[DSP] @11,639,416tk: [+0 T:0x87c2d334 S:0x87c312f4] CR - processRmsCmd(0x859048a8, 4056): cmd = 5
[DSP] @11,639,489tk: [+0 T:0x87c2d334 S:0x87c312f4] CR - remote time = 0x0, trace buffer size = 4032
@8,029,663us: [+0 T:0x00121fc0 S:0x40906b24] CE - Engine_fwriteTrace> returning count [2078]
@8,029,693us: [+0 T:0x00121fc0 S:0x40906b9c] CV - VISA_call Completed: messageId=0x00020002, command=0x0, return(s
tatus=0)
@8,029,724us: [+5 T:0x00121fc0 S:0x40906b8c] CV - VISA_freeMsg(0x100580, 0x40a18880): Freeing message with message
Id=0x00020002
@8,029,754us: [+0 T:0x00121fc0 S:0x40906bf4] ti.sdo.ce.audio1.AUDDEC1 - AUDDEC1_process> Exit (handle=0x100580, re
tVal=0x0)
@8,029,785us: [+2 T:0x00121fc0 S:0x40906c44] ti.sdo.dmai - [Adec1] AUDDEC1_process() ret 0, consumed 341, created
2048 samples
W/AudioFlinger( 1080): sampleRate() unknown thread 2
W/AudioFlinger( 1080): frameCount() unknown thread 2
W/AudioFlinger( 1080): latency() unknown thread 2
262967:59:38.458483000 964 WARN audioflingersink gst_audioflinger_sink_prepare:447 error: Failed to create Au
dioFlinger for format 3
262967:59:38.459399000 964 WARN TIAuddec1 gst_tiauddec1_chain:816 error: Failed to queue input buffer into ci
rcular buffer
E/AudioFlinger( 1080): unknown output thread
E/AudioTrack( 964): AudioFlinger could not create track, status: -22
D/GstPlayer( 964): [1323], DEBUG audioflinger_wrapper.cpp:125, audioflinger_device_set(): Set AudioTrack, statu
s: -22, streamType: 3, sampleRate: 48000, channelCount: 1, bufferCount: 4800
@8,066,131us: [+2 T:0x00121fc0 S:0x40906d7c] ti.sdo.dmai - [Buffer] Free Buffer of size 117120 at 0x40a88000 (0x84
700000 phys)
@8,405,975us: [+0 T:0x00121fc0 S:0x40906d5c] OM - Memory_free> Enter(0x40a88000, 0x1c980)
@8,406,036us: [+0 T:0x00121fc0 S:0x40906d24] OM - Memory_contigFree> Enter(addr=1084784640, size=117120)
@8,406,066us: [+1 T:0x00121fc0 S:0x40906cfc] OM - Memory__removeContigBuf> Enter(virtAddr=0x40a88000, size=117120)
@8,406,097us: [+1 T:0x00121fc0 S:0x40906cfc] OM - Memory__removeContigBuf> removing cb->phys=0x84700000, cb->size=
0x1c980, cb->virt=0x40a88000
@8,406,127us: [+0 T:0x00121fc0 S:0x40906cdc] OM - Memory_free> Enter(0x101070, 0x10)
@8,406,158us: [+0 T:0x00121fc0 S:0x40906cdc] OM - Memory_free> return (0x1)
@8,406,341us: [+0 T:0x00121fc0 S:0x40906d24] OM - Memory_contigFree> return (0x1)
@8,406,372us: [+0 T:0x00121fc0 S:0x40906d5c] OM - Memory_free> return (0x1)
@8,406,433us: [+2 T:0x00121fc0 S:0x40906d3c] ti.sdo.dmai - [Buffer] Free Buffer of size 8192 at 0x40aa5000 (0x8471
d000 phys)
@8,406,463us: [+0 T:0x00121fc0 S:0x40906d1c] OM - Memory_free> Enter(0x40aa5000, 0x2000)
@8,406,494us: [+0 T:0x00121fc0 S:0x40906ce4] OM - Memory_contigFree> Enter(addr=1084903424, size=8192)
@8,406,524us: [+1 T:0x00121fc0 S:0x40906cbc] OM - Memory__removeContigBuf> Enter(virtAddr=0x40aa5000, size=8192)
@8,406,555us: [+1 T:0x00121fc0 S:0x40906cbc] OM - Memory__removeContigBuf> removing cb->phys=0x8471d000, cb->size=
0x2000, cb->virt=0x40aa5000
@8,406,585us: [+0 T:0x00121fc0 S:0x40906c9c] OM - Memory_free> Enter(0x101668, 0x10)
@8,406,616us: [+0 T:0x00121fc0 S:0x40906c9c] OM - Memory_free> return (0x1)
@8,406,677us: [+0 T:0x00121fc0 S:0x40906ce4] OM - Memory_contigFree> return (0x1)
@8,406,707us: [+0 T:0x00121fc0 S:0x40906d1c] OM - Memory_free> return (0x1)
@8,406,707us: [+2 T:0x00121fc0 S:0x40906d3c] ti.sdo.dmai - [Buffer] Free Buffer of size 8192 at 0x40aa8000 (0x8472
0000 phys)
@8,406,738us: [+0 T:0x00121fc0 S:0x40906d1c] OM - Memory_free> Enter(0x40aa8000, 0x2000)
@8,406,768us: [+0 T:0x00121fc0 S:0x40906ce4] OM - Memory_contigFree> Enter(addr=1084915712, size=8192)
@8,406,829us: [+1 T:0x00121fc0 S:0x40906cbc] OM - Memory__removeContigBuf> Enter(virtAddr=0x40aa8000, size=8192)
@8,406,860us: [+1 T:0x00121fc0 S:0x40906cbc] OM - Memory__removeContigBuf> removing cb->phys=0x84720000, cb->size=
0x2000, cb->virt=0x40aa8000
@8,406,890us: [+0 T:0x00121fc0 S:0x40906c9c] OM - Memory_free> Enter(0x1016c0, 0x10)
@8,406,921us: [+0 T:0x00121fc0 S:0x40906c9c] OM - Memory_free> return (0x1)
@8,406,951us: [+0 T:0x00121fc0 S:0x40906ce4] OM - Memory_contigFree> return (0x1)
@8,406,982us: [+0 T:0x00121fc0 S:0x40906d1c] OM - Memory_free> return (0x1)
@8,407,043us: [+0 T:0x00121fc0 S:0x40906de4] ti.sdo.ce.audio1.AUDDEC1 - AUDDEC1_delete> Enter (handle=0x100580)
@8,407,073us: [+0 T:0x00121fc0 S:0x40906dc4] CV - VISA_delete(0x100580)
@8,407,073us: [+5 T:0x00121fc0 S:0x40906dc4] CV - VISA_delete> deleting codec (localQueue=0x10001, remoteQueue=0x2
)
@8,407,104us: [+0 T:0x00121fc0 S:0x40906d9c] CE - Engine_ctrlNode(0x100478, 0x1005b8, 0x0)
@8,407,135us: [+0 T:0x00121fc0 S:0x40906d7c] OC - Comm_put> Enter(queue=0x2, msg=0x40a18880)
@8,407,196us: [+0 T:0x00121fc0 S:0x40906d7c] OC - Comm_put> return (0)
@8,407,287us: [+0 T:0x00121fc0 S:0x40906d74] OC - Comm_get> Enter(queue=0x10001, msg=0x1005b8, timeout=-1)
@8,407,440us: [+0 T:0x00121fc0 S:0x40906d74] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@8,407,470us: [+0 T:0x00121fc0 S:0x40906d9c] CE - Engine_ctrlNode> Returning 0x0
@8,407,501us: [+0 T:0x00121fc0 S:0x40906d84] CE - Engine_deleteNode(0x100478)
@8,407,531us: [+0 T:0x00121fc0 S:0x40906d64] OC - Comm_put> Enter(queue=0x0, msg=0x40a17880)
@8,407,562us: [+0 T:0x00121fc0 S:0x40906d64] OC - Comm_put> return (0)
@8,407,592us: [+0 T:0x00121fc0 S:0x40906d5c] OC - Comm_get> Enter(queue=0x10000, msg=0x40906ddc, timeout=-1)
@8,745,544us: [+0 T:0x00121fc0 S:0x40906d5c] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
@8,745,635us: [+5 T:0x00121fc0 S:0x40906d84] CE - Engine_deleteNode(0x100478): algName = aachedec, algHandle = 0x8
7c31eb8, stack size = 18432, stack used = 5159(28%)
@8,745,666us: [+0 T:0x00121fc0 S:0x40906d5c] OC - Comm_delete> Enter (comm=0x1005c8)
@8,746,032us: [+0 T:0x00121fc0 S:0x40906d3c] OM - Memory_free> Enter(0x1005c8, 0x4)
@8,746,093us: [+0 T:0x00121fc0 S:0x40906d3c] OM - Memory_free> return (0x1)
@8,746,124us: [+0 T:0x00121fc0 S:0x40906d5c] OC - Comm_delete> return
@8,746,154us: [+0 T:0x00121fc0 S:0x40906d5c] OM - Memory_free> Enter(0x100478, 0x20)
@8,746,154us: [+0 T:0x00121fc0 S:0x40906d5c] OM - Memory_free> return (0x1)
@8,746,185us: [+0 T:0x00121fc0 S:0x40906db4] OC - Comm_free> Enter (msg=0x40a18880)
@8,746,246us: [+0 T:0x00121fc0 S:0x40906db4] OC - Comm_free> return (0)
@8,746,276us: [+0 T:0x00121fc0 S:0x40906da4] OM - Memory_free> Enter(0x1005b8, 0x4)
@8,746,307us: [+0 T:0x00121fc0 S:0x40906da4] OM - Memory_free> return (0x1)
@8,746,307us: [+0 T:0x00121fc0 S:0x40906da4] OM - Memory_free> Enter(0x100580, 0x34)
@8,746,337us: [+0 T:0x00121fc0 S:0x40906da4] OM - Memory_free> return (0x1)
@8,746,368us: [+0 T:0x00121fc0 S:0x40906de4] ti.sdo.ce.audio1.AUDDEC1 - AUDDEC1_delete> return
@8,746,398us: [+0 T:0x00121fc0 S:0x40906df4] CE - Engine_close(0x100348)
@8,746,429us: [+0 T:0x00121fc0 S:0x40906d64] OC - Comm_put> Enter(queue=0x0, msg=0x40a17880)
@8,746,520us: [+0 T:0x00121fc0 S:0x40906d64] OC - Comm_put> return (0)
@8,746,551us: [+0 T:0x00121fc0 S:0x40906d5c] OC - Comm_get> Enter(queue=0x10000, msg=0x40906df0, timeout=-1)
E/GstPlayer( 964): xuzhi.Tony : audioflinger_device_set :status return ERROR
I/GST-dbg ( 964): 0:00:45.476135000 964 0x1007d0 WARN audioflingersink external/gst-android/gstplayer/
sink/audioflingersink/gstaudioflingersink.c:447:gst_audioflinger_sink_prepare:<audiosink-actual-sink-audioflinger>
error: Failed to create AudioFlinger for format 3
E/GstDriver( 964): bus receive message ERROR 13: Could not get/set settings from/on resource. from external/gst-a
ndroid/gstplayer/sink/audioflingersink/gstaudioflingersink.c(447): gst_audioflinger_sink_prepare (): /GstPlayBin2:
playbin25/GstPlaySink:playsink5/GstBin:abin/GstAutoAudioSink:audiosink/GstAudioFlingerSink:audiosink-actual-sink-a
udioflinger:
E/GstDriver( 964): Failed to create AudioFlinger for format 3
I/GST-dbg ( 964): 0:00:45.477020000 964 0xc2f98 WARN TIAuddec1 gsttiauddec1.c:816:gst_tiauddec
1_chain:<tiauddec10> error: Failed to queue input buffer into circular buffer
I/GST-dbg ( 964):
E/MediaPlayer( 1237): error (0, 0)
E/GstDriver( 964): bus receive message ERROR 10: Failed to queue input buffer into circular buffer
E/GstDriver( 964): from gsttiauddec1.c(816): gst_tiauddec1_chain (): /GstPlayBin2:playbin25/GstURIDecodeBin:urid
ecodebin7/GstDecodeBin2:decodebin27/GstTIAuddec1:tiauddec10
E/MediaPlayer( 1237): error (0, 0)
V/GstDriver( 964): playbin25: structure name=playbin2-stream-changed
I/AudioService( 1043): AudioFocus requestAudioFocus() from android.media.AudioManager@440ad270com.android.music.
MediaPlaybackService$3@440ac3d8
I/AudioService( 1043): Remote Control registerMediaButtonEventReceiver() for ComponentInfo{com.android.music/c
om.android.music.MediaButtonIntentReceiver}
E/MediaPlayer( 1237): Attempt to call getDuration without a valid mediaplayer
E/MediaPlayer( 1237): error (-38, 0)
E/MediaPlayer( 1237): start called in state 0
E/MediaPlayer( 1237): error (-38, 0)
@8,747,985us: [+0 T:0x00121fc0 S:0x40906d5c] OC - Comm_get> MSGQ_get() status=0x8000, return (0)
[DSP] @12,824,338tk: [+0 T:0x87c322e4 S:0x87c36aac] CN - NODE_EXECFXN(0x87c31df0): aachedec#0 exiting per request
...
[DSP] @12,825,397tk: [+0 T:0x87c2d334 S:0x87c312f4] CR - processRmsCmd(0x859048a8, 4056): cmd = 2
[DSP] @12,825,988tk: [+0 T:0x87c2d334 S:0x87c312ac] CN - NODE_delete(0x87c31df0): aachedec#0
[DSP] @12,826,092tk: [+0 T:0x87c2d334 S:0x87c3128c] ti.sdo.ce.audio1.AUDDEC1 - AUDDEC1_delete> Enter (handle=0x87c
31eb8)
[DSP] @12,826,164tk: [+0 T:0x87c2d334 S:0x87c3125c] CV - VISA_delete(0x87c31eb8)
[DSP] @12,826,218tk: [+5 T:0x87c2d334 S:0x87c3125c] CV - VISA_delete> deleting codec (localQueue=0xffff, remoteQue
ue=0xffff)
[DSP] @12,826,281tk: [+5 T:0x87c2d334 S:0x87c3125c] CV - VISA_delete> deleting codec 0x87c31ef0
[DSP] @12,826,338tk: [+0 T:0x87c2d334 S:0x87c3123c] ti.sdo.ce.alg.Algorithm - Algorithm_delete> Enter(alg=0x87c31e
f0)
[DSP] @12,826,451tk: [+0 T:0x87c2d334 S:0x87c3120c] OM - Memory_free> Enter(addr=0x87c31ef0, size=16)
[DSP] @12,826,512tk: [+0 T:0x87c2d334 S:0x87c3120c] OM - Memory_free> return (0x1)
[DSP] @12,826,558tk: [+0 T:0x87c2d334 S:0x87c3123c] ti.sdo.ce.alg.Algorithm - Algorithm_delete> Exit
[DSP] @12,826,617tk: [+0 T:0x87c2d334 S:0x87c3122c] OM - Memory_free> Enter(addr=0x87c31eb8, size=52)
[DSP] @12,826,672tk: [+0 T:0x87c2d334 S:0x87c3122c] OM - Memory_free> return (0x1)
[DSP] @12,826,717tk: [+0 T:0x87c2d334 S:0x87c3128c] ti.sdo.ce.audio1.AUDDEC1 - AUDDEC1_delete> return
[DSP] @12,826,774tk: [+0 T:0x87c2d334 S:0x87c31274] OM - Memory_free> Enter(addr=0x87c31e10, size=36)
[DSP] @12,826,830tk: [+0 T:0x87c2d334 S:0x87c31274] OM - Memory_free> return (0x1)
[DSP] @12,826,875tk: [+0 T:0x87c2d334 S:0x87c3127c] OM - Memory_free> Enter(addr=0x87c31df0, size=32)
[DSP] @12,826,931tk: [+0 T:0x87c2d334 S:0x87c3127c] OM - Memory_free> return (0x1)
[DSP] @12,826,976tk: [+0 T:0x87c2d334 S:0x87c312a4] OM - Memory_free> Enter(addr=0x87c31de0, size=11)
[DSP] @12,827,032tk: [+0 T:0x87c2d334 S:0x87c312a4] OM - Memory_free> return (0x1)
[DSP] @12,827,079tk: [+0 T:0x87c2d334 S:0x87c312a4] OM - Memory_free> Enter(addr=0x87c31dc8, size=24)
[DSP] @12,827,135tk: [+0 T:0x87c2d334 S:0x87c312a4] OM - Memory_free> return (0x1)
[DSP] @13,884,652tk: [+0 T:0x87c2d334 S:0x87c312f4] CR - processRmsCmd(0x859048a8, 4056): cmd = 5
[DSP] @13,884,718tk: [+0 T:0x87c2d334 S:0x87c312f4] CR - remote time = 0x0, trace buffer size = 4032
@9,085,357us: [+0 T:0x00121fc0 S:0x40906d94] CE - Engine_fwriteTrace> returning count [2362]
@9,085,418us: [+0 T:0x00121fc0 S:0x40906dd4] CS - Server_disconnectTrace('0x100348', 0x0)
@9,085,418us: [+0 T:0x00121fc0 S:0x40906dd4] CS - Server_disconnectTrace> return(0)
@9,085,449us: [+0 T:0x00121fc0 S:0x40906de4] OC - Comm_free> Enter (msg=0x40a17880)
@9,085,510us: [+0 T:0x00121fc0 S:0x40906de4] OC - Comm_free> return (0)
@9,085,540us: [+0 T:0x00121fc0 S:0x40906dd4] OC - Comm_delete> Enter (comm=0x1004a8)
@9,085,815us: [+0 T:0x00121fc0 S:0x40906db4] OM - Memory_free> Enter(0x1004a8, 0x4)
@9,085,876us: [+0 T:0x00121fc0 S:0x40906db4] OM - Memory_free> return (0x1)
@9,085,906us: [+0 T:0x00121fc0 S:0x40906dd4] OC - Comm_delete> return
@9,085,937us: [+0 T:0x00121fc0 S:0x40906de4] OC - Comm_release> Enter(queue=0x0)
@9,085,968us: [+0 T:0x00121fc0 S:0x40906de4] OC - Comm_release> return (0)
@9,085,998us: [+0 T:0x00121fc0 S:0x40906dd4] CE - rserverClose(0x81678aa4), count = 1
@9,085,998us: [+0 T:0x00121fc0 S:0x40906dc4] OP - Processor_delete> Enter(proc=0xbe28)
@9,086,029us: [+0 T:0x00121fc0 S:0x40906da4] OP - doCmd> Enter (cmdId=2, proc=0xbe28)
@9,086,059us: [+0 T:0x00121fc0 S:0x40906d94] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x56ed0]
@9,086,090us: [+0 T:0x00121fc0 S:0x40906d94] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x56ed0]
@9,086,120us: [+0 T:0x00121fc0 S:0x40906d84] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x56ee0] timeout[0xfffffff
f]
0:00:00.029328000 964 WARN typefind gst_type_find_get_extension:706 failed to query peer uri
I/ActivityManager( 1043): Starting activity: Intent { act=com.android.music.PLAYBACK_VIEWER flg=0x4000000 cmp=com.
android.music/.MediaPlaybackActivity }
E/MediaPlayer( 1237): Error (0,0)
D/MultiPlayer( 1237): Error: 0,0
E/MediaPlayer( 1237): Error (-38,0)
D/MultiPlayer( 1237): Error: -38,0
E/MediaPlayer( 1237): Error (-38,0)
D/MultiPlayer( 1237): Error: -38,0
E/MediaPlayer( 1237): Attempt to call getDuration without a valid mediaplayer
E/MediaPlayer( 1237): error (-38, 0)
V/GstMediaScanner( 1211): MediaScanner extractAlbumArt 53
D/MediaPlayerService( 964): SF does not support mpeg2 Audio formate (.aac) file so play with PV
E/MetadataRetrieverClient( 964): create gst metadata retriever...
V/GstMetadataRetriever( 964): GstMetadataRetriever constructor
V/GstMetadataRetrieverDriver( 964): constructor
V/GstMetadataRetrieverDriver( 964): persist.gst.debug property 0
V/GstMetadataRetrieverDriver( 964): persist.gst.trace property /dev/console
V/GstMetadataRetrieverDriver( 964): route the trace to /dev/console
V/GstMetadataRetrieverDriver( 964): gstreamer init check
V/GstMetadataRetriever( 964): GstMetadataRetriever constructor exit
V/GstMetadataRetriever( 964): GstMetadataRetriever setMode mode=1
V/GstMetadataRetriever( 964): GstMetadataRetriever::setMode video protection already deactivated
V/GstMetadataRetriever( 964): GstMetadataRetriever setDataSource fd=27 offset=0 lenght=1602218
I/GstMetadataRetrieverDriver( 964): create source from fd 27 offset 0 lenght 1602218
V/GstMetadataRetrieverDriver( 964): dup(fd) old 27 new 28
V/GstMetadataRetrieverDriver( 964): create pipeline
V/GstMetadataRetrieverDriver( 964): pipeline creation: pipeline2
V/GstMetadataRetrieverDriver( 964): persist.gst.verbose property = 0
V/GstMetadataRetrieverDriver( 964): prepareSync
E/MediaPlayer( 1237): Error (-38,0)
D/MultiPlayer( 1237): Error: -38,0
I/ActivityManager( 1043): Displayed activity com.android.music/.MediaPlaybackActivity: 439 ms (total 439 ms)
@9,086,212us: [+0 T:0x00058388 S:0x40706e34] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x56ed0] status[0]
@9,425,292us: [+0 T:0x00058388 S:0x40706e54] OP - getCmd_d> Exit (result=2)
@9,425,323us: [+0 T:0x00058388 S:0x40706e54] OP - Processor_delete_d> Enter (proc=0xbe28)
@9,425,354us: [+0 T:0x00058388 S:0x40706e3c] ti.sdo.ce.ipc.Power - Power_disconnect> Enter (handle=0x100380)
@9,425,384us: [+2 T:0x00058388 S:0x40706e3c] ti.sdo.ce.ipc.Power - Power_disconnect> Calling LPM_disconnect to dis
connect from the DSP power handler...
@9,425,476us: [+0 T:0x00058388 S:0x40706e3c] ti.sdo.ce.ipc.Power - Power_disconnect> return (0)
@9,425,506us: [+2 T:0x00058388 S:0x40706e54] OP - Processor_delete_d> Closing remote transport...
@9,425,750us: [+2 T:0x00058388 S:0x40706e54] OP - Processor_delete_d> Stopping DSP...
@9,425,811us: [+2 T:0x00058388 S:0x40706e54] OP - Processor_delete_d> Closing pool...
@9,425,964us: [+2 T:0x00058388 S:0x40706e54] OP - Processor_delete_d> Detaching from DSP...
@9,427,490us: [+2 T:0x00058388 S:0x40706e54] OP - Processor_delete_d> Destroying DSP... (object, that is)
@9,427,764us: [+0 T:0x00058388 S:0x40706e3c] ti.sdo.ce.ipc.Power - Power_off> Enter (handle=0x100380)
@9,427,795us: [+2 T:0x00058388 S:0x40706e3c] ti.sdo.ce.ipc.Power - Power_off> Turning off DSP power...
@9,427,917us: [+2 T:0x00058388 S:0x40706e3c] ti.sdo.ce.ipc.Power - Power_off> Closing Local Power Manager object..
.
@9,427,947us: [+0 T:0x00058388 S:0x40706e3c] ti.sdo.ce.ipc.Power - Power_off> return (0)
@9,427,978us: [+0 T:0x00058388 S:0x40706e34] OM - Memory_free> Enter(0xfc9c0, 0x0)
@9,428,009us: [+0 T:0x00058388 S:0x40706e34] OM - Memory_free> return (0x1)
@9,428,009us: [+0 T:0x00058388 S:0x40706e54] OP - Processor_delete_d> return
@9,428,039us: [+0 T:0x00058388 S:0x40706e5c] ti.sdo.ce.osal.Sem - Entered Sem_post> sem[0x56ee0]
@9,428,100us: [+0 T:0x00121fc0 S:0x40906d84] ti.sdo.ce.osal.Sem - Leaving Sem_pend> sem[0x56ee0] status[0]
@9,764,251us: [+0 T:0x00121fc0 S:0x40906da4] OP - doCmd> Exit (result=1)
@9,764,312us: [+1 T:0x00121fc0 S:0x40906dc4] OP - Processor_delete(0xbe28) freeing object ...
@9,764,343us: [+0 T:0x00121fc0 S:0x40906da4] OM - Memory_free> Enter(0xbe28, 0x24)
@9,764,373us: [+0 T:0x00121fc0 S:0x40906da4] OM - Memory_free> return (0x1)
@9,764,404us: [+0 T:0x00121fc0 S:0x40906dc4] OP - Processor_delete> return.
@9,764,434us: [+0 T:0x00121fc0 S:0x40906dd4] CE - rserverClose(0x81678aa4) done.
@9,764,465us: [+0 T:0x00121fc0 S:0x40906dd4] OM - Memory_free> Enter(0x100348, 0x34)
@9,764,495us: [+0 T:0x00121fc0 S:0x40906dd4] OM - Memory_free> return (0x1)
@9,764,526us: [+0 T:0x00121fc0 S:0x40906df4] CE - Engine_close exit
V/GstMetadataRetrieverDriver( 964): receive GST_MESSAGE_ASYNC_DONE
@9,764,892us: [+0 T:0x00058388 S:0x40706e5c] ti.sdo.ce.osal.Sem - Leaving Sem_post> sem[0x56ee0]
@9,764,953us: [+0 T:0x00058388 S:0x40706e54] OP - getCmd_d> Enter (proc=0x40706eac)
@9,764,984us: [+0 T:0x00058388 S:0x40706e34] ti.sdo.ce.osal.Sem - Entered Sem_pend> sem[0x56ed0] timeout[0xfffffff
f]
0:00:00.008545000 964 WARN typefind gst_type_find_get_extension:706 failed to query peer uri
V/GstMetadataRetriever( 964): GstMetadataRetriever setDataSource OK
V/GstMetadataRetriever( 964): GstMetadataRetriever extractAlbumArt
V/GstMetadataRetrieverDriver( 964): getAlbumArt try to get image from tags
E/MetadataRetrieverClient( 964): failed to extract an album art
V/GstMetadataRetriever( 964): GstMetadataRetriever destructor
V/GstMetadataRetrieverDriver( 964): quit
V/GstMetadataRetrieverDriver( 964): flush bus messages
V/GstMetadataRetrieverDriver( 964): free pipeline pipeline2
V/GstMetadataRetrieverDriver( 964): set pipeline state to NULL: 1 (0:Failure, 1:Success, 2:Async, 3:NO_PREROLL)
V/GstMetadataRetrieverDriver( 964): destructor
V/GstMediaScanner( 1211): MediaScanner extractAlbumArt 53
D/MediaPlayerService( 964): SF does not support mpeg2 Audio formate (.aac) file so play with PV
E/MetadataRetrieverClient( 964): create gst metadata retriever...
V/GstMetadataRetriever( 964): GstMetadataRetriever constructor
V/GstMetadataRetrieverDriver( 964): constructor
V/GstMetadataRetrieverDriver( 964): persist.gst.debug property 0
V/GstMetadataRetrieverDriver( 964): persist.gst.trace property /dev/console
V/GstMetadataRetrieverDriver( 964): route the trace to /dev/console
V/GstMetadataRetrieverDriver( 964): gstreamer init check
V/GstMetadataRetriever( 964): GstMetadataRetriever constructor exit
V/GstMetadataRetriever( 964): GstMetadataRetriever setMode mode=1
V/GstMetadataRetriever( 964): GstMetadataRetriever::setMode video protection already deactivated
V/GstMetadataRetriever( 964): GstMetadataRetriever setDataSource fd=24 offset=0 lenght=1602218
I/GstMetadataRetrieverDriver( 964): create source from fd 24 offset 0 lenght 1602218
V/GstMetadataRetrieverDriver( 964): dup(fd) old 24 new 25
V/GstMetadataRetrieverDriver( 964): create pipeline
V/GstMetadataRetrieverDriver( 964): pipeline creation: pipeline3
V/GstMetadataRetrieverDriver( 964): persist.gst.verbose property = 0
V/GstMetadataRetrieverDriver( 964): prepareSync
V/GstMetadataRetrieverDriver( 964): receive GST_MESSAGE_ASYNC_DONE
V/GstMetadataRetriever( 964): GstMetadataRetriever setDataSource OK
V/GstMetadataRetriever( 964): GstMetadataRetriever extractAlbumArt
V/GstMetadataRetrieverDriver( 964): getAlbumArt try to get image from tags
E/MetadataRetrieverClient( 964): failed to extract an album art
V/GstMetadataRetriever( 964): GstMetadataRetriever destructor
V/GstMetadataRetrieverDriver( 964): quit
V/GstMetadataRetrieverDriver( 964): flush bus messages
V/GstMetadataRetrieverDriver( 964): free pipeline pipeline3
V/GstMetadataRetrieverDriver( 964): set pipeline state to NULL: 1 (0:Failure, 1:Success, 2:Async, 3:NO_PREROLL)
V/GstMetadataRetrieverDriver( 964): destructor
Do you find some true info?Thanks!
Best Regards
Kelvin
