[TIMOB-4899] Android: Camera crashes Sony Ericsson Xperia Arc Android 2.3.2, 2.3.3 with all branches
GitHub Issue | n/a |
---|---|
Type | Bug |
Priority | High |
Status | Closed |
Resolution | Duplicate |
Resolution Date | 2013-03-20T17:29:19.000+0000 |
Affected Version/s | Release 1.8.3 |
Fix Version/s | Release 3.1.0, 2013 Sprint 06 API, 2013 Sprint 06 |
Components | Android |
Labels | api |
Reporter | Patric de Waha |
Assignee | Ingo Muschenetz |
Created | 2011-07-10T11:20:55.000+0000 |
Updated | 2017-03-23T05:24:49.000+0000 |
Description
I found the problem, but first, a small introduction to the issue:
Sony Ericsson Xperia Arc has a branded Android version, and a special camera (also camera software).
Basically Titanium crashes after taking a picture (result should be delivered to titanium), but then a Null Pointer Exception occurs.
It is very simple to reproduce, just invoke showCamera(), nothing else.
Titanium.Media.showCamera({
success:function(event) {},
cancel:function() {},
error:function(error) {},
allowEditing:true
});
Complete log of the device until crash can be found [here](http://pastebin.com/5C5JzBpG) and below:
05-26 09:38:58.863: VERBOSE/AudioService(226): HDMI disconnected
05-26 09:38:58.868: WARN/AudioPolicyManager(105): setDeviceConnectionState() device not connected: 800
05-26 09:39:00.018: DEBUG/DigitalClockWidget Receiver(748): onReceive: android.intent.action.TIME_TICK
05-26 09:39:00.158: DEBUG/dalvikvm(358): GC_EXTERNAL_ALLOC freed 254K, 51% free 3196K/6471K, external 7921K/7976K, paused 29ms
05-26 09:39:00.367: VERBOSE/AudioService(226): HDMI disconnected
05-26 09:39:00.367: WARN/AudioPolicyManager(105): setDeviceConnectionState() device not connected: 800
05-26 09:39:00.948: DEBUG/dalvikvm(358): GC_EXTERNAL_ALLOC freed 95K, 52% free 3142K/6471K, external 7567K/8804K, paused 28ms
05-26 09:39:01.868: VERBOSE/AudioService(226): HDMI disconnected
05-26 09:39:01.868: WARN/AudioPolicyManager(105): setDeviceConnectionState() device not connected: 800
05-26 09:39:02.938: INFO/ActivityManager(226): Starting: Intent { act=android.intent.action.MAIN cat=[android.intent.category.LAUNCHER] flg=0x10200000 cmp=com.zapon.zapon/.ZaponActivity bnds=[12,431][125,589] } from pid 358
05-26 09:39:02.978: INFO/ActivityManager(226): Start proc com.zapon.zapon for activity com.zapon.zapon/.ZaponActivity: pid=952 uid=10107 gids={1015, 1006, 3003}
05-26 09:39:03.088: WARN/ResourceType(226): Skipping entry 0x7f04000b in package table 0 because it is not complex!
05-26 09:39:03.098: WARN/ResourceType(226): Skipping entry 0x7f040038 in package table 0 because it is not complex!
05-26 09:39:03.188: INFO/TiApplication(952): (main) [0,0] checkpoint, app created.
05-26 09:39:03.308: INFO/TiApplication(952): (main) [130,130] Titanium 1.7.0 (2011/03/31 12:08 6cae16)
05-26 09:39:03.368: VERBOSE/AudioService(226): HDMI disconnected
05-26 09:39:03.368: WARN/AudioPolicyManager(105): setDeviceConnectionState() device not connected: 800
05-26 09:39:03.498: INFO/TiRootActivity(952): (main) [0,0] checkpoint, on root activity create, savedInstanceState: null
05-26 09:39:03.658: ERROR/TiApplication(952): (main) [158,158] APP PROXY: [Ti.App]
05-26 09:39:03.658: DEBUG/TiCommonContactsApi(952): (main) [4,162] Using newer contacts api. Android SDK level: 9
05-26 09:39:03.728: DEBUG/KrollContext(952): (kroll$1: app://app.js) [65,227] Running evaluated script: file:///android_asset/Resources/app.js
05-26 09:39:03.808: DEBUG/dalvikvm(952): GC_CONCURRENT freed 880K, 51% free 3332K/6791K, external 1685K/2133K, paused 2ms+2ms
05-26 09:39:03.838: INFO/ActivityManager(226): Starting: Intent { cmp=com.zapon.zapon/org.appcelerator.titanium.TiActivity (has extras) } from pid 952
05-26 09:39:03.878: DEBUG/dalvikvm(952): GC_EXTERNAL_ALLOC freed 125K, 52% free 3285K/6791K, external 1685K/2133K, paused 28ms
05-26 09:39:03.918: DEBUG/dalvikvm(952): GC_EXTERNAL_ALLOC freed 14K, 52% free 3271K/6791K, external 2260K/2823K, paused 26ms
05-26 09:39:03.948: INFO/TiRootActivity(952): (main) [0,0] checkpoint, on root activity resume. context = org.appcelerator.titanium.TiContext@2b0b6d90
05-26 09:39:03.968: WARN/TiAnalyticsSvc(952): (Thread-12) [22,22] Analytics Service Started
05-26 09:39:03.978: DEBUG/KrollContext(952): (kroll$2: app://main.js) [14,36] Running evaluated script: app://main.js
05-26 09:39:03.998: DEBUG/Camera-JNI(952): isExtensionObject
05-26 09:39:03.998: WARN/ServiceManager(105): Permission failure: com.sonyericsson.permission.CAMERA_EXTENDED from uid=10107 pid=952
05-26 09:39:04.018: INFO/caladbolg(105): 134459839 cald_camctrl.c (6185) 965 P [SVR] 134459809 + Cald_CamCtrl_PowerUp
05-26 09:39:04.018: INFO/caladbolg(105): 134461029 cald_camctrl.c (6854) 965 P [SVR] 134461029 + Cald_CamCtrl_FSM_Func_PowerUp
05-26 09:39:04.048: INFO/caladbolg(105): 134487976 cald_hal_qct.c (2769) 965 P [HAL] 134487946 + Cald_Hal_Qct_If_PowerUp
05-26 09:39:04.068: INFO/TiAnalyticsSvc(952): (Thread-12) [84,120] Sending 2 analytics events.
05-26 09:39:04.198: INFO/caladbolg(105): 134637085 cald_hal_qct.c (2848) 965 P [HAL] 134637055 - Cald_Hal_Qct_If_PowerUp (0)
05-26 09:39:04.198: INFO/caladbolg(105): 134641541 cald_camctrl.c (6929) 965 P [SVR] 134641541 - Cald_CamCtrl_FSM_Func_PowerUp (0)
05-26 09:39:04.198: INFO/caladbolg(105): 134641602 cald_camctrl.c (6192) 965 P [SVR] 134641602 - Cald_CamCtrl_PowerUp (0)
05-26 09:39:04.208: INFO/StagefrightPlayer(105): setDataSource('/system/media/audio/ui/camera_click.ogg')
05-26 09:39:04.208: DEBUG/DrmManager(Native)(103): DrmManager::openDecryptSession: no capable plug-in found
05-26 09:39:04.208: DEBUG/IDrmManagerService(Native)(103): NULL decryptHandle is returned
05-26 09:39:04.208: DEBUG/IDrmManagerService(Native)(105): no decryptHandle is generated in service side
05-26 09:39:04.218: INFO/StagefrightPlayer(105): setDataSource('/system/media/audio/ui/VideoRecord.ogg')
05-26 09:39:04.228: DEBUG/DrmManager(Native)(103): DrmManager::openDecryptSession: no capable plug-in found
05-26 09:39:04.228: DEBUG/IDrmManagerService(Native)(103): NULL decryptHandle is returned
05-26 09:39:04.228: DEBUG/IDrmManagerService(Native)(105): no decryptHandle is generated in service side
05-26 09:39:04.238: DEBUG/Camera-JNI(952): isExtensionObject
05-26 09:39:04.238: DEBUG/Camera-JNI(952): isExtensionObject
05-26 09:39:04.238: INFO/caladbolg(105): 134684296 cald_camctrl.c (4150) 965 P [SVR] 134684266 + Cald_CamCtrl_ICamera_CancelAutoLock
05-26 09:39:04.238: INFO/caladbolg(105): 134684357 cald_camctrl.c (8561) 965 P [SVR] 134684357 + Cald_CamCtrl_FSM_Func_CancelAutoLock
05-26 09:39:04.238: INFO/caladbolg(105): 134684388 cald_camctrl.c (8596) 965 P [SVR] 134684388 - Cald_CamCtrl_FSM_Func_CancelAutoLock (0)
05-26 09:39:04.248: INFO/caladbolg(105): 134684418 cald_camctrl.c (4155) 965 P [SVR] 134684418 - Cald_CamCtrl_ICamera_CancelAutoLock (0)
05-26 09:39:04.248: INFO/caladbolg(105): 134687043 cald_camctrl.c (6201) 965 P [SVR] 134687012 + Cald_CamCtrl_PowerDown
05-26 09:39:04.248: INFO/caladbolg(105): 134687104 cald_camctrl.c (6941) 965 P [SVR] 134687104 + Cald_CamCtrl_FSM_Func_PowerDown
05-26 09:39:04.248: INFO/caladbolg(105): 134690094 cald_hal_qct.c (2864) 965 P [HAL] 134690094 + Cald_Hal_Qct_If_PowerDown
05-26 09:39:04.258: DEBUG/kernel(112): [ 142.895843] msm_enqueue: queue event new max is 1
05-26 09:39:04.258: DEBUG/kernel(112): [ 142.895874] msm_enqueue: queue control new max is 1
05-26 09:39:04.428: INFO/caladbolg(105): 134871216 cald_hal_qct.c (2888) 965 P [HAL] 134871216 - Cald_Hal_Qct_If_PowerDown (0)
05-26 09:39:04.428: INFO/caladbolg(105): 134872498 cald_camctrl.c (6979) 965 P [SVR] 134872498 - Cald_CamCtrl_FSM_Func_PowerDown (0)
05-26 09:39:04.428: INFO/caladbolg(105): 134872681 cald_camctrl.c (6206) 965 P [SVR] 134872681 - Cald_CamCtrl_PowerDown (0)
05-26 09:39:04.458: INFO/ActivityManager(226): Starting: Intent { act=android.media.action.IMAGE_CAPTURE cat=[android.intent.category.DEFAULT] cmp=com.sonyericsson.android.camera/.CameraActivityForCaptureOnly (has extras) } from pid 952
05-26 09:39:04.468: INFO/WindowManager(226): Setting rotation to 1, animFlags=1
05-26 09:39:04.488: INFO/ActivityManager(226): Displayed com.zapon.zapon/org.appcelerator.titanium.TiActivity: +523ms (total +1m31s933ms)
05-26 09:39:04.488: INFO/ActivityManager(226): Config changed: { scale=1.0 imsi=270/1 loc=en_US touch=3 keys=1/1/2 nav=1/1 orien=2 layout=34 uiMode=17 seq=5}
05-26 09:39:04.498: DEBUG/GestureDetector(302): touchSlop:31 doubleTapSlop:195
05-26 09:39:04.588: INFO/ActivityManager(226): Start proc com.sonyericsson.android.camera for activity com.sonyericsson.android.camera/.CameraActivityForCaptureOnly: pid=980 uid=10067 gids={1006, 1015}
05-26 09:39:04.598: WARN/InputManagerService(226): Starting input on non-focused client com.android.internal.view.IInputMethodClient$Stub$Proxy@2b1d31b8 (uid=10107 pid=952)
05-26 09:39:04.598: WARN/InputManagerService(226): Client not active, ignoring focus gain of: com.android.internal.view.IInputMethodClient$Stub$Proxy@2b1971d0
05-26 09:39:04.678: DEBUG/dalvikvm(302): GC_EXTERNAL_ALLOC freed 153K, 48% free 3011K/5767K, external 2656K/2666K, paused 135ms
05-26 09:39:04.738: DEBUG/dalvikvm(102): GC_EXPLICIT freed 10K, 53% free 2554K/5379K, external 1685K/2133K, paused 159ms
05-26 09:39:04.828: DEBUG/dalvikvm(102): GC_EXPLICIT freed <1K, 53% free 2554K/5379K, external 1685K/2133K, paused 92ms
05-26 09:39:04.868: VERBOSE/AudioService(226): HDMI disconnected
05-26 09:39:04.868: WARN/AudioPolicyManager(105): setDeviceConnectionState() device not connected: 800
05-26 09:39:04.868: INFO/CustomizationProvider(855): No configuration file: /system/etc/customization/settings/com/sonyericsson/textinput/uxp/custom_settings.xml
05-26 09:39:04.908: DEBUG/dalvikvm(102): GC_EXPLICIT freed <1K, 53% free 2554K/5379K, external 1685K/2133K, paused 76ms
05-26 09:39:04.918: INFO/CustomizationProvider(855): No configuration file: /system/etc/customization/settings/com/sonyericsson/android/camera/custom_settings.xml
05-26 09:39:04.928: INFO/ActivityManager(226): Start proc com.sonyericsson.conversations for content provider com.sonyericsson.conversations/.provider.ConversationsSettingsProvider: pid=987 uid=10026 gids={3003, 1015}
05-26 09:39:04.998: INFO/ActivityThread(987): Pub com.sonyericsson.conversations: com.sonyericsson.conversations.provider.ConversationsSettingsProvider
05-26 09:39:05.018: INFO/CustomizationProvider(855): No configuration file: /system/etc/customization/settings/com/sonyericsson/conversations/custom_settings.xml
05-26 09:39:05.108: DEBUG/dalvikvm(980): GC_EXTERNAL_ALLOC freed 126K, 51% free 2720K/5447K, external 1685K/2133K, paused 42ms
05-26 09:39:05.238: INFO/ActivityManager(226): Start proc com.sonyericsson.fmradio for broadcast com.sonyericsson.fmradio/.FMBroadcastReceiver: pid=995 uid=10054 gids={}
05-26 09:39:05.248: DEBUG/Camera-JNI(980): isExtensionObject
05-26 09:39:05.278: INFO/caladbolg(105): 135720307 cald_camctrl.c (6185) 1006 P [SVR] 135720276 + Cald_CamCtrl_PowerUp
05-26 09:39:05.278: INFO/caladbolg(105): 135720368 cald_camctrl.c (6854) 1006 P [SVR] 135720368 + Cald_CamCtrl_FSM_Func_PowerUp
05-26 09:39:05.288: INFO/caladbolg(105): 135729859 cald_hal_qct.c (2769) 1006 P [HAL] 135729859 + Cald_Hal_Qct_If_PowerUp
05-26 09:39:05.428: INFO/caladbolg(105): 135867646 cald_hal_qct.c (2848) 1006 P [HAL] 135864411 - Cald_Hal_Qct_If_PowerUp (0)
05-26 09:39:05.428: INFO/caladbolg(105): 135869996 cald_camctrl.c (6929) 1006 P [SVR] 135869965 - Cald_CamCtrl_FSM_Func_PowerUp (0)
05-26 09:39:05.428: INFO/caladbolg(105): 135870118 cald_camctrl.c (6192) 1006 P [SVR] 135870087 - Cald_CamCtrl_PowerUp (0)
05-26 09:39:05.448: INFO/StagefrightPlayer(105): setDataSource('/system/media/audio/ui/camera_click.ogg')
05-26 09:39:05.448: DEBUG/DrmManager(Native)(103): DrmManager::openDecryptSession: no capable plug-in found
05-26 09:39:05.448: DEBUG/IDrmManagerService(Native)(103): NULL decryptHandle is returned
05-26 09:39:05.448: DEBUG/IDrmManagerService(Native)(105): no decryptHandle is generated in service side
05-26 09:39:05.478: INFO/StagefrightPlayer(105): setDataSource('/system/media/audio/ui/VideoRecord.ogg')
05-26 09:39:05.478: DEBUG/DrmManager(Native)(103): DrmManager::openDecryptSession: no capable plug-in found
05-26 09:39:05.478: DEBUG/IDrmManagerService(Native)(103): NULL decryptHandle is returned
05-26 09:39:05.478: DEBUG/IDrmManagerService(Native)(105): no decryptHandle is generated in service side
05-26 09:39:05.508: DEBUG/Camera-JNI(980): isExtensionObject
05-26 09:39:05.508: DEBUG/SemcExtensionCamera(980): SemcExtensionCamera()
05-26 09:39:05.548: WARN/AudioService(226): stream was not muted by this client
05-26 09:39:05.548: ERROR/AudioService(226): Could not get client death handler for stream: 5
05-26 09:39:05.558: WARN/AudioService(226): stream was not muted by this client
05-26 09:39:05.558: ERROR/AudioService(226): Could not get client death handler for stream: 5
05-26 09:39:05.578: INFO/ActivityManager(226): No longer want com.sonyericsson.hdmi.activity (pid 826): hidden #16
05-26 09:39:05.588: INFO/ActivityManager(226): No longer want com.google.android.googlequicksearchbox (pid 755): hidden #16
05-26 09:39:05.659: INFO/ActivityManager(226): Displayed com.sonyericsson.android.camera/.CameraActivityForCaptureOnly: +1s79ms
05-26 09:39:05.708: WARN/IInputConnectionWrapper(358): showStatusIcon on inactive InputConnection
05-26 09:39:05.728: INFO/CustomizationProvider(855): No configuration file: /system/etc/customization/settings/com/sonyericsson/textinput/uxp/custom_settings.xml
05-26 09:39:05.738: DEBUG/kernel(112): [ 144.371978] mdp4_overlay_pipe_alloc: pipe=806fa520 ndx=5
05-26 09:39:05.738: DEBUG/kernel(112): [ 144.371978] mpd4_overlay_req2pipe: zorder=0 pipe_num=2
05-26 09:39:05.768: DEBUG/kernel(112): [ 144.400177] mdp4_dtv_on: <ID=0 1280x720 (110,40,220), (5,5,20) 74MHz>
05-26 09:39:05.768: DEBUG/kernel(112): [ 144.400238] mdp4_overlay_pipe_alloc: pipe=806fa678 ndx=6
05-26 09:39:05.768: DEBUG/kernel(112): [ 144.400238] mpd4_overlay_req2pipe: zorder=0 pipe_num=3
05-26 09:39:05.768: DEBUG/kernel(112): [ 144.409118] msm_enqueue: queue control new max is 1
05-26 09:39:05.778: INFO/caladbolg(105): 136214875 cald_capctrl.c (6003) 1008 P [CAP] 136214844 + Cald_CapCtrl_FSM_Func_StartPreview
05-26 09:39:05.778: INFO/caladbolg(105): 136217499 cald_hal_qct.c (2971) 1008 P [HAL] 136217469 + Cald_Hal_Qct_If_StartPreview
05-26 09:39:05.788: WARN/kernel(112): [ 144.428344] msm_pp_release: pp not in progress for 0
05-26 09:39:05.798: INFO/caladbolg(105): 136239594 cald_hal_qct.c (3024) 1008 P [HAL] 136239594 - Cald_Hal_Qct_If_StartPreview (0)
05-26 09:39:05.798: INFO/caladbolg(105): 136239655 cald_capctrl.c (6232) 1008 P [CAP] 136239655 - Cald_CapCtrl_FSM_Func_StartPreview
05-26 09:39:05.828: DEBUG/kernel(112): [ 144.469177] msm_enqueue: queue frame new max is 1
05-26 09:39:05.828: DEBUG/kernel(112): [ 144.469207] msm_enqueue: queue event new max is 2
05-26 09:39:06.078: DEBUG/dalvikvm(980): GC_EXTERNAL_ALLOC freed 655K, 50% free 3311K/6599K, external 4098K/4104K, paused 33ms
05-26 09:39:06.128: INFO/caladbolg(105): 136567688 cald_camctrl.c (13244) 1008 P [SVR] 136567688 + Cald_CamCtrl_FSM_Func_FrameDoneVF
05-26 09:39:06.128: INFO/caladbolg(105): 136567749 cald_camctrl.c (13254) 1008 P [SVR] 136567749 - Cald_CamCtrl_FSM_Func_FrameDoneVF
05-26 09:39:06.368: VERBOSE/AudioService(226): HDMI disconnected
05-26 09:39:06.368: WARN/AudioPolicyManager(105): setDeviceConnectionState() device not connected: 800
05-26 09:39:06.448: DEBUG/dalvikvm(980): GC_EXTERNAL_ALLOC freed 107K, 48% free 3480K/6599K, external 5182K/5188K, paused 30ms
05-26 09:39:06.498: DEBUG/SemcExtensionCamera(980): start()
05-26 09:39:06.498: INFO/caladbolg(105): 136935791 cald_capctrl.c (6690) 1008 P [CAP] 136935791 + Cald_CapCtrl_FSM_Func_StartFaceDetection
05-26 09:39:06.498: INFO/caladbolg(105): 136940705 cald_capctrl.c (6705) 1008 P [CAP] 136940705 - Cald_CapCtrl_FSM_Func_StartFaceDetection
05-26 09:39:06.498: INFO/caladbolg(105): 136940796 cald_capctrl.c (8185) 1008 P [CAP] 136940796 + Cald_CapCtrl_FSM_Func_Face_StartDone
05-26 09:39:06.498: INFO/caladbolg(105): 136940827 cald_capctrl.c (8196) 1008 P [CAP] 136940827 - Cald_CapCtrl_FSM_Func_Face_StartDone
05-26 09:39:06.498: DEBUG/SemcExtensionCamera(980): SemcEx:startSceneRecognition
05-26 09:39:06.498: DEBUG/Camera-JNI(980): startSceneRecognition
05-26 09:39:06.498: INFO/caladbolg(105): 136942933 cald_capctrl.c (6718) 1008 P [CAP] 136942933 + Cald_CapCtrl_FSM_Func_StartSceneDetection
05-26 09:39:06.498: INFO/caladbolg(105): 136943024 cald_capctrl.c (6727) 1008 P [CAP] 136943024 - Cald_CapCtrl_FSM_Func_StartSceneDetection
05-26 09:39:06.538: DEBUG/SemcExtensionCamera(980): setSearchFaceCallback()
05-26 09:39:06.548: INFO/StagefrightPlayer(105): setDataSource('/system/media/audio/camera/sound1/shutter.ogg')
05-26 09:39:06.548: DEBUG/DrmManager(Native)(103): DrmManager::openDecryptSession: no capable plug-in found
05-26 09:39:06.548: DEBUG/IDrmManagerService(Native)(103): NULL decryptHandle is returned
05-26 09:39:06.548: DEBUG/IDrmManagerService(Native)(105): no decryptHandle is generated in service side
05-26 09:39:06.678: DEBUG/SemcExtensionCamera(980): setSearchFaceCallback()
05-26 09:39:06.908: DEBUG/Camera-JNI(980): stopSceneRecognition
05-26 09:39:06.908: INFO/caladbolg(105): 137352539 cald_camctrl.c (4150) 1006 P [SVR] 137352539 + Cald_CamCtrl_ICamera_CancelAutoLock
05-26 09:39:06.908: INFO/caladbolg(105): 137352601 cald_camctrl.c (8561) 1006 P [SVR] 137352601 + Cald_CamCtrl_FSM_Func_CancelAutoLock
05-26 09:39:06.908: INFO/caladbolg(105): 137352631 cald_camctrl.c (8596) 1006 P [SVR] 137352631 - Cald_CamCtrl_FSM_Func_CancelAutoLock (0)
05-26 09:39:06.908: INFO/caladbolg(105): 137352692 cald_camctrl.c (4155) 1006 P [SVR] 137352662 - Cald_CamCtrl_ICamera_CancelAutoLock (0)
05-26 09:39:06.908: INFO/caladbolg(105): 137354340 cald_capctrl.c (6254) 1008 P [CAP] 137354340 + Cald_CapCtrl_FSM_Func_StopPreview
05-26 09:39:06.908: INFO/caladbolg(105): 137354401 cald_hal_qct.c (3036) 1008 P [HAL] 137354401 + Cald_Hal_Qct_If_StopPreview
05-26 09:39:06.918: INFO/caladbolg(105): 137355072 cald_hal_qct.c (3065) 1008 P [HAL] 137355042 - Cald_Hal_Qct_If_StopPreview (0)
05-26 09:39:06.918: INFO/caladbolg(105): 137355225 cald_capctrl.c (6333) 1008 P [CAP] 137355225 - Cald_CapCtrl_FSM_Func_StopPreview
05-26 09:39:06.968: DEBUG/kernel(112): [ 145.608245] mdp4_overlay_pipe_free: pipe=806fa520 ndx=5
05-26 09:39:06.968: DEBUG/kernel(112): [ 145.608306] mdp4_overlay_pipe_free: pipe=806fa678 ndx=6
05-26 09:39:07.038: DEBUG/dalvikvm(952): GC_CONCURRENT freed 595K, 50% free 3445K/6791K, external 2332K/2912K, paused 2ms+2ms
05-26 09:39:07.108: DEBUG/kernel(112): [ 145.742462] mdp4_dtv_off
05-26 09:39:07.108: DEBUG/kernel(112): [ 145.743438] mdp4_overlay_pipe_alloc: pipe=806fa520 ndx=5
05-26 09:39:07.108: DEBUG/kernel(112): [ 145.743438] mpd4_overlay_req2pipe: zorder=0 pipe_num=2
05-26 09:39:07.128: INFO/caladbolg(105): 137573548 cald_capctrl.c (6003) 1008 P [CAP] 137573517 + Cald_CapCtrl_FSM_Func_StartPreview
05-26 09:39:07.128: INFO/caladbolg(105): 137573883 cald_hal_qct.c (2971) 1008 P [HAL] 137573883 + Cald_Hal_Qct_If_StartPreview
05-26 09:39:07.138: DEBUG/kernel(112): [ 145.770172] mdp4_dtv_on: <ID=0 1280x720 (110,40,220), (5,5,20) 74MHz>
05-26 09:39:07.138: DEBUG/kernel(112): [ 145.770233] mdp4_overlay_pipe_alloc: pipe=806fa678 ndx=6
05-26 09:39:07.138: DEBUG/kernel(112): [ 145.770233] mpd4_overlay_req2pipe: zorder=0 pipe_num=3
05-26 09:39:07.148: WARN/kernel(112): [ 145.780670] msm_pp_release: pp not in progress for 0
05-26 09:39:07.169: INFO/caladbolg(105): 137605439 cald_hal_qct.c (3024) 1008 P [HAL] 137605439 - Cald_Hal_Qct_If_StartPreview (0)
05-26 09:39:07.169: INFO/caladbolg(105): 137605500 cald_capctrl.c (6232) 1008 P [CAP] 137605500 - Cald_CapCtrl_FSM_Func_StartPreview
05-26 09:39:07.169: DEBUG/SemcExtensionCamera(980): start()
05-26 09:39:07.169: INFO/caladbolg(105): 137610138 cald_capctrl.c (6690) 1008 P [CAP] 137610108 + Cald_CapCtrl_FSM_Func_StartFaceDetection
05-26 09:39:07.169: INFO/caladbolg(105): 137610505 cald_capctrl.c (6705) 1008 P [CAP] 137610505 - Cald_CapCtrl_FSM_Func_StartFaceDetection
05-26 09:39:07.169: INFO/caladbolg(105): 137610566 cald_capctrl.c (8185) 1008 P [CAP] 137610566 + Cald_CapCtrl_FSM_Func_Face_StartDone
05-26 09:39:07.169: INFO/caladbolg(105): 137610596 cald_capctrl.c (8196) 1008 P [CAP] 137610596 - Cald_CapCtrl_FSM_Func_Face_StartDone
05-26 09:39:07.169: DEBUG/SemcExtensionCamera(980): SemcEx:startSceneRecognition
05-26 09:39:07.169: DEBUG/Camera-JNI(980): startSceneRecognition
05-26 09:39:07.169: INFO/caladbolg(105): 137613282 cald_capctrl.c (6718) 1008 P [CAP] 137613282 + Cald_CapCtrl_FSM_Func_StartSceneDetection
05-26 09:39:07.169: INFO/caladbolg(105): 137613373 cald_capctrl.c (6727) 1008 P [CAP] 137613343 - Cald_CapCtrl_FSM_Func_StartSceneDetection
05-26 09:39:07.368: INFO/dalvikvm(952): Total arena pages for JIT: 11
05-26 09:39:07.468: DEBUG/dalvikvm(980): GC_CONCURRENT freed 594K, 48% free 3542K/6727K, external 5760K/6493K, paused 3ms+2ms
05-26 09:39:07.688: INFO/caladbolg(105): 138131562 cald_camctrl.c (13244) 1008 P [SVR] 138131531 + Cald_CamCtrl_FSM_Func_FrameDoneVF
05-26 09:39:07.688: INFO/caladbolg(105): 138131623 cald_camctrl.c (13254) 1008 P [SVR] 138131623 - Cald_CamCtrl_FSM_Func_FrameDoneVF
05-26 09:39:07.828: DEBUG/dalvikvm(226): GC_EXPLICIT freed 946K, 39% free 5957K/9735K, external 7575K/8273K, paused 126ms
05-26 09:39:07.868: VERBOSE/AudioService(226): HDMI disconnected
05-26 09:39:07.868: WARN/AudioPolicyManager(105): setDeviceConnectionState() device not connected: 800
05-26 09:39:08.558: DEBUG/kernel(112): [ 147.177856] msm_enqueue: queue event new max is 3
05-26 09:39:08.558: DEBUG/kernel(112): [ 147.177886] msm_enqueue: queue event new max is 4
05-26 09:39:08.558: DEBUG/kernel(112): [ 147.178466] msm_enqueue: queue event new max is 5
05-26 09:39:08.658: WARN/TiAnalyticsSvc(952): (Thread-12) [4592,4712] Stopping Analytics Service
05-26 09:39:08.668: INFO/ActivityManager(226): No longer want com.sonyericsson.widget.togglewidgets (pid 741): hidden #16
05-26 09:39:09.370: VERBOSE/AudioService(226): HDMI disconnected
05-26 09:39:09.370: WARN/AudioPolicyManager(105): setDeviceConnectionState() device not connected: 800
05-26 09:39:10.228: DEBUG/lights(226): set_light_buttons: brightness=255
05-26 09:39:10.228: WARN/KeyCharacterMap(980): Can't open keycharmap file
05-26 09:39:10.228: WARN/KeyCharacterMap(980): Error loading keycharmap file '/system/usr/keychars/pm8058-keypad.kcm.bin'. hw.keyboards.0.devname='pm8058-keypad'
05-26 09:39:10.228: WARN/KeyCharacterMap(980): Using default keymap: /system/usr/keychars/qwerty.kcm.bin
05-26 09:39:10.228: DEBUG/SemcExtensionCamera(980): setSearchFaceCallback()
05-26 09:39:10.228: DEBUG/SemcExtensionCamera(980): startAutoFocus
05-26 09:39:10.228: DEBUG/Camera-JNI(980): startAutoFocus
05-26 09:39:10.228: INFO/caladbolg(105): 140669037 cald_camctrl.c (4133) 1006 P [SVR] 140669007 + Cald_CamCtrl_ICamera_StartAutoLock
05-26 09:39:10.228: INFO/caladbolg(105): 140669098 cald_camctrl.c (8512) 1006 P [SVR] 140669098 + Cald_CamCtrl_FSM_Func_StartAutoLock
05-26 09:39:10.228: INFO/caladbolg(105): 140669403 cald_camctrl.c (8550) 1006 P [SVR] 140669403 - Cald_CamCtrl_FSM_Func_StartAutoLock (0)
05-26 09:39:10.228: INFO/caladbolg(105): 140669465 cald_camctrl.c (4141) 1006 P [SVR] 140669465 - Cald_CamCtrl_ICamera_StartAutoLock (0)
05-26 09:39:10.819: INFO/caladbolg(105): 141257050 cald_camctrl.c (3663) 1014 P [SVR] 141257019 + Cald_CamCtrl_ICBIqCtrl_AutoLockDone
05-26 09:39:10.819: INFO/caladbolg(105): 141257325 cald_camctrl.c (13573) 1014 P [SVR] 141257294 + Cald_CamCtrl_FSM_Func_AutoLockDone
05-26 09:39:10.828: INFO/caladbolg(105): 141267090 cald_camctrl.c (13589) 1014 P [SVR] 141267029 - Cald_CamCtrl_FSM_Func_AutoLockDone
05-26 09:39:10.828: INFO/caladbolg(105): 141267914 cald_camctrl.c (3678) 1014 P [SVR] 141267884 - Cald_CamCtrl_ICBIqCtrl_AutoLockDone (0)
05-26 09:39:10.828: INFO/StagefrightPlayer(105): setDataSource('/system/media/audio/camera/sound1/af_success.ogg')
05-26 09:39:10.838: DEBUG/DrmManager(Native)(103): DrmManager::openDecryptSession: no capable plug-in found
05-26 09:39:10.838: DEBUG/IDrmManagerService(Native)(103): NULL decryptHandle is returned
05-26 09:39:10.838: DEBUG/IDrmManagerService(Native)(105): no decryptHandle is generated in service side
05-26 09:39:10.868: VERBOSE/AudioService(226): HDMI disconnected
05-26 09:39:10.868: WARN/AudioPolicyManager(105): setDeviceConnectionState() device not connected: 800
05-26 09:39:10.918: INFO/AudioHardwareMSM7X30(105): Routing audio to Speakerphone
05-26 09:39:10.938: DEBUG/AudioHardwareMSM7X30(105): value of device and enable is 6 1
05-26 09:39:10.948: DEBUG/kernel(112): [ 149.589538] [msm7x30.c:msm_device_put] device speaker_stereo_rx set 1
05-26 09:39:10.948: ERROR/kernel(112): [ 149.589569] [msm7x30.c:msm_device_put] device freq =48000
05-26 09:39:10.948: DEBUG/kernel(112): [ 149.589569] __msm_rpc_connect: server not found 30000060:50001
05-26 09:39:10.958: DEBUG/kernel(112): [ 149.593933] [adsp.c:msm_adsp_get] module AFETASK has been registered
05-26 09:39:10.958: DEBUG/kernel(112): [ 149.593933] [adsp.c:msm_adsp_enable] enable 'AFETASK'state[0] id[17227119]
05-26 09:39:10.968: DEBUG/kernel(112): [ 149.603912] [adsp.c:adsp_rtos_mtoa_cb] rpc event=0, proc_id=2, module=17227119, image=0
05-26 09:39:10.968: DEBUG/kernel(112): [ 149.603942] [adsp.c:adsp_rtos_mtoa_cb] module AFETASK: READY
05-26 09:39:11.028: DEBUG/kernel(112): [ 149.661010] msm_snddev_poweramp_on: power on amplifier
05-26 09:39:11.028: DEBUG/kernel(112): [ 149.661102] [adsp.c:msm_adsp_get] module AUDPPTASK has been registered
05-26 09:39:11.028: DEBUG/kernel(112): [ 149.661102] [adsp.c:msm_adsp_enable] enable 'AUDPPTASK'state[0] id[17227122]
05-26 09:39:11.028: DEBUG/kernel(112): [ 149.663024] [adsp.c:adsp_rtos_mtoa_cb] rpc event=0, proc_id=2, module=17227122, image=0
05-26 09:39:11.028: DEBUG/kernel(112): [ 149.663055] [adsp.c:adsp_rtos_mtoa_cb] module AUDPPTASK: READY
05-26 09:39:11.028: DEBUG/kernel(112): [ 149.667053] [audpp.c:audpp_dsp_event] ENABLE
05-26 09:39:11.038: DEBUG/kernel(112): [ 149.673278] [adsp.c:msm_adsp_write] AUDPPTASK command took 39 attempts: rc 0
05-26 09:39:11.038: ERROR/kernel(112): [ 149.673278] [audio_acdb.c:acdb_fill_audpp_cal_gain] unable to find audpp calibration gain block returning
05-26 09:39:11.038: ERROR/kernel(112): [ 149.673522] [audio_acdb.c:acdb_fill_audpp_cal_gain] unable to find audpp calibration gain block returning
05-26 09:39:11.708: INFO/caladbolg(105): 142147156 cald_camctrl.c (4097) 1006 P [SVR] 142147126 + Cald_CamCtrl_ICamera_TakeSnapshot
05-26 09:39:11.708: INFO/caladbolg(105): 142147309 cald_camctrl.c (8150) 1006 P [SVR] 142147278 + Cald_CamCtrl_FSM_Func_TakeSnapshot
05-26 09:39:11.708: INFO/caladbolg(105): 142148072 cald_camctrl.c (8294) 1006 P [SVR] 142148041 - Cald_CamCtrl_FSM_Func_TakeSnapshot (0)
05-26 09:39:11.708: INFO/caladbolg(105): 142148255 cald_camctrl.c (4107) 1006 P [SVR] 142148255 - Cald_CamCtrl_ICamera_TakeSnapshot (0)
05-26 09:39:11.748: INFO/caladbolg(105): 142185914 cald_camctrl.c (3686) 1014 P [SVR] 142185914 + Cald_CamCtrl_ICBIqCtrl_PrepareSnapshotDone
05-26 09:39:11.748: INFO/caladbolg(105): 142186066 cald_camctrl.c (3700) 1014 P [SVR] 142186066 - Cald_CamCtrl_ICBIqCtrl_PrepareSnapshotDone (0)
05-26 09:39:11.748: INFO/caladbolg(105): 142186341 cald_capctrl.c (6403) 1008 P [CAP] 142186341 + Cald_CapCtrl_FSM_Func_StartSnapshot
05-26 09:39:11.748: INFO/caladbolg(105): 142187104 cald_capctrl.c (6646) 1008 P [CAP] 142187073 - Cald_CapCtrl_FSM_Func_StartSnapshot
05-26 09:39:11.768: INFO/caladbolg(105): 142212311 cald_hal_qct.c (3078) 1008 P [HAL] 142212311 + Cald_Hal_Qct_If_StartSnapshot
05-26 09:39:11.798: DEBUG/dalvikvm(980): GC_EXPLICIT freed 71K, 48% free 3560K/6727K, external 5599K/6493K, paused 87ms
05-26 09:39:11.848: WARN/KeyCharacterMap(980): Can't open keycharmap file
05-26 09:39:11.848: WARN/KeyCharacterMap(980): Error loading keycharmap file '/system/usr/keychars/pm8058-keypad.kcm.bin'. hw.keyboards.0.devname='pm8058-keypad'
05-26 09:39:11.848: WARN/KeyCharacterMap(980): Using default keymap: /system/usr/keychars/qwerty.kcm.bin
05-26 09:39:11.998: DEBUG/kernel(112): [ 150.639587] msm_divert_frame: Frame PP sync->pp_mask 1
05-26 09:39:11.998: DEBUG/kernel(112): [ 150.639617] msm_divert_frame: Frame PP sync->pp_mask 1
05-26 09:39:12.068: WARN/kernel(112): [ 150.706665] msm_vfe_sync: overwriting pp_thumb!
05-26 09:39:12.068: WARN/kernel(112): [ 150.706695] msm_vfe_sync: overwriting pp_snap!
05-26 09:39:12.068: WARN/kernel(112): [ 150.706695] msm_vfe_sync: overwriting pp_snap!
05-26 09:39:12.068: DEBUG/kernel(112): [ 150.706726] msm_divert_frame: Frame PP sync->pp_mask 1
05-26 09:39:12.068: DEBUG/kernel(112): [ 150.706756] msm_divert_frame: Frame PP sync->pp_mask 1
05-26 09:39:12.068: DEBUG/kernel(112): [ 150.706756] msm_enqueue: queue pict new max is 1
05-26 09:39:12.188: INFO/caladbolg(105): 142629059 cald_hal_qct.c (3142) 1008 P [HAL] 142629029 - Cald_Hal_Qct_If_StartSnapshot (0)
05-26 09:39:12.188: INFO/caladbolg(105): 142629700 cald_capctrl.c (7244) 1008 P [CAP] 142629670 + Cald_CapCtrl_FSM_Func_Hal_SnapshotImageDone
05-26 09:39:12.198: INFO/caladbolg(105): 142635010 cald_capctrl.c (7347) 1008 P [CAP] 142634949 - Cald_CapCtrl_FSM_Func_Hal_SnapshotImageDone
05-26 09:39:12.198: INFO/caladbolg(105): 142635712 cald_capctrl.c (6968) 1008 P [CAP] 142635712 + Cald_CapCtrl_FSM_Func_Hal_Shutter
05-26 09:39:12.198: INFO/caladbolg(105): 142636383 cald_camctrl.c (3511) 1008 P [SVR] 142636353 + Cald_CamCtrl_ICBCapCtrl_CamShutter
05-26 09:39:12.198: INFO/caladbolg(105): 142636658 cald_camctrl.c (13418) 1008 P [SVR] 142636628 + Cald_CamCtrl_FSM_Func_CamShutter
05-26 09:39:12.198: INFO/caladbolg(105): 142639649 cald_camctrl.c (13434) 1008 P [SVR] 142639588 - Cald_CamCtrl_FSM_Func_CamShutter (0)
05-26 09:39:12.198: INFO/caladbolg(105): 142639862 cald_camctrl.c (3525) 1008 P [SVR] 142639832 - Cald_CamCtrl_ICBCapCtrl_CamShutter (0)
05-26 09:39:12.198: INFO/caladbolg(105): 142639985 cald_capctrl.c (6976) 1008 P [CAP] 142639985 - Cald_CapCtrl_FSM_Func_Hal_Shutter
05-26 09:39:12.198: INFO/caladbolg(105): 142640259 cald_capctrl.c (7244) 1008 P [CAP] 142640229 + Cald_CapCtrl_FSM_Func_Hal_SnapshotImageDone
05-26 09:39:12.198: INFO/caladbolg(105): 142640473 cald_capctrl.c (7347) 1008 P [CAP] 142640442 - Cald_CapCtrl_FSM_Func_Hal_SnapshotImageDone
05-26 09:39:12.198: INFO/AudioHardwareMSM7X30(105): Routing audio to Speakerphone
05-26 09:39:12.368: VERBOSE/AudioService(226): HDMI disconnected
05-26 09:39:12.368: WARN/AudioPolicyManager(105): setDeviceConnectionState() device not connected: 800
05-26 09:39:12.668: INFO/caladbolg(105): 143105713 cald_capctrl.c (7785) 1008 P [CAP] 143105683 + Cald_CapCtrl_FSM_Func_ImageStab_AllProcDone
05-26 09:39:12.668: INFO/caladbolg(105): 143106781 cald_hal_qct.c (4772) 1008 P [HAL] 143106781 + Cald_Hal_Qct_If_StartResize
05-26 09:39:12.668: INFO/caladbolg(105): 143107575 cald_hal_qct.c (4819) 1008 P [HAL] 143107544 - Cald_Hal_Qct_If_StartResize (0)
05-26 09:39:12.668: INFO/caladbolg(105): 143107605 cald_capctrl.c (7875) 1008 P [CAP] 143107605 - Cald_CapCtrl_FSM_Func_ImageStab_AllProcDone
05-26 09:39:12.728: INFO/caladbolg(105): 143167908 cald_capctrl.c (7505) 1008 P [CAP] 143167878 + Cald_CapCtrl_FSM_Func_Hal_ResizeDone
05-26 09:39:12.728: INFO/caladbolg(105): 143167939 cald_hal_qct.c (4835) 1008 P [HAL] 143167939 + Cald_Hal_Qct_If_StopResize
05-26 09:39:12.728: INFO/caladbolg(105): 143168183 cald_hal_qct.c (4865) 1008 P [HAL] 143168183 - Cald_Hal_Qct_If_StopResize (0)
05-26 09:39:12.728: INFO/caladbolg(105): 143168213 cald_camctrl.c (3558) 1008 P [SVR] 143168213 + Cald_CamCtrl_ICBCapCtrl_ThumbnailDone
05-26 09:39:12.728: INFO/caladbolg(105): 143168274 cald_camctrl.c (13455) 1008 P [SVR] 143168274 + Cald_CamCtrl_FSM_Func_ThumbnailDone
05-26 09:39:12.728: INFO/caladbolg(105): 143168335 cald_camctrl.c (13480) 1008 P [SVR] 143168335 - Cald_CamCtrl_FSM_Func_ThumbnailDone (0)
05-26 09:39:12.728: INFO/caladbolg(105): 143168366 cald_camctrl.c (3573) 1008 P [SVR] 143168366 - Cald_CamCtrl_ICBCapCtrl_ThumbnailDone (0)
05-26 09:39:12.728: INFO/caladbolg(105): 143168396 cald_hal_qct.c (4772) 1008 P [HAL] 143168396 + Cald_Hal_Qct_If_StartResize
05-26 09:39:12.728: INFO/caladbolg(105): 143168549 cald_hal_qct.c (4819) 1008 P [HAL] 143168518 - Cald_Hal_Qct_If_StartResize (0)
05-26 09:39:12.728: INFO/caladbolg(105): 143168580 cald_capctrl.c (7601) 1008 P [CAP] 143168580 - Cald_CapCtrl_FSM_Func_Hal_ResizeDone
05-26 09:39:12.798: INFO/caladbolg(105): 143235413 cald_capctrl.c (7505) 1008 P [CAP] 143235382 + Cald_CapCtrl_FSM_Func_Hal_ResizeDone
05-26 09:39:12.798: INFO/caladbolg(105): 143235535 cald_hal_qct.c (4835) 1008 P [HAL] 143235535 + Cald_Hal_Qct_If_StopResize
05-26 09:39:12.798: INFO/caladbolg(105): 143236054 cald_hal_qct.c (4865) 1008 P [HAL] 143236023 - Cald_Hal_Qct_If_StopResize (0)
05-26 09:39:12.798: INFO/caladbolg(105): 143238923 cald_hal_qct.c (4660) 1008 P [HAL] 143238892 + Cald_Hal_Qct_If_StartYuvToJpeg
05-26 09:39:12.808: INFO/caladbolg(105): 143246979 cald_hal_qct.c (4711) 1008 P [HAL] 143246949 - Cald_Hal_Qct_If_StartYuvToJpeg (0)
05-26 09:39:12.808: INFO/caladbolg(105): 143247101 cald_capctrl.c (7601) 1008 P [CAP] 143247071 - Cald_CapCtrl_FSM_Func_Hal_ResizeDone
05-26 09:39:12.868: INFO/caladbolg(105): 143310669 cald_capctrl.c (7621) 1008 P [CAP] 143310639 + Cald_CapCtrl_FSM_Func_Hal_EncodeDone
05-26 09:39:12.868: INFO/caladbolg(105): 143311158 cald_camctrl.c (3584) 1008 P [SVR] 143311127 + Cald_CamCtrl_ICBCapCtrl_SnapshotDone
05-26 09:39:12.868: INFO/caladbolg(105): 143311310 cald_camctrl.c (13494) 1008 P [SVR] 143311310 + Cald_CamCtrl_FSM_Func_SnapshotDone
05-26 09:39:12.878: INFO/caladbolg(105): 143315003 cald_camctrl.c (13564) 1008 P [SVR] 143314972 - Cald_CamCtrl_FSM_Func_SnapshotDone (0)
05-26 09:39:12.878: INFO/caladbolg(105): 143315155 cald_camctrl.c (3600) 1008 P [SVR] 143315125 - Cald_CamCtrl_ICBCapCtrl_SnapshotDone (0)
05-26 09:39:12.878: INFO/caladbolg(105): 143315247 cald_hal_qct.c (3154) 1008 P [HAL] 143315216 + Cald_Hal_Qct_If_StopSnapshot
05-26 09:39:12.878: INFO/caladbolg(105): 143315339 cald_hal_qct.c (3179) 1008 P [HAL] 143315339 - Cald_Hal_Qct_If_StopSnapshot (0)
05-26 09:39:12.878: INFO/caladbolg(105): 143322937 cald_capctrl.c (7687) 1008 P [CAP] 143322907 - Cald_CapCtrl_FSM_Func_Hal_EncodeDone
05-26 09:39:12.878: INFO/caladbolg(105): 143323151 cald_capctrl.c (6254) 1008 P [CAP] 143323151 + Cald_CapCtrl_FSM_Func_StopPreview
05-26 09:39:12.878: INFO/caladbolg(105): 143323273 cald_hal_qct.c (3036) 1008 P [HAL] 143323243 + Cald_Hal_Qct_If_StopPreview
05-26 09:39:12.878: INFO/caladbolg(105): 143323395 cald_hal_qct.c (3065) 1008 P [HAL] 143323395 - Cald_Hal_Qct_If_StopPreview (0)
05-26 09:39:12.878: INFO/caladbolg(105): 143324372 cald_capctrl.c (6333) 1008 P [CAP] 143324341 - Cald_CapCtrl_FSM_Func_StopPreview
05-26 09:39:12.888: INFO/caladbolg(105): 143332367 cald_capctrl.c (6003) 1008 P [CAP] 143332337 + Cald_CapCtrl_FSM_Func_StartPreview
05-26 09:39:12.888: INFO/caladbolg(105): 143333924 cald_hal_qct.c (2971) 1008 P [HAL] 143333893 + Cald_Hal_Qct_If_StartPreview
05-26 09:39:12.908: WARN/kernel(112): [ 151.547973] msm_pp_release: pp not in progress for 0
05-26 09:39:12.918: INFO/caladbolg(105): 143363953 cald_hal_qct.c (3024) 1008 P [HAL] 143363923 - Cald_Hal_Qct_If_StartPreview (0)
05-26 09:39:12.918: INFO/caladbolg(105): 143364075 cald_capctrl.c (6232) 1008 P [CAP] 143364075 - Cald_CapCtrl_FSM_Func_StartPreview
05-26 09:39:12.928: INFO/caladbolg(105): 143364380 cald_capctrl.c (8185) 1008 P [CAP] 143364380 + Cald_CapCtrl_FSM_Func_Face_StartDone
05-26 09:39:12.928: INFO/caladbolg(105): 143365082 cald_capctrl.c (8196) 1008 P [CAP] 143365082 - Cald_CapCtrl_FSM_Func_Face_StartDone
05-26 09:39:12.928: DEBUG/Camera-JNI(980): stopAutoFocus
05-26 09:39:12.938: INFO/caladbolg(105): 143374421 cald_camctrl.c (4150) 1006 P [SVR] 143374390 + Cald_CamCtrl_ICamera_CancelAutoLock
05-26 09:39:12.938: INFO/caladbolg(105): 143374970 cald_camctrl.c (8561) 1006 P [SVR] 143374970 + Cald_CamCtrl_FSM_Func_CancelAutoLock
05-26 09:39:12.968: INFO/caladbolg(105): 143412781 cald_camctrl.c (8596) 1006 P [SVR] 143412751 - Cald_CamCtrl_FSM_Func_CancelAutoLock (0)
05-26 09:39:12.968: INFO/caladbolg(105): 143412903 cald_camctrl.c (4155) 1006 P [SVR] 143412903 - Cald_CamCtrl_ICamera_CancelAutoLock (0)
05-26 09:39:12.988: DEBUG/SemcExtensionCamera(980): setSearchFaceCallback()
05-26 09:39:13.048: INFO/caladbolg(105): 143487915 cald_camctrl.c (13244) 1008 P [SVR] 143487915 + Cald_CamCtrl_FSM_Func_FrameDoneVF
05-26 09:39:13.048: INFO/caladbolg(105): 143488007 cald_camctrl.c (13254) 1008 P [SVR] 143488007 - Cald_CamCtrl_FSM_Func_FrameDoneVF
05-26 09:39:13.068: INFO/CustomizationProvider(855): No configuration file: /system/etc/customization/settings/com/sonyericsson/textinput/uxp/custom_settings.xml
05-26 09:39:13.118: DEBUG/MediaScannerService(526): IMediaScannerService.scanFile: /mnt/sdcard/DCIM/100ANDRO/DSC_0020.jpg mimeType: null
05-26 09:39:13.298: DEBUG/dalvikvm(526): GC_EXTERNAL_ALLOC freed 448K, 53% free 2783K/5895K, external 1894K/2257K, paused 70ms
05-26 09:39:13.868: VERBOSE/AudioService(226): HDMI disconnected
05-26 09:39:13.868: WARN/AudioPolicyManager(105): setDeviceConnectionState() device not connected: 800
05-26 09:39:13.868: DEBUG/dalvikvm(980): GC_EXTERNAL_ALLOC freed 731K, 49% free 4022K/7879K, external 6312K/6493K, paused 62ms
05-26 09:39:13.978: DEBUG/Camera-JNI(980): stopSceneRecognition
05-26 09:39:13.978: INFO/caladbolg(105): 144423371 cald_camctrl.c (4150) 1006 P [SVR] 144423371 + Cald_CamCtrl_ICamera_CancelAutoLock
05-26 09:39:13.978: INFO/caladbolg(105): 144423462 cald_camctrl.c (8561) 1006 P [SVR] 144423432 + Cald_CamCtrl_FSM_Func_CancelAutoLock
05-26 09:39:13.978: INFO/caladbolg(105): 144423493 cald_camctrl.c (8596) 1006 P [SVR] 144423462 - Cald_CamCtrl_FSM_Func_CancelAutoLock (0)
05-26 09:39:13.978: INFO/caladbolg(105): 144423523 cald_camctrl.c (4155) 1006 P [SVR] 144423523 - Cald_CamCtrl_ICamera_CancelAutoLock (0)
05-26 09:39:13.988: INFO/caladbolg(105): 144424744 cald_capctrl.c (6254) 1008 P [CAP] 144424714 + Cald_CapCtrl_FSM_Func_StopPreview
05-26 09:39:13.988: INFO/caladbolg(105): 144424775 cald_hal_qct.c (3036) 1008 P [HAL] 144424775 + Cald_Hal_Qct_If_StopPreview
05-26 09:39:13.988: INFO/caladbolg(105): 144425293 cald_hal_qct.c (3065) 1008 P [HAL] 144425293 - Cald_Hal_Qct_If_StopPreview (0)
05-26 09:39:13.988: INFO/caladbolg(105): 144425446 cald_capctrl.c (6333) 1008 P [CAP] 144425415 - Cald_CapCtrl_FSM_Func_StopPreview
05-26 09:39:14.058: WARN/AudioService(226): stream was not muted by this client
05-26 09:39:14.058: ERROR/AudioService(226): Could not get client death handler for stream: 5
05-26 09:39:14.058: WARN/AudioService(226): stream was not muted by this client
05-26 09:39:14.058: ERROR/AudioService(226): Could not get client death handler for stream: 5
05-26 09:39:14.058: DEBUG/SemcExtensionCamera(980): setSearchFaceCallback()
05-26 09:39:14.058: DEBUG/Camera-JNI(980): isExtensionObject
05-26 09:39:14.058: INFO/caladbolg(105): 144497498 cald_camctrl.c (4150) 1006 P [SVR] 144497467 + Cald_CamCtrl_ICamera_CancelAutoLock
05-26 09:39:14.058: INFO/caladbolg(105): 144497559 cald_camctrl.c (8561) 1006 P [SVR] 144497559 + Cald_CamCtrl_FSM_Func_CancelAutoLock
05-26 09:39:14.058: INFO/caladbolg(105): 144497590 cald_camctrl.c (8596) 1006 P [SVR] 144497590 - Cald_CamCtrl_FSM_Func_CancelAutoLock (0)
05-26 09:39:14.058: INFO/caladbolg(105): 144497620 cald_camctrl.c (4155) 1006 P [SVR] 144497620 - Cald_CamCtrl_ICamera_CancelAutoLock (0)
05-26 09:39:14.058: INFO/caladbolg(105): 144500061 cald_camctrl.c (6201) 1006 P [SVR] 144500031 + Cald_CamCtrl_PowerDown
05-26 09:39:14.058: INFO/caladbolg(105): 144500122 cald_camctrl.c (6941) 1006 P [SVR] 144500122 + Cald_CamCtrl_FSM_Func_PowerDown
05-26 09:39:14.058: INFO/caladbolg(105): 144501709 cald_hal_qct.c (2864) 1006 P [HAL] 144501679 + Cald_Hal_Qct_If_PowerDown
05-26 09:39:14.088: DEBUG/kernel(112): [ 152.727691] mdp4_overlay_pipe_free: pipe=806fa520 ndx=5
05-26 09:39:14.088: DEBUG/kernel(112): [ 152.727722] mdp4_overlay_pipe_free: pipe=806fa678 ndx=6
05-26 09:39:14.228: DEBUG/kernel(112): [ 152.860137] mdp4_dtv_off
05-26 09:39:14.278: INFO/caladbolg(105): 144717286 cald_hal_qct.c (2888) 1006 P [HAL] 144717255 - Cald_Hal_Qct_If_PowerDown (0)
05-26 09:39:14.278: INFO/caladbolg(105): 144718720 cald_camctrl.c (6979) 1006 P [SVR] 144718720 - Cald_CamCtrl_FSM_Func_PowerDown (0)
05-26 09:39:14.278: INFO/caladbolg(105): 144718903 cald_camctrl.c (6206) 1006 P [SVR] 144718903 - Cald_CamCtrl_PowerDown (0)
05-26 09:39:14.308: DEBUG/AndroidRuntime(952): Shutting down VM
05-26 09:39:14.308: WARN/dalvikvm(952): threadid=1: thread exiting with uncaught exception (group=0x2aac8560)
05-26 09:39:14.318: ERROR/TiUncaughtHandler(952): (main) [5649,10361] Sending event: exception on thread: main msg:java.lang.RuntimeException: Failure delivering result ResultInfo{who=null, request=1, result=-1, data=Intent { act=inline-data dat=file:///sdcard/dcim/Camera/zapon/tia1482999171.jpg typ=image/jpeg (has extras) }} to activity {com.zapon.zapon/org.appcelerator.titanium.TiActivity}: java.lang.NullPointerException; Titanium 1.7.0,2011/03/31 12:08,6cae16
05-26 09:39:14.318: ERROR/TiUncaughtHandler(952): java.lang.RuntimeException: Failure delivering result ResultInfo{who=null, request=1, result=-1, data=Intent { act=inline-data dat=file:///sdcard/dcim/Camera/zapon/tia1482999171.jpg typ=image/jpeg (has extras) }} to activity {com.zapon.zapon/org.appcelerator.titanium.TiActivity}: java.lang.NullPointerException
05-26 09:39:14.318: ERROR/TiUncaughtHandler(952): at android.app.ActivityThread.deliverResults(ActivityThread.java:2504)
05-26 09:39:14.318: ERROR/TiUncaughtHandler(952): at android.app.ActivityThread.handleSendResult(ActivityThread.java:2546)
05-26 09:39:14.318: ERROR/TiUncaughtHandler(952): at android.app.ActivityThread.access$2000(ActivityThread.java:121)
05-26 09:39:14.318: ERROR/TiUncaughtHandler(952): at android.app.ActivityThread$H.handleMessage(ActivityThread.java:966)
05-26 09:39:14.318: ERROR/TiUncaughtHandler(952): at android.os.Handler.dispatchMessage(Handler.java:99)
05-26 09:39:14.318: ERROR/TiUncaughtHandler(952): at android.os.Looper.loop(Looper.java:123)
05-26 09:39:14.318: ERROR/TiUncaughtHandler(952): at android.app.ActivityThread.main(ActivityThread.java:3652)
05-26 09:39:14.318: ERROR/TiUncaughtHandler(952): at java.lang.reflect.Method.invokeNative(Native Method)
05-26 09:39:14.318: ERROR/TiUncaughtHandler(952): at java.lang.reflect.Method.invoke(Method.java:507)
05-26 09:39:14.318: ERROR/TiUncaughtHandler(952): at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:862)
05-26 09:39:14.318: ERROR/TiUncaughtHandler(952): at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:620)
05-26 09:39:14.318: ERROR/TiUncaughtHandler(952): at dalvik.system.NativeStart.main(Native Method)
05-26 09:39:14.318: ERROR/TiUncaughtHandler(952): Caused by: java.lang.NullPointerException
05-26 09:39:14.318: ERROR/TiUncaughtHandler(952): at java.io.File.fixSlashes(File.java:205)
05-26 09:39:14.318: ERROR/TiUncaughtHandler(952): at java.io.File.init(File.java:189)
05-26 09:39:14.318: ERROR/TiUncaughtHandler(952): at java.io.File.<init>(File.java:139)
05-26 09:39:14.318: ERROR/TiUncaughtHandler(952): at ti.modules.titanium.media.MediaModule$CameraResultHandler.onResult(MediaModule.java:318)
05-26 09:39:14.318: ERROR/TiUncaughtHandler(952): at org.appcelerator.titanium.util.TiActivitySupportHelper$1.onResult(TiActivitySupportHelper.java:52)
05-26 09:39:14.318: ERROR/TiUncaughtHandler(952): at org.appcelerator.titanium.util.TiActivitySupportHelper.onActivityResult(TiActivitySupportHelper.java:68)
05-26 09:39:14.318: ERROR/TiUncaughtHandler(952): at org.appcelerator.titanium.TiBaseActivity.onActivityResult(TiBaseActivity.java:351)
05-26 09:39:14.318: ERROR/TiUncaughtHandler(952): at android.app.Activity.dispatchActivityResult(Activity.java:3907)
05-26 09:39:14.318: ERROR/TiUncaughtHandler(952): at android.app.ActivityThread.deliverResults(ActivityThread.java:2500)
05-26 09:39:14.318: ERROR/TiUncaughtHandler(952): ... 11 more
05-26 09:39:14.348: ERROR/AndroidRuntime(952): FATAL EXCEPTION: main
05-26 09:39:14.348: ERROR/AndroidRuntime(952): java.lang.RuntimeException: Failure delivering result ResultInfo{who=null, request=1, result=-1, data=Intent { act=inline-data dat=file:///sdcard/dcim/Camera/zapon/tia1482999171.jpg typ=image/jpeg (has extras) }} to activity {com.zapon.zapon/org.appcelerator.titanium.TiActivity}: java.lang.NullPointerException
05-26 09:39:14.348: ERROR/AndroidRuntime(952): at android.app.ActivityThread.deliverResults(ActivityThread.java:2504)
05-26 09:39:14.348: ERROR/AndroidRuntime(952): at android.app.ActivityThread.handleSendResult(ActivityThread.java:2546)
05-26 09:39:14.348: ERROR/AndroidRuntime(952): at android.app.ActivityThread.access$2000(ActivityThread.java:121)
05-26 09:39:14.348: ERROR/AndroidRuntime(952): at android.app.ActivityThread$H.handleMessage(ActivityThread.java:966)
05-26 09:39:14.348: ERROR/AndroidRuntime(952): at android.os.Handler.dispatchMessage(Handler.java:99)
05-26 09:39:14.348: ERROR/AndroidRuntime(952): at android.os.Looper.loop(Looper.java:123)
05-26 09:39:14.348: ERROR/AndroidRuntime(952): at android.app.ActivityThread.main(ActivityThread.java:3652)
05-26 09:39:14.348: ERROR/AndroidRuntime(952): at java.lang.reflect.Method.invokeNative(Native Method)
05-26 09:39:14.348: ERROR/AndroidRuntime(952): at java.lang.reflect.Method.invoke(Method.java:507)
05-26 09:39:14.348: ERROR/AndroidRuntime(952): at com.android.internal.os.ZygoteInit$MethodAndArgsCaller.run(ZygoteInit.java:862)
05-26 09:39:14.348: ERROR/AndroidRuntime(952): at com.android.internal.os.ZygoteInit.main(ZygoteInit.java:620)
05-26 09:39:14.348: ERROR/AndroidRuntime(952): at dalvik.system.NativeStart.main(Native Method)
05-26 09:39:14.348: ERROR/AndroidRuntime(952): Caused by: java.lang.NullPointerException
05-26 09:39:14.348: ERROR/AndroidRuntime(952): at java.io.File.fixSlashes(File.java:205)
05-26 09:39:14.348: ERROR/AndroidRuntime(952): at java.io.File.init(File.java:189)
05-26 09:39:14.348: ERROR/AndroidRuntime(952): at java.io.File.<init>(File.java:139)
05-26 09:39:14.348: ERROR/AndroidRuntime(952): at ti.modules.titanium.media.MediaModule$CameraResultHandler.onResult(MediaModule.java:318)
05-26 09:39:14.348: ERROR/AndroidRuntime(952): at org.appcelerator.titanium.util.TiActivitySupportHelper$1.onResult(TiActivitySupportHelper.java:52)
05-26 09:39:14.348: ERROR/AndroidRuntime(952): at org.appcelerator.titanium.util.TiActivitySupportHelper.onActivityResult(TiActivitySupportHelper.java:68)
05-26 09:39:14.348: ERROR/AndroidRuntime(952): at org.appcelerator.titanium.TiBaseActivity.onActivityResult(TiBaseActivity.java:351)
05-26 09:39:14.348: ERROR/AndroidRuntime(952): at android.app.Activity.dispatchActivityResult(Activity.java:3907)
05-26 09:39:14.348: ERROR/AndroidRuntime(952): at android.app.ActivityThread.deliverResults(ActivityThread.java:2500)
05-26 09:39:14.348: ERROR/AndroidRuntime(952): ... 11 more
05-26 09:39:14.358: WARN/ActivityManager(226): Force finishing activity com.zapon.zapon/org.appcelerator.titanium.TiActivity
05-26 09:39:14.868: WARN/ActivityManager(226): Activity pause timeout for HistoryRecord{2b3d3ae0 com.zapon.zapon/org.appcelerator.titanium.TiActivity}
05-26 09:39:15.118: DEBUG/MediaScannerService(526): IMediaScannerService.scanFile: /mnt/sdcard/DCIM/Camera/zapon/tia1482999171.jpg mimeType: null
05-26 09:39:15.368: VERBOSE/AudioService(226): HDMI disconnected
05-26 09:39:15.368: WARN/AudioPolicyManager(105): setDeviceConnectionState() device not connected: 800
05-26 09:39:15.388: DEBUG/dalvikvm(526): GC_EXTERNAL_ALLOC freed 419K, 54% free 2755K/5895K, external 2211K/2239K, paused 26ms
05-26 09:39:16.158: INFO/Process(952): Sending signal. PID: 952 SIG: 9
05-26 09:39:16.168: ERROR/InputDispatcher(226): channel '2b392150 com.zapon.zapon/com.zapon.zapon.ZaponActivity (server)' ~ Consumer closed input channel or an error occurred. events=0x8
05-26 09:39:16.168: ERROR/InputDispatcher(226): channel '2b392150 com.zapon.zapon/com.zapon.zapon.ZaponActivity (server)' ~ Channel is unrecoverably broken and will be disposed!
05-26 09:39:16.168: INFO/ActivityManager(226): Process com.zapon.zapon (pid 952) has died.
05-26 09:39:16.178: INFO/WindowManager(226): WIN DEATH: Window{2b392150 com.zapon.zapon/com.zapon.zapon.ZaponActivity paused=false}
05-26 09:39:16.178: INFO/WindowManager(226): WIN DEATH: Window{2b323420 com.zapon.zapon/org.appcelerator.titanium.TiActivity paused=false}
05-26 09:39:16.188: INFO/WindowManager(226): Setting rotation to 0, animFlags=1
05-26 09:39:16.188: INFO/ActivityManager(226): Config changed: { scale=1.0 imsi=270/1 loc=en_US touch=3 keys=1/1/2 nav=1/1 orien=1 layout=34 uiMode=17 seq=6}
05-26 09:39:16.238: DEBUG/GestureDetector(302): touchSlop:31 doubleTapSlop:195
05-26 09:39:16.428: DEBUG/dalvikvm(302): GC_EXTERNAL_ALLOC freed 334K, 50% free 3041K/6023K, external 2757K/2760K, paused 171ms
05-26 09:39:16.518: INFO/CustomizationProvider(855): No configuration file: /system/etc/customization/settings/com/sonyericsson/textinput/uxp/custom_settings.xml
05-26 09:39:16.638: WARN/IInputConnectionWrapper(980): getTextBeforeCursor on inactive InputConnection
05-26 09:39:16.638: WARN/IInputConnectionWrapper(980): getExtractedText on inactive InputConnection
05-26 09:39:16.638: WARN/IInputConnectionWrapper(980): showStatusIcon on inactive InputConnection
05-26 09:39:16.658: INFO/CustomizationProvider(855): No configuration file: /system/etc/customization/settings/com/sonyericsson/textinput/uxp/custom_settings.xml
05-26 09:39:16.868: VERBOSE/AudioService(226): HDMI disconnected
05-26 09:39:16.868: WARN/AudioPolicyManager(105): setDeviceConnectionState() device not connected: 800
05-26 09:39:17.288: DEBUG/AudioHardwareMSM7X30(105): AudioStreamOutMSM72xx::standby()
05-26 09:39:17.288: DEBUG/AudioHardwareMSM7X30(105): updateDeviceInfo: E rx_device 6 and tx_device 12
05-26 09:39:17.288: DEBUG/AudioHardwareMSM7X30(105): No active voicecall/playback, disabling cur_rx 6
05-26 09:39:17.288: DEBUG/AudioHardwareMSM7X30(105): value of device and enable is 6 0
05-26 09:39:17.298: DEBUG/kernel(112): [ 155.937438] [msm7x30.c:msm_device_put] device speaker_stereo_rx set 0
05-26 09:39:17.298: DEBUG/kernel(112): [ 155.939392] msm_snddev_poweramp_off: power off amplifier
05-26 09:39:17.298: DEBUG/AudioHardwareMSM7X30(105): No active voicecall/recording, disabling cur_tx 12
05-26 09:39:17.298: DEBUG/AudioHardwareMSM7X30(105): value of device and enable is 12 0
05-26 09:39:17.298: DEBUG/AudioHardwareMSM7X30(105): updateDeviceInfo: X cur_rx 6 cur_tx 12
05-26 09:39:17.308: DEBUG/kernel(112): [ 155.943023] [adsp.c:msm_adsp_put] closing module AFETASK
05-26 09:39:17.308: DEBUG/kernel(112): [ 155.944030] [msm7x30.c:msm_device_put] device speaker_mono_tx set 0
05-26 09:39:17.308: DEBUG/kernel(112): [ 155.944274] [audpp.c:audpp_dsp_event] DISABLE
05-26 09:39:17.308: DEBUG/kernel(112): [ 155.944488] [audpp.c:audpp_disable] Received CFG_MSG_DISABLE from ADSP
05-26 09:39:17.308: DEBUG/kernel(112): [ 155.944549] [adsp.c:msm_adsp_disable] disable interrupt
05-26 09:39:17.308: DEBUG/kernel(112): [ 155.944580] [adsp.c:msm_adsp_put] closing module AUDPPTASK
Issue is caused by a bug in [MediaModule.java:onResult:L247](https://github.com/appcelerator/titanium_mobile/blob/master/android/modules/media/src/ti/modules/titanium/media/MediaModule.java#L247)
Please read the comments in the following for the solution:
public void onResult(Activity activity, int requestCode, int resultCode, Intent data)
{
if (resultCode == Activity.RESULT_CANCELED) {
//....
} else {
// Problem begins here
if (data == null) {
// Some code..
} else {
// ... more code
Cursor c = activity.getContentResolver().query(data.getData(), projection, null, null, null);
// on the Xperia ARC the cursor is NULL, I can't tell why
if (c != null) {
// the variable dataPath is initialized for the first time in this block, but this code
// part is never reached for the Xperia Arc
}
// Therefor dataPath is NULL, that's why a NPE occurs later on
// There is no error handling for a null cursor, but code after this line
// totally expects it to have done its job...
String localImageUrl = dataPath;
}
}
}
My workaround for this was:
Check if cursor will be null, if so, then ignore the passed data, and go right into the EXTRA_OUTPUT codeblock..
Not clean, but at least it works.
Also you should get an Xperia arc, as there are other bugs
(Kitchensink crashes, tap from dashboard opens the application several times instead of opening the existing ones, etc...)
Thanks
Patric Thank you for this ticket. Please note the changes I made to improve it. One useful tip is that it's always good to have code and logs in the ticket rather than to provide a link. A jira markup code block is good for this. I have now moved this ticket to the proper project. Cheers
I am not sure but it is possible that this bug affects several Xperia devices (Arc, Arc S, SK17i, ...). It would be a great improvement to avoid this crash ! It is opened since July 2011 and nothing seems to be planned to fix this...
Many users are complaining about this on our Android app. Here is a list of devices (all are Xperia) in which crashes happen : Xperia Arc X10 (X10i), Xperia Arc S (LT18i), Xperia Ray (ST18i), Xperia Mini Pro (SK17i), Xperia Arc X12 (LT15i), Xperia U (ST25i), Xperia Active (ST17i) It may affects all Xperia devices. Moreover, this bug is still present for new SDK versions : our new app version is using the Titanium SDK 2.1.1.GA and the crashes remain.
Same issues for me (with SDK 2.1.1.GA). And it's quite annoying since my app can't work anymore without this functionality...
Hi guys, is it planned to have this bug fixed anytime soon ? It's really annoying since my app is based on taking pictures. It's been a year since this ticket has been opened and nothing seems to have been done. Cheers,
I solved this issue, thanks to Patric's post. To be more specific, I did the following: - in the MediaModule.java file (line 421): if (c == null) { dataPath = "file://" + imageFile.getAbsolutePath(); } else { ... } String localImageUrl = dataPath; Not pretty, but it works. I'm still hoping to have an official fix by Appcelerator's team. Edit: I added a pull request on Appcelerator's Github. Juste follow the link: https://github.com/appcelerator/titanium_mobile/pull/3093
Hi, I have to solve this issue too but i can't find the right file "MediaModule.java" in the Titanium sdk folder "AppData\Roaming\Titanium\mobilesdk\win32\2.1.3.GA". Can somebody help me ?
Same crash log. Different device
Resolving as duplicate. Should be fixed with fix for TIMOB-12848 https://github.com/appcelerator/titanium_mobile/pull/3992
Closing ticket as duplicate with reference to the linked issues above.