allgood / OpenNoteScanner

Android application for scanning and manipulating handwritten notes and documents.
Other
1.36k stars 283 forks source link

crash on startup #85

Closed enaut closed 7 years ago

enaut commented 7 years ago

Hey immediately on startup the app crashes with the following log on Oneplus 5 with resurrection remix and no gapps installed - any help would be apreciated:

The most relevant part might be:

08-25 08:21:07.245  9748  9766 E cv::error(): OpenCV Error: Assertion failed (_dx.type() == CV_16SC1 || _dx.type() == CV_16SC3) in void cv::Canny(cv::InputArray, cv::InputArray, cv::OutputArray, double, double, bool), file /build/master_pack-android/opencv/modules/imgproc/src/canny.cpp, line 1076
08-25 08:21:07.246  9748  9766 E org.opencv.imgproc: imgproc::Canny_11() caught cv::Exception: /build/master_pack-android/opencv/modules/imgproc/src/canny.cpp:1076: error: (-215) _dx.type() == CV_16SC1 || _dx.type() == CV_16SC3 in function void cv::Canny(cv::InputArray, cv::InputArray, cv::OutputArray, double, double, bool)
08-25 08:21:07.247  9748  9766 E AndroidRuntime: FATAL EXCEPTION: Worker Thread
08-25 08:21:07.247  9748  9766 E AndroidRuntime: Process: com.todobom.opennotescanner, PID: 9748
08-25 08:21:07.247  9748  9766 E AndroidRuntime: CvException [org.opencv.core.CvException: cv::Exception: /build/master_pack-android/opencv/modules/imgproc/src/canny.cpp:1076: error: (-215) _dx.type() == CV_16SC1 || _dx.type() == CV_16SC3 in function void cv::Canny(cv::InputArray, cv::InputArray, cv::OutputArray, double, double, bool)
08-25 08:21:07.247  9748  9766 E AndroidRuntime: ]
08-25 08:21:07.247  9748  9766 E AndroidRuntime:    at org.opencv.imgproc.Imgproc.Canny_1(Native Method)
08-25 08:21:07.247  9748  9766 E AndroidRuntime:    at org.opencv.imgproc.Imgproc.Canny(Imgproc.java:984)
08-25 08:21:07.247  9748  9766 E AndroidRuntime:    at com.todobom.opennotescanner.ImageProcessor.findContours(ImageProcessor.java:497)
08-25 08:21:07.247  9748  9766 E AndroidRuntime:    at com.todobom.opennotescanner.ImageProcessor.detectPreviewDocument(ImageProcessor.java:213)
08-25 08:21:07.247  9748  9766 E AndroidRuntime:    at com.todobom.opennotescanner.ImageProcessor.processPreviewFrame(ImageProcessor.java:132)
08-25 08:21:07.247  9748  9766 E AndroidRuntime:    at com.todobom.opennotescanner.ImageProcessor.handleMessage(ImageProcessor.java:89)
08-25 08:21:07.247  9748  9766 E AndroidRuntime:    at android.os.Handler.dispatchMessage(Handler.java:102)
08-25 08:21:07.247  9748  9766 E AndroidRuntime:    at android.os.Looper.loop(Looper.java:154)
08-25 08:21:07.247  9748  9766 E AndroidRuntime:    at android.os.HandlerThread.run(HandlerThread.java:61)
08-25 08:21:06.268  2602  2602 D wpa_supplicant: wlan0: Control interface command 'SIGNAL_POLL'
08-25 08:21:06.271  2602  2602 D wpa_supplicant: CTRL-DEBUG: global_ctrl_sock-sendto: sock=9 sndbuf=212992 outq=0 send_len=62
08-25 08:21:06.397  1538  2211 I AudioPolicyManagerCustom: FLAG None hence request for a primary output
08-25 08:21:06.398  1538  2212 I AudioPolicyManagerCustom: FLAG None hence request for a primary output
08-25 08:21:06.400  1668  2417 I ActivityManager: START u0 {act=android.intent.action.MAIN cat=[android.intent.category.LAUNCHER] flg=0x10200000 cmp=com.todobom.opennotescanner/.OpenNoteScannerActivity (has extras)} from uid 10039 on display 0
08-25 08:21:06.403  1538  1599 D audio_hw_primary: start_output_stream: enter: stream(0xeb353a00)usecase(1: low-latency-playback) devices(0x2)
08-25 08:21:06.404  1538  1599 D audio_hw_primary: select_devices for use case (low-latency-playback)
08-25 08:21:06.404  1538  1599 D audio_hw_primary: select_devices: out_snd_device(2: speaker) in_snd_device(0: )
08-25 08:21:06.404  1538  1599 I msm8974_platform: platform_check_and_set_codec_backend_cfg:becf: afe: bitwidth 24, samplerate 48000 channels 2, backend_idx 0 usecase = 1 device (speaker)
08-25 08:21:06.404  1538  1599 D msm8974_platform: platform_split_snd_device: snd_device(2) new_snd_devices (speaker)
08-25 08:21:06.405  1538  1599 I msm8974_platform: platform_check_and_set_codec_backend_cfg: new_snd_devices[0] is 2
08-25 08:21:06.405  1538  1599 I msm8974_platform: platform_check_codec_backend_cfg:becf: afe: bitwidth 24, samplerate 48000 channels 2, backend_idx 0 usecase = 1 device (speaker)
08-25 08:21:06.405  1538  1599 D msm8974_platform: platform_check_codec_backend_cfg:becf: afe: reset bitwidth to 24 (based on supported value for this platform)
08-25 08:21:06.405  1538  1599 D msm8974_platform: platform_check_codec_backend_cfg:becf: afe: playback on codec device not supporting native playback set default Sample Rate(48k)
08-25 08:21:06.405  1538  1599 I msm8974_platform: platform_check_codec_backend_cfg:becf: afe: Codec selected backend: 0 updated bit width: 24 and sample rate: 48000
08-25 08:21:06.405  1538  1599 D audio_hw_primary: check_usecases_codec_backend:becf: force routing 0
08-25 08:21:06.405  1538  1599 E msm8974_platform: platform_check_backends_match: Invalid snd_device = 
08-25 08:21:06.405  1538  1599 D audio_hw_primary: check_usecases_codec_backend:becf: (44) check_usecases curr device: speaker, usecase device: backends match 0
08-25 08:21:06.405  1538  1599 D audio_hw_primary: check_usecases_codec_backend:becf: check_usecases num.of Usecases to switch 0
08-25 08:21:06.405  1538  1599 D hardware_info: hw_info_append_hw_type : device_name = speaker
08-25 08:21:06.405  1538  1599 D msm8974_platform: platform_split_snd_device: snd_device(2) new_snd_devices (speaker)
08-25 08:21:06.405  1538  1599 D audio_hw_primary: enable_snd_device: snd_device(2: speaker)
08-25 08:21:06.406  1538  1599 I soundtrigger: audio_extn_sound_trigger_update_device_status: device 0x2 of type 0 for Event 1, with Raise=0
08-25 08:21:06.406  1538  1599 I audio_hw_utils: audio_extn_utils_update_stream_output_app_type_cfg Allowing 24-bit playback on speaker ONLY at default sampling rate
08-25 08:21:06.406  1538  1599 D soundtrigger: audio_extn_sound_trigger_update_stream_status: uc_id 1 of type 0 for Event 3, with Raise=0
08-25 08:21:06.406  1538  1599 D audio_hw_utils: audio_extn_utils_send_app_type_cfg: usecase->out_snd_device speaker
08-25 08:21:06.406  1538  1599 D msm8974_platform: platform_split_snd_device: snd_device(2) new_snd_devices (speaker)
08-25 08:21:06.407  1538  1599 I audio_hw_utils: send_app_type_cfg_for_device PLAYBACK app_type 69937, acdb_dev_id 15, sample_rate 48000, snd_device_be_idx 2
08-25 08:21:06.409  1538  1599 D msm8974_platform: platform_split_snd_device: snd_device(2) new_snd_devices (speaker)
08-25 08:21:06.409  1538  1599 D ACDB-LOADER: ACDB -> send_audio_cal, acdb_id = 15, path = 0, app id = 0x11131, sample rate = 48000
08-25 08:21:06.409  1538  1599 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_GAIN_DEP_STEP_TABLE, vol index 0
08-25 08:21:06.409  1538  1599 D ACDB-LOADER: ACDB -> AUDIO_SET_VOL_CAL cal type = 12
08-25 08:21:06.410  1538  1599 D ACDB-LOADER: ACDB -> audstrm_cal->cal_type.cal_data.cal_size = 16
08-25 08:21:06.410  1538  1599 D ACDB-LOADER: ACDB -> GET_AFE_TOPOLOGY_ID for adcd_id 15, Topology Id 1025e
08-25 08:21:06.410  1538  1599 D ACDB-LOADER: ACDB -> send_hw_delay : acdb_id = 15 path = 0
08-25 08:21:06.410  1538  1599 D audio_hw_primary: enable_audio_route: apply mixer and update path: low-latency-playback speaker
08-25 08:21:06.413  1538  1599 D audio_hw_primary: select_devices: done
08-25 08:21:06.416  1538  1599 D msm8974_platform: platform_set_channel_map mixer_ctl_name:Playback Channel Map13
08-25 08:21:06.416  1538  1599 D msm8974_platform: platform_set_channel_map: set mapping(1 2 0 0 0 0 0 0) for channel:2
08-25 08:21:06.433  1668  1692 I ActivityManager: Start proc 9748:com.todobom.opennotescanner/u0a98 for activity com.todobom.opennotescanner/.OpenNoteScannerActivity
08-25 08:21:06.440  1538  1599 D audio_hw_primary: start_output_stream: exit
08-25 08:21:06.441   687  2990 E ANDR-PERF-RESOURCEQS: Failed to reset optimization [3, 0]
08-25 08:21:06.450  9748  9748 I art     : Starting a blocking GC AddRemoveAppImageSpace
08-25 08:21:06.452  9748  9748 W System  : ClassLoader referenced unknown path: /data/app/com.todobom.opennotescanner-1/lib/arm64
08-25 08:21:06.490  9748  9748 D OpenNoteScannerActivity: resuming
08-25 08:21:06.490  9748  9748 D OpenNoteScannerActivity: myBuild arm64-v8a
08-25 08:21:06.490  9748  9748 D OpenNoteScannerActivity: myBuild armeabi-v7a
08-25 08:21:06.490  9748  9748 D OpenNoteScannerActivity: myBuild armeabi
08-25 08:21:06.493  9457  9457 D OpenCVEngine/Service: Service starting
08-25 08:21:06.493  9457  9457 D OpenCVEngine/Service: Found config: config330
08-25 08:21:06.494  9457  9457 D OpenCVEngine/Service: Added config: 3.3.0
08-25 08:21:06.494  9457  9457 I OpenCVEngine/Service: Service onBind called for intent Intent { act=org.opencv.engine.BIND pkg=org.opencv.engine }
08-25 08:21:06.495  9457  9457 I OpenCVEngine/Service: Service onUnbind called for intent Intent { act=org.opencv.engine.BIND pkg=org.opencv.engine }
08-25 08:21:06.497  9457  9457 D OpenCVEngine/Service: Service starting
08-25 08:21:06.497  9457  9457 D OpenCVEngine/Service: Found config: config330
08-25 08:21:06.498  9457  9457 D OpenCVEngine/Service: Added config: 3.3.0
08-25 08:21:06.498  9457  9457 I OpenCVEngine/Service: Service onBind called for intent Intent { act=org.opencv.engine.BIND pkg=org.opencv.engine }
08-25 08:21:06.506  9748  9748 D OpenCVManager/Helper: Service connection created
08-25 08:21:06.507  9748  9748 D OpenCVManager/Helper: Trying to get library path
08-25 08:21:06.508  9748  9748 D OpenCVManager/Helper: Trying to get library list
08-25 08:21:06.508  9748  9748 D OpenCVManager/Helper: Library list: "libopencv_java3.so"
08-25 08:21:06.508  9748  9748 D OpenCVManager/Helper: First attempt to load libs
08-25 08:21:06.508  9748  9748 D OpenCVManager/Helper: Trying to init OpenCV libs
08-25 08:21:06.508  9748  9748 D OpenCVManager/Helper: Trying to load libs by dependency list
08-25 08:21:06.508  9748  9748 D OpenCVManager/Helper: Trying to load library /data/app/org.opencv.engine-1/lib/arm64/libopencv_java3.so
08-25 08:21:06.513  9748  9748 D OpenCVManager/Helper: OpenCV libs init was ok!
08-25 08:21:06.513  9748  9748 D OpenCVManager/Helper: First attempt to load libs is OK
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper: 
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper: General configuration for OpenCV 3.3.0 =====================================
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:   Version control:               3.3.0
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper: 
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:   Platform:
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     Timestamp:                   2017-08-04T00:37:11Z
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     Host:                        Linux 4.8.0-58-generic x86_64
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     Target:                      Linux 1 aarch64
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     CMake:                       2.8.12.2
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     CMake generator:             Ninja
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     CMake build tool:            /usr/bin/ninja
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     Configuration:               Release
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper: 
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:   CPU/HW features:
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     Baseline:                    NEON
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:       requested:                 NEON FP16
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:       required:                  NEON
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:       disabled:                  VFPV3
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper: 
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:   C/C++:
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     Built as dynamic libs?:      NO
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     C++ Compiler:                /usr/bin/ccache /opt/android/android-ndk-r10e/toolchains/aarch64-linux-android-4.9/prebuilt/linux-x86_64/bin/aarch64-linux-android-g++ (ver 4.9)
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     C++ flags (Release):         -fexceptions -frtti -Wno-psabi --sysroot=/opt/android/android-ndk-r10e/platforms/android-21/arch-arm64 -funwind-tables -fsigned-char -no-canonical-prefixes -fdata-sections -ffunction-sections -Wa,--noexecstack    -fsigned-char -W -Wall -Werror=return-type -Werror=non-virtual-dtor -Werror=address -Werror=sequence-point -Wformat -Werror=format-security -Wmissing-declarations -Wundef -Winit-self -Wpointer-arith -Wshadow -Wsign-promo -Wuninitialized -Winit-self -Wno-narrowing -Wno-delete-non-virtual-dtor -Wno-comment -fdiagnostics-show-option -fomit-frame-pointer   -fvisibility=hidden -fvisibility-inlines-hidden -fomit-frame-pointer -fstrict-aliasing -funswitch-loops -finline-limit=300 -O3 -DNDEBUG  -DNDEBUG
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     C++ flags (Debug):           -fexceptions -frtti -Wno-psabi --sysroot=/opt/android/android-ndk-r10e/platforms/android-21/arch-arm64 -funwind-tables -fsigned-char -no-canonical-prefixes -fdata-sections -ffunction-sections -Wa,--noexecstack    -fsigned-char -W -Wall -Werror=return-type -Werror=non-virtual-dtor -Werror=address -Werror=sequence-point -Wformat -Werror=format-security -Wmissing-declarations -Wundef -Winit-self -Wpointer-arith -Wshadow -Wsign-promo -Wuninitialized -Winit-self -Wno-narrowing -Wno-delete-non-virtual-dtor -Wno-comment -fdiagnostics-show-option -fomit-frame-pointer   -fvisibility=hidden -fvisibility-inlines-hidden -fno-omit-frame-pointer -fno-strict-aliasing -O0 -g -DDEBUG -D_DEBUG  -DDEBUG -D_DEBUG
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     C Compiler:                  /usr/bin/ccache /opt/android/android-ndk-r10e/toolchains/aarch64-linux-android-4.9/prebuilt/linux-x86_64/bin/aarch64-linux-android-gcc
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     C flags (Release):           -fexceptions -Wno-psabi --sysroot=/opt/android/android-ndk-r10e/platforms/android-21/arch-arm64 -funwind-tables -fsigned-char -no-canonical-prefixes -fdata-sections -ffunction-sections -Wa,--noexecstack    -fsigned-char -W -Wall -Werror=return-type -Werror=non-virtual-dtor -Werror=address -Werror=sequence-point -Wformat -Werror=format-security -Wmissing-declarations -Wmissing-prototypes -Wstrict-prototypes -Wundef -Winit-self -Wpointer-arith -Wshadow -Wuninitialized -Winit-self -Wno-narrowing -Wno-comment -fdiagnostics-show-option -fomit-frame-pointer   -fvisibility=hidden -fomit-frame-pointer -fstrict-aliasing -funswitch-loops -finline-limit=300 -O3 -DNDEBUG  -DNDEBUG
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     C flags (Debug):             -fexceptions -Wno-psabi --sysroot=/opt/android/android-ndk-r10e/platforms/android-21/arch-arm64 -funwind-tables -fsigned-char -no-canonical-prefixes -fdata-sections -ffunction-sections -Wa,--noexecstack    -fsigned-char -W -Wall -Werror=return-type -Werror=non-virtual-dtor -Werror=address -Werror=sequence-point -Wformat -Werror=format-security -Wmissing-declarations -Wmissing-prototypes -Wstrict-prototypes -Wundef -Winit-self -Wpointer-arith -Wshadow -Wuninitialized -Winit-self -Wno-narrowing -Wno-comment -fdiagnostics-show-option -fomit-frame-pointer   -fvisibility=hidden -fno-omit-frame-pointer -fno-strict-aliasing -O0 -g -DDEBUG -D_DEBUG  -DDEBUG -D_DEBUG
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     Linker flags (Release):      -Wl,--no-undefined -Wl,--gc-sections -Wl,-z,noexecstack -Wl,-z,relro -Wl,-z,now 
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     Linker flags (Debug):        -Wl,--no-undefined -Wl,--gc-sections -Wl,-z,noexecstack -Wl,-z,relro -Wl,-z,now 
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     ccache:                      YES
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     Precompiled headers:         NO
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     Extra dependencies:          z dl m log
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     3rdparty dependencies:       cpufeatures libprotobuf libjpeg libwebp libpng libtiff libjasper IlmImf tegra_hal tbb
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper: 
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:   OpenCV modules:
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     To be built:                 core flann imgproc ml objdetect photo video dnn imgcodecs shape videoio highgui superres features2d calib3d java stitching videostab
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     Disabled:                    world
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     Disabled by dependency:      -
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     Unavailable:                 cudaarithm cudabgsegm cudacodec cudafeatures2d cudafilters cudaimgproc cudalegacy cudaobjdetect cudaoptflow cudastereo cudawarping cudev python2 python3 ts viz
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper: 
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:   Android: 
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     Android ABI:                 arm64-v8a
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     STL type:                    gnustl_static
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     Native API level:            android-21
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     SDK target:                  android-21
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     Android NDK:                 /opt/android/android-ndk-r10e (toolchain: aarch64-linux-android-4.9)
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     android tool:                /opt/android/android-sdk-java7/tools/android (Android SDK Tools, revision 25.2.2.)
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     Google Play manager:         NO
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     Android examples:            YES
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper: 
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:   GUI: 
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     GTK+:                        NO
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     GThread :                    NO
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     GtkGlExt:                    NO
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     OpenGL support:              NO
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     VTK support:                 NO
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper: 
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:   Media I/O: 
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     ZLib:                        z (ver 1.2.3)
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     JPEG:                        build (ver 90)
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     WEBP:                        build (ver encoder: 0x020e)
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     PNG:                         build (ver 1.6.24)
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     TIFF:                        build (ver 42 - 4.0.2)
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     JPEG 2000:                   build (ver 1.900.1)
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     OpenEXR:                     build (ver 1.7.1)
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     GDAL:                        NO
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     GDCM:                        NO
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper: 
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:   Video I/O:
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper: 
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:   Parallel framework:            TBB (ver 4.4 interface 9003)
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper: 
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:   Trace:                         YES ()
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper: 
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:   Other third-party libraries:
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     Use Intel IPP:               NO
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     Use Intel IPP IW:            NO
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     Use Eigen:                   NO
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     Use Cuda:                    NO
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     Use OpenCL:                  NO
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     Use OpenVX:                  NO
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     Use custom HAL:              YES (carotene (ver 0.0.1))
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper: 
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:   Python 2:
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     Interpreter:                 /usr/bin/python2.7 (ver 2.7.6)
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper: 
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:   Python 3:
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     Interpreter:                 /usr/bin/python3.4 (ver 3.4.3)
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper: 
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:   Python (for build):            /usr/bin/python2.7
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper: 
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:   Java:
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     ant:                         /usr/bin/ant (ver 1.9.3)
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     Java wrappers:               YES
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     Java tests:                  NO
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper: 
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:   Matlab:                        NO
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper: 
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:   Tests and samples:
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     Tests:                       NO
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     Performance tests:           NO
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:     C/C++ Examples:              NO
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper: 
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:   Install path:                  /build/master_pack-android/build/o4a/install
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper: 
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper:   cvconfig.h is in:              /build/master_pack-android/build/o4a
08-25 08:21:06.514  9748  9748 I OpenCVManager/Helper: -----------------------------------------------------------------
08-25 08:21:06.514  9748  9748 D OpenCVManager/Helper: Init finished with status 0
08-25 08:21:06.514  9748  9748 D OpenCVManager/Helper: Unbind from service
08-25 08:21:06.515  9748  9748 D OpenCVManager/Helper: Calling using callback
08-25 08:21:06.516  9457  9457 I OpenCVEngine/Service: Service onUnbind called for intent Intent { act=org.opencv.engine.BIND pkg=org.opencv.engine }
08-25 08:21:06.527  9748  9767 I Adreno  : QUALCOMM build                   : 8209866, I528a81912f
08-25 08:21:06.527  9748  9767 I Adreno  : Build Date                       : 04/01/17
08-25 08:21:06.527  9748  9767 I Adreno  : OpenGL ES Shader Compiler Version: XE031.14.00.02
08-25 08:21:06.527  9748  9767 I Adreno  : Local Branch                     : 
08-25 08:21:06.527  9748  9767 I Adreno  : Remote Branch                    : 
08-25 08:21:06.527  9748  9767 I Adreno  : Remote Branch                    : 
08-25 08:21:06.527  9748  9767 I Adreno  : Reconstruct Branch               : 
08-25 08:21:06.528  9748  9767 I Adreno  : PFP: 0x005ff087, ME: 0x005ff063
08-25 08:21:06.529  9748  9767 I OpenGLRenderer: Initialized EGL, version 1.4
08-25 08:21:06.530  9748  9767 D OpenGLRenderer: Swap behavior 1
08-25 08:21:06.541  1539  8139 I CameraService: CameraService::connect call (PID -1 "com.todobom.opennotescanner", camera ID 0) for HAL version default and Camera API version 1
08-25 08:21:06.572  1540  9768 D NuPlayerDriver: notifyListener_l(0xea88cc00), (1, 0, 0), loop setting(0, 0)
08-25 08:21:06.586  1540  9770 D NuPlayerDriver: notifyListener_l(0xea88c660), (1, 0, 0), loop setting(0, 0)
08-25 08:21:06.596  1540  9772 D NuPlayerDriver: notifyListener_l(0xea88c0c0), (1, 0, 0), loop setting(0, 0)
08-25 08:21:06.596  1539  8139 I Camera2ClientBase: Camera 0: Opened. Client: com.todobom.opennotescanner (PID 9748, UID 10098)
08-25 08:21:06.598  1539  8139 I CameraService: onTorchStatusChangedLocked: Torch status changed for cameraId=0, newStatus=0
08-25 08:21:06.599  1539  8139 I QCamera : <HAL><INFO> int qcamera::QCamera2Factory::cameraDeviceOpen(int, struct hw_device_t **): 428: Open camera id 0 API version 768
08-25 08:21:06.602  1539  8139 I QCamera : <HAL><INFO> qcamera::QCamera3HardwareInterface::QCamera3HardwareInterface(uint32_t, const camera_module_callbacks_t *): 522: AV timer enabled: 0
08-25 08:21:06.605  1539  8139 D QCameraPerf: perfLockHandle 228, updated refCount: 1, perfLockType: 0
08-25 08:21:06.605  1539  8139 I QCamera : <HAL><INFO> int qcamera::QCamera3HardwareInterface::openCamera(struct hw_device_t **): 796: [KPI Perf]: E PROFILE_OPEN_CAMERA camera id 0
08-25 08:21:06.605  1539  8139 I CameraService: onTorchStatusChangedLocked: Torch status changed for cameraId=0, newStatus=0
08-25 08:21:06.613  1539  8139 D QCamera : Debug log file is not enabled
08-25 08:21:06.614  1539  8139 I mm-camera: <MCT   >< INFO> 116: mct_controller_new: Creating new mct_controller with session-id 4
08-25 08:21:06.614  1539  9777 I mm-camera: <MCT   >< INFO> 5165: mct_pipeline_start_session_thread: E sensor
08-25 08:21:06.614  1539  9777 I mm-camera: <MCT   >< INFO> 5172: mct_pipeline_start_session_thread: Calling start_session on Module sensor
08-25 08:21:06.614  1539  9778 I mm-camera: <MCT   >< INFO> 5165: mct_pipeline_start_session_thread: E iface
08-25 08:21:06.614  1539  9778 I mm-camera: <MCT   >< INFO> 5172: mct_pipeline_start_session_thread: Calling start_session on Module iface
08-25 08:21:06.614  1539  9780 I mm-camera: <MCT   >< INFO> 5165: mct_pipeline_start_session_thread: E isp
08-25 08:21:06.614  1539  9780 I mm-camera: <MCT   >< INFO> 5172: mct_pipeline_start_session_thread: Calling start_session on Module isp
08-25 08:21:06.614  1539  9780 I mm-camera: <ISP   >< INFO> 209: isp_module_start_session: session id 4 
08-25 08:21:06.615  1539  9781 I mm-camera: <MCT   >< INFO> 5165: mct_pipeline_start_session_thread: E stats
08-25 08:21:06.615  1539  9781 I mm-camera: <MCT   >< INFO> 5172: mct_pipeline_start_session_thread: Calling start_session on Module stats
08-25 08:21:06.615  1539  9778 I mm-camera: <MCT   >< INFO> 5175: mct_pipeline_start_session_thread: Module iface start_session rc = 1
08-25 08:21:06.615  1539  9778 I mm-camera: <MCT   >< INFO> 5183: mct_pipeline_start_session_thread: started_num = 1, success = 1
08-25 08:21:06.615  1539  9778 I mm-camera: <MCT   >< INFO> 5190: mct_pipeline_start_session_thread: X iface
08-25 08:21:06.615  1539  9784 I mm-camera: <MCT   >< INFO> 5165: mct_pipeline_start_session_thread: E pproc
08-25 08:21:06.615  1539  9784 I mm-camera: <MCT   >< INFO> 5172: mct_pipeline_start_session_thread: Calling start_session on Module pproc
08-25 08:21:06.615  1539  9780 I mm-camera: <MCT   >< INFO> 5175: mct_pipeline_start_session_thread: Module isp start_session rc = 1
08-25 08:21:06.615  1539  9780 I mm-camera: <MCT   >< INFO> 5183: mct_pipeline_start_session_thread: started_num = 2, success = 2
08-25 08:21:06.615  1539  9780 I mm-camera: <MCT   >< INFO> 5190: mct_pipeline_start_session_thread: X isp
08-25 08:21:06.615  1539  9787 I mm-camera: <MCT   >< INFO> 5165: mct_pipeline_start_session_thread: E imglib
08-25 08:21:06.616  1539  9787 I mm-camera: <MCT   >< INFO> 5172: mct_pipeline_start_session_thread: Calling start_session on Module imglib
08-25 08:21:06.616  1539  9787 I mm-camera: <MCT   >< INFO> 5175: mct_pipeline_start_session_thread: Module imglib start_session rc = 1
08-25 08:21:06.616  1539  9787 I mm-camera: <MCT   >< INFO> 5183: mct_pipeline_start_session_thread: started_num = 3, success = 3
08-25 08:21:06.616  1539  9787 I mm-camera: <MCT   >< INFO> 5190: mct_pipeline_start_session_thread: X imglib
08-25 08:21:06.616  1539  9790 I OPCAMERA_SENSOR: add_listener: listener=(0x0, 0xcfe61200)
08-25 08:21:06.616  1539  9781 I OPCAMERA_SENSOR: init_module: module=0xd04f8008 private=0xde87c080 list=0xcfe61220
08-25 08:21:06.617  1539  9784 I mm-camera: <MCT   >< INFO> 5175: mct_pipeline_start_session_thread: Module pproc start_session rc = 1
08-25 08:21:06.617  1539  9784 I mm-camera: <MCT   >< INFO> 5183: mct_pipeline_start_session_thread: started_num = 4, success = 4
08-25 08:21:06.617  1539  9784 I mm-camera: <MCT   >< INFO> 5190: mct_pipeline_start_session_thread: X pproc
08-25 08:21:06.618  1539  9781 I mm-camera: <MCT   >< INFO> 5175: mct_pipeline_start_session_thread: Module stats start_session rc = 1
08-25 08:21:06.618  1539  9781 I mm-camera: <MCT   >< INFO> 5183: mct_pipeline_start_session_thread: started_num = 5, success = 5
08-25 08:21:06.618  1539  9781 I mm-camera: <MCT   >< INFO> 5190: mct_pipeline_start_session_thread: X stats
08-25 08:21:06.619  1539  9792 I OPCAMERA_SENSOR: listener_func: listenerfd=61, pipe=(46, 47)
08-25 08:21:06.619  1539  9792 I OPCAMERA_SENSOR: listener_func: enable sensor=2 priv=0xde87c080
08-25 08:21:06.624  1539  9777 I mm-camera: <MCT   >< INFO> 5175: mct_pipeline_start_session_thread: Module sensor start_session rc = 1
08-25 08:21:06.624  1539  9777 I mm-camera: <MCT   >< INFO> 5183: mct_pipeline_start_session_thread: started_num = 6, success = 6
08-25 08:21:06.627  1539  9777 I mm-camera: <MCT   >< INFO> 5190: mct_pipeline_start_session_thread: X sensor
08-25 08:21:06.627  1539  9792 I OPCAMERA_SENSOR: listener_func: enable sensor=1 priv=0xde87c080
08-25 08:21:06.628  1539  8139 I mm-camera: <MCT   >< INFO> 5086: mct_pipeline_start_stream_internal: Adding session stream streamid= 0xf for session=4
08-25 08:21:06.628  1539  8139 I mm-camera: <MCT   >< INFO> 5134: mct_pipeline_start_stream_internal: Linking session stream for session 4
08-25 08:21:06.628  1539  8139 I mm-camera: <MCT   >< INFO> 517: mct_stream_start_link: Start linking Session-stream 0x4000f
08-25 08:21:06.628  1539  8139 I mm-camera: <ISP   >< INFO> 837: isp_port_check_caps_reserve: port 0xe777aa40 ide 4000f type 10 dim 0 0
08-25 08:21:06.628  1539  8139 I mm-camera: <PPROC >< INFO> 448: pproc_port_add_modules_to_stream: in identity 4000f stream 10 int_link = 0xe77f9300
08-25 08:21:06.628  1539  8139 I mm-camera: <PPROC >< INFO> 460: pproc_port_add_modules_to_stream: :LINK linking mods tmod and paaf for identity 4000f
08-25 08:21:06.628  1033  1052 E Sensors : sns_reg_la.c(188):reg read: offset 2304, num bytes: 1
08-25 08:21:06.628  1539  8139 I mm-camera: <PPROC >< INFO> 460: pproc_port_add_modules_to_stream: :LINK linking mods paaf and sac for identity 4000f
08-25 08:21:06.628  1539  8139 I mm-camera: <PPROC >< INFO> 460: pproc_port_add_modules_to_stream: :LINK linking mods sac and rtb for identity 4000f
08-25 08:21:06.629  1539  8139 I mm-camera: <PPROC >< INFO> 460: pproc_port_add_modules_to_stream: :LINK linking mods rtb and ppeiscore for identity 4000f
08-25 08:21:06.629  1539  8139 I mm-camera: <PPROC >< INFO> 460: pproc_port_add_modules_to_stream: :LINK linking mods ppeiscore and c2d for identity 4000f
08-25 08:21:06.629  1539  8139 I mm-camera: <C2D   >< INFO> 1545: c2d_module_notify_add_stream: width 0, height 0, stride 0, scanline 0, is_type 0
08-25 08:21:06.629  1539  8139 I mm-camera: <PPROC >< INFO> 460: pproc_port_add_modules_to_stream: :LINK linking mods c2d and cpp for identity 4000f
08-25 08:21:06.629  1539  8139 I mm-camera: <CPP   >< INFO> 2332: cpp_module_notify_add_stream: :stream 10, width 0, height 0, stride 0,scanline 0, framelen 0
08-25 08:21:06.629  1539  8139 I mm-camera: <CPP   >< INFO> 2514: cpp_module_notify_add_stream: : stream 10, fmt 1, asf_mode 0, sharpness_level 0.000000,asf mask 0, denoise 0, denoise_mask 0, dsdn mask 0,dsdn enable 0, tnr mask 0, tnr enable 0, ds_mask 0, luma dsdn 0
08-25 08:21:06.629  1539  8139 I mm-camera: <PPROC >< INFO> 460: pproc_port_add_modules_to_stream: :LINK linking mods cpp and rtbdm for identity 4000f
08-25 08:21:06.629  1539  8139 I mm-camera: <PPROC >< INFO> 460: pproc_port_add_modules_to_stream: :LINK linking mods rtbdm and ezt for identity 4000f
08-25 08:21:06.629  1539  8139 I mm-camera: <PPROC >< INFO> 460: pproc_port_add_modules_to_stream: :LINK linking mods ezt and quadracfa for identity 4000f
08-25 08:21:06.630  1539  8139 E mm-camera: <STATS ><ERROR> 2989: stats_port_check_caps_reserve: Invalid Port capability type!
08-25 08:21:06.630  1539  8139 E mm-camera: <STATS ><ERROR> 2989: stats_port_check_caps_reserve: Invalid Port capability type!
08-25 08:21:06.630  1539  8139 E mm-camera: <STATS ><ERROR> 2989: stats_port_check_caps_reserve: Invalid Port capability type!
08-25 08:21:06.630  1539  8139 E mm-camera: <STATS ><ERROR> 2989: stats_port_check_caps_reserve: Invalid Port capability type!
08-25 08:21:06.630  1539  8139 E mm-camera: <STATS ><ERROR> 2989: stats_port_check_caps_reserve: Invalid Port capability type!
08-25 08:21:06.630  1539  8139 I mm-camera: <MCT   >< INFO> 5143: mct_pipeline_start_stream_internal: Session stream linked successfully session 4
08-25 08:21:06.634  1539  8139 I QCamera : <HAL><INFO> int qcamera::QCamera3HardwareInterface::openCamera(struct hw_device_t **): 806: [KPI Perf]: X PROFILE_OPEN_CAMERA camera id 0, rc: 0
08-25 08:21:06.634  1539  8139 I QCamera : <HAL><INFO> int qcamera::QCamera3HardwareInterface::initialize(const struct camera3_callback_ops *): 1011: E :mCameraId = 0 mState = 1
08-25 08:21:06.634  1539  8139 I QCamera : <HAL><INFO> int qcamera::QCamera3HardwareInterface::initialize(const struct camera3_callback_ops *): 1044: X
08-25 08:21:06.634  1539  8139 W Camera2-Parameters: initialize: Camera 0: Unknown preview format: 24
08-25 08:21:06.634  1539  8139 W Camera2-Parameters: initialize: Camera 0: Unknown preview format: 25
08-25 08:21:06.635  1539  9792 I OPCAMERA_SENSOR: listener_func: enable sensor=0 priv=0xde87c080
08-25 08:21:06.635  1539  8139 I Camera2-Parameters: Camera 0: Disabling ZSL mode
08-25 08:21:06.635  1539  8139 I Camera2-Parameters: initialize: allowZslMode: 0 slowJpegMode 1
08-25 08:21:06.635  1033  1052 E Sensors : sns_reg_la.c(188):reg read: offset 2304, num bytes: 1
08-25 08:21:06.637  9748  9748 D OpenNoteScannerActivity: supported preview resolution: 1920x1080
08-25 08:21:06.637  9748  9748 D OpenNoteScannerActivity: supported picture resolution: 4608x3456 ratio: 1.3333334
08-25 08:21:06.637  9748  9748 D OpenNoteScannerActivity: supported picture resolution: 4608x2592 ratio: 1.7777778
08-25 08:21:06.637  9748  9748 D OpenNoteScannerActivity: supported picture resolution: 4160x3120 ratio: 1.3333334
08-25 08:21:06.637  9748  9748 D OpenNoteScannerActivity: supported picture resolution: 3840x2160 ratio: 1.7777778
08-25 08:21:06.637  9748  9748 D OpenNoteScannerActivity: supported picture resolution: 3456x3456 ratio: 1.0
08-25 08:21:06.637  9748  9748 D OpenNoteScannerActivity: supported picture resolution: 3264x2448 ratio: 1.3333334
08-25 08:21:06.637  9748  9748 D OpenNoteScannerActivity: supported picture resolution: 2560x1920 ratio: 1.3333334
08-25 08:21:06.637  9748  9748 D OpenNoteScannerActivity: supported picture resolution: 2304x1728 ratio: 1.3333334
08-25 08:21:06.637  9748  9748 D OpenNoteScannerActivity: supported picture resolution: 2304x1296 ratio: 1.7777778
08-25 08:21:06.637  9748  9748 D OpenNoteScannerActivity: supported picture resolution: 1920x1080 ratio: 1.7777778
08-25 08:21:06.637  9748  9748 D OpenNoteScannerActivity: supported picture resolution: 1728x1728 ratio: 1.0
08-25 08:21:06.638  9748  9748 D OpenNoteScannerActivity: supported picture resolution: 1440x1080 ratio: 1.3333334
08-25 08:21:06.638  9748  9748 D OpenNoteScannerActivity: supported picture resolution: 1280x960 ratio: 1.3333334
08-25 08:21:06.638  9748  9748 D OpenNoteScannerActivity: supported picture resolution: 1280x720 ratio: 1.7777778
08-25 08:21:06.638  9748  9748 D OpenNoteScannerActivity: supported picture resolution: 720x480 ratio: 1.5
08-25 08:21:06.638  9748  9748 D OpenNoteScannerActivity: supported picture resolution: 640x480 ratio: 1.3333334
08-25 08:21:06.638  9748  9748 D OpenNoteScannerActivity: supported picture resolution: 480x360 ratio: 1.3333334
08-25 08:21:06.638  9748  9748 D OpenNoteScannerActivity: supported picture resolution: 480x320 ratio: 1.5
08-25 08:21:06.638  9748  9748 D OpenNoteScannerActivity: supported picture resolution: 352x288 ratio: 1.2222222
08-25 08:21:06.638  9748  9748 D OpenNoteScannerActivity: supported picture resolution: 320x240 ratio: 1.3333334
08-25 08:21:06.638  9748  9748 D OpenNoteScannerActivity: supported picture resolution: 176x144 ratio: 1.2222222
08-25 08:21:06.638  9748  9748 D OpenNoteScannerActivity: Max supported picture resolution with preview aspect ratio: 4608x2592
08-25 08:21:06.638  9748  9748 D OpenNoteScannerActivity: max supported picture resolution: 4608x2592
08-25 08:21:06.638  9748  9748 D OpenNoteScannerActivity: enabling autofocus
08-25 08:21:06.638  1539  5204 E Camera2-Metadata: Mismatched tag type when updating entry enable (-2146762752) of type byte; got type int32 data instead 
08-25 08:21:06.638  1539  5204 E Camera2-Metadata: Mismatched tag type when updating entry is_main (-2146762751) of type byte; got type int32 data instead 
08-25 08:21:06.639  1539  5204 E Camera2-Metadata: Mismatched tag type when updating entry enable (-2146762752) of type byte; got type int32 data instead 
08-25 08:21:06.639  1539  5204 E Camera2-Metadata: Mismatched tag type when updating entry is_main (-2146762751) of type byte; got type int32 data instead 
08-25 08:21:06.639  1539  8139 I QCamera : <HAL><INFO> static int qcamera::QCamera3HardwareInterface::flush(const struct camera3_device *): 11726: Flush returned during state 2
08-25 08:21:06.640  1539  5204 D QCameraPerf: perfLockHandle 229, updated refCount: 1, perfLockType: 2
08-25 08:21:06.640  1539  5204 I QCamera : <HAL><INFO> int qcamera::QCamera3HardwareInterface::configureStreamsPerfLocked(camera3_stream_configuration_t *): 1634: stream[0] type = 0, format = 34, width = 1920, height = 1080, rotation = 0, usage = 0x900
08-25 08:21:06.640  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=800000a
08-25 08:21:06.640  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000018
08-25 08:21:06.640  1539  9775 I mm-camera: <MCT   >< INFO> 617: mct_stream_start_link: Link Metadata stream 0x40001: do nothing
08-25 08:21:06.640  1539  9775 I mm-camera: <MCT   >< INFO> 4244: mct_pipeline_process_set: Linking successful for stream 0x40001 stream type=7
08-25 08:21:06.640  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000004
08-25 08:21:06.640  1539  5204 D QCameraPerf: perfLockHandle 229, refCount: 1, perfLockType: 2
08-25 08:21:06.642  1539  5204 D Camera3-Device: Set real time priority for request queue thread (tid 9805)
08-25 08:21:06.644  1539  9805 D QCameraPerf: perfLockHandle 230, updated refCount: 1, perfLockType: 2
08-25 08:21:06.644  1539  9805 I QCamera : <HAL><INFO> int qcamera::QCamera3HardwareInterface::processCaptureRequest(camera3_capture_request_t *, List<InternalRequest> &): 4408: STREAM INFO : type 1, wxh: 1920 x 1080, pp_mask: 0x10100068e, Format:0 is_type: 0
08-25 08:21:06.644  1539  9805 I QCamera : <HAL><INFO> int qcamera::QCamera3HardwareInterface::processCaptureRequest(camera3_capture_request_t *, List<InternalRequest> &): 4408: STREAM INFO : type 11, wxh: 640 x 360, pp_mask: 0x10100068e, Format:0 is_type: 0
08-25 08:21:06.644  1539  9775 I mm-camera: <IFACE >< INFO> 6136: iface_util_set_dis_enable_flag: iface_util_set_dis_enable_flag:6136 DIS enable flag = 0
08-25 08:21:06.644  1539  9775 E mm-camera: <SENSOR><ERROR> 3597: sensor_get_cur_chromatix_name: Res_idx : 0, 3A chromatix : imx398_3a_4656x3496_30fps_preview
08-25 08:21:06.644  1539  9775 I mm-camera: <SENSOR>< INFO> 4364: sensor_get_resolution_info: sensor info: name: imx398, res: -1, max_fps: 0.000000, w: 0, h: 0 op pix clk: 0, FLL: 0, LLPCK: 0, mode: 0, PDAF support: 0
08-25 08:21:06.644  1539  9775 I mm-camera: <C2D   >< INFO> 1953: c2d_module_handle_set_parm_event: META_STREAM_INFO type = 1 w x h : 1920 x 1080 pp_mask = 0x100068e
08-25 08:21:06.644  1539  9775 I mm-camera: <C2D   >< INFO> 1953: c2d_module_handle_set_parm_event: META_STREAM_INFO type = 11 w x h : 640 x 360 pp_mask = 0x100068e
08-25 08:21:06.644  1539  9775 I mm-camera: <ISP   >< INFO> 6930: isp_util_print_meta_stream_info: Stream type 1 Resolution: 1920x1080 pp_mask: 0x100068e
08-25 08:21:06.644  1539  9775 I mm-camera: <ISP   >< INFO> 6930: isp_util_print_meta_stream_info: Stream type 11 Resolution: 640x360 pp_mask: 0x100068e
08-25 08:21:06.644  1539  9775 I mm-camera: <ISP   >< INFO> 2597: isp_resource_allocate: INFO: ISP resource acquired: session 4 num_isp 1
08-25 08:21:06.644  1539  9775 I mm-camera: <ISP   >< INFO> 2599: isp_resource_allocate: INFO: ISP resource acquired: hw_id 0
08-25 08:21:06.644  1539  9775 I mm-camera: <ISP   >< INFO> 6776: isp_util_decide_stream_mapping: stream_port_map num streams 2
08-25 08:21:06.645  1539  9775 I mm-camera: <ISP   >< INFO> 6790: isp_util_decide_stream_mapping: INFO: type 1 resolution 1920x1080 hw_stream 0 need_native_buff 1 controllable_output 0 shared_output 0is_changed 0 changed_dim 1920x1080
08-25 08:21:06.645  1539  9775 I mm-camera: <ISP   >< INFO> 6790: isp_util_decide_stream_mapping: INFO: type 11 resolution 640x360 hw_stream 2 need_native_buff 1 controllable_output 0 shared_output 0is_changed 0 changed_dim 640x360
08-25 08:21:06.645  1539  9775 I mm-camera: <IFACE >< INFO> 6291: iface_util_handle_meta_stream_info: iface_util_handle_meta_stream_info: ms_type 1 num streams 2
08-25 08:21:06.645  1539  9775 W mm-camera: <IFACE >< WARN> 2829: iface_util_modify_plane_info_for_native_buf: iface_util_modify_plane_info_for_native_buf: Invalid cam_format 2088533116
08-25 08:21:06.645  1539  9775 W mm-camera: <IFACE >< WARN> 2864: iface_util_calculate_frame_length_for_native_buf: iface_util_calculate_frame_length_for_native_buf: returned fail=-1
08-25 08:21:06.645  1539  9775 W mm-camera: <IFACE >< WARN> 2829: iface_util_modify_plane_info_for_native_buf: iface_util_modify_plane_info_for_native_buf: Invalid cam_format 2088533116
08-25 08:21:06.645  1539  9775 W mm-camera: <IFACE >< WARN> 2864: iface_util_calculate_frame_length_for_native_buf: iface_util_calculate_frame_length_for_native_buf: returned fail=-1
08-25 08:21:06.646  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=800000a
08-25 08:21:06.646  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000018
08-25 08:21:06.646  1539  9775 I mm-camera: <MCT   >< INFO> 492: mct_stream_start_link: Start linking preview stream 0x40002
08-25 08:21:06.646  1539  9775 I mm-camera: <MCT   >< INFO> 503: mct_stream_start_link: non secure stream linking
08-25 08:21:06.646  1539  9775 I mm-camera: <ISP   >< INFO> 837: isp_port_check_caps_reserve: port 0xe777aa40 ide 40002 type 1 dim 1920 1080
08-25 08:21:06.646  1539  9775 I mm-camera: <PPROC >< INFO> 448: pproc_port_add_modules_to_stream: in identity 40002 stream 1 int_link = 0xe77f9580
08-25 08:21:06.646  1539  9775 I mm-camera: <PPROC >< INFO> 460: pproc_port_add_modules_to_stream: :LINK linking mods tmod and paaf for identity 40002
08-25 08:21:06.647  1539  9775 I mm-camera: <PPROC >< INFO> 460: pproc_port_add_modules_to_stream: :LINK linking mods paaf and cpp for identity 40002
08-25 08:21:06.647  1539  9775 I mm-camera: <CPP   >< INFO> 2332: cpp_module_notify_add_stream: :stream 1, width 1920, height 1080, stride 1920,scanline 1088, framelen 3153920
08-25 08:21:06.647  1539  9775 I mm-camera: <CPP   >< INFO> 2356: cpp_module_notify_add_stream: offset_x 0, offset_y 0, offset 0, meta_len 0,meta_scanline 0, meta_stride 0, plane_len 2088960
08-25 08:21:06.647  1539  9775 I mm-camera: <CPP   >< INFO> 2356: cpp_module_notify_add_stream: offset_x 0, offset_y 0, offset 0, meta_len 0,meta_scanline 0, meta_stride 0, plane_len 1064960
08-25 08:21:06.647  1539  9775 I mm-camera: <CPP   >< INFO> 2514: cpp_module_notify_add_stream: : stream 1, fmt 7, asf_mode 0, sharpness_level 0.333333,asf mask 1, denoise 0, denoise_mask 1, dsdn mask 0,dsdn enable 0, tnr mask 0, tnr enable 0, ds_mask 1, luma dsdn 0
08-25 08:21:06.647  1539  9775 W mm-camera: <IMGLIB>< WARN> 1060: faceproc_dsp_comp_create: fddsp stub library not loaded
08-25 08:21:06.647  1539  9775 W mm-camera: <IMGLIB>< WARN> 3825: module_faceproc_comp_create: create comp failed, eng_type=1
08-25 08:21:06.647  1539  9775 I mm-camera: <MCT   >< INFO> 4244: mct_pipeline_process_set: Linking successful for stream 0x40002 stream type=1
08-25 08:21:06.647  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000004
08-25 08:21:06.647  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=800000a
08-25 08:21:06.648  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000018
08-25 08:21:06.648  1539  9775 I mm-camera: <MCT   >< INFO> 603: mct_stream_start_link: Starting Analysis stream linking
08-25 08:21:06.648  1539  9775 I mm-camera: <ISP   >< INFO> 837: isp_port_check_caps_reserve: port 0xe777aa40 ide 40003 type 11 dim 640 360
08-25 08:21:06.648  1539  9775 I mm-camera: <PPROC >< INFO> 448: pproc_port_add_modules_to_stream: in identity 40003 stream 11 int_link = 0xe77f9800
08-25 08:21:06.648  1539  9775 I mm-camera: <PPROC >< INFO> 460: pproc_port_add_modules_to_stream: :LINK linking mods tmod and paaf for identity 40003
08-25 08:21:06.648  1539  9775 I mm-camera: <MCT   >< INFO> 4244: mct_pipeline_process_set: Linking successful for stream 0x40003 stream type=11
08-25 08:21:06.648  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000004
08-25 08:21:06.649  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000019
08-25 08:21:06.754  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000019
08-25 08:21:06.757  1539  9805 I QCamera : <MCI><INFO> mm_channel_start: 1939: start stream at idx(0) stream_type(7)
08-25 08:21:06.757  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000008
08-25 08:21:06.757  1539  9775 I mm-camera: <MCT   >< INFO> 4291: mct_pipeline_process_set:  STREAM-ON on stream 0x40001 stream type=7
08-25 08:21:06.758  1539  9775 I mm-camera: <MCT   >< INFO> 4307: mct_pipeline_process_set:  STREAM-ON success for stream 0x40001, stream type=7
08-25 08:21:06.758  1539  9805 I QCamera : <MCI><INFO> mm_channel_start: 1939: start stream at idx(1) stream_type(1)
08-25 08:21:06.758  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000008
08-25 08:21:06.758  1539  9775 I mm-camera: <MCT   >< INFO> 4291: mct_pipeline_process_set:  STREAM-ON on stream 0x40002 stream type=1
08-25 08:21:06.758  1539  9775 I mm-camera: <SENSOR>< INFO> 4364: sensor_get_resolution_info: sensor info: name: imx398, res: 1, max_fps: 30.020000, w: 4656, h: 2608 op pix clk: 480000000, FLL: 2686, LLPCK: 5536, mode: 1, PDAF support: 1
08-25 08:21:06.758  1539  9775 I mm-camera: <CPP   >< INFO> 2261: cpp_module_handle_stream_cfg_event: frame_offset=1, input_fps=30.00, identity=0x4000f
08-25 08:21:06.758  1539  9775 I mm-camera: <CPP   >< INFO> 2261: cpp_module_handle_stream_cfg_event: frame_offset=1, input_fps=30.00, identity=0x40002
08-25 08:21:06.758  1539  9795 I mm-camera: <STATS_AEC >< INFO> 2819: aec_set_param: SHDR LIMITS:0 0 (0 0) (0 0)
08-25 08:21:06.758  1539  9775 E mm-camera: <SENSOR><ERROR> 8086: module_sensor_set_decode_format_based_on_pack_mode: Pack mode is 0
08-25 08:21:06.759  1539  9775 E mm-camera: <SENSOR><ERROR> 3597: sensor_get_cur_chromatix_name: Res_idx : 1, 3A chromatix : imx398_3a_4656x2608_30fps_preview
08-25 08:21:06.759  1539  9796 E mm-camera: <STATS_AF ><ERROR> 930: af_haf_util_update_force_scan_end_params: force scan timeout enabled,max th: 60 
08-25 08:21:06.759  1539  9796 I mm-camera: <STATS_AF >< INFO> 1001: af_haf_update_tuning_data: Setting default init pos to far end
08-25 08:21:06.759  1539  9795 I mm-camera: <STATS_AEC >< INFO> 657: aec_set_initial_exp_index: last idex:419 light_sensor_diff_ratio:0.073721 light_sensor:1068.000000 last_light:1153.000000 lastcct_value:3534
08-25 08:21:06.759  1539  9795 I mm-camera: <STATS_AEC >< INFO> 692: aec_set_initial_exp_index: light_sensor:1068.000000, cct:3534, lastidx:419, start idx:200,
08-25 08:21:06.759  1539  9795 I mm-camera: <STATS_AEC >< INFO> 696: aec_set_initial_exp_index: Final warm start index=200, Range: start=83,end=336
08-25 08:21:06.759  1539  9775 E mm-camera: <IFACE ><ERROR> 2245: iface_util_set_chromatix: iface_util_set_chromatix:2245 failed: iface_hvx_open rc 0
08-25 08:21:06.759  1539  9775 I mm-camera: <IFACE >< INFO> 415: iface_util_dump_sensor_cfg: iface_util_dump_sensor_cfg: sensor dim: width = 4656, heght = 2608, fmt = 30, is_bayer = 1, init_skip = 0
08-25 08:21:06.760  1539  9775 I mm-camera: <IFACE >< INFO> 4138: iface_util_set_hw_stream_config_pix: iface_util_set_hw_stream_config_pix: Assigned vfe 0 intf 0 for related cam type 1
08-25 08:21:06.760  1539  9775 I mm-camera: <IFACE >< INFO> 3615: iface_util_dump_isp_resource_request:  =====DUMP RESOURCE: PIX STREAM=== 
08-25 08:21:06.760  1539  9775 I mm-camera: <IFACE >< INFO> 3616: iface_util_dump_isp_resource_request: num pix stream = 2
08-25 08:21:06.760  1539  9775 I mm-camera: <IFACE >< INFO> 3619: iface_util_dump_isp_resource_request: num_isp = 1, isp_mask = 1, request_op_pix_clk = 0
08-25 08:21:06.760  1539  9775 I mm-camera: <IFACE >< INFO> 3623: iface_util_dump_isp_resource_request: ispif stripe info: split 0, overlap 0, stripe offset 0
08-25 08:21:06.760  1539  9775 I mm-camera: <IFACE >< INFO> 3626: iface_util_dump_isp_resource_request: pix stream 0
08-25 08:21:06.760  1539  9775 I mm-camera: <IFACE >< INFO> 3629: iface_util_dump_isp_resource_request: num mct stream mapped = 1(Mapped stream ID[0] = 2)
08-25 08:21:06.760  1539  9775 I mm-camera: <IFACE >< INFO> 3632: iface_util_dump_isp_resource_request: axi path = 1(ENC-0/VIEW-1/CAMIF-2/IDEAL-3), cam_fmt 7
08-25 08:21:06.760  1539  9775 I mm-camera: <IFACE >< INFO> 3626: iface_util_dump_isp_resource_request: pix stream 1
08-25 08:21:06.760  1539  9775 I mm-camera: <IFACE >< INFO> 3629: iface_util_dump_isp_resource_request: num mct stream mapped = 1(Mapped stream ID[0] = 3)
08-25 08:21:06.760  1539  9775 I mm-camera: <IFACE >< INFO> 3632: iface_util_dump_isp_resource_request: axi path = 2(ENC-0/VIEW-1/CAMIF-2/IDEAL-3), cam_fmt 101
08-25 08:21:06.760  1539  9775 I mm-camera: <IFACE >< INFO> 3654: iface_util_dump_isp_resource_request: num STATS stream = 7
08-25 08:21:06.760  1539  9775 I mm-camera-iface2: Enable overrid for VFE: 0: MAX (vfe: 410635838, op_pixel_clk: 480000000)
08-25 08:21:06.760  1539  9775 I mm-camera: <CPP   >< INFO> 919: cpp_module_handle_isp_out_dim_event: [STREAM_PARAMS]  stream type 1, width 1920, height 1080,stride 1920, scanline 1088, planes 2
08-25 08:21:06.760  1539  9775 I mm-camera: <CPP   >< INFO> 938: cpp_module_handle_isp_out_dim_event: [STREAM_PARAMS] plane 0, stride 1920, scanline 1088, offset_x 0, offset_y 0, len 2088960, offset:0
08-25 08:21:06.760  1539  9775 I mm-camera: <CPP   >< INFO> 938: cpp_module_handle_isp_out_dim_event: [STREAM_PARAMS] plane 1, stride 1920, scanline 1088, offset_x 0, offset_y 0, len 1044480, offset:0
08-25 08:21:06.761  1539  9775 I mm-camera: <IFACE >< INFO> 4024: iface_create_axi: iface_create_axi:4024: Create axi hw for session 4 on VFE 0
08-25 08:21:06.764  1539  9775 I mm-camera: <IFACE >< INFO> 9626: iface_util_dump_camif_cfg: =====Camif DUMP cfg for PIX interface====
08-25 08:21:06.764  1539  9775 I mm-camera: <IFACE >< INFO> 9628: iface_util_dump_camif_cfg: camif input type = 3(MIPI=3), op_pix_clk = 480000000
08-25 08:21:06.764  1539  9775 I mm-camera: <IFACE >< INFO> 9630: iface_util_dump_camif_cfg: camif pix_pattern(RGRG-0/GRGR-1/BGBG-2/GBGB-3) = 0
08-25 08:21:06.764  1539  9775 I mm-camera: <IFACE >< INFO> 9632: iface_util_dump_camif_cfg: camif first_pix = 0, last_pix = 4655
08-25 08:21:06.764  1539  9775 I mm-camera: <IFACE >< INFO> 9634: iface_util_dump_camif_cfg: camif first_line = 0, last_line = 2607
08-25 08:21:06.764  1539  9775 I mm-camera: <IFACE >< INFO> 9636: iface_util_dump_camif_cfg: camif pixels_per_line = 4656, lines_per_frame = 2608
08-25 08:21:06.764  1539  9775 I mm-camera: <IFACE >< INFO> 9640: iface_util_dump_camif_cfg: camif irq subsample pattern = 0, period = 0 sof_step 1
08-25 08:21:06.764  1539  9821 I mm-camera: <IFACE >< INFO> 562: iface_dump_axi_plane_config: === AXI DUMP: VFE session_id 4, hw_stream_id 10002 ===
08-25 08:21:06.764  1539  9821 I mm-camera: <IFACE >< INFO> 566: iface_dump_axi_plane_config:     AXI DUMP Axi_src: VIEWFINDER hw_stream width 1920, height 1080
08-25 08:21:06.764  1539  9821 I mm-camera: <IFACE >< INFO> 568: iface_dump_axi_plane_config: need buf divert = 1, burst count = 0
08-25 08:21:06.764  1539  9821 I mm-camera: <IFACE >< INFO> 571: iface_dump_axi_plane_config: hfr mode = 0, skip pattern = 0, init_frame_drop = 0
08-25 08:21:06.764  1539  9821 I mm-camera: <IFACE >< INFO> 604: iface_dump_axi_plane_config: plane[0]: plane_fmt 0(Y-0/CB-1/Cr-2/CrCb-3/CbCr-4)
08-25 08:21:06.764  1539  9821 I mm-camera: <IFACE >< INFO> 606: iface_dump_axi_plane_config: plane[0]: width = 1920, height = 1080
08-25 08:21:06.764  1539  9821 I mm-camera: <IFACE >< INFO> 608: iface_dump_axi_plane_config: plane[0]: stride = 1920, scanlines = 1088
08-25 08:21:06.764  1539  9821 I mm-camera: <IFACE >< INFO> 610: iface_dump_axi_plane_config: plane[0]: address_offset 0
08-25 08:21:06.764  1539  9821 I mm-camera: <IFACE >< INFO> 604: iface_dump_axi_plane_config: plane[1]: plane_fmt 4(Y-0/CB-1/Cr-2/CrCb-3/CbCr-4)
08-25 08:21:06.764  1539  9821 I mm-camera: <IFACE >< INFO> 606: iface_dump_axi_plane_config: plane[1]: width = 1920, height = 540
08-25 08:21:06.764  1539  9821 I mm-camera: <IFACE >< INFO> 608: iface_dump_axi_plane_config: plane[1]: stride = 1920, scanlines = 544
08-25 08:21:06.764  1539  9821 I mm-camera: <IFACE >< INFO> 610: iface_dump_axi_plane_config: plane[1]: address_offset 0
08-25 08:21:06.764  1539  9821 I mm-camera: <IFACE >< INFO> 562: iface_dump_axi_plane_config: === AXI DUMP: VFE session_id 4, hw_stream_id 10003 ===
08-25 08:21:06.764  1539  9821 I mm-camera: <IFACE >< INFO> 566: iface_dump_axi_plane_config:     AXI DUMP Axi_src: VIDEO hw_stream width 640, height 360
08-25 08:21:06.764  1539  9821 I mm-camera: <IFACE >< INFO> 568: iface_dump_axi_plane_config: need buf divert = 1, burst count = 0
08-25 08:21:06.764  1539  9821 I mm-camera: <IFACE >< INFO> 571: iface_dump_axi_plane_config: hfr mode = 0, skip pattern = 0, init_frame_drop = 0
08-25 08:21:06.764  1539  9821 I mm-camera: <IFACE >< INFO> 604: iface_dump_axi_plane_config: plane[0]: plane_fmt 0(Y-0/CB-1/Cr-2/CrCb-3/CbCr-4)
08-25 08:21:06.764  1539  9821 I mm-camera: <IFACE >< INFO> 606: iface_dump_axi_plane_config: plane[0]: width = 640, height = 360
08-25 08:21:06.764  1539  9821 I mm-camera: <IFACE >< INFO> 608: iface_dump_axi_plane_config: plane[0]: stride = 640, scanlines = 480
08-25 08:21:06.764  1539  9821 I mm-camera: <IFACE >< INFO> 610: iface_dump_axi_plane_config: plane[0]: address_offset 0
08-25 08:21:06.764  1539  9821 I mm-camera: <IFACE >< INFO> 562: iface_dump_axi_plane_config: === AXI DUMP: VFE session_id 4, hw_stream_id 9000f ===
08-25 08:21:06.764  1539  9821 I mm-camera: <IFACE >< INFO> 566: iface_dump_axi_plane_config:     AXI DUMP Axi_src: CAMIF_RAW hw_stream width 2328, height 326
08-25 08:21:06.764  1539  9821 I mm-camera: <IFACE >< INFO> 568: iface_dump_axi_plane_config: need buf divert = 1, burst count = 0
08-25 08:21:06.764  1539  9821 I mm-camera: <IFACE >< INFO> 571: iface_dump_axi_plane_config: hfr mode = 0, skip pattern = 0, init_frame_drop = 0
08-25 08:21:06.764  1539  9821 I mm-camera: <IFACE >< INFO> 604: iface_dump_axi_plane_config: plane[0]: plane_fmt 0(Y-0/CB-1/Cr-2/CrCb-3/CbCr-4)
08-25 08:21:06.764  1539  9821 I mm-camera: <IFACE >< INFO> 606: iface_dump_axi_plane_config: plane[0]: width = 2328, height = 326
08-25 08:21:06.764  1539  9821 I mm-camera: <IFACE >< INFO> 608: iface_dump_axi_plane_config: plane[0]: stride = 2336, scanlines = 326
08-25 08:21:06.764  1539  9821 I mm-camera: <IFACE >< INFO> 610: iface_dump_axi_plane_config: plane[0]: address_offset 0
08-25 08:21:06.765  1539  9775 I mm-camera: <IFACE >< INFO> 1778: iface_streamon_to_thread: iface_streamon_to_thread: E, session id = 4, user stream id = 2
08-25 08:21:06.765  1539  9785 I mm-camera: <IFACE >< INFO> 2125: iface_streamon: E, session_id 4 mct_stream_id = 2
08-25 08:21:06.765  1539  9785 I mm-camera: <IFACE >< INFO> 12119: iface_util_get_user_streams_by_bundle: got No.1 bundled streamon, mct stream id 2total bundled stream num = 2
08-25 08:21:06.768  1539  9775 I mm-camera: <CPP   >< INFO> 4460: cpp_module_handle_streamon_event: identity=0x40002, stream-on done
08-25 08:21:06.768  1539  9775 I mm-camera: <IFACE >< INFO> 1807: iface_streamon_to_thread: iface_streamon_to_thread: X, session id = 4, user stream id = 2
08-25 08:21:06.769  1539  9789 I mm-camera: <CPP   >< INFO> 368: cpp_hardware_set_clock: Set clock 576000000 BW avg 209952000 BW inst 209952000
08-25 08:21:06.769  1539  9775 I mm-camera: <MCT   >< INFO> 156: start_sof_check_thread: Starting SOF timeout thread session id =4
08-25 08:21:06.770  1539  9775 I mm-camera: <MCT   >< INFO> 4307: mct_pipeline_process_set:  STREAM-ON success for stream 0x40002, stream type=1
08-25 08:21:06.770  1539  9805 I QCamera : <MCI><INFO> mm_channel_start: 1939: start stream at idx(2) stream_type(11)
08-25 08:21:06.770  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000008
08-25 08:21:06.770  1539  9775 I mm-camera: <MCT   >< INFO> 4291: mct_pipeline_process_set:  STREAM-ON on stream 0x40003 stream type=11
08-25 08:21:06.770  1539  9775 I mm-camera: <IFACE >< INFO> 1778: iface_streamon_to_thread: iface_streamon_to_thread: E, session id = 4, user stream id = 3
08-25 08:21:06.770  1539  9785 I mm-camera: <IFACE >< INFO> 2125: iface_streamon: E, session_id 4 mct_stream_id = 3
08-25 08:21:06.770  1539  9785 I mm-camera: <IFACE >< INFO> 12113: iface_util_get_user_streams_by_bundle: streamon, got all bundled streamon!
08-25 08:21:06.772  1539  9775 I imagefw_android: detect        detect      hunter      M_Detect_Hunter_SmallFace_Gray_6_0_0_model
08-25 08:21:06.772  1539  9775 I imagefw_android: detect        align       deep        M_Align_Deepface_106_track_2_7_0_model
08-25 08:21:06.772  1539  9775 I imagefw_android: detect        align       deep        M_Align_Deepface_21_2_1_1_model
08-25 08:21:06.772  1539  9775 I imagefw_android: track     detect      hunter      M_Detect_Hunter_SmallFace_Gray_6_0_0_model
08-25 08:21:06.772  1539  9775 I imagefw_android: track     align       deep        M_Align_Deepface_106_track_2_7_0_model
08-25 08:21:06.772  1539  9775 I imagefw_android: track     align       deep        M_Align_Deepface_21_track_2_3_0_model
08-25 08:21:06.785  1539  9785 I mm-camera: <IFACE >< INFO> 2420: iface_streamon: X
08-25 08:21:06.785  1539  9775 I mm-camera: <IFACE >< INFO> 1807: iface_streamon_to_thread: iface_streamon_to_thread: X, session id = 4, user stream id = 3
08-25 08:21:06.785  1539  9775 I mm-camera: <MCT   >< INFO> 4307: mct_pipeline_process_set:  STREAM-ON success for stream 0x40003, stream type=11
08-25 08:21:06.814  1539  9820 I mm-camera: <ISP   >< INFO> 1398: isp_handler_module_handle_reg_update:  Warning! Invalid reg_update state 0
08-25 08:21:06.815  1539  9776 I mm-camera: <STATS_AWB >< INFO> 2277: awb_port_parse_set_param: auto awb
08-25 08:21:06.815  1539  9776 I mm-camera: <STATS_AF >< INFO> 5256: af_port_handle_set_focus_mode_evt: AFCam-[mode -0 role-0] Set Focus mode: 7 old_mode: 4
08-25 08:21:06.819  1539  9796 I mm-camera: <SENSOR>< INFO> 345: af_actuator_move_focus: curr_step_pos:590, curr_len_pos(dac):348, num_steps:100, direction:0 total_steps:690
08-25 08:21:06.835  1539  9796 I mm-camera: <STATS_AF >< INFO> 2791: af_util_adjust_roi:  Calculated new ROI: (1864, 840, 928 928) roi_type:0 in_low_light: 0 spotlight:0 green_count:0 lux_idx:200.000000 lens_type:0
08-25 08:21:06.835  1539  9796 I mm-camera: <STATS_AF >< INFO> 1260: af_process_frame: Waiting for available pd stats!
08-25 08:21:06.835  1539  9796 I mm-camera: <STATS_AF >< INFO> 1291: af_port_send_stats_config: iir a11=1.712158, a12=-0.815308, a21=1.869690, a22=-0.898743
08-25 08:21:06.835  1539  9796 I mm-camera: <STATS_AF >< INFO> 1298: af_port_send_stats_config: iir b10=0.092346 b11=0.000000, b12=-0.092346 b20=0.112976 a21=0.000000, a22=-0.112976 cam_role:0 i:0
08-25 08:21:06.835  1539  9796 I mm-camera: <STATS_AF >< INFO> 1291: af_port_send_stats_config: iir a11=0.000000, a12=0.000000, a21=0.000000, a22=0.000000
08-25 08:21:06.835  1539  9796 I mm-camera: <STATS_AF >< INFO> 1298: af_port_send_stats_config: iir b10=0.000000 b11=0.000000, b12=0.000000 b20=0.000000 a21=0.000000, a22=0.000000 cam_role:0 i:1
08-25 08:21:06.835  1539  9796 I mm-camera: <STATS_AF >< INFO> 1291: af_port_send_stats_config: iir a11=1.712158, a12=-0.815308, a21=1.869690, a22=-0.898743
08-25 08:21:06.835  1539  9796 I mm-camera: <STATS_AF >< INFO> 1298: af_port_send_stats_config: iir b10=0.092346 b11=0.000000, b12=-0.092346 b20=0.112976 a21=0.000000, a22=-0.112976 cam_role:0 i:2
08-25 08:21:06.835  1539  9796 I mm-camera: <STATS_AF >< INFO> 1459: af_port_send_pdaf_config: HAF-TAF: Send default config flag 
08-25 08:21:06.849  1539  9795 E mm-camera: <STATS_AEC ><ERROR> 2461: aec_process_parse_input_info: aec_process_parse_input_info: Current Bestshot Mode:0
08-25 08:21:06.850  1539  9782 I mm-camera: <ISP   >< INFO> 245: ihist_stats46_stats_config_validate: warning: Invalid IHIST ROI from 3A 0 0 0 0
08-25 08:21:06.868  1539  9796 I mm-camera: <STATS_AF >< INFO> 1080: af_process_parse_stats: fv: 35577.398438, fv_norm: 14694.535156, lens_pos: 590, cur_luma: 0.000000  Stats ID =2 Stats type: 0 aec_settled: 0 exp_index: 266 fps:30 real_gain:2.142669 scan_cnt:0 progress:0 gyro:0.000000 sadr:0.000000
08-25 08:21:06.903  1539  9796 I mm-camera: <STATS_AF >< INFO> 1080: af_process_parse_stats: fv: 2969.179932, fv_norm: 1618.539795, lens_pos: 590, cur_luma: 0.000000  Stats ID =3 Stats type: 0 aec_settled: 0 exp_index: 331 fps:16 real_gain:7.510083 scan_cnt:0 progress:0 gyro:0.001521 sadr:0.000000
08-25 08:21:06.921  1539  9817 I QCamera : <HAL><INFO> virtual void qcamera::QCamera3ProcessingChannel::streamCbRoutine(mm_camera_super_buf_t *, qcamera::QCamera3Stream *): 885: [KPI Perf] : PROFILE_FIRST_PREVIEW_FRAME camera id 0
08-25 08:21:06.927  1539  9817 D QCameraPerf: perfLockHandle 230, refCount: 1, perfLockType: 2
08-25 08:21:06.927  1539  9817 D QCameraPerf: perfLockHandle 228, refCount: 1, perfLockType: 0
08-25 08:21:06.927  1539  9817 D QCameraPerf: void qcamera::QCameraPerfLock::powerHintInternal(power_hint_t, bool): power hint
08-25 08:21:06.927  1539  9817 I QCOM PowerHAL: Powerhal hint received=a00
08-25 08:21:06.927  1539  9817 I QTI PowerHAL: Video Encode hint start
08-25 08:21:06.928  1539  1539 D QCameraPerf: perfLockHandle 231, updated refCount: 1, perfLockType: 2
08-25 08:21:06.930  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000009
08-25 08:21:06.930  1539  9775 I mm-camera: <MCT   >< INFO> 4291: mct_pipeline_process_set:  STREAM-OFF on stream 0x40003 stream type=11
08-25 08:21:06.930  1539  9775 I mm-camera: <IFACE >< INFO> 1833: iface_streamoff_to_thread: iface_streamoff_to_thread: E, session id = 4, user stream id = 3
08-25 08:21:06.930  1539  9785 I mm-camera: <IFACE >< INFO> 2466: iface_streamoff: E, session_id 4 mct_stream_id = 3
08-25 08:21:06.930  1539  9785 I mm-camera: <IFACE >< INFO> 12127: iface_util_get_user_streams_by_bundle: streamoff, first bundled streamoff all bindled streams!
08-25 08:21:06.930  1539  9785 I mm-camera: <IFACE >< INFO> 440: iface_ispif_get_cfg_params_from_hw_streams: interace 0 active count = 2, skip stop ispif 
08-25 08:21:06.930  1539  9785 I mm-camera: <IFACE >< INFO> 440: iface_ispif_get_cfg_params_from_hw_streams: interace 0 active count = 1, skip stop ispif 
08-25 08:21:06.930  1539  9785 I mm-camera: <IFACE >< INFO> 2701: iface_streamoff: session_id = 4, active_streams = 0
08-25 08:21:06.930  1539  9785 I mm-camera: <IFACE >< INFO> 2710: iface_streamoff: X
08-25 08:21:06.930  1539  9775 I mm-camera: <IFACE >< INFO> 1859: iface_streamoff_to_thread: iface_streamoff_to_thread: X, session id = 4, user stream id = 3
08-25 08:21:06.931  1539  9830 E mm-camera: <IMGLIB><ERROR> 602: face_proc_thread_loop: maybe some error happened! p_frame=0x0 keyBuff_valid=0
08-25 08:21:06.931  1539  9775 I mm-camera: <MCT   >< INFO> 4307: mct_pipeline_process_set:  STREAM-OFF success for stream 0x40003, stream type=11
08-25 08:21:06.931  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000009
08-25 08:21:06.931  1539  9775 I mm-camera: <MCT   >< INFO> 4291: mct_pipeline_process_set:  STREAM-OFF on stream 0x40002 stream type=1
08-25 08:21:06.931  1539  9775 I mm-camera: <IFACE >< INFO> 1833: iface_streamoff_to_thread: iface_streamoff_to_thread: E, session id = 4, user stream id = 2
08-25 08:21:06.931  1539  9785 I mm-camera: <IFACE >< INFO> 2466: iface_streamoff: E, session_id 4 mct_stream_id = 2
08-25 08:21:06.931  1539  9785 I mm-camera: <IFACE >< INFO> 12133: iface_util_get_user_streams_by_bundle: skip streamoff! left 0 bundled streamoff, mct stream id 2total bundled stream num = 2
08-25 08:21:06.931  1539  9785 I mm-camera: <IFACE >< INFO> 2705: iface_streamoff: all bundled stream streamoff, clear hal bundled mask
08-25 08:21:06.931  1539  9785 I mm-camera: <IFACE >< INFO> 2710: iface_streamoff: X
08-25 08:21:06.931  1539  9775 I mm-camera: <IFACE >< INFO> 1859: iface_streamoff_to_thread: iface_streamoff_to_thread: X, session id = 4, user stream id = 2
08-25 08:21:06.937  1539  9776 I mm-camera: <MCT   >< INFO> 1767: mct_pipeline_control_hw_state: mct_pipeline_control_hw_state lpmbit 40 
08-25 08:21:06.937  1539  9775 I mm-camera: <CPP   >< INFO> 4535: cpp_module_handle_streamoff_event: info: doing stream-off for identity 0x40002
08-25 08:21:06.937  1539  9789 I mm-camera: <CPP   >< INFO> 368: cpp_hardware_set_clock: Set clock 200000000 BW avg 0 BW inst 0
08-25 08:21:06.938  1539  9775 I mm-camera: <CPP   >< INFO> 4721: cpp_module_handle_streamoff_event: info: stream-off done for identity 0x40002
08-25 08:21:06.938  1539  9775 I mm-camera: <IFACE >< INFO> 2734: iface_streamoff_post_isp: shubh: free native buf session: 4 hw_stream: 65538
08-25 08:21:06.940  1539  9775 I mm-camera: <IFACE >< INFO> 2734: iface_streamoff_post_isp: shubh: free native buf session: 4 hw_stream: 65539
08-25 08:21:06.940  1539  9775 I mm-camera: <IFACE >< INFO> 2734: iface_streamoff_post_isp: shubh: free native buf session: 4 hw_stream: 589839
08-25 08:21:06.941  1539  9775 I mm-camera: <IFACE >< INFO> 2741: iface_streamoff_post_isp: session id = 0x4,Delta between vfe irqs 0 sec 0 usec
08-25 08:21:06.942  1539  9775 I mm-camera: <IFACE >< INFO> 10888: iface_util_release_resource: camif_cnt= 1, rdi_cnt= 0, used mask 1
08-25 08:21:06.942  1539  9775 I mm-camera: <IFACE >< INFO> 10888: iface_util_release_resource: camif_cnt= 0, rdi_cnt= 0, used mask 0
08-25 08:21:06.942  1539  9775 I mm-camera: <IFACE >< INFO> 3984: iface_destroy_hw: iface_destroy_hw: Destroy axi hw on VFE :0
08-25 08:21:06.942  1539  9775 I mm-camera: <IFACE >< INFO> 10888: iface_util_release_resource: camif_cnt= 0, rdi_cnt= 0, used mask 0
08-25 08:21:06.942  1539  9775 I mm-camera: <MCT   >< INFO> 186: stop_sof_check_thread: Stopping SOF timeout thread session =4
08-25 08:21:06.942  1539  9827 I mm-camera: <MCT   >< INFO> 114: mct_bus_sof_thread_run: Closing SOF tracker thread
08-25 08:21:06.942  1539  9775 I mm-camera: <MCT   >< INFO> 4307: mct_pipeline_process_set:  STREAM-OFF success for stream 0x40002, stream type=1
08-25 08:21:06.943  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000009
08-25 08:21:06.943  1539  9775 I mm-camera: <MCT   >< INFO> 4291: mct_pipeline_process_set:  STREAM-OFF on stream 0x40001 stream type=7
08-25 08:21:06.943  1539  9775 I mm-camera: <MCT   >< INFO> 4307: mct_pipeline_process_set:  STREAM-OFF success for stream 0x40001, stream type=7
08-25 08:21:06.945  1539  1539 I QCamera : <HAL><INFO> int qcamera::QCamera3HardwareInterface::configureStreamsPerfLocked(camera3_stream_configuration_t *): 1634: stream[0] type = 0, format = 34, width = 1920, height = 1080, rotation = 0, usage = 0x900
08-25 08:21:06.945  1539  1539 I QCamera : <HAL><INFO> int qcamera::QCamera3HardwareInterface::configureStreamsPerfLocked(camera3_stream_configuration_t *): 1634: stream[1] type = 0, format = 35, width = 1920, height = 1080, rotation = 0, usage = 0x3
08-25 08:21:06.945  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=800000b
08-25 08:21:06.945  1539  9775 I mm-camera: <MCT   >< INFO> 4375: mct_pipeline_process_set: Issuing DEL_STREAM on stream 0x40002 and stream type=1
08-25 08:21:06.945  1539  9775 I mm-camera: <IFACE >< INFO> 720: iface_unreserve_sink_port: stream_id 2 mode 0 
08-25 08:21:06.945  1539  9775 I mm-camera: <ISP   >< INFO> 926: isp_port_check_caps_unreserve: ide 40002 port 0xe777aa40
08-25 08:21:06.945  1539  9775 I mm-camera: <MCT   >< INFO> 4391: mct_pipeline_process_set: Stream 0x40002 and stream type=1, successfully deleted
08-25 08:21:06.945  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=800000b
08-25 08:21:06.945  1539  9775 I mm-camera: <MCT   >< INFO> 4375: mct_pipeline_process_set: Issuing DEL_STREAM on stream 0x40001 and stream type=7
08-25 08:21:06.945  1539  9775 I mm-camera: <MCT   >< INFO> 4391: mct_pipeline_process_set: Stream 0x40001 and stream type=7, successfully deleted
08-25 08:21:06.945  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=800000b
08-25 08:21:06.945  1539  9775 I mm-camera: <MCT   >< INFO> 4375: mct_pipeline_process_set: Issuing DEL_STREAM on stream 0x40003 and stream type=11
08-25 08:21:06.946  1539  9775 I mm-camera: <IFACE >< INFO> 720: iface_unreserve_sink_port: stream_id 3 mode 0 
08-25 08:21:06.946  1539  9775 I mm-camera: <ISP   >< INFO> 926: isp_port_check_caps_unreserve: ide 40003 port 0xe777aa40
08-25 08:21:06.946  1539  9775 I mm-camera: <MCT   >< INFO> 4391: mct_pipeline_process_set: Stream 0x40003 and stream type=11, successfully deleted
08-25 08:21:06.946  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=800000a
08-25 08:21:06.946  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000018
08-25 08:21:06.946  1539  9775 I mm-camera: <MCT   >< INFO> 617: mct_stream_start_link: Link Metadata stream 0x40001: do nothing
08-25 08:21:06.946  1539  9775 I mm-camera: <MCT   >< INFO> 4244: mct_pipeline_process_set: Linking successful for stream 0x40001 stream type=7
08-25 08:21:06.946  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000004
08-25 08:21:06.946  1539  1539 D QCameraPerf: perfLockHandle 231, refCount: 1, perfLockType: 2
08-25 08:21:06.947  1539  1539 D Camera3-Device: Set real time priority for request queue thread (tid 9805)
08-25 08:21:06.948  1539  9775 I mm-camera: <ISP   >< INFO> 6934: isp_util_print_meta_stream_info: Deallocate resources
08-25 08:21:06.950  1539  9775 I mm-camera: <ISP   >< INFO> 7243: isp_util_handle_stream_info: streams_desc num_streams is 0 
08-25 08:21:06.950  1539  9775 I mm-camera: <IFACE >< INFO> 6291: iface_util_handle_meta_stream_info: iface_util_handle_meta_stream_info: ms_type 1 num streams 0
08-25 08:21:06.950  1539  9805 D QCameraPerf: perfLockHandle 232, updated refCount: 1, perfLockType: 2
08-25 08:21:06.950  1539  9805 I QCamera : <HAL><INFO> int qcamera::QCamera3HardwareInterface::processCaptureRequest(camera3_capture_request_t *, List<InternalRequest> &): 4408: STREAM INFO : type 1, wxh: 1920 x 1080, pp_mask: 0x10100068e, Format:0 is_type: 0
08-25 08:21:06.950  1539  9805 I QCamera : <HAL><INFO> int qcamera::QCamera3HardwareInterface::processCaptureRequest(camera3_capture_request_t *, List<InternalRequest> &): 4408: STREAM INFO : type 5, wxh: 1920 x 1080, pp_mask: 0x100068e, Format:0 is_type: 0
08-25 08:21:06.950  1539  9805 I QCamera : <HAL><INFO> int qcamera::QCamera3HardwareInterface::processCaptureRequest(camera3_capture_request_t *, List<InternalRequest> &): 4408: STREAM INFO : type 11, wxh: 640 x 360, pp_mask: 0x10100068e, Format:0 is_type: 0
08-25 08:21:06.950  1539  9775 I mm-camera: <IFACE >< INFO> 6136: iface_util_set_dis_enable_flag: iface_util_set_dis_enable_flag:6136 DIS enable flag = 0
08-25 08:21:06.950  1539  9775 E mm-camera: <SENSOR><ERROR> 3597: sensor_get_cur_chromatix_name: Res_idx : 0, 3A chromatix : imx398_3a_4656x3496_30fps_preview
08-25 08:21:06.951  1539  9775 I mm-camera: <SENSOR>< INFO> 4364: sensor_get_resolution_info: sensor info: name: imx398, res: -1, max_fps: 0.000000, w: 0, h: 0 op pix clk: 0, FLL: 0, LLPCK: 0, mode: 0, PDAF support: 0
08-25 08:21:06.951  1539  9775 I mm-camera: <C2D   >< INFO> 1953: c2d_module_handle_set_parm_event: META_STREAM_INFO type = 1 w x h : 1920 x 1080 pp_mask = 0x100068e
08-25 08:21:06.951  1539  9775 I mm-camera: <C2D   >< INFO> 1953: c2d_module_handle_set_parm_event: META_STREAM_INFO type = 5 w x h : 1920 x 1080 pp_mask = 0x100068e
08-25 08:21:06.951  1539  9775 I mm-camera: <C2D   >< INFO> 1953: c2d_module_handle_set_parm_event: META_STREAM_INFO type = 11 w x h : 640 x 360 pp_mask = 0x100068e
08-25 08:21:06.951  1539  9775 I mm-camera: <ISP   >< INFO> 6930: isp_util_print_meta_stream_info: Stream type 1 Resolution: 1920x1080 pp_mask: 0x100068e
08-25 08:21:06.951  1539  9775 I mm-camera: <ISP   >< INFO> 6930: isp_util_print_meta_stream_info: Stream type 5 Resolution: 1920x1080 pp_mask: 0x100068e
08-25 08:21:06.951  1539  9775 I mm-camera: <ISP   >< INFO> 6930: isp_util_print_meta_stream_info: Stream type 11 Resolution: 640x360 pp_mask: 0x100068e
08-25 08:21:06.951  1539  9775 I mm-camera: <ISP   >< INFO> 2597: isp_resource_allocate: INFO: ISP resource acquired: session 4 num_isp 1
08-25 08:21:06.951  1539  9775 I mm-camera: <ISP   >< INFO> 2599: isp_resource_allocate: INFO: ISP resource acquired: hw_id 0
08-25 08:21:06.951  1539  9775 I mm-camera: <ISP   >< INFO> 6776: isp_util_decide_stream_mapping: stream_port_map num streams 3
08-25 08:21:06.951  1539  9775 I mm-camera: <ISP   >< INFO> 6790: isp_util_decide_stream_mapping: INFO: type 1 resolution 1920x1080 hw_stream 0 need_native_buff 1 controllable_output 0 shared_output 0is_changed 0 changed_dim 1920x1080
08-25 08:21:06.951  1539  9775 I mm-camera: <ISP   >< INFO> 6790: isp_util_decide_stream_mapping: INFO: type 5 resolution 1920x1080 hw_stream 0 need_native_buff 1 controllable_output 0 shared_output 0is_changed 0 changed_dim 1920x1080
08-25 08:21:06.951  1539  9775 I mm-camera: <ISP   >< INFO> 6790: isp_util_decide_stream_mapping: INFO: type 11 resolution 640x360 hw_stream 2 need_native_buff 1 controllable_output 0 shared_output 0is_changed 0 changed_dim 640x360
08-25 08:21:06.951  1539  9775 I mm-camera: <IFACE >< INFO> 6291: iface_util_handle_meta_stream_info: iface_util_handle_meta_stream_info: ms_type 1 num streams 3
08-25 08:21:06.951  1539  9775 W mm-camera: <IFACE >< WARN> 2829: iface_util_modify_plane_info_for_native_buf: iface_util_modify_plane_info_for_native_buf: Invalid cam_format 2088533116
08-25 08:21:06.951  1539  9775 W mm-camera: <IFACE >< WARN> 2864: iface_util_calculate_frame_length_for_native_buf: iface_util_calculate_frame_length_for_native_buf: returned fail=-1
08-25 08:21:06.951  1539  9775 W mm-camera: <IFACE >< WARN> 2829: iface_util_modify_plane_info_for_native_buf: iface_util_modify_plane_info_for_native_buf: Invalid cam_format 2088533116
08-25 08:21:06.951  1539  9775 W mm-camera: <IFACE >< WARN> 2864: iface_util_calculate_frame_length_for_native_buf: iface_util_calculate_frame_length_for_native_buf: returned fail=-1
08-25 08:21:06.952  1539  9775 W mm-camera: <IFACE >< WARN> 2829: iface_util_modify_plane_info_for_native_buf: iface_util_modify_plane_info_for_native_buf: Invalid cam_format 2088533116
08-25 08:21:06.952  1539  9775 W mm-camera: <IFACE >< WARN> 2864: iface_util_calculate_frame_length_for_native_buf: iface_util_calculate_frame_length_for_native_buf: returned fail=-1
08-25 08:21:06.952  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=800000a
08-25 08:21:06.952  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000018
08-25 08:21:06.952  1539  9775 I mm-camera: <MCT   >< INFO> 492: mct_stream_start_link: Start linking preview stream 0x40002
08-25 08:21:06.952  1539  9775 I mm-camera: <MCT   >< INFO> 503: mct_stream_start_link: non secure stream linking
08-25 08:21:06.952  1539  9775 I mm-camera: <ISP   >< INFO> 837: isp_port_check_caps_reserve: port 0xe777aa40 ide 40002 type 1 dim 1920 1080
08-25 08:21:06.953  1539  9775 I mm-camera: <PPROC >< INFO> 448: pproc_port_add_modules_to_stream: in identity 40002 stream 1 int_link = 0xe77f9580
08-25 08:21:06.953  1539  9775 I mm-camera: <PPROC >< INFO> 460: pproc_port_add_modules_to_stream: :LINK linking mods tmod and paaf for identity 40002
08-25 08:21:06.953  1539  9775 I mm-camera: <PPROC >< INFO> 460: pproc_port_add_modules_to_stream: :LINK linking mods paaf and cpp for identity 40002
08-25 08:21:06.953  1539  9775 I mm-camera: <CPP   >< INFO> 2332: cpp_module_notify_add_stream: :stream 1, width 1920, height 1080, stride 1920,scanline 1088, framelen 3153920
08-25 08:21:06.953  1539  9775 I mm-camera: <CPP   >< INFO> 2356: cpp_module_notify_add_stream: offset_x 0, offset_y 0, offset 0, meta_len 0,meta_scanline 0, meta_stride 0, plane_len 2088960
08-25 08:21:06.953  1539  9775 I mm-camera: <CPP   >< INFO> 2356: cpp_module_notify_add_stream: offset_x 0, offset_y 0, offset 0, meta_len 0,meta_scanline 0, meta_stride 0, plane_len 1064960
08-25 08:21:06.953  1539  9775 I mm-camera: <CPP   >< INFO> 2514: cpp_module_notify_add_stream: : stream 1, fmt 7, asf_mode 1, sharpness_level 1.000000,asf mask 1, denoise 1, denoise_mask 1, dsdn mask 0,dsdn enable 0, tnr mask 0, tnr enable 0, ds_mask 1, luma dsdn 0
08-25 08:21:06.953  1539  9775 W mm-camera: <IMGLIB>< WARN> 1060: faceproc_dsp_comp_create: fddsp stub library not loaded
08-25 08:21:06.953  1539  9775 W mm-camera: <IMGLIB>< WARN> 3825: module_faceproc_comp_create: create comp failed, eng_type=1
08-25 08:21:06.953  1539  9775 I mm-camera: <MCT   >< INFO> 4244: mct_pipeline_process_set: Linking successful for stream 0x40002 stream type=1
08-25 08:21:06.953  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000004
08-25 08:21:06.953  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=800000a
08-25 08:21:06.954  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000018
08-25 08:21:06.954  1539  9775 I mm-camera: <MCT   >< INFO> 537: mct_stream_start_link: Start linking callback stream 0x40003
08-25 08:21:06.954  1539  9775 I mm-camera: <ISP   >< INFO> 837: isp_port_check_caps_reserve: port 0xe777aa40 ide 40003 type 5 dim 1920 1080
08-25 08:21:06.954  1539  9775 I mm-camera: <PPROC >< INFO> 448: pproc_port_add_modules_to_stream: in identity 40003 stream 5 int_link = 0xe77f9580
08-25 08:21:06.954  1539  9775 I mm-camera: <PPROC >< INFO> 460: pproc_port_add_modules_to_stream: :LINK linking mods tmod and cpp for identity 40003
08-25 08:21:06.954  1539  9775 I mm-camera: <CPP   >< INFO> 2332: cpp_module_notify_add_stream: :stream 5, width 1920, height 1080, stride 1920,scanline 1088, framelen 3133440
08-25 08:21:06.954  1539  9775 I mm-camera: <CPP   >< INFO> 2356: cpp_module_notify_add_stream: offset_x 0, offset_y 0, offset 0, meta_len 0,meta_scanline 0, meta_stride 0, plane_len 2088960
08-25 08:21:06.954  1539  9775 I mm-camera: <CPP   >< INFO> 2356: cpp_module_notify_add_stream: offset_x 0, offset_y 0, offset 0, meta_len 0,meta_scanline 0, meta_stride 0, plane_len 1044480
08-25 08:21:06.954  1539  9775 I mm-camera: <CPP   >< INFO> 2514: cpp_module_notify_add_stream: : stream 5, fmt 2, asf_mode 1, sharpness_level 1.000000,asf mask 1, denoise 1, denoise_mask 1, dsdn mask 0,dsdn enable 0, tnr mask 0, tnr enable 0, ds_mask 1, luma dsdn 0
08-25 08:21:06.954  1539  9775 I mm-camera: <MCT   >< INFO> 4244: mct_pipeline_process_set: Linking successful for stream 0x40003 stream type=5
08-25 08:21:06.954  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000004
08-25 08:21:06.955  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=800000a
08-25 08:21:06.955  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000018
08-25 08:21:06.955  1539  9775 I mm-camera: <MCT   >< INFO> 603: mct_stream_start_link: Starting Analysis stream linking
08-25 08:21:06.955  1539  9775 I mm-camera: <ISP   >< INFO> 837: isp_port_check_caps_reserve: port 0xe777aa40 ide 40004 type 11 dim 640 360
08-25 08:21:06.955  1539  9775 I mm-camera: <PPROC >< INFO> 448: pproc_port_add_modules_to_stream: in identity 40004 stream 11 int_link = 0xe77f9800
08-25 08:21:06.955  1539  9775 I mm-camera: <PPROC >< INFO> 460: pproc_port_add_modules_to_stream: :LINK linking mods tmod and paaf for identity 40004
08-25 08:21:06.955  1539  9775 I mm-camera: <MCT   >< INFO> 4244: mct_pipeline_process_set: Linking successful for stream 0x40004 stream type=11
08-25 08:21:06.956  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000004
08-25 08:21:06.956  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000019
08-25 08:21:06.956  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000019
08-25 08:21:06.956  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000019
08-25 08:21:06.959  1539  9805 I QCamera : <MCI><INFO> mm_channel_start: 1939: start stream at idx(0) stream_type(7)
08-25 08:21:06.959  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000008
08-25 08:21:06.959  1539  9775 I mm-camera: <MCT   >< INFO> 4291: mct_pipeline_process_set:  STREAM-ON on stream 0x40001 stream type=7
08-25 08:21:06.959  1539  9775 I mm-camera: <MCT   >< INFO> 4307: mct_pipeline_process_set:  STREAM-ON success for stream 0x40001, stream type=7
08-25 08:21:06.959  1539  9805 I QCamera : <MCI><INFO> mm_channel_start: 1939: start stream at idx(1) stream_type(1)
08-25 08:21:06.959  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000008
08-25 08:21:06.959  1539  9775 I mm-camera: <MCT   >< INFO> 4291: mct_pipeline_process_set:  STREAM-ON on stream 0x40002 stream type=1
08-25 08:21:06.960  1539  9775 I mm-camera: <SENSOR>< INFO> 4364: sensor_get_resolution_info: sensor info: name: imx398, res: 1, max_fps: 30.020000, w: 4656, h: 2608 op pix clk: 480000000, FLL: 2686, LLPCK: 5536, mode: 1, PDAF support: 1
08-25 08:21:06.960  1539  9795 I mm-camera: <STATS_AEC >< INFO> 2819: aec_set_param: SHDR LIMITS:0 0 (0 0) (0 0)
08-25 08:21:06.960  1539  9775 I mm-camera: <CPP   >< INFO> 2261: cpp_module_handle_stream_cfg_event: frame_offset=1, input_fps=30.00, identity=0x4000f
08-25 08:21:06.960  1539  9775 I mm-camera: <CPP   >< INFO> 2261: cpp_module_handle_stream_cfg_event: frame_offset=1, input_fps=30.00, identity=0x40002
08-25 08:21:06.960  1539  9775 I mm-camera: <CPP   >< INFO> 2261: cpp_module_handle_stream_cfg_event: frame_offset=1, input_fps=30.00, identity=0x40003
08-25 08:21:06.960  1539  9775 E mm-camera: <SENSOR><ERROR> 8086: module_sensor_set_decode_format_based_on_pack_mode: Pack mode is 0
08-25 08:21:06.960  1539  9775 E mm-camera: <SENSOR><ERROR> 3597: sensor_get_cur_chromatix_name: Res_idx : 1, 3A chromatix : imx398_3a_4656x2608_30fps_preview
08-25 08:21:06.960  1539  9796 E mm-camera: <STATS_AF ><ERROR> 930: af_haf_util_update_force_scan_end_params: force scan timeout enabled,max th: 60 
08-25 08:21:06.960  1539  9796 I mm-camera: <STATS_AF >< INFO> 1001: af_haf_update_tuning_data: Setting default init pos to far end
08-25 08:21:06.961  1539  9775 E mm-camera: <IFACE ><ERROR> 2245: iface_util_set_chromatix: iface_util_set_chromatix:2245 failed: iface_hvx_open rc 0
08-25 08:21:06.961  1539  9775 I mm-camera: <IFACE >< INFO> 415: iface_util_dump_sensor_cfg: iface_util_dump_sensor_cfg: sensor dim: width = 4656, heght = 2608, fmt = 30, is_bayer = 1, init_skip = 0
08-25 08:21:06.961  1539  9795 I mm-camera: <STATS_AEC >< INFO> 657: aec_set_initial_exp_index: last idex:395 light_sensor_diff_ratio:0.071986 light_sensor:1070.000000 last_light:1153.000000 lastcct_value:4100
08-25 08:21:06.961  1539  9795 I mm-camera: <STATS_AEC >< INFO> 692: aec_set_initial_exp_index: light_sensor:1070.000000, cct:4100, lastidx:395, start idx:200,
08-25 08:21:06.961  1539  9795 I mm-camera: <STATS_AEC >< INFO> 696: aec_set_initial_exp_index: Final warm start index=200, Range: start=83,end=336
08-25 08:21:06.961  1539  9775 I mm-camera: <IFACE >< INFO> 4138: iface_util_set_hw_stream_config_pix: iface_util_set_hw_stream_config_pix: Assigned vfe 0 intf 0 for related cam type 1
08-25 08:21:06.961  1539  9775 I mm-camera: <IFACE >< INFO> 3615: iface_util_dump_isp_resource_request:  =====DUMP RESOURCE: PIX STREAM=== 
08-25 08:21:06.961  1539  9775 I mm-camera: <IFACE >< INFO> 3616: iface_util_dump_isp_resource_request: num pix stream = 2
08-25 08:21:06.961  1539  9775 I mm-camera: <IFACE >< INFO> 3619: iface_util_dump_isp_resource_request: num_isp = 1, isp_mask = 1, request_op_pix_clk = 0
08-25 08:21:06.961  1539  9775 I mm-camera: <IFACE >< INFO> 3623: iface_util_dump_isp_resource_request: ispif stripe info: split 0, overlap 0, stripe offset 0
08-25 08:21:06.961  1539  9775 I mm-camera: <IFACE >< INFO> 3626: iface_util_dump_isp_resource_request: pix stream 0
08-25 08:21:06.961  1539  9775 I mm-camera: <IFACE >< INFO> 3629: iface_util_dump_isp_resource_request: num mct stream mapped = 2(Mapped stream ID[0] = 2)
08-25 08:21:06.961  1539  9775 I mm-camera: <IFACE >< INFO> 3632: iface_util_dump_isp_resource_request: axi path = 1(ENC-0/VIEW-1/CAMIF-2/IDEAL-3), cam_fmt 7
08-25 08:21:06.961  1539  9775 I mm-camera: <IFACE >< INFO> 3626: iface_util_dump_isp_resource_request: pix stream 1
08-25 08:21:06.961  1539  9775 I mm-camera: <IFACE >< INFO> 3629: iface_util_dump_isp_resource_request: num mct stream mapped = 1(Mapped stream ID[0] = 4)
08-25 08:21:06.961  1539  9775 I mm-camera: <IFACE >< INFO> 3632: iface_util_dump_isp_resource_request: axi path = 2(ENC-0/VIEW-1/CAMIF-2/IDEAL-3), cam_fmt 101
08-25 08:21:06.961  1539  9775 I mm-camera: <IFACE >< INFO> 3654: iface_util_dump_isp_resource_request: num STATS stream = 7
08-25 08:21:06.961  1539  9775 I mm-camera-iface2: Enable overrid for VFE: 0: MAX (vfe: 410635838, op_pixel_clk: 480000000)
08-25 08:21:06.962  1539  9775 I mm-camera: <CPP   >< INFO> 919: cpp_module_handle_isp_out_dim_event: [STREAM_PARAMS]  stream type 1, width 1920, height 1080,stride 1920, scanline 1088, planes 2
08-25 08:21:06.962  1539  9775 I mm-camera: <CPP   >< INFO> 938: cpp_module_handle_isp_out_dim_event: [STREAM_PARAMS] plane 0, stride 1920, scanline 1088, offset_x 0, offset_y 0, len 2088960, offset:0
08-25 08:21:06.962  1539  9775 I mm-camera: <CPP   >< INFO> 938: cpp_module_handle_isp_out_dim_event: [STREAM_PARAMS] plane 1, stride 1920, scanline 1088, offset_x 0, offset_y 0, len 1044480, offset:0
08-25 08:21:06.962  1539  9775 I mm-camera: <CPP   >< INFO> 919: cpp_module_handle_isp_out_dim_event: [STREAM_PARAMS]  stream type 5, width 1920, height 1080,stride 1920, scanline 1088, planes 2
08-25 08:21:06.962  1539  9775 I mm-camera: <CPP   >< INFO> 938: cpp_module_handle_isp_out_dim_event: [STREAM_PARAMS] plane 0, stride 1920, scanline 1088, offset_x 0, offset_y 0, len 2088960, offset:0
08-25 08:21:06.962  1539  9775 I mm-camera: <CPP   >< INFO> 938: cpp_module_handle_isp_out_dim_event: [STREAM_PARAMS] plane 1, stride 1920, scanline 1088, offset_x 0, offset_y 0, len 1044480, offset:0
08-25 08:21:06.963  1539  9775 I mm-camera: <IFACE >< INFO> 4024: iface_create_axi: iface_create_axi:4024: Create axi hw for session 4 on VFE 0
08-25 08:21:06.964  1539  9775 I mm-camera: <IFACE >< INFO> 9626: iface_util_dump_camif_cfg: =====Camif DUMP cfg for PIX interface====
08-25 08:21:06.964  1539  9775 I mm-camera: <IFACE >< INFO> 9628: iface_util_dump_camif_cfg: camif input type = 3(MIPI=3), op_pix_clk = 480000000
08-25 08:21:06.964  1539  9775 I mm-camera: <IFACE >< INFO> 9630: iface_util_dump_camif_cfg: camif pix_pattern(RGRG-0/GRGR-1/BGBG-2/GBGB-3) = 0
08-25 08:21:06.964  1539  9775 I mm-camera: <IFACE >< INFO> 9632: iface_util_dump_camif_cfg: camif first_pix = 0, last_pix = 4655
08-25 08:21:06.964  1539  9775 I mm-camera: <IFACE >< INFO> 9634: iface_util_dump_camif_cfg: camif first_line = 0, last_line = 2607
08-25 08:21:06.964  1539  9775 I mm-camera: <IFACE >< INFO> 9636: iface_util_dump_camif_cfg: camif pixels_per_line = 4656, lines_per_frame = 2608
08-25 08:21:06.964  1539  9775 I mm-camera: <IFACE >< INFO> 9640: iface_util_dump_camif_cfg: camif irq subsample pattern = 0, period = 0 sof_step 1
08-25 08:21:06.964  1539  9845 I mm-camera: <IFACE >< INFO> 562: iface_dump_axi_plane_config: === AXI DUMP: VFE session_id 4, hw_stream_id 10002 ===
08-25 08:21:06.964  1539  9845 I mm-camera: <IFACE >< INFO> 566: iface_dump_axi_plane_config:     AXI DUMP Axi_src: VIEWFINDER hw_stream width 1920, height 1080
08-25 08:21:06.964  1539  9845 I mm-camera: <IFACE >< INFO> 568: iface_dump_axi_plane_config: need buf divert = 1, burst count = 0
08-25 08:21:06.964  1539  9845 I mm-camera: <IFACE >< INFO> 571: iface_dump_axi_plane_config: hfr mode = 0, skip pattern = 0, init_frame_drop = 0
08-25 08:21:06.964  1539  9845 I mm-camera: <IFACE >< INFO> 604: iface_dump_axi_plane_config: plane[0]: plane_fmt 0(Y-0/CB-1/Cr-2/CrCb-3/CbCr-4)
08-25 08:21:06.964  1539  9845 I mm-camera: <IFACE >< INFO> 606: iface_dump_axi_plane_config: plane[0]: width = 1920, height = 1080
08-25 08:21:06.964  1539  9845 I mm-camera: <IFACE >< INFO> 608: iface_dump_axi_plane_config: plane[0]: stride = 1920, scanlines = 1088
08-25 08:21:06.964  1539  9845 I mm-camera: <IFACE >< INFO> 610: iface_dump_axi_plane_config: plane[0]: address_offset 0
08-25 08:21:06.964  1539  9845 I mm-camera: <IFACE >< INFO> 604: iface_dump_axi_plane_config: plane[1]: plane_fmt 4(Y-0/CB-1/Cr-2/CrCb-3/CbCr-4)
08-25 08:21:06.964  1539  9845 I mm-camera: <IFACE >< INFO> 606: iface_dump_axi_plane_config: plane[1]: width = 1920, height = 540
08-25 08:21:06.964  1539  9845 I mm-camera: <IFACE >< INFO> 608: iface_dump_axi_plane_config: plane[1]: stride = 1920, scanlines = 544
08-25 08:21:06.965  1539  9845 I mm-camera: <IFACE >< INFO> 610: iface_dump_axi_plane_config: plane[1]: address_offset 0
08-25 08:21:06.965  1539  9845 I mm-camera: <IFACE >< INFO> 562: iface_dump_axi_plane_config: === AXI DUMP: VFE session_id 4, hw_stream_id 10004 ===
08-25 08:21:06.965  1539  9845 I mm-camera: <IFACE >< INFO> 566: iface_dump_axi_plane_config:     AXI DUMP Axi_src: VIDEO hw_stream width 640, height 360
08-25 08:21:06.965  1539  9845 I mm-camera: <IFACE >< INFO> 568: iface_dump_axi_plane_config: need buf divert = 1, burst count = 0
08-25 08:21:06.965  1539  9845 I mm-camera: <IFACE >< INFO> 571: iface_dump_axi_plane_config: hfr mode = 0, skip pattern = 0, init_frame_drop = 0
08-25 08:21:06.965  1539  9845 I mm-camera: <IFACE >< INFO> 604: iface_dump_axi_plane_config: plane[0]: plane_fmt 0(Y-0/CB-1/Cr-2/CrCb-3/CbCr-4)
08-25 08:21:06.965  1539  9845 I mm-camera: <IFACE >< INFO> 606: iface_dump_axi_plane_config: plane[0]: width = 640, height = 360
08-25 08:21:06.965  1539  9845 I mm-camera: <IFACE >< INFO> 608: iface_dump_axi_plane_config: plane[0]: stride = 640, scanlines = 480
08-25 08:21:06.965  1539  9845 I mm-camera: <IFACE >< INFO> 610: iface_dump_axi_plane_config: plane[0]: address_offset 0
08-25 08:21:06.965  1539  9845 I mm-camera: <IFACE >< INFO> 562: iface_dump_axi_plane_config: === AXI DUMP: VFE session_id 4, hw_stream_id 9000f ===
08-25 08:21:06.965  1539  9845 I mm-camera: <IFACE >< INFO> 566: iface_dump_axi_plane_config:     AXI DUMP Axi_src: CAMIF_RAW hw_stream width 2328, height 326
08-25 08:21:06.965  1539  9845 I mm-camera: <IFACE >< INFO> 568: iface_dump_axi_plane_config: need buf divert = 1, burst count = 0
08-25 08:21:06.965  1539  9845 I mm-camera: <IFACE >< INFO> 571: iface_dump_axi_plane_config: hfr mode = 0, skip pattern = 0, init_frame_drop = 0
08-25 08:21:06.965  1539  9845 I mm-camera: <IFACE >< INFO> 604: iface_dump_axi_plane_config: plane[0]: plane_fmt 0(Y-0/CB-1/Cr-2/CrCb-3/CbCr-4)
08-25 08:21:06.965  1539  9845 I mm-camera: <IFACE >< INFO> 606: iface_dump_axi_plane_config: plane[0]: width = 2328, height = 326
08-25 08:21:06.965  1539  9845 I mm-camera: <IFACE >< INFO> 608: iface_dump_axi_plane_config: plane[0]: stride = 2336, scanlines = 326
08-25 08:21:06.965  1539  9845 I mm-camera: <IFACE >< INFO> 610: iface_dump_axi_plane_config: plane[0]: address_offset 0
08-25 08:21:06.966  1539  9775 I mm-camera: <IFACE >< INFO> 1778: iface_streamon_to_thread: iface_streamon_to_thread: E, session id = 4, user stream id = 2
08-25 08:21:06.966  1539  9785 I mm-camera: <IFACE >< INFO> 2125: iface_streamon: E, session_id 4 mct_stream_id = 2
08-25 08:21:06.966  1539  9785 I mm-camera: <IFACE >< INFO> 12119: iface_util_get_user_streams_by_bundle: got No.1 bundled streamon, mct stream id 2total bundled stream num = 3
08-25 08:21:06.969  1539  9775 I mm-camera: <CPP   >< INFO> 4460: cpp_module_handle_streamon_event: identity=0x40002, stream-on done
08-25 08:21:06.969  1539  9775 I mm-camera: <IFACE >< INFO> 1807: iface_streamon_to_thread: iface_streamon_to_thread: X, session id = 4, user stream id = 2
08-25 08:21:06.969  1539  9789 I mm-camera: <CPP   >< INFO> 368: cpp_hardware_set_clock: Set clock 576000000 BW avg 209952000 BW inst 209952000
08-25 08:21:06.970  1539  9775 I mm-camera: <MCT   >< INFO> 156: start_sof_check_thread: Starting SOF timeout thread session id =4
08-25 08:21:06.971  1539  9775 I mm-camera: <MCT   >< INFO> 4307: mct_pipeline_process_set:  STREAM-ON success for stream 0x40002, stream type=1
08-25 08:21:06.971  1539  9805 I QCamera : <MCI><INFO> mm_channel_start: 1939: start stream at idx(2) stream_type(5)
08-25 08:21:06.971  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000008
08-25 08:21:06.971  1539  9775 I mm-camera: <MCT   >< INFO> 4291: mct_pipeline_process_set:  STREAM-ON on stream 0x40003 stream type=5
08-25 08:21:06.971  1539  9775 I mm-camera: <IFACE >< INFO> 1778: iface_streamon_to_thread: iface_streamon_to_thread: E, session id = 4, user stream id = 3
08-25 08:21:06.971  1539  9785 I mm-camera: <IFACE >< INFO> 2125: iface_streamon: E, session_id 4 mct_stream_id = 3
08-25 08:21:06.971  1539  9785 I mm-camera: <IFACE >< INFO> 12119: iface_util_get_user_streams_by_bundle: got No.2 bundled streamon, mct stream id 3total bundled stream num = 3
08-25 08:21:06.971  1539  9775 I mm-camera: <CPP   >< INFO> 4460: cpp_module_handle_streamon_event: identity=0x40003, stream-on done
08-25 08:21:06.972  1539  9775 I mm-camera: <IFACE >< INFO> 1807: iface_streamon_to_thread: iface_streamon_to_thread: X, session id = 4, user stream id = 3
08-25 08:21:06.972  1539  9775 I mm-camera: <MCT   >< INFO> 4307: mct_pipeline_process_set:  STREAM-ON success for stream 0x40003, stream type=5
08-25 08:21:06.972  1539  9789 I mm-camera: <CPP   >< INFO> 368: cpp_hardware_set_clock: Set clock 576000000 BW avg 419904000 BW inst 419904000
08-25 08:21:06.972  1539  9805 I QCamera : <MCI><INFO> mm_channel_start: 1939: start stream at idx(3) stream_type(11)
08-25 08:21:06.972  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000008
08-25 08:21:06.972  1539  9775 I mm-camera: <MCT   >< INFO> 4291: mct_pipeline_process_set:  STREAM-ON on stream 0x40004 stream type=11
08-25 08:21:06.972  1539  9775 I mm-camera: <IFACE >< INFO> 1778: iface_streamon_to_thread: iface_streamon_to_thread: E, session id = 4, user stream id = 4
08-25 08:21:06.972  1539  9785 I mm-camera: <IFACE >< INFO> 2125: iface_streamon: E, session_id 4 mct_stream_id = 4
08-25 08:21:06.972  1539  9785 I mm-camera: <IFACE >< INFO> 12113: iface_util_get_user_streams_by_bundle: streamon, got all bundled streamon!
08-25 08:21:06.973  1668  1724 I ActivityManager: Displayed com.todobom.opennotescanner/.OpenNoteScannerActivity: +551ms
08-25 08:21:06.974  1539  9775 I imagefw_android: detect        detect      hunter      M_Detect_Hunter_SmallFace_Gray_6_0_0_model
08-25 08:21:06.974  1539  9775 I imagefw_android: detect        align       deep        M_Align_Deepface_106_track_2_7_0_model
08-25 08:21:06.974  1539  9775 I imagefw_android: detect        align       deep        M_Align_Deepface_21_2_1_1_model
08-25 08:21:06.974  1539  9775 I imagefw_android: track     detect      hunter      M_Detect_Hunter_SmallFace_Gray_6_0_0_model
08-25 08:21:06.974  1539  9775 I imagefw_android: track     align       deep        M_Align_Deepface_106_track_2_7_0_model
08-25 08:21:06.974  1539  9775 I imagefw_android: track     align       deep        M_Align_Deepface_21_track_2_3_0_model
08-25 08:21:06.986  1539  9785 I mm-camera: <IFACE >< INFO> 2420: iface_streamon: X
08-25 08:21:06.986  1539  9775 I mm-camera: <IFACE >< INFO> 1807: iface_streamon_to_thread: iface_streamon_to_thread: X, session id = 4, user stream id = 4
08-25 08:21:06.986  1539  9775 I mm-camera: <MCT   >< INFO> 4307: mct_pipeline_process_set:  STREAM-ON success for stream 0x40004, stream type=11
08-25 08:21:07.015  1539  9844 I mm-camera: <ISP   >< INFO> 1398: isp_handler_module_handle_reg_update:  Warning! Invalid reg_update state 0
08-25 08:21:07.016  1539  9776 I mm-camera: <STATS_AWB >< INFO> 2277: awb_port_parse_set_param: auto awb
08-25 08:21:07.036  1539  9796 I mm-camera: <STATS_AF >< INFO> 2791: af_util_adjust_roi:  Calculated new ROI: (1864, 840, 928 928) roi_type:0 in_low_light: 0 spotlight:0 green_count:0 lux_idx:331.000000 lens_type:0
08-25 08:21:07.036  1539  9796 I mm-camera: <STATS_AF >< INFO> 1080: af_process_parse_stats: fv: 26097.519531, fv_norm: 35932.914062, lens_pos: 590, cur_luma: 1.000000  Stats ID =1 Stats type: 0 aec_settled: 0 exp_index: 200 fps:30 real_gain:1.030178 scan_cnt:0 progress:0 gyro:0.000188 sadr:0.000000
08-25 08:21:07.036  1539  9796 I mm-camera: <STATS_AF >< INFO> 1291: af_port_send_stats_config: iir a11=1.712158, a12=-0.815308, a21=1.869690, a22=-0.898743
08-25 08:21:07.036  1539  9796 I mm-camera: <STATS_AF >< INFO> 1298: af_port_send_stats_config: iir b10=0.092346 b11=0.000000, b12=-0.092346 b20=0.112976 a21=0.000000, a22=-0.112976 cam_role:0 i:0
08-25 08:21:07.036  1539  9796 I mm-camera: <STATS_AF >< INFO> 1291: af_port_send_stats_config: iir a11=0.000000, a12=0.000000, a21=0.000000, a22=0.000000
08-25 08:21:07.036  1539  9796 I mm-camera: <STATS_AF >< INFO> 1298: af_port_send_stats_config: iir b10=0.000000 b11=0.000000, b12=0.000000 b20=0.000000 a21=0.000000, a22=0.000000 cam_role:0 i:1
08-25 08:21:07.036  1539  9796 I mm-camera: <STATS_AF >< INFO> 1291: af_port_send_stats_config: iir a11=1.712158, a12=-0.815308, a21=1.869690, a22=-0.898743
08-25 08:21:07.036  1539  9796 I mm-camera: <STATS_AF >< INFO> 1298: af_port_send_stats_config: iir b10=0.092346 b11=0.000000, b12=-0.092346 b20=0.112976 a21=0.000000, a22=-0.112976 cam_role:0 i:2
08-25 08:21:07.036  1539  9796 I mm-camera: <STATS_AF >< INFO> 1459: af_port_send_pdaf_config: HAF-TAF: Send default config flag 
08-25 08:21:07.049  1539  9795 E mm-camera: <STATS_AEC ><ERROR> 2461: aec_process_parse_input_info: aec_process_parse_input_info: Current Bestshot Mode:0
08-25 08:21:07.049  1539  9782 I mm-camera: <ISP   >< INFO> 245: ihist_stats46_stats_config_validate: warning: Invalid IHIST ROI from 3A 0 0 0 0
08-25 08:21:07.050  1539  9776 I mm-camera: <STATS_AWB >< INFO> 2277: awb_port_parse_set_param: auto awb
08-25 08:21:07.069  1539  9796 I mm-camera: <STATS_AF >< INFO> 1080: af_process_parse_stats: fv: 26645.500000, fv_norm: 36671.859375, lens_pos: 590, cur_luma: 0.000000  Stats ID =2 Stats type: 0 aec_settled: 0 exp_index: 266 fps:30 real_gain:2.207730 scan_cnt:0 progress:0 gyro:0.002413 sadr:0.000000
08-25 08:21:07.082  1539  9795 E mm-camera: <STATS_AEC ><ERROR> 2461: aec_process_parse_input_info: aec_process_parse_input_info: Current Bestshot Mode:0
08-25 08:21:07.104  1539  9796 I mm-camera: <STATS_AF >< INFO> 1080: af_process_parse_stats: fv: 2174.819824, fv_norm: 4450.071289, lens_pos: 590, cur_luma: 0.000000  Stats ID =3 Stats type: 0 aec_settled: 0 exp_index: 331 fps:16 real_gain:7.733717 scan_cnt:0 progress:0 gyro:0.002413 sadr:0.000000
08-25 08:21:07.105  1539  9796 I mm-camera: <STATS_AF >< INFO> 1337: af_process_frame: AF_FOCUS_STATUS changed 0->3
08-25 08:21:07.105  1539  9796 I mm-camera: <STATS_AF >< INFO> 979: af_port_update_af_state: AFCam-[mode -0 role-0] Af State changed new_state=1, old_state=0!, cause=5, af_mode=7
08-25 08:21:07.122  1539  9839 I QCamera : <HAL><INFO> virtual void qcamera::QCamera3ProcessingChannel::streamCbRoutine(mm_camera_super_buf_t *, qcamera::QCamera3Stream *): 885: [KPI Perf] : PROFILE_FIRST_PREVIEW_FRAME camera id 0
08-25 08:21:07.138  1539  9796 I mm-camera: <STATS_AF >< INFO> 1080: af_process_parse_stats: fv: 8890.860352, fv_norm: 557.377991, lens_pos: 590, cur_luma: 0.000000  Stats ID =4 Stats type: 0 aec_settled: 0 exp_index: 394 fps:16 real_gain:48.321503 scan_cnt:1 progress:25 gyro:0.002588 sadr:0.000000
08-25 08:21:07.149  1539  9789 I mm-camera: <CPP   >< INFO> 368: cpp_hardware_set_clock: Set clock 200000000 BW avg 209952000 BW inst 209952000
08-25 08:21:07.161  1539  9789 I mm-camera: <CPP   >< INFO> 368: cpp_hardware_set_clock: Set clock 200000000 BW avg 419904000 BW inst 419904000
08-25 08:21:07.195  9748  9748 D OpenNoteScannerActivity: onPreviewFrame - received image 1920x1080 focused: true imageprocessor: available
08-25 08:21:07.198  1539  9796 I mm-camera: <STATS_AF >< INFO> 1080: af_process_parse_stats: fv: 110669.484375, fv_norm: 990.596558, lens_pos: 590, cur_luma: 0.000000  Stats ID =5 Stats type: 0 aec_settled: 1 exp_index: 419 fps:16 real_gain:95.362183 scan_cnt:2 progress:25 gyro:0.000867 sadr:0.000000
08-25 08:21:07.206  9748  9748 D OpenNoteScannerActivity: sending message to ImageProcessor: previewFrame - com.todobom.opennotescanner.helpers.PreviewFrame@fccb4e9
08-25 08:21:07.206  9748  9766 D ImageProcessor: Message Received: previewFrame - com.todobom.opennotescanner.helpers.PreviewFrame@fccb4e9
08-25 08:21:07.245  9748  9766 E cv::error(): OpenCV Error: Assertion failed (_dx.type() == CV_16SC1 || _dx.type() == CV_16SC3) in void cv::Canny(cv::InputArray, cv::InputArray, cv::OutputArray, double, double, bool), file /build/master_pack-android/opencv/modules/imgproc/src/canny.cpp, line 1076
08-25 08:21:07.246  9748  9766 E org.opencv.imgproc: imgproc::Canny_11() caught cv::Exception: /build/master_pack-android/opencv/modules/imgproc/src/canny.cpp:1076: error: (-215) _dx.type() == CV_16SC1 || _dx.type() == CV_16SC3 in function void cv::Canny(cv::InputArray, cv::InputArray, cv::OutputArray, double, double, bool)
08-25 08:21:07.247  9748  9766 E AndroidRuntime: FATAL EXCEPTION: Worker Thread
08-25 08:21:07.247  9748  9766 E AndroidRuntime: Process: com.todobom.opennotescanner, PID: 9748
08-25 08:21:07.247  9748  9766 E AndroidRuntime: CvException [org.opencv.core.CvException: cv::Exception: /build/master_pack-android/opencv/modules/imgproc/src/canny.cpp:1076: error: (-215) _dx.type() == CV_16SC1 || _dx.type() == CV_16SC3 in function void cv::Canny(cv::InputArray, cv::InputArray, cv::OutputArray, double, double, bool)
08-25 08:21:07.247  9748  9766 E AndroidRuntime: ]
08-25 08:21:07.247  9748  9766 E AndroidRuntime:    at org.opencv.imgproc.Imgproc.Canny_1(Native Method)
08-25 08:21:07.247  9748  9766 E AndroidRuntime:    at org.opencv.imgproc.Imgproc.Canny(Imgproc.java:984)
08-25 08:21:07.247  9748  9766 E AndroidRuntime:    at com.todobom.opennotescanner.ImageProcessor.findContours(ImageProcessor.java:497)
08-25 08:21:07.247  9748  9766 E AndroidRuntime:    at com.todobom.opennotescanner.ImageProcessor.detectPreviewDocument(ImageProcessor.java:213)
08-25 08:21:07.247  9748  9766 E AndroidRuntime:    at com.todobom.opennotescanner.ImageProcessor.processPreviewFrame(ImageProcessor.java:132)
08-25 08:21:07.247  9748  9766 E AndroidRuntime:    at com.todobom.opennotescanner.ImageProcessor.handleMessage(ImageProcessor.java:89)
08-25 08:21:07.247  9748  9766 E AndroidRuntime:    at android.os.Handler.dispatchMessage(Handler.java:102)
08-25 08:21:07.247  9748  9766 E AndroidRuntime:    at android.os.Looper.loop(Looper.java:154)
08-25 08:21:07.247  9748  9766 E AndroidRuntime:    at android.os.HandlerThread.run(HandlerThread.java:61)
08-25 08:21:07.248  1668  3260 W ActivityManager:   Force finishing activity com.todobom.opennotescanner/.OpenNoteScannerActivity
08-25 08:21:07.253  1668  3260 W ContextImpl: Calling a method in the system process without a qualified user: android.app.ContextImpl.sendBroadcast:877 com.android.server.am.AppErrors.crashApplicationInner:375 com.android.server.am.AppErrors.crashApplication:309 com.android.server.am.ActivityManagerService.handleApplicationCrashInner:13757 com.android.server.am.ActivityManagerService.handleApplicationCrash:13739 
08-25 08:21:07.258  1539  9796 I mm-camera: <STATS_AF >< INFO> 1080: af_process_parse_stats: fv: 2887365.500000, fv_norm: 4043.547363, lens_pos: 590, cur_luma: 2.000000  Stats ID =6 Stats type: 0 aec_settled: 1 exp_index: 419 fps:16 real_gain:95.362183 scan_cnt:3 progress:25 gyro:0.002691 sadr:34.375000
08-25 08:21:07.262  9748  9748 D OpenNoteScannerActivity: onPreviewFrame - received image 1920x1080 focused: true imageprocessor: busy
08-25 08:21:07.318  1539  9796 I mm-camera: <STATS_AF >< INFO> 1080: af_process_parse_stats: fv: 7103134.000000, fv_norm: 4954.640625, lens_pos: 590, cur_luma: 12.000000  Stats ID =7 Stats type: 0 aec_settled: 1 exp_index: 419 fps:16 real_gain:95.362183 scan_cnt:3 progress:25 gyro:0.004544 sadr:38.281246
08-25 08:21:07.320  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000009
08-25 08:21:07.320  1539  9775 I mm-camera: <MCT   >< INFO> 4291: mct_pipeline_process_set:  STREAM-OFF on stream 0x40004 stream type=11
08-25 08:21:07.320  1539  9775 I mm-camera: <IFACE >< INFO> 1833: iface_streamoff_to_thread: iface_streamoff_to_thread: E, session id = 4, user stream id = 4
08-25 08:21:07.320  1539  9785 I mm-camera: <IFACE >< INFO> 2466: iface_streamoff: E, session_id 4 mct_stream_id = 4
08-25 08:21:07.320  1539  9785 I mm-camera: <IFACE >< INFO> 12127: iface_util_get_user_streams_by_bundle: streamoff, first bundled streamoff all bindled streams!
08-25 08:21:07.320  1539  9785 I mm-camera: <IFACE >< INFO> 440: iface_ispif_get_cfg_params_from_hw_streams: interace 0 active count = 2, skip stop ispif 
08-25 08:21:07.320  1539  9785 I mm-camera: <IFACE >< INFO> 440: iface_ispif_get_cfg_params_from_hw_streams: interace 0 active count = 1, skip stop ispif 
08-25 08:21:07.320  1539  9785 I mm-camera: <IFACE >< INFO> 2701: iface_streamoff: session_id = 4, active_streams = 0
08-25 08:21:07.320  1539  9785 I mm-camera: <IFACE >< INFO> 2710: iface_streamoff: X
08-25 08:21:07.320  1539  9775 I mm-camera: <IFACE >< INFO> 1859: iface_streamoff_to_thread: iface_streamoff_to_thread: X, session id = 4, user stream id = 4
08-25 08:21:07.321  1539  9853 E mm-camera: <IMGLIB><ERROR> 602: face_proc_thread_loop: maybe some error happened! p_frame=0x0 keyBuff_valid=0
08-25 08:21:07.321  1539  9775 I mm-camera: <MCT   >< INFO> 4307: mct_pipeline_process_set:  STREAM-OFF success for stream 0x40004, stream type=11
08-25 08:21:07.321  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000009
08-25 08:21:07.321  1539  9775 I mm-camera: <MCT   >< INFO> 4291: mct_pipeline_process_set:  STREAM-OFF on stream 0x40002 stream type=1
08-25 08:21:07.321  1539  9775 I mm-camera: <IFACE >< INFO> 1833: iface_streamoff_to_thread: iface_streamoff_to_thread: E, session id = 4, user stream id = 2
08-25 08:21:07.321  1539  9785 I mm-camera: <IFACE >< INFO> 2466: iface_streamoff: E, session_id 4 mct_stream_id = 2
08-25 08:21:07.321  1539  9785 I mm-camera: <IFACE >< INFO> 12133: iface_util_get_user_streams_by_bundle: skip streamoff! left 1 bundled streamoff, mct stream id 2total bundled stream num = 3
08-25 08:21:07.321  1539  9785 I mm-camera: <IFACE >< INFO> 2710: iface_streamoff: X
08-25 08:21:07.321  1539  9775 I mm-camera: <IFACE >< INFO> 1859: iface_streamoff_to_thread: iface_streamoff_to_thread: X, session id = 4, user stream id = 2
08-25 08:21:07.321  1539  9776 I mm-camera: <MCT   >< INFO> 1767: mct_pipeline_control_hw_state: mct_pipeline_control_hw_state lpmbit 40 
08-25 08:21:07.321  1539  9775 I mm-camera: <CPP   >< INFO> 4535: cpp_module_handle_streamoff_event: info: doing stream-off for identity 0x40002
08-25 08:21:07.322  1539  9789 I mm-camera: <CPP   >< INFO> 368: cpp_hardware_set_clock: Set clock 200000000 BW avg 209952000 BW inst 209952000
08-25 08:21:07.322  1539  9775 I mm-camera: <CPP   >< INFO> 4721: cpp_module_handle_streamoff_event: info: stream-off done for identity 0x40002
08-25 08:21:07.322  1539  9775 I mm-camera: <MCT   >< INFO> 4307: mct_pipeline_process_set:  STREAM-OFF success for stream 0x40002, stream type=1
08-25 08:21:07.322  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000009
08-25 08:21:07.322  1539  9775 I         : mct_pipeline_flush_super_param_queue: length = 1
08-25 08:21:07.322  1539  9775 I         : mct_pipeline_flush_super_param_queue: index = 0
08-25 08:21:07.322  1539  9775 I         : mct_pipeline_flush_super_param_queue: index = 1
08-25 08:21:07.322  1539  9775 I         : mct_pipeline_flush_super_param_queue: index = 2
08-25 08:21:07.322  1539  9775 I         : mct_pipeline_flush_super_param_queue: length = 0
08-25 08:21:07.322  1539  9775 I mm-camera: <MCT   >< INFO> 4291: mct_pipeline_process_set:  STREAM-OFF on stream 0x40003 stream type=5
08-25 08:21:07.322  1539  9775 I mm-camera: <IFACE >< INFO> 1833: iface_streamoff_to_thread: iface_streamoff_to_thread: E, session id = 4, user stream id = 3
08-25 08:21:07.323  1539  9785 I mm-camera: <IFACE >< INFO> 2466: iface_streamoff: E, session_id 4 mct_stream_id = 3
08-25 08:21:07.323  1539  9785 I mm-camera: <IFACE >< INFO> 12133: iface_util_get_user_streams_by_bundle: skip streamoff! left 0 bundled streamoff, mct stream id 3total bundled stream num = 3
08-25 08:21:07.323  1539  9785 I mm-camera: <IFACE >< INFO> 2705: iface_streamoff: all bundled stream streamoff, clear hal bundled mask
08-25 08:21:07.323  1539  9785 I mm-camera: <IFACE >< INFO> 2710: iface_streamoff: X
08-25 08:21:07.323  1539  9775 I mm-camera: <IFACE >< INFO> 1859: iface_streamoff_to_thread: iface_streamoff_to_thread: X, session id = 4, user stream id = 3
08-25 08:21:07.326  1539  9775 I mm-camera: <CPP   >< INFO> 4535: cpp_module_handle_streamoff_event: info: doing stream-off for identity 0x40003
08-25 08:21:07.326  1539  9789 I mm-camera: <CPP   >< INFO> 368: cpp_hardware_set_clock: Set clock 200000000 BW avg 0 BW inst 0
08-25 08:21:07.328  1539  9775 I mm-camera: <CPP   >< INFO> 4721: cpp_module_handle_streamoff_event: info: stream-off done for identity 0x40003
08-25 08:21:07.328  1539  9775 I mm-camera: <IFACE >< INFO> 2734: iface_streamoff_post_isp: shubh: free native buf session: 4 hw_stream: 65538
08-25 08:21:07.329  1539  9775 I mm-camera: <IFACE >< INFO> 2734: iface_streamoff_post_isp: shubh: free native buf session: 4 hw_stream: 65540
08-25 08:21:07.330  1539  9775 I mm-camera: <IFACE >< INFO> 2734: iface_streamoff_post_isp: shubh: free native buf session: 4 hw_stream: 589839
08-25 08:21:07.330  1539  9775 I mm-camera: <IFACE >< INFO> 2741: iface_streamoff_post_isp: session id = 0x4,Delta between vfe irqs 0 sec 0 usec
08-25 08:21:07.331  1539  9775 I mm-camera: <IFACE >< INFO> 10888: iface_util_release_resource: camif_cnt= 1, rdi_cnt= 0, used mask 1
08-25 08:21:07.331  1539  9775 I mm-camera: <IFACE >< INFO> 10888: iface_util_release_resource: camif_cnt= 0, rdi_cnt= 0, used mask 0
08-25 08:21:07.331  1539  9775 I mm-camera: <IFACE >< INFO> 3984: iface_destroy_hw: iface_destroy_hw: Destroy axi hw on VFE :0
08-25 08:21:07.332  1539  9775 I mm-camera: <IFACE >< INFO> 10888: iface_util_release_resource: camif_cnt= 0, rdi_cnt= 0, used mask 0
08-25 08:21:07.332  1539  9775 I mm-camera: <MCT   >< INFO> 186: stop_sof_check_thread: Stopping SOF timeout thread session =4
08-25 08:21:07.332  1539  9849 I mm-camera: <MCT   >< INFO> 114: mct_bus_sof_thread_run: Closing SOF tracker thread
08-25 08:21:07.332  1539  9775 I mm-camera: <MCT   >< INFO> 4307: mct_pipeline_process_set:  STREAM-OFF success for stream 0x40003, stream type=5
08-25 08:21:07.334  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000009
08-25 08:21:07.334  1539  9775 I mm-camera: <MCT   >< INFO> 4291: mct_pipeline_process_set:  STREAM-OFF on stream 0x40001 stream type=7
08-25 08:21:07.334  1539  9775 I mm-camera: <MCT   >< INFO> 4307: mct_pipeline_process_set:  STREAM-OFF success for stream 0x40001, stream type=7
08-25 08:21:07.337  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000019
08-25 08:21:07.338  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000019
08-25 08:21:07.338  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000019
08-25 08:21:07.338  1539  2181 W Camera2Client: notifyError: Received recoverable error 3 from HAL - ignoring, requestId 10000001
08-25 08:21:07.338  1539  2181 W Camera3-OutputStream: A frame is dropped for stream 1
08-25 08:21:07.338  1539  2181 W Camera3-OutputStream: A frame is dropped for stream 0
08-25 08:21:07.338  1539  2181 W Camera2Client: notifyError: Received recoverable error 3 from HAL - ignoring, requestId 10000001
08-25 08:21:07.338  1539  2181 W Camera3-OutputStream: A frame is dropped for stream 1
08-25 08:21:07.338  1539  2181 W Camera3-OutputStream: A frame is dropped for stream 0
08-25 08:21:07.338  1539  2181 W Camera2Client: notifyError: Received recoverable error 3 from HAL - ignoring, requestId 10000001
08-25 08:21:07.338  1539  2181 W Camera3-OutputStream: A frame is dropped for stream 1
08-25 08:21:07.338  1539  2181 W Camera3-OutputStream: A frame is dropped for stream 0
08-25 08:21:07.338  1539  2181 W Camera2Client: notifyError: Received recoverable error 3 from HAL - ignoring, requestId 10000001
08-25 08:21:07.338  1539  2181 W Camera3-OutputStream: A frame is dropped for stream 1
08-25 08:21:07.338  1539  2181 W Camera3-OutputStream: A frame is dropped for stream 0
08-25 08:21:07.339  1668  5300 I OpenGLRenderer: Initialized EGL, version 1.4
08-25 08:21:07.339  1668  5300 D OpenGLRenderer: Swap behavior 1
08-25 08:21:07.341  1539  2181 I QCamera : <MCI><INFO> mm_channel_start: 1939: start stream at idx(0) stream_type(7)
08-25 08:21:07.341  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000008
08-25 08:21:07.341  1539  9775 I mm-camera: <MCT   >< INFO> 4291: mct_pipeline_process_set:  STREAM-ON on stream 0x40001 stream type=7
08-25 08:21:07.341  1539  9775 I mm-camera: <MCT   >< INFO> 4307: mct_pipeline_process_set:  STREAM-ON success for stream 0x40001, stream type=7
08-25 08:21:07.341  1539  2181 I QCamera : <MCI><INFO> mm_channel_start: 1939: start stream at idx(1) stream_type(1)
08-25 08:21:07.341  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000008
08-25 08:21:07.341  1539  9775 I mm-camera: <MCT   >< INFO> 4291: mct_pipeline_process_set:  STREAM-ON on stream 0x40002 stream type=1
08-25 08:21:07.341  1539  9775 I mm-camera: <SENSOR>< INFO> 4364: sensor_get_resolution_info: sensor info: name: imx398, res: 1, max_fps: 30.020000, w: 4656, h: 2608 op pix clk: 480000000, FLL: 2686, LLPCK: 5536, mode: 1, PDAF support: 1
08-25 08:21:07.341  1539  9775 I mm-camera: <CPP   >< INFO> 2261: cpp_module_handle_stream_cfg_event: frame_offset=1, input_fps=30.00, identity=0x4000f
08-25 08:21:07.341  1539  9775 I mm-camera: <CPP   >< INFO> 2261: cpp_module_handle_stream_cfg_event: frame_offset=1, input_fps=30.00, identity=0x40002
08-25 08:21:07.341  1539  9775 I mm-camera: <CPP   >< INFO> 2261: cpp_module_handle_stream_cfg_event: frame_offset=1, input_fps=30.00, identity=0x40003
08-25 08:21:07.342  1539  9775 E mm-camera: <SENSOR><ERROR> 8086: module_sensor_set_decode_format_based_on_pack_mode: Pack mode is 0
08-25 08:21:07.342  1539  9795 I mm-camera: <STATS_AEC >< INFO> 2819: aec_set_param: SHDR LIMITS:0 0 (0 0) (0 0)
08-25 08:21:07.342  1539  9775 E mm-camera: <SENSOR><ERROR> 3597: sensor_get_cur_chromatix_name: Res_idx : 1, 3A chromatix : imx398_3a_4656x2608_30fps_preview
08-25 08:21:07.342  1539  9775 E mm-camera: <IFACE ><ERROR> 2245: iface_util_set_chromatix: iface_util_set_chromatix:2245 failed: iface_hvx_open rc 0
08-25 08:21:07.342  1539  9775 I mm-camera: <IFACE >< INFO> 415: iface_util_dump_sensor_cfg: iface_util_dump_sensor_cfg: sensor dim: width = 4656, heght = 2608, fmt = 30, is_bayer = 1, init_skip = 0
08-25 08:21:07.342  1539  9796 E mm-camera: <STATS_AF ><ERROR> 930: af_haf_util_update_force_scan_end_params: force scan timeout enabled,max th: 60 
08-25 08:21:07.342  1539  9796 I mm-camera: <STATS_AF >< INFO> 1001: af_haf_update_tuning_data: Setting default init pos to far end
08-25 08:21:07.343  1539  9775 I mm-camera: <IFACE >< INFO> 4138: iface_util_set_hw_stream_config_pix: iface_util_set_hw_stream_config_pix: Assigned vfe 0 intf 0 for related cam type 1
08-25 08:21:07.343  1539  9775 I mm-camera: <IFACE >< INFO> 3615: iface_util_dump_isp_resource_request:  =====DUMP RESOURCE: PIX STREAM=== 
08-25 08:21:07.343  1539  9775 I mm-camera: <IFACE >< INFO> 3616: iface_util_dump_isp_resource_request: num pix stream = 2
08-25 08:21:07.343  1539  9775 I mm-camera: <IFACE >< INFO> 3619: iface_util_dump_isp_resource_request: num_isp = 1, isp_mask = 1, request_op_pix_clk = 0
08-25 08:21:07.343  1539  9775 I mm-camera: <IFACE >< INFO> 3623: iface_util_dump_isp_resource_request: ispif stripe info: split 0, overlap 0, stripe offset 0
08-25 08:21:07.343  1539  9775 I mm-camera: <IFACE >< INFO> 3626: iface_util_dump_isp_resource_request: pix stream 0
08-25 08:21:07.343  1539  9775 I mm-camera: <IFACE >< INFO> 3629: iface_util_dump_isp_resource_request: num mct stream mapped = 2(Mapped stream ID[0] = 2)
08-25 08:21:07.343  1539  9775 I mm-camera: <IFACE >< INFO> 3632: iface_util_dump_isp_resource_request: axi path = 1(ENC-0/VIEW-1/CAMIF-2/IDEAL-3), cam_fmt 7
08-25 08:21:07.343  1539  9775 I mm-camera: <IFACE >< INFO> 3626: iface_util_dump_isp_resource_request: pix stream 1
08-25 08:21:07.343  1539  9775 I mm-camera: <IFACE >< INFO> 3629: iface_util_dump_isp_resource_request: num mct stream mapped = 1(Mapped stream ID[0] = 4)
08-25 08:21:07.343  1539  9775 I mm-camera: <IFACE >< INFO> 3632: iface_util_dump_isp_resource_request: axi path = 2(ENC-0/VIEW-1/CAMIF-2/IDEAL-3), cam_fmt 101
08-25 08:21:07.343  1539  9775 I mm-camera: <IFACE >< INFO> 3654: iface_util_dump_isp_resource_request: num STATS stream = 7
08-25 08:21:07.343  1539  9775 I mm-camera-iface2: Enable overrid for VFE: 0: MAX (vfe: 410635838, op_pixel_clk: 480000000)
08-25 08:21:07.343  1539  9775 I mm-camera: <CPP   >< INFO> 919: cpp_module_handle_isp_out_dim_event: [STREAM_PARAMS]  stream type 1, width 1920, height 1080,stride 1920, scanline 1088, planes 2
08-25 08:21:07.343  1539  9775 I mm-camera: <CPP   >< INFO> 938: cpp_module_handle_isp_out_dim_event: [STREAM_PARAMS] plane 0, stride 1920, scanline 1088, offset_x 0, offset_y 0, len 2088960, offset:0
08-25 08:21:07.343  1539  9775 I mm-camera: <CPP   >< INFO> 938: cpp_module_handle_isp_out_dim_event: [STREAM_PARAMS] plane 1, stride 1920, scanline 1088, offset_x 0, offset_y 0, len 1044480, offset:0
08-25 08:21:07.343  1539  9775 I mm-camera: <CPP   >< INFO> 919: cpp_module_handle_isp_out_dim_event: [STREAM_PARAMS]  stream type 5, width 1920, height 1080,stride 1920, scanline 1088, planes 2
08-25 08:21:07.343  1539  9775 I mm-camera: <CPP   >< INFO> 938: cpp_module_handle_isp_out_dim_event: [STREAM_PARAMS] plane 0, stride 1920, scanline 1088, offset_x 0, offset_y 0, len 2088960, offset:0
08-25 08:21:07.343  1539  9775 I mm-camera: <CPP   >< INFO> 938: cpp_module_handle_isp_out_dim_event: [STREAM_PARAMS] plane 1, stride 1920, scanline 1088, offset_x 0, offset_y 0, len 1044480, offset:0
08-25 08:21:07.344  1539  9775 I mm-camera: <IFACE >< INFO> 4024: iface_create_axi: iface_create_axi:4024: Create axi hw for session 4 on VFE 0
08-25 08:21:07.344  1539  9775 I mm-camera: <IFACE >< INFO> 9626: iface_util_dump_camif_cfg: =====Camif DUMP cfg for PIX interface====
08-25 08:21:07.344  1539  9775 I mm-camera: <IFACE >< INFO> 9628: iface_util_dump_camif_cfg: camif input type = 3(MIPI=3), op_pix_clk = 480000000
08-25 08:21:07.344  1539  9775 I mm-camera: <IFACE >< INFO> 9630: iface_util_dump_camif_cfg: camif pix_pattern(RGRG-0/GRGR-1/BGBG-2/GBGB-3) = 0
08-25 08:21:07.344  1539  9775 I mm-camera: <IFACE >< INFO> 9632: iface_util_dump_camif_cfg: camif first_pix = 0, last_pix = 4655
08-25 08:21:07.344  1539  9775 I mm-camera: <IFACE >< INFO> 9634: iface_util_dump_camif_cfg: camif first_line = 0, last_line = 2607
08-25 08:21:07.344  1539  9775 I mm-camera: <IFACE >< INFO> 9636: iface_util_dump_camif_cfg: camif pixels_per_line = 4656, lines_per_frame = 2608
08-25 08:21:07.344  1539  9775 I mm-camera: <IFACE >< INFO> 9640: iface_util_dump_camif_cfg: camif irq subsample pattern = 0, period = 0 sof_step 1
08-25 08:21:07.344  1539  9870 I mm-camera: <IFACE >< INFO> 562: iface_dump_axi_plane_config: === AXI DUMP: VFE session_id 4, hw_stream_id 10002 ===
08-25 08:21:07.344  1539  9870 I mm-camera: <IFACE >< INFO> 566: iface_dump_axi_plane_config:     AXI DUMP Axi_src: VIEWFINDER hw_stream width 1920, height 1080
08-25 08:21:07.344  1539  9870 I mm-camera: <IFACE >< INFO> 568: iface_dump_axi_plane_config: need buf divert = 1, burst count = 0
08-25 08:21:07.344  1539  9870 I mm-camera: <IFACE >< INFO> 571: iface_dump_axi_plane_config: hfr mode = 0, skip pattern = 0, init_frame_drop = 0
08-25 08:21:07.344  1539  9870 I mm-camera: <IFACE >< INFO> 604: iface_dump_axi_plane_config: plane[0]: plane_fmt 0(Y-0/CB-1/Cr-2/CrCb-3/CbCr-4)
08-25 08:21:07.344  1539  9870 I mm-camera: <IFACE >< INFO> 606: iface_dump_axi_plane_config: plane[0]: width = 1920, height = 1080
08-25 08:21:07.344  1539  9870 I mm-camera: <IFACE >< INFO> 608: iface_dump_axi_plane_config: plane[0]: stride = 1920, scanlines = 1088
08-25 08:21:07.344  1539  9870 I mm-camera: <IFACE >< INFO> 610: iface_dump_axi_plane_config: plane[0]: address_offset 0
08-25 08:21:07.344  1539  9870 I mm-camera: <IFACE >< INFO> 604: iface_dump_axi_plane_config: plane[1]: plane_fmt 4(Y-0/CB-1/Cr-2/CrCb-3/CbCr-4)
08-25 08:21:07.344  1539  9870 I mm-camera: <IFACE >< INFO> 606: iface_dump_axi_plane_config: plane[1]: width = 1920, height = 540
08-25 08:21:07.344  1539  9870 I mm-camera: <IFACE >< INFO> 608: iface_dump_axi_plane_config: plane[1]: stride = 1920, scanlines = 544
08-25 08:21:07.344  1539  9870 I mm-camera: <IFACE >< INFO> 610: iface_dump_axi_plane_config: plane[1]: address_offset 0
08-25 08:21:07.344  1539  9870 I mm-camera: <IFACE >< INFO> 562: iface_dump_axi_plane_config: === AXI DUMP: VFE session_id 4, hw_stream_id 10004 ===
08-25 08:21:07.344  1539  9870 I mm-camera: <IFACE >< INFO> 566: iface_dump_axi_plane_config:     AXI DUMP Axi_src: VIDEO hw_stream width 640, height 360
08-25 08:21:07.344  1539  9870 I mm-camera: <IFACE >< INFO> 568: iface_dump_axi_plane_config: need buf divert = 1, burst count = 0
08-25 08:21:07.344  1539  9870 I mm-camera: <IFACE >< INFO> 571: iface_dump_axi_plane_config: hfr mode = 0, skip pattern = 0, init_frame_drop = 0
08-25 08:21:07.344  1539  9870 I mm-camera: <IFACE >< INFO> 604: iface_dump_axi_plane_config: plane[0]: plane_fmt 0(Y-0/CB-1/Cr-2/CrCb-3/CbCr-4)
08-25 08:21:07.344  1539  9870 I mm-camera: <IFACE >< INFO> 606: iface_dump_axi_plane_config: plane[0]: width = 640, height = 360
08-25 08:21:07.344  1539  9870 I mm-camera: <IFACE >< INFO> 608: iface_dump_axi_plane_config: plane[0]: stride = 640, scanlines = 480
08-25 08:21:07.344  1539  9870 I mm-camera: <IFACE >< INFO> 610: iface_dump_axi_plane_config: plane[0]: address_offset 0
08-25 08:21:07.344  1539  9870 I mm-camera: <IFACE >< INFO> 562: iface_dump_axi_plane_config: === AXI DUMP: VFE session_id 4, hw_stream_id 9000f ===
08-25 08:21:07.344  1539  9870 I mm-camera: <IFACE >< INFO> 566: iface_dump_axi_plane_config:     AXI DUMP Axi_src: CAMIF_RAW hw_stream width 2328, height 326
08-25 08:21:07.344  1539  9870 I mm-camera: <IFACE >< INFO> 568: iface_dump_axi_plane_config: need buf divert = 1, burst count = 0
08-25 08:21:07.344  1539  9870 I mm-camera: <IFACE >< INFO> 571: iface_dump_axi_plane_config: hfr mode = 0, skip pattern = 0, init_frame_drop = 0
08-25 08:21:07.344  1539  9870 I mm-camera: <IFACE >< INFO> 604: iface_dump_axi_plane_config: plane[0]: plane_fmt 0(Y-0/CB-1/Cr-2/CrCb-3/CbCr-4)
08-25 08:21:07.344  1539  9870 I mm-camera: <IFACE >< INFO> 606: iface_dump_axi_plane_config: plane[0]: width = 2328, height = 326
08-25 08:21:07.344  1539  9870 I mm-camera: <IFACE >< INFO> 608: iface_dump_axi_plane_config: plane[0]: stride = 2336, scanlines = 326
08-25 08:21:07.344  1539  9870 I mm-camera: <IFACE >< INFO> 610: iface_dump_axi_plane_config: plane[0]: address_offset 0
08-25 08:21:07.345  1539  9775 I mm-camera: <IFACE >< INFO> 1778: iface_streamon_to_thread: iface_streamon_to_thread: E, session id = 4, user stream id = 2
08-25 08:21:07.345  1539  9785 I mm-camera: <IFACE >< INFO> 2125: iface_streamon: E, session_id 4 mct_stream_id = 2
08-25 08:21:07.345  1539  9785 I mm-camera: <IFACE >< INFO> 12119: iface_util_get_user_streams_by_bundle: got No.1 bundled streamon, mct stream id 2total bundled stream num = 3
08-25 08:21:07.352  1539  9775 I mm-camera: <CPP   >< INFO> 4460: cpp_module_handle_streamon_event: identity=0x40002, stream-on done
08-25 08:21:07.352  1539  9775 I mm-camera: <IFACE >< INFO> 1807: iface_streamon_to_thread: iface_streamon_to_thread: X, session id = 4, user stream id = 2
08-25 08:21:07.352  1539  9789 I mm-camera: <CPP   >< INFO> 368: cpp_hardware_set_clock: Set clock 576000000 BW avg 209952000 BW inst 209952000
08-25 08:21:07.353  1539  9775 I mm-camera: <MCT   >< INFO> 156: start_sof_check_thread: Starting SOF timeout thread session id =4
08-25 08:21:07.353  1539  9775 I mm-camera: <MCT   >< INFO> 4307: mct_pipeline_process_set:  STREAM-ON success for stream 0x40002, stream type=1
08-25 08:21:07.353  1539  2181 I QCamera : <MCI><INFO> mm_channel_start: 1939: start stream at idx(2) stream_type(5)
08-25 08:21:07.353  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000008
08-25 08:21:07.353  1539  9775 I mm-camera: <MCT   >< INFO> 4291: mct_pipeline_process_set:  STREAM-ON on stream 0x40003 stream type=5
08-25 08:21:07.354  1539  9775 I mm-camera: <IFACE >< INFO> 1778: iface_streamon_to_thread: iface_streamon_to_thread: E, session id = 4, user stream id = 3
08-25 08:21:07.354  1539  9785 I mm-camera: <IFACE >< INFO> 2125: iface_streamon: E, session_id 4 mct_stream_id = 3
08-25 08:21:07.354  1539  9785 I mm-camera: <IFACE >< INFO> 12119: iface_util_get_user_streams_by_bundle: got No.2 bundled streamon, mct stream id 3total bundled stream num = 3
08-25 08:21:07.354  1539  9775 I mm-camera: <CPP   >< INFO> 4460: cpp_module_handle_streamon_event: identity=0x40003, stream-on done
08-25 08:21:07.354  1539  9775 I mm-camera: <IFACE >< INFO> 1807: iface_streamon_to_thread: iface_streamon_to_thread: X, session id = 4, user stream id = 3
08-25 08:21:07.354  1539  9775 I mm-camera: <MCT   >< INFO> 4307: mct_pipeline_process_set:  STREAM-ON success for stream 0x40003, stream type=5
08-25 08:21:07.354  1539  2181 I QCamera : <MCI><INFO> mm_channel_start: 1939: start stream at idx(3) stream_type(11)
08-25 08:21:07.354  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000008
08-25 08:21:07.354  1539  9775 I mm-camera: <MCT   >< INFO> 4291: mct_pipeline_process_set:  STREAM-ON on stream 0x40004 stream type=11
08-25 08:21:07.354  1539  9789 I mm-camera: <CPP   >< INFO> 368: cpp_hardware_set_clock: Set clock 576000000 BW avg 419904000 BW inst 419904000
08-25 08:21:07.354  1539  9775 I mm-camera: <IFACE >< INFO> 1778: iface_streamon_to_thread: iface_streamon_to_thread: E, session id = 4, user stream id = 4
08-25 08:21:07.354  1539  9785 I mm-camera: <IFACE >< INFO> 2125: iface_streamon: E, session_id 4 mct_stream_id = 4
08-25 08:21:07.354  1539  9785 I mm-camera: <IFACE >< INFO> 12113: iface_util_get_user_streams_by_bundle: streamon, got all bundled streamon!
08-25 08:21:07.356  1539  9775 I imagefw_android: detect        detect      hunter      M_Detect_Hunter_SmallFace_Gray_6_0_0_model
08-25 08:21:07.356  1539  9775 I imagefw_android: detect        align       deep        M_Align_Deepface_106_track_2_7_0_model
08-25 08:21:07.356  1539  9775 I imagefw_android: detect        align       deep        M_Align_Deepface_21_2_1_1_model
08-25 08:21:07.356  1539  9775 I imagefw_android: track     detect      hunter      M_Detect_Hunter_SmallFace_Gray_6_0_0_model
08-25 08:21:07.356  1539  9775 I imagefw_android: track     align       deep        M_Align_Deepface_106_track_2_7_0_model
08-25 08:21:07.356  1539  9775 I imagefw_android: track     align       deep        M_Align_Deepface_21_track_2_3_0_model
08-25 08:21:07.368  1539  9785 I mm-camera: <IFACE >< INFO> 2420: iface_streamon: X
08-25 08:21:07.368  1539  9775 I mm-camera: <IFACE >< INFO> 1807: iface_streamon_to_thread: iface_streamon_to_thread: X, session id = 4, user stream id = 4
08-25 08:21:07.368  1539  9775 I mm-camera: <MCT   >< INFO> 4307: mct_pipeline_process_set:  STREAM-ON success for stream 0x40004, stream type=11
08-25 08:21:07.416  1539  9869 I mm-camera: <ISP   >< INFO> 1398: isp_handler_module_handle_reg_update:  Warning! Invalid reg_update state 0
08-25 08:21:07.420  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000009
08-25 08:21:07.420  1539  9775 I mm-camera: <MCT   >< INFO> 4291: mct_pipeline_process_set:  STREAM-OFF on stream 0x40004 stream type=11
08-25 08:21:07.420  1539  9775 I mm-camera: <IFACE >< INFO> 1833: iface_streamoff_to_thread: iface_streamoff_to_thread: E, session id = 4, user stream id = 4
08-25 08:21:07.420  1539  9785 I mm-camera: <IFACE >< INFO> 2466: iface_streamoff: E, session_id 4 mct_stream_id = 4
08-25 08:21:07.420  1539  9785 I mm-camera: <IFACE >< INFO> 12127: iface_util_get_user_streams_by_bundle: streamoff, first bundled streamoff all bindled streams!
08-25 08:21:07.420  1539  9785 I mm-camera: <IFACE >< INFO> 440: iface_ispif_get_cfg_params_from_hw_streams: interace 0 active count = 2, skip stop ispif 
08-25 08:21:07.420  1539  9785 I mm-camera: <IFACE >< INFO> 440: iface_ispif_get_cfg_params_from_hw_streams: interace 0 active count = 1, skip stop ispif 
08-25 08:21:07.421  1539  9785 I mm-camera: <IFACE >< INFO> 2701: iface_streamoff: session_id = 4, active_streams = 0
08-25 08:21:07.421  1539  9785 I mm-camera: <IFACE >< INFO> 2710: iface_streamoff: X
08-25 08:21:07.421  1539  9775 I mm-camera: <IFACE >< INFO> 1859: iface_streamoff_to_thread: iface_streamoff_to_thread: X, session id = 4, user stream id = 4
08-25 08:21:07.421  1539  9877 E mm-camera: <IMGLIB><ERROR> 602: face_proc_thread_loop: maybe some error happened! p_frame=0x0 keyBuff_valid=0
08-25 08:21:07.421  1539  9775 I mm-camera: <MCT   >< INFO> 4307: mct_pipeline_process_set:  STREAM-OFF success for stream 0x40004, stream type=11
08-25 08:21:07.421  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000009
08-25 08:21:07.421  1539  9775 I mm-camera: <MCT   >< INFO> 4291: mct_pipeline_process_set:  STREAM-OFF on stream 0x40002 stream type=1
08-25 08:21:07.421  1539  9775 I mm-camera: <IFACE >< INFO> 1833: iface_streamoff_to_thread: iface_streamoff_to_thread: E, session id = 4, user stream id = 2
08-25 08:21:07.421  1539  9785 I mm-camera: <IFACE >< INFO> 2466: iface_streamoff: E, session_id 4 mct_stream_id = 2
08-25 08:21:07.421  1539  9785 I mm-camera: <IFACE >< INFO> 12133: iface_util_get_user_streams_by_bundle: skip streamoff! left 1 bundled streamoff, mct stream id 2total bundled stream num = 3
08-25 08:21:07.421  1539  9785 I mm-camera: <IFACE >< INFO> 2710: iface_streamoff: X
08-25 08:21:07.421  1539  9775 I mm-camera: <IFACE >< INFO> 1859: iface_streamoff_to_thread: iface_streamoff_to_thread: X, session id = 4, user stream id = 2
08-25 08:21:07.421  1539  9776 I mm-camera: <MCT   >< INFO> 1767: mct_pipeline_control_hw_state: mct_pipeline_control_hw_state lpmbit 40 
08-25 08:21:07.421  1539  9775 I mm-camera: <CPP   >< INFO> 4535: cpp_module_handle_streamoff_event: info: doing stream-off for identity 0x40002
08-25 08:21:07.422  1539  9775 I mm-camera: <CPP   >< INFO> 4721: cpp_module_handle_streamoff_event: info: stream-off done for identity 0x40002
08-25 08:21:07.422  1539  9775 I mm-camera: <MCT   >< INFO> 4307: mct_pipeline_process_set:  STREAM-OFF success for stream 0x40002, stream type=1
08-25 08:21:07.422  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000009
08-25 08:21:07.422  1539  9775 I mm-camera: <MCT   >< INFO> 4291: mct_pipeline_process_set:  STREAM-OFF on stream 0x40003 stream type=5
08-25 08:21:07.422  1539  9775 I mm-camera: <IFACE >< INFO> 1833: iface_streamoff_to_thread: iface_streamoff_to_thread: E, session id = 4, user stream id = 3
08-25 08:21:07.422  1539  9785 I mm-camera: <IFACE >< INFO> 2466: iface_streamoff: E, session_id 4 mct_stream_id = 3
08-25 08:21:07.422  1539  9785 I mm-camera: <IFACE >< INFO> 12133: iface_util_get_user_streams_by_bundle: skip streamoff! left 0 bundled streamoff, mct stream id 3total bundled stream num = 3
08-25 08:21:07.422  1539  9785 I mm-camera: <IFACE >< INFO> 2705: iface_streamoff: all bundled stream streamoff, clear hal bundled mask
08-25 08:21:07.422  1539  9785 I mm-camera: <IFACE >< INFO> 2710: iface_streamoff: X
08-25 08:21:07.422  1539  9789 I mm-camera: <CPP   >< INFO> 368: cpp_hardware_set_clock: Set clock 200000000 BW avg 209952000 BW inst 209952000
08-25 08:21:07.422  1539  9775 I mm-camera: <IFACE >< INFO> 1859: iface_streamoff_to_thread: iface_streamoff_to_thread: X, session id = 4, user stream id = 3
08-25 08:21:07.425  1539  9775 I mm-camera: <CPP   >< INFO> 4535: cpp_module_handle_streamoff_event: info: doing stream-off for identity 0x40003
08-25 08:21:07.425  1539  9789 I mm-camera: <CPP   >< INFO> 368: cpp_hardware_set_clock: Set clock 200000000 BW avg 0 BW inst 0
08-25 08:21:07.426  1539  9775 I mm-camera: <CPP   >< INFO> 4721: cpp_module_handle_streamoff_event: info: stream-off done for identity 0x40003
08-25 08:21:07.426  1539  9775 I mm-camera: <IFACE >< INFO> 2734: iface_streamoff_post_isp: shubh: free native buf session: 4 hw_stream: 65538
08-25 08:21:07.427  1539  9775 I mm-camera: <IFACE >< INFO> 2734: iface_streamoff_post_isp: shubh: free native buf session: 4 hw_stream: 65540
08-25 08:21:07.428  1539  9775 I mm-camera: <IFACE >< INFO> 2734: iface_streamoff_post_isp: shubh: free native buf session: 4 hw_stream: 589839
08-25 08:21:07.428  1539  9775 I mm-camera: <IFACE >< INFO> 2741: iface_streamoff_post_isp: session id = 0x4,Delta between vfe irqs 0 sec 0 usec
08-25 08:21:07.430  1539  9775 I mm-camera: <IFACE >< INFO> 10888: iface_util_release_resource: camif_cnt= 1, rdi_cnt= 0, used mask 1
08-25 08:21:07.430  1539  9775 I mm-camera: <IFACE >< INFO> 10888: iface_util_release_resource: camif_cnt= 0, rdi_cnt= 0, used mask 0
08-25 08:21:07.430  1539  9775 I mm-camera: <IFACE >< INFO> 3984: iface_destroy_hw: iface_destroy_hw: Destroy axi hw on VFE :0
08-25 08:21:07.430  1539  9775 I mm-camera: <IFACE >< INFO> 10888: iface_util_release_resource: camif_cnt= 0, rdi_cnt= 0, used mask 0
08-25 08:21:07.430  1539  9775 I mm-camera: <MCT   >< INFO> 186: stop_sof_check_thread: Stopping SOF timeout thread session =4
08-25 08:21:07.430  1539  9873 I mm-camera: <MCT   >< INFO> 114: mct_bus_sof_thread_run: Closing SOF tracker thread
08-25 08:21:07.430  1539  9775 I mm-camera: <MCT   >< INFO> 4307: mct_pipeline_process_set:  STREAM-OFF success for stream 0x40003, stream type=5
08-25 08:21:07.430  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000009
08-25 08:21:07.430  1539  9775 I mm-camera: <MCT   >< INFO> 4291: mct_pipeline_process_set:  STREAM-OFF on stream 0x40001 stream type=7
08-25 08:21:07.430  1539  9775 I mm-camera: <MCT   >< INFO> 4307: mct_pipeline_process_set:  STREAM-OFF success for stream 0x40001, stream type=7
08-25 08:21:07.432  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000019
08-25 08:21:07.432  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000019
08-25 08:21:07.432  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000019
08-25 08:21:07.434  1539  1539 I QCamera : <MCI><INFO> mm_channel_start: 1939: start stream at idx(0) stream_type(7)
08-25 08:21:07.434  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000008
08-25 08:21:07.434  1539  9775 I mm-camera: <MCT   >< INFO> 4291: mct_pipeline_process_set:  STREAM-ON on stream 0x40001 stream type=7
08-25 08:21:07.434  1539  9775 I mm-camera: <MCT   >< INFO> 4307: mct_pipeline_process_set:  STREAM-ON success for stream 0x40001, stream type=7
08-25 08:21:07.434  1539  1539 I QCamera : <MCI><INFO> mm_channel_start: 1939: start stream at idx(1) stream_type(1)
08-25 08:21:07.434  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000008
08-25 08:21:07.434  1539  9775 I mm-camera: <MCT   >< INFO> 4291: mct_pipeline_process_set:  STREAM-ON on stream 0x40002 stream type=1
08-25 08:21:07.434  1539  9775 I mm-camera: <SENSOR>< INFO> 4364: sensor_get_resolution_info: sensor info: name: imx398, res: 1, max_fps: 30.020000, w: 4656, h: 2608 op pix clk: 480000000, FLL: 2686, LLPCK: 5536, mode: 1, PDAF support: 1
08-25 08:21:07.435  1539  9795 I mm-camera: <STATS_AEC >< INFO> 2819: aec_set_param: SHDR LIMITS:0 0 (0 0) (0 0)
08-25 08:21:07.435  1539  9775 I mm-camera: <CPP   >< INFO> 2261: cpp_module_handle_stream_cfg_event: frame_offset=1, input_fps=30.00, identity=0x4000f
08-25 08:21:07.435  1539  9775 I mm-camera: <CPP   >< INFO> 2261: cpp_module_handle_stream_cfg_event: frame_offset=1, input_fps=30.00, identity=0x40002
08-25 08:21:07.435  1539  9775 I mm-camera: <CPP   >< INFO> 2261: cpp_module_handle_stream_cfg_event: frame_offset=1, input_fps=30.00, identity=0x40003
08-25 08:21:07.435  1539  9775 E mm-camera: <SENSOR><ERROR> 8086: module_sensor_set_decode_format_based_on_pack_mode: Pack mode is 0
08-25 08:21:07.435  1539  9775 E mm-camera: <SENSOR><ERROR> 3597: sensor_get_cur_chromatix_name: Res_idx : 1, 3A chromatix : imx398_3a_4656x2608_30fps_preview
08-25 08:21:07.435  1539  9775 E mm-camera: <IFACE ><ERROR> 2245: iface_util_set_chromatix: iface_util_set_chromatix:2245 failed: iface_hvx_open rc 0
08-25 08:21:07.435  1539  9775 I mm-camera: <IFACE >< INFO> 415: iface_util_dump_sensor_cfg: iface_util_dump_sensor_cfg: sensor dim: width = 4656, heght = 2608, fmt = 30, is_bayer = 1, init_skip = 0
08-25 08:21:07.436  1539  9796 E mm-camera: <STATS_AF ><ERROR> 930: af_haf_util_update_force_scan_end_params: force scan timeout enabled,max th: 60 
08-25 08:21:07.436  1539  9796 I mm-camera: <STATS_AF >< INFO> 1001: af_haf_update_tuning_data: Setting default init pos to far end
08-25 08:21:07.436  1539  9775 I mm-camera: <IFACE >< INFO> 4138: iface_util_set_hw_stream_config_pix: iface_util_set_hw_stream_config_pix: Assigned vfe 0 intf 0 for related cam type 1
08-25 08:21:07.436  1539  9775 I mm-camera: <IFACE >< INFO> 3615: iface_util_dump_isp_resource_request:  =====DUMP RESOURCE: PIX STREAM=== 
08-25 08:21:07.436  1539  9775 I mm-camera: <IFACE >< INFO> 3616: iface_util_dump_isp_resource_request: num pix stream = 2
08-25 08:21:07.436  1539  9775 I mm-camera: <IFACE >< INFO> 3619: iface_util_dump_isp_resource_request: num_isp = 1, isp_mask = 1, request_op_pix_clk = 0
08-25 08:21:07.436  1539  9775 I mm-camera: <IFACE >< INFO> 3623: iface_util_dump_isp_resource_request: ispif stripe info: split 0, overlap 0, stripe offset 0
08-25 08:21:07.436  1539  9775 I mm-camera: <IFACE >< INFO> 3626: iface_util_dump_isp_resource_request: pix stream 0
08-25 08:21:07.436  1539  9775 I mm-camera: <IFACE >< INFO> 3629: iface_util_dump_isp_resource_request: num mct stream mapped = 2(Mapped stream ID[0] = 2)
08-25 08:21:07.436  1539  9775 I mm-camera: <IFACE >< INFO> 3632: iface_util_dump_isp_resource_request: axi path = 1(ENC-0/VIEW-1/CAMIF-2/IDEAL-3), cam_fmt 7
08-25 08:21:07.436  1539  9775 I mm-camera: <IFACE >< INFO> 3626: iface_util_dump_isp_resource_request: pix stream 1
08-25 08:21:07.436  1539  9775 I mm-camera: <IFACE >< INFO> 3629: iface_util_dump_isp_resource_request: num mct stream mapped = 1(Mapped stream ID[0] = 4)
08-25 08:21:07.436  1539  9775 I mm-camera: <IFACE >< INFO> 3632: iface_util_dump_isp_resource_request: axi path = 2(ENC-0/VIEW-1/CAMIF-2/IDEAL-3), cam_fmt 101
08-25 08:21:07.436  1539  9775 I mm-camera: <IFACE >< INFO> 3654: iface_util_dump_isp_resource_request: num STATS stream = 7
08-25 08:21:07.436  1539  9775 I mm-camera-iface2: Enable overrid for VFE: 0: MAX (vfe: 410635838, op_pixel_clk: 480000000)
08-25 08:21:07.436  1539  9775 I mm-camera: <CPP   >< INFO> 919: cpp_module_handle_isp_out_dim_event: [STREAM_PARAMS]  stream type 1, width 1920, height 1080,stride 1920, scanline 1088, planes 2
08-25 08:21:07.436  1539  9775 I mm-camera: <CPP   >< INFO> 938: cpp_module_handle_isp_out_dim_event: [STREAM_PARAMS] plane 0, stride 1920, scanline 1088, offset_x 0, offset_y 0, len 2088960, offset:0
08-25 08:21:07.436  1539  9775 I mm-camera: <CPP   >< INFO> 938: cpp_module_handle_isp_out_dim_event: [STREAM_PARAMS] plane 1, stride 1920, scanline 1088, offset_x 0, offset_y 0, len 1044480, offset:0
08-25 08:21:07.436  1539  9775 I mm-camera: <CPP   >< INFO> 919: cpp_module_handle_isp_out_dim_event: [STREAM_PARAMS]  stream type 5, width 1920, height 1080,stride 1920, scanline 1088, planes 2
08-25 08:21:07.437  1539  9775 I mm-camera: <CPP   >< INFO> 938: cpp_module_handle_isp_out_dim_event: [STREAM_PARAMS] plane 0, stride 1920, scanline 1088, offset_x 0, offset_y 0, len 2088960, offset:0
08-25 08:21:07.437  1539  9775 I mm-camera: <CPP   >< INFO> 938: cpp_module_handle_isp_out_dim_event: [STREAM_PARAMS] plane 1, stride 1920, scanline 1088, offset_x 0, offset_y 0, len 1044480, offset:0
08-25 08:21:07.437  1539  9775 I mm-camera: <IFACE >< INFO> 4024: iface_create_axi: iface_create_axi:4024: Create axi hw for session 4 on VFE 0
08-25 08:21:07.437  1539  9775 I mm-camera: <IFACE >< INFO> 9626: iface_util_dump_camif_cfg: =====Camif DUMP cfg for PIX interface====
08-25 08:21:07.437  1539  9775 I mm-camera: <IFACE >< INFO> 9628: iface_util_dump_camif_cfg: camif input type = 3(MIPI=3), op_pix_clk = 480000000
08-25 08:21:07.437  1539  9775 I mm-camera: <IFACE >< INFO> 9630: iface_util_dump_camif_cfg: camif pix_pattern(RGRG-0/GRGR-1/BGBG-2/GBGB-3) = 0
08-25 08:21:07.437  1539  9775 I mm-camera: <IFACE >< INFO> 9632: iface_util_dump_camif_cfg: camif first_pix = 0, last_pix = 4655
08-25 08:21:07.438  1539  9775 I mm-camera: <IFACE >< INFO> 9634: iface_util_dump_camif_cfg: camif first_line = 0, last_line = 2607
08-25 08:21:07.438  1539  9775 I mm-camera: <IFACE >< INFO> 9636: iface_util_dump_camif_cfg: camif pixels_per_line = 4656, lines_per_frame = 2608
08-25 08:21:07.438  1539  9775 I mm-camera: <IFACE >< INFO> 9640: iface_util_dump_camif_cfg: camif irq subsample pattern = 0, period = 0 sof_step 1
08-25 08:21:07.438  1539  9886 I mm-camera: <IFACE >< INFO> 562: iface_dump_axi_plane_config: === AXI DUMP: VFE session_id 4, hw_stream_id 10002 ===
08-25 08:21:07.438  1539  9886 I mm-camera: <IFACE >< INFO> 566: iface_dump_axi_plane_config:     AXI DUMP Axi_src: VIEWFINDER hw_stream width 1920, height 1080
08-25 08:21:07.438  1539  9886 I mm-camera: <IFACE >< INFO> 568: iface_dump_axi_plane_config: need buf divert = 1, burst count = 0
08-25 08:21:07.438  1539  9886 I mm-camera: <IFACE >< INFO> 571: iface_dump_axi_plane_config: hfr mode = 0, skip pattern = 0, init_frame_drop = 0
08-25 08:21:07.438  1539  9886 I mm-camera: <IFACE >< INFO> 604: iface_dump_axi_plane_config: plane[0]: plane_fmt 0(Y-0/CB-1/Cr-2/CrCb-3/CbCr-4)
08-25 08:21:07.438  1539  9886 I mm-camera: <IFACE >< INFO> 606: iface_dump_axi_plane_config: plane[0]: width = 1920, height = 1080
08-25 08:21:07.438  1539  9886 I mm-camera: <IFACE >< INFO> 608: iface_dump_axi_plane_config: plane[0]: stride = 1920, scanlines = 1088
08-25 08:21:07.438  1539  9886 I mm-camera: <IFACE >< INFO> 610: iface_dump_axi_plane_config: plane[0]: address_offset 0
08-25 08:21:07.438  1539  9886 I mm-camera: <IFACE >< INFO> 604: iface_dump_axi_plane_config: plane[1]: plane_fmt 4(Y-0/CB-1/Cr-2/CrCb-3/CbCr-4)
08-25 08:21:07.438  1539  9886 I mm-camera: <IFACE >< INFO> 606: iface_dump_axi_plane_config: plane[1]: width = 1920, height = 540
08-25 08:21:07.438  1539  9886 I mm-camera: <IFACE >< INFO> 608: iface_dump_axi_plane_config: plane[1]: stride = 1920, scanlines = 544
08-25 08:21:07.438  1539  9886 I mm-camera: <IFACE >< INFO> 610: iface_dump_axi_plane_config: plane[1]: address_offset 0
08-25 08:21:07.438  1539  9886 I mm-camera: <IFACE >< INFO> 562: iface_dump_axi_plane_config: === AXI DUMP: VFE session_id 4, hw_stream_id 10004 ===
08-25 08:21:07.438  1539  9886 I mm-camera: <IFACE >< INFO> 566: iface_dump_axi_plane_config:     AXI DUMP Axi_src: VIDEO hw_stream width 640, height 360
08-25 08:21:07.438  1539  9886 I mm-camera: <IFACE >< INFO> 568: iface_dump_axi_plane_config: need buf divert = 1, burst count = 0
08-25 08:21:07.438  1539  9886 I mm-camera: <IFACE >< INFO> 571: iface_dump_axi_plane_config: hfr mode = 0, skip pattern = 0, init_frame_drop = 0
08-25 08:21:07.438  1539  9886 I mm-camera: <IFACE >< INFO> 604: iface_dump_axi_plane_config: plane[0]: plane_fmt 0(Y-0/CB-1/Cr-2/CrCb-3/CbCr-4)
08-25 08:21:07.438  1539  9886 I mm-camera: <IFACE >< INFO> 606: iface_dump_axi_plane_config: plane[0]: width = 640, height = 360
08-25 08:21:07.438  1539  9886 I mm-camera: <IFACE >< INFO> 608: iface_dump_axi_plane_config: plane[0]: stride = 640, scanlines = 480
08-25 08:21:07.438  1539  9886 I mm-camera: <IFACE >< INFO> 610: iface_dump_axi_plane_config: plane[0]: address_offset 0
08-25 08:21:07.438  1539  9886 I mm-camera: <IFACE >< INFO> 562: iface_dump_axi_plane_config: === AXI DUMP: VFE session_id 4, hw_stream_id 9000f ===
08-25 08:21:07.438  1539  9886 I mm-camera: <IFACE >< INFO> 566: iface_dump_axi_plane_config:     AXI DUMP Axi_src: CAMIF_RAW hw_stream width 2328, height 326
08-25 08:21:07.438  1539  9886 I mm-camera: <IFACE >< INFO> 568: iface_dump_axi_plane_config: need buf divert = 1, burst count = 0
08-25 08:21:07.438  1539  9886 I mm-camera: <IFACE >< INFO> 571: iface_dump_axi_plane_config: hfr mode = 0, skip pattern = 0, init_frame_drop = 0
08-25 08:21:07.438  1539  9886 I mm-camera: <IFACE >< INFO> 604: iface_dump_axi_plane_config: plane[0]: plane_fmt 0(Y-0/CB-1/Cr-2/CrCb-3/CbCr-4)
08-25 08:21:07.438  1539  9886 I mm-camera: <IFACE >< INFO> 606: iface_dump_axi_plane_config: plane[0]: width = 2328, height = 326
08-25 08:21:07.438  1539  9886 I mm-camera: <IFACE >< INFO> 608: iface_dump_axi_plane_config: plane[0]: stride = 2336, scanlines = 326
08-25 08:21:07.438  1539  9886 I mm-camera: <IFACE >< INFO> 610: iface_dump_axi_plane_config: plane[0]: address_offset 0
08-25 08:21:07.438  1539  9775 I mm-camera: <IFACE >< INFO> 1778: iface_streamon_to_thread: iface_streamon_to_thread: E, session id = 4, user stream id = 2
08-25 08:21:07.438  1539  9785 I mm-camera: <IFACE >< INFO> 2125: iface_streamon: E, session_id 4 mct_stream_id = 2
08-25 08:21:07.439  1539  9785 I mm-camera: <IFACE >< INFO> 12119: iface_util_get_user_streams_by_bundle: got No.1 bundled streamon, mct stream id 2total bundled stream num = 3
08-25 08:21:07.444  1539  9775 I mm-camera: <CPP   >< INFO> 4460: cpp_module_handle_streamon_event: identity=0x40002, stream-on done
08-25 08:21:07.444  1539  9775 I mm-camera: <IFACE >< INFO> 1807: iface_streamon_to_thread: iface_streamon_to_thread: X, session id = 4, user stream id = 2
08-25 08:21:07.445  1539  9789 I mm-camera: <CPP   >< INFO> 368: cpp_hardware_set_clock: Set clock 576000000 BW avg 209952000 BW inst 209952000
08-25 08:21:07.445  1539  9775 I mm-camera: <MCT   >< INFO> 156: start_sof_check_thread: Starting SOF timeout thread session id =4
08-25 08:21:07.446  1539  9775 I mm-camera: <MCT   >< INFO> 4307: mct_pipeline_process_set:  STREAM-ON success for stream 0x40002, stream type=1
08-25 08:21:07.446  1539  1539 I QCamera : <MCI><INFO> mm_channel_start: 1939: start stream at idx(2) stream_type(5)
08-25 08:21:07.446  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000008
08-25 08:21:07.446  1539  9775 I mm-camera: <MCT   >< INFO> 4291: mct_pipeline_process_set:  STREAM-ON on stream 0x40003 stream type=5
08-25 08:21:07.446  1539  9775 I mm-camera: <IFACE >< INFO> 1778: iface_streamon_to_thread: iface_streamon_to_thread: E, session id = 4, user stream id = 3
08-25 08:21:07.446  1539  9785 I mm-camera: <IFACE >< INFO> 2125: iface_streamon: E, session_id 4 mct_stream_id = 3
08-25 08:21:07.446  1539  9785 I mm-camera: <IFACE >< INFO> 12119: iface_util_get_user_streams_by_bundle: got No.2 bundled streamon, mct stream id 3total bundled stream num = 3
08-25 08:21:07.446  1539  9775 I mm-camera: <CPP   >< INFO> 4460: cpp_module_handle_streamon_event: identity=0x40003, stream-on done
08-25 08:21:07.446  1539  9775 I mm-camera: <IFACE >< INFO> 1807: iface_streamon_to_thread: iface_streamon_to_thread: X, session id = 4, user stream id = 3
08-25 08:21:07.446  1539  9775 I mm-camera: <MCT   >< INFO> 4307: mct_pipeline_process_set:  STREAM-ON success for stream 0x40003, stream type=5
08-25 08:21:07.446  1539  1539 I QCamera : <MCI><INFO> mm_channel_start: 1939: start stream at idx(3) stream_type(11)
08-25 08:21:07.446  1539  9789 I mm-camera: <CPP   >< INFO> 368: cpp_hardware_set_clock: Set clock 576000000 BW avg 419904000 BW inst 419904000
08-25 08:21:07.446  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000008
08-25 08:21:07.446  1539  9775 I mm-camera: <MCT   >< INFO> 4291: mct_pipeline_process_set:  STREAM-ON on stream 0x40004 stream type=11
08-25 08:21:07.446  1539  9775 I mm-camera: <IFACE >< INFO> 1778: iface_streamon_to_thread: iface_streamon_to_thread: E, session id = 4, user stream id = 4
08-25 08:21:07.446  1539  9785 I mm-camera: <IFACE >< INFO> 2125: iface_streamon: E, session_id 4 mct_stream_id = 4
08-25 08:21:07.446  1539  9785 I mm-camera: <IFACE >< INFO> 12113: iface_util_get_user_streams_by_bundle: streamon, got all bundled streamon!
08-25 08:21:07.449  1539  9775 I imagefw_android: detect        detect      hunter      M_Detect_Hunter_SmallFace_Gray_6_0_0_model
08-25 08:21:07.449  1539  9775 I imagefw_android: detect        align       deep        M_Align_Deepface_106_track_2_7_0_model
08-25 08:21:07.449  1539  9775 I imagefw_android: detect        align       deep        M_Align_Deepface_21_2_1_1_model
08-25 08:21:07.449  1539  9775 I imagefw_android: track     detect      hunter      M_Detect_Hunter_SmallFace_Gray_6_0_0_model
08-25 08:21:07.449  1539  9775 I imagefw_android: track     align       deep        M_Align_Deepface_106_track_2_7_0_model
08-25 08:21:07.449  1539  9775 I imagefw_android: track     align       deep        M_Align_Deepface_21_track_2_3_0_model
08-25 08:21:07.461  1539  9785 I mm-camera: <IFACE >< INFO> 2420: iface_streamon: X
08-25 08:21:07.461  1539  9775 I mm-camera: <IFACE >< INFO> 1807: iface_streamon_to_thread: iface_streamon_to_thread: X, session id = 4, user stream id = 4
08-25 08:21:07.461  1539  9775 I mm-camera: <MCT   >< INFO> 4307: mct_pipeline_process_set:  STREAM-ON success for stream 0x40004, stream type=11
08-25 08:21:07.511  1539  9885 I mm-camera: <ISP   >< INFO> 1398: isp_handler_module_handle_reg_update:  Warning! Invalid reg_update state 0
08-25 08:21:07.531  1539  9796 I mm-camera: <STATS_AF >< INFO> 2791: af_util_adjust_roi:  Calculated new ROI: (1748, 724, 1160 1160) roi_type:0 in_low_light: 1 spotlight:0 green_count:0 lux_idx:422.000000 lens_type:0
08-25 08:21:07.531  1539  9796 I mm-camera: <STATS_AF >< INFO> 1080: af_process_parse_stats: fv: 2655549.500000, fv_norm: 1784.302490, lens_pos: 590, cur_luma: 12.000000  Stats ID =1 Stats type: 0 aec_settled: 1 exp_index: 419 fps:16 real_gain:95.362183 scan_cnt:3 progress:25 gyro:0.002954 sadr:38.281246
08-25 08:21:07.532  1539  9796 I mm-camera: <STATS_AF >< INFO> 1291: af_port_send_stats_config: iir a11=1.705690, a12=-0.846000, a21=1.324200, a22=-0.750310
08-25 08:21:07.532  1539  9796 I mm-camera: <STATS_AF >< INFO> 1298: af_port_send_stats_config: iir b10=0.077331 b11=0.000000, b12=-0.077331 b20=0.126830 a21=0.000000, a22=-0.126830 cam_role:0 i:0
08-25 08:21:07.532  1539  9796 I mm-camera: <STATS_AF >< INFO> 1291: af_port_send_stats_config: iir a11=0.000000, a12=0.000000, a21=0.000000, a22=0.000000
08-25 08:21:07.532  1539  9796 I mm-camera: <STATS_AF >< INFO> 1298: af_port_send_stats_config: iir b10=0.000000 b11=0.000000, b12=0.000000 b20=0.000000 a21=0.000000, a22=0.000000 cam_role:0 i:1
08-25 08:21:07.532  1539  9796 I mm-camera: <STATS_AF >< INFO> 1291: af_port_send_stats_config: iir a11=1.705690, a12=-0.846000, a21=1.324200, a22=-0.750310
08-25 08:21:07.532  1539  9796 I mm-camera: <STATS_AF >< INFO> 1298: af_port_send_stats_config: iir b10=0.077331 b11=0.000000, b12=-0.077331 b20=0.126830 a21=0.000000, a22=-0.126830 cam_role:0 i:2
08-25 08:21:07.532  1539  9796 I mm-camera: <STATS_AF >< INFO> 1459: af_port_send_pdaf_config: HAF-TAF: Send default config flag 
08-25 08:21:07.540  1539  1539 I Camera3-Device: disconnect: E
08-25 08:21:07.541  1539  1539 I QCamera : <HAL><INFO> static int qcamera::QCamera3HardwareInterface::close_camera_device(struct hw_device_t *): 11758: [KPI Perf]: E camera id 0
08-25 08:21:07.541  1539  1539 D QCameraPerf: void qcamera::QCameraPerfLock::powerHintInternal(power_hint_t, bool): power hint
08-25 08:21:07.541  1539  1539 E QCOM PowerHAL: Invalid hint ID.
08-25 08:21:07.541  1539  1539 I QTI PowerHAL: Video Encode hint stop
08-25 08:21:07.541  1539  1539 D QCameraPerf: perfLockHandle 233, updated refCount: 1, perfLockType: 1
08-25 08:21:07.541  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000009
08-25 08:21:07.541  1539  9775 I mm-camera: <MCT   >< INFO> 4291: mct_pipeline_process_set:  STREAM-OFF on stream 0x40004 stream type=11
08-25 08:21:07.541  1539  9775 I mm-camera: <IFACE >< INFO> 1833: iface_streamoff_to_thread: iface_streamoff_to_thread: E, session id = 4, user stream id = 4
08-25 08:21:07.542  1539  9785 I mm-camera: <IFACE >< INFO> 2466: iface_streamoff: E, session_id 4 mct_stream_id = 4
08-25 08:21:07.542  1539  9785 I mm-camera: <IFACE >< INFO> 12127: iface_util_get_user_streams_by_bundle: streamoff, first bundled streamoff all bindled streams!
08-25 08:21:07.542  1539  9785 I mm-camera: <IFACE >< INFO> 440: iface_ispif_get_cfg_params_from_hw_streams: interace 0 active count = 2, skip stop ispif 
08-25 08:21:07.542  1539  9785 I mm-camera: <IFACE >< INFO> 440: iface_ispif_get_cfg_params_from_hw_streams: interace 0 active count = 1, skip stop ispif 
08-25 08:21:07.542  1539  9785 I mm-camera: <IFACE >< INFO> 2701: iface_streamoff: session_id = 4, active_streams = 0
08-25 08:21:07.542  1539  9785 I mm-camera: <IFACE >< INFO> 2710: iface_streamoff: X
08-25 08:21:07.542  1539  9775 I mm-camera: <IFACE >< INFO> 1859: iface_streamoff_to_thread: iface_streamoff_to_thread: X, session id = 4, user stream id = 4
08-25 08:21:07.543  1539  9893 E mm-camera: <IMGLIB><ERROR> 602: face_proc_thread_loop: maybe some error happened! p_frame=0x0 keyBuff_valid=0
08-25 08:21:07.543  1539  9775 I mm-camera: <MCT   >< INFO> 4307: mct_pipeline_process_set:  STREAM-OFF success for stream 0x40004, stream type=11
08-25 08:21:07.543  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000009
08-25 08:21:07.543  1539  9775 I mm-camera: <MCT   >< INFO> 4291: mct_pipeline_process_set:  STREAM-OFF on stream 0x40002 stream type=1
08-25 08:21:07.543  1539  9775 I mm-camera: <IFACE >< INFO> 1833: iface_streamoff_to_thread: iface_streamoff_to_thread: E, session id = 4, user stream id = 2
08-25 08:21:07.543  1539  9785 I mm-camera: <IFACE >< INFO> 2466: iface_streamoff: E, session_id 4 mct_stream_id = 2
08-25 08:21:07.543  1539  9785 I mm-camera: <IFACE >< INFO> 12133: iface_util_get_user_streams_by_bundle: skip streamoff! left 1 bundled streamoff, mct stream id 2total bundled stream num = 3
08-25 08:21:07.543  1539  9785 I mm-camera: <IFACE >< INFO> 2710: iface_streamoff: X
08-25 08:21:07.543  1539  9775 I mm-camera: <IFACE >< INFO> 1859: iface_streamoff_to_thread: iface_streamoff_to_thread: X, session id = 4, user stream id = 2
08-25 08:21:07.543  1539  9776 I mm-camera: <MCT   >< INFO> 1767: mct_pipeline_control_hw_state: mct_pipeline_control_hw_state lpmbit 40 
08-25 08:21:07.543  1539  9775 I mm-camera: <CPP   >< INFO> 4535: cpp_module_handle_streamoff_event: info: doing stream-off for identity 0x40002
08-25 08:21:07.543  1539  9775 I mm-camera: <CPP   >< INFO> 4721: cpp_module_handle_streamoff_event: info: stream-off done for identity 0x40002
08-25 08:21:07.543  1539  9775 I mm-camera: <MCT   >< INFO> 4307: mct_pipeline_process_set:  STREAM-OFF success for stream 0x40002, stream type=1
08-25 08:21:07.544  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000009
08-25 08:21:07.544  1539  9775 I mm-camera: <MCT   >< INFO> 4291: mct_pipeline_process_set:  STREAM-OFF on stream 0x40003 stream type=5
08-25 08:21:07.544  1539  9775 I mm-camera: <IFACE >< INFO> 1833: iface_streamoff_to_thread: iface_streamoff_to_thread: E, session id = 4, user stream id = 3
08-25 08:21:07.544  1539  9785 I mm-camera: <IFACE >< INFO> 2466: iface_streamoff: E, session_id 4 mct_stream_id = 3
08-25 08:21:07.544  1539  9785 I mm-camera: <IFACE >< INFO> 12133: iface_util_get_user_streams_by_bundle: skip streamoff! left 0 bundled streamoff, mct stream id 3total bundled stream num = 3
08-25 08:21:07.544  1539  9785 I mm-camera: <IFACE >< INFO> 2705: iface_streamoff: all bundled stream streamoff, clear hal bundled mask
08-25 08:21:07.544  1539  9785 I mm-camera: <IFACE >< INFO> 2710: iface_streamoff: X
08-25 08:21:07.544  1539  9775 I mm-camera: <IFACE >< INFO> 1859: iface_streamoff_to_thread: iface_streamoff_to_thread: X, session id = 4, user stream id = 3
08-25 08:21:07.544  1539  9789 I mm-camera: <CPP   >< INFO> 368: cpp_hardware_set_clock: Set clock 200000000 BW avg 209952000 BW inst 209952000
08-25 08:21:07.547  1539  9775 I mm-camera: <CPP   >< INFO> 4535: cpp_module_handle_streamoff_event: info: doing stream-off for identity 0x40003
08-25 08:21:07.547  1539  9789 I mm-camera: <CPP   >< INFO> 368: cpp_hardware_set_clock: Set clock 200000000 BW avg 0 BW inst 0
08-25 08:21:07.547  1539  9775 I mm-camera: <CPP   >< INFO> 4721: cpp_module_handle_streamoff_event: info: stream-off done for identity 0x40003
08-25 08:21:07.548  1539  9775 I mm-camera: <IFACE >< INFO> 2734: iface_streamoff_post_isp: shubh: free native buf session: 4 hw_stream: 65538
08-25 08:21:07.549  1539  9775 I mm-camera: <IFACE >< INFO> 2734: iface_streamoff_post_isp: shubh: free native buf session: 4 hw_stream: 65540
08-25 08:21:07.549  1539  9775 I mm-camera: <IFACE >< INFO> 2734: iface_streamoff_post_isp: shubh: free native buf session: 4 hw_stream: 589839
08-25 08:21:07.550  1539  9775 I mm-camera: <IFACE >< INFO> 2741: iface_streamoff_post_isp: session id = 0x4,Delta between vfe irqs 0 sec 0 usec
08-25 08:21:07.551  1539  9775 I mm-camera: <IFACE >< INFO> 10888: iface_util_release_resource: camif_cnt= 1, rdi_cnt= 0, used mask 1
08-25 08:21:07.551  1539  9775 I mm-camera: <IFACE >< INFO> 10888: iface_util_release_resource: camif_cnt= 0, rdi_cnt= 0, used mask 0
08-25 08:21:07.551  1539  9775 I mm-camera: <IFACE >< INFO> 3984: iface_destroy_hw: iface_destroy_hw: Destroy axi hw on VFE :0
08-25 08:21:07.551  1539  9775 I mm-camera: <IFACE >< INFO> 10888: iface_util_release_resource: camif_cnt= 0, rdi_cnt= 0, used mask 0
08-25 08:21:07.551  1539  9775 I mm-camera: <MCT   >< INFO> 186: stop_sof_check_thread: Stopping SOF timeout thread session =4
08-25 08:21:07.551  1539  9889 I mm-camera: <MCT   >< INFO> 114: mct_bus_sof_thread_run: Closing SOF tracker thread
08-25 08:21:07.552  1539  9775 I mm-camera: <MCT   >< INFO> 4307: mct_pipeline_process_set:  STREAM-OFF success for stream 0x40003, stream type=5
08-25 08:21:07.552  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=8000009
08-25 08:21:07.552  1539  9775 I mm-camera: <MCT   >< INFO> 4291: mct_pipeline_process_set:  STREAM-OFF on stream 0x40001 stream type=7
08-25 08:21:07.552  1539  9775 I mm-camera: <MCT   >< INFO> 4307: mct_pipeline_process_set:  STREAM-OFF success for stream 0x40001, stream type=7
08-25 08:21:07.554  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=800000b
08-25 08:21:07.554  1539  9775 I mm-camera: <MCT   >< INFO> 4375: mct_pipeline_process_set: Issuing DEL_STREAM on stream 0x40002 and stream type=1
08-25 08:21:07.554  1539  9775 I mm-camera: <IFACE >< INFO> 720: iface_unreserve_sink_port: stream_id 2 mode 0 
08-25 08:21:07.554  1539  9775 I mm-camera: <ISP   >< INFO> 926: isp_port_check_caps_unreserve: ide 40002 port 0xe777aa40
08-25 08:21:07.554  1539  9775 I mm-camera: <MCT   >< INFO> 4391: mct_pipeline_process_set: Stream 0x40002 and stream type=1, successfully deleted
08-25 08:21:07.554  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=800000b
08-25 08:21:07.555  1539  9775 I mm-camera: <MCT   >< INFO> 4375: mct_pipeline_process_set: Issuing DEL_STREAM on stream 0x40003 and stream type=5
08-25 08:21:07.555  1539  9775 I mm-camera: <IFACE >< INFO> 720: iface_unreserve_sink_port: stream_id 3 mode 0 
08-25 08:21:07.555  1539  9775 I mm-camera: <ISP   >< INFO> 926: isp_port_check_caps_unreserve: ide 40003 port 0xe777aa40
08-25 08:21:07.555  1539  9775 I mm-camera: <MCT   >< INFO> 4391: mct_pipeline_process_set: Stream 0x40003 and stream type=5, successfully deleted
08-25 08:21:07.555  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=800000b
08-25 08:21:07.555  1539  9775 I mm-camera: <MCT   >< INFO> 4375: mct_pipeline_process_set: Issuing DEL_STREAM on stream 0x40004 and stream type=11
08-25 08:21:07.555  1539  9775 I mm-camera: <IFACE >< INFO> 720: iface_unreserve_sink_port: stream_id 4 mode 0 
08-25 08:21:07.555  1539  9775 I mm-camera: <ISP   >< INFO> 926: isp_port_check_caps_unreserve: ide 40004 port 0xe777aa40
08-25 08:21:07.556  1539  9775 I mm-camera: <MCT   >< INFO> 4391: mct_pipeline_process_set: Stream 0x40004 and stream type=11, successfully deleted
08-25 08:21:07.556  1539  9775 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=800000b
08-25 08:21:07.556  1539  9775 I mm-camera: <MCT   >< INFO> 4375: mct_pipeline_process_set: Issuing DEL_STREAM on stream 0x40001 and stream type=7
08-25 08:21:07.556  1539  9775 I mm-camera: <MCT   >< INFO> 4391: mct_pipeline_process_set: Stream 0x40001 and stream type=7, successfully deleted
08-25 08:21:07.556  1539  9775 I mm-camera: <ISP   >< INFO> 6934: isp_util_print_meta_stream_info: Deallocate resources
08-25 08:21:07.557  1539  9775 I mm-camera: <ISP   >< INFO> 7243: isp_util_handle_stream_info: streams_desc num_streams is 0 
08-25 08:21:07.557  1539  9775 I mm-camera: <IFACE >< INFO> 6291: iface_util_handle_meta_stream_info: iface_util_handle_meta_stream_info: ms_type 1 num streams 0
08-25 08:21:07.557  1539  1539 I QCamera : <HAL><INFO> int qcamera::QCamera3HardwareInterface::closeCamera(): 948: [KPI Perf]: E PROFILE_CLOSE_CAMERA camera id 0
08-25 08:21:07.557  1539  1539 I mm-camera: <MCT   >< INFO> 307: mct_controller_destroy: Initiating destroy sequence for session = 4
08-25 08:21:07.558  1539  1539 I mm-camera: <MCT   >< INFO> 325: mct_controller_destroy: serv_thread closed
08-25 08:21:07.558  1539  1539 I mm-camera: <MCT   >< INFO> 346: mct_controller_destroy: bus_handler thread closed
08-25 08:21:07.558  1539  1539 I mm-camera: <MCT   >< INFO> 5243: mct_pipeline_stop_session: Initiating stop_session on session 4
08-25 08:21:07.558  1539  1539 I mm-camera: <MCT   >< INFO> 4146: mct_pipeline_process_set: command=800000b
08-25 08:21:07.558  1539  1539 I mm-camera: <MCT   >< INFO> 4375: mct_pipeline_process_set: Issuing DEL_STREAM on stream 0x4000f and stream type=10
08-25 08:21:07.558  1539  1539 I mm-camera: <IFACE >< INFO> 720: iface_unreserve_sink_port: stream_id f mode 0 
08-25 08:21:07.559  1539  1539 I mm-camera: <ISP   >< INFO> 926: isp_port_check_caps_unreserve: ide 4000f port 0xe777aa40
08-25 08:21:07.559  1539  1539 I mm-camera: <MCT   >< INFO> 4391: mct_pipeline_process_set: Stream 0x4000f and stream type=10, successfully deleted
08-25 08:21:07.560  1539  9896 I mm-camera: <MCT   >< INFO> 4977: mct_pipeline_stop_session_thread: Stop module name: sensor - E
08-25 08:21:07.560  1539  9897 I mm-camera: <MCT   >< INFO> 4977: mct_pipeline_stop_session_thread: Stop module name: iface - E
08-25 08:21:07.561  1539  9897 I mm-camera: <MCT   >< INFO> 4985: mct_pipeline_stop_session_thread: Stop module name: iface - X
08-25 08:21:07.561  1539  9899 I mm-camera: <MCT   >< INFO> 4977: mct_pipeline_stop_session_thread: Stop module name: stats - E
08-25 08:21:07.561  1539  9898 I mm-camera: <MCT   >< INFO> 4977: mct_pipeline_stop_session_thread: Stop module name: isp - E
08-25 08:21:07.561  1539  9898 I mm-camera: <ISP   >< INFO> 509: isp_module_stop_session: session id 4
08-25 08:21:07.561  1539  9792 I OPCAMERA_SENSOR: listener_func: disable sensor=2 priv=0xde87c080
08-25 08:21:07.561  1539  9900 I mm-camera: <MCT   >< INFO> 4977: mct_pipeline_stop_session_thread: Stop module name: pproc - E
08-25 08:21:07.562  1539  1539 I mm-camera: <MCT   >< INFO> 5265: mct_pipeline_stop_session: Modules left: 5
08-25 08:21:07.562  1539  9902 I mm-camera: <MCT   >< INFO> 4977: mct_pipeline_stop_session_thread: Stop module name: imglib - E
08-25 08:21:07.562  1539  9900 I mm-camera: <MCT   >< INFO> 4985: mct_pipeline_stop_session_thread: Stop module name: pproc - X
08-25 08:21:07.562  1539  1539 I mm-camera: <MCT   >< INFO> 5265: mct_pipeline_stop_session: Modules left: 4
08-25 08:21:07.562  1539  9902 I mm-camera: <MCT   >< INFO> 4985: mct_pipeline_stop_session_thread: Stop module name: imglib - X
08-25 08:21:07.562  1539  1539 I mm-camera: <MCT   >< INFO> 5265: mct_pipeline_stop_session: Modules left: 3
08-25 08:21:07.562  1539  9898 I mm-camera: <MCT   >< INFO> 4985: mct_pipeline_stop_session_thread: Stop module name: isp - X
08-25 08:21:07.562  1539  1539 I mm-camera: <MCT   >< INFO> 5265: mct_pipeline_stop_session: Modules left: 2
08-25 08:21:07.564  1539  9792 I OPCAMERA_SENSOR: listener_func: disable sensor=1 priv=0xde87c080
08-25 08:21:07.566  1539  9792 I OPCAMERA_SENSOR: listener_func: disable sensor=0 priv=0xde87c080
08-25 08:21:07.568  1033  1052 E Sensors : sns_reg_la.c(297):reg write: offset 1792, num bytes: 24
08-25 08:21:07.570  1539  9792 I OPCAMERA_SENSOR: listener_func: exit (0x0, 0x0, 0x0, 0x0, 0x0)
08-25 08:21:07.571  1539  9899 I OPCAMERA_SENSOR: deinit_module: (0x0, 0x0, 0x0, 0x0)
08-25 08:21:07.571  1539  9899 I OPCAMERA_SENSOR: deinit_module: module=0xd04f8008 private=0xde87c080 list=0x0
08-25 08:21:07.572  1539  9899 I mm-camera: <MCT   >< INFO> 4985: mct_pipeline_stop_session_thread: Stop module name: stats - X
08-25 08:21:07.572  1539  1539 I mm-camera: <MCT   >< INFO> 5265: mct_pipeline_stop_session: Modules left: 1
08-25 08:21:07.579  1539  9896 I mm-camera: <MCT   >< INFO> 4985: mct_pipeline_stop_session_thread: Stop module name: sensor - X
08-25 08:21:07.579  1539  1539 I mm-camera: <MCT   >< INFO> 5265: mct_pipeline_stop_session: Modules left: 0
08-25 08:21:07.579  1539  1539 I mm-camera: <MCT   >< INFO> 5274: mct_pipeline_stop_session: Stopped session 4 successfully
08-25 08:21:07.579  1539  1539 I mm-camera: <MCT   >< INFO> 5584: mct_pipeline_destroy: E: session:4
08-25 08:21:07.579  1539  1539 E mm-camera: <MCT   ><ERROR> 177: stop_sof_check_thread: Returning as SOF timer thread not yet initialized
08-25 08:21:07.579  1539  1539 I mm-camera: <MCT   >< INFO> 5663: mct_pipeline_destroy: X: Pipeline destroyed successfully session =4
08-25 08:21:07.579  1539  1539 I mm-camera: <MCT   >< INFO> 420: mct_controller_destroy: X Successfully closed mct_controller session 4
08-25 08:21:07.580  1539  1539 I CameraService: onTorchStatusChangedLocked: Torch status changed for cameraId=0, newStatus=1
08-25 08:21:07.580  1539  1539 I QCamera : <HAL><INFO> int qcamera::QCamera3HardwareInterface::closeCamera(): 990: [KPI Perf]: X PROFILE_CLOSE_CAMERA camera id 0, rc: 0
08-25 08:21:07.580  1539  1539 D QCameraPerf: perfLockHandle 233, refCount: 1, perfLockType: 1
08-25 08:21:07.581  1539  1539 I QCamera : <HAL><INFO> static int qcamera::QCamera3HardwareInterface::close_camera_device(struct hw_device_t *): 11760: [KPI Perf]: X
08-25 08:21:07.581  1539  1539 I Camera3-Device: disconnect: X
08-25 08:21:07.581  1539  1539 I Camera3-Device: disconnect: E
08-25 08:21:07.582  1539  1539 I CameraService: disconnect: Disconnected client for camera 0 for PID 9748
08-25 08:21:07.582  1539  2181 I Camera2Client: Camera 0: Closed
08-25 08:21:07.582  1539  2181 I Camera2ClientBase: Closed Camera 0. Client was: com.todobom.opennotescanner (PID 9748, UID 10098)
08-25 08:21:07.583  1540  2317 D NuPlayerDriver: reset(0xea88cc00) at state 4
08-25 08:21:07.583  1540  2317 D NuPlayerDriver: notifyListener_l(0xea88cc00), (8, 0, 0), loop setting(0, 0)
08-25 08:21:07.583  1540  9768 W AMessage: failed to post message as target looper for handler 0 is gone.
08-25 08:21:07.583  1540  9768 D NuPlayerDriver: notifyResetComplete(0xea88cc00)
08-25 08:21:07.584  1540  2318 D NuPlayerDriver: reset(0xea88c660) at state 4
08-25 08:21:07.584  1540  2318 D NuPlayerDriver: notifyListener_l(0xea88c660), (8, 0, 0), loop setting(0, 0)
08-25 08:21:07.584  1540  9770 W AMessage: failed to post message as target looper for handler 0 is gone.
08-25 08:21:07.584  1540  9770 D NuPlayerDriver: notifyResetComplete(0xea88c660)
08-25 08:21:07.585  1540  2317 D NuPlayerDriver: reset(0xea88c0c0) at state 4
08-25 08:21:07.585  1540  2317 D NuPlayerDriver: notifyListener_l(0xea88c0c0), (8, 0, 0), loop setting(0, 0)
08-25 08:21:07.585  1540  9772 W AMessage: failed to post message as target looper for handler 0 is gone.
08-25 08:21:07.585  1540  9772 D NuPlayerDriver: notifyResetComplete(0xea88c0c0)
08-25 08:21:07.733   775   775 W SurfaceFlinger: couldn't log to binary event log: overflow.
08-25 08:21:09.296  2602  2602 D wpa_supplicant: wlan0: Control interface command 'SIGNAL_POLL'
08-25 08:21:09.304  2602  2602 D wpa_supplicant: CTRL-DEBUG: global_ctrl_sock-sendto: sock=9 sndbuf=212992 outq=0 send_len=62
08-25 08:21:09.600  1538  1599 D audio_hw_primary: out_standby: enter: stream (0xeb353a00) usecase(1: low-latency-playback)
08-25 08:21:09.671  1538  1599 D audio_hw_primary: disable_audio_route: reset and update mixer path: low-latency-playback speaker
08-25 08:21:09.674  1538  1599 D soundtrigger: audio_extn_sound_trigger_update_stream_status: uc_id 1 of type 0 for Event 2, with Raise=0
08-25 08:21:09.674  1538  1599 D hardware_info: hw_info_append_hw_type : device_name = speaker
08-25 08:21:09.674  1538  1599 D audio_hw_primary: disable_snd_device: snd_device(2: speaker)
08-25 08:21:09.674  1538  1599 D msm8974_platform: platform_split_snd_device: snd_device(2) new_snd_devices (speaker)
08-25 08:21:09.674  1538  1599 I soundtrigger: audio_extn_sound_trigger_update_device_status: device 0x2 of type 0 for Event 0, with Raise=0
08-25 08:21:09.674  1538  1599 D audio_hw_primary: out_standby: exit
ghost commented 7 years ago

Same for me on a Moto Z Play running latest LineageOS 14.1 without any Google apps.

allgood commented 7 years ago

Strange, it mentions Camera2 functions, but ONS isn't using Camera2 API yet. It is possible that there is some limitation on the O.S. I use on Moto Z Play with stock firmware. Right now I am unable to test it with Lineage O.S.

enaut commented 7 years ago

I tried the samples from openCV library those all work. Also when starting it crashes only after like a second. In that second the camera image is shown and focus is doing its work so access to the camera seems to be working.

allgood commented 7 years ago

Not so different, but the samples uses the camera in another way. ONS don't use camera services from OpenCV.

I don't remember exactly but we had a collaborator that was looking into porting ONS to Camera2, but it is a very hard api. I may try to get into it once I get some free time.

Em ter, 5 de set de 2017 às 02:41, Franz Dietrich notifications@github.com escreveu:

I tried the samples from openCV library those all work.

— You are receiving this because you commented.

Reply to this email directly, view it on GitHub https://github.com/ctodobom/OpenNoteScanner/issues/85#issuecomment-327076428, or mute the thread https://github.com/notifications/unsubscribe-auth/AFyh0I0X1EGMrI_dRF75wmaNV1XhlFJZks5sfN7tgaJpZM4PCRpf .

lyn1337 commented 7 years ago

when starting it crashes only after like a second. In that second the camera image is shown and focus is doing its work so access to the camera seems to be working.

same here.

allgood commented 7 years ago

Looks like this is the important part of the log, i will try to analise it on the next days. It is hard without having a device that it's failing, so, if any of you have coding skills and can help me, it will be welcome.

Best regards, Claudemir

08-25 08:21:07.195  9748  9748 D OpenNoteScannerActivity: onPreviewFrame - received image 1920x1080 focused: true imageprocessor: available
08-25 08:21:07.198  1539  9796 I mm-camera: <STATS_AF >< INFO> 1080: af_process_parse_stats: fv: 110669.484375, fv_norm: 990.596558, lens_pos: 590, cur_luma: 0.000000  Stats ID =5 Stats type: 0 aec_settled: 1 exp_index: 419 fps:16 real_gain:95.362183 scan_cnt:2 progress:25 gyro:0.000867 sadr:0.000000
08-25 08:21:07.206  9748  9748 D OpenNoteScannerActivity: sending message to ImageProcessor: previewFrame - com.todobom.opennotescanner.helpers.PreviewFrame@fccb4e9
08-25 08:21:07.206  9748  9766 D ImageProcessor: Message Received: previewFrame - com.todobom.opennotescanner.helpers.PreviewFrame@fccb4e9
08-25 08:21:07.245  9748  9766 E cv::error(): OpenCV Error: Assertion failed (_dx.type() == CV_16SC1 || _dx.type() == CV_16SC3) in void cv::Canny(cv::InputArray, cv::InputArray, cv::OutputArray, double, double, bool), file /build/master_pack-android/opencv/modules/imgproc/src/canny.cpp, line 1076
08-25 08:21:07.246  9748  9766 E org.opencv.imgproc: imgproc::Canny_11() caught cv::Exception: /build/master_pack-android/opencv/modules/imgproc/src/canny.cpp:1076: error: (-215) _dx.type() == CV_16SC1 || _dx.type() == CV_16SC3 in function void cv::Canny(cv::InputArray, cv::InputArray, cv::OutputArray, double, double, bool)
08-25 08:21:07.247  9748  9766 E AndroidRuntime: FATAL EXCEPTION: Worker Thread
08-25 08:21:07.247  9748  9766 E AndroidRuntime: Process: com.todobom.opennotescanner, PID: 9748
08-25 08:21:07.247  9748  9766 E AndroidRuntime: CvException [org.opencv.core.CvException: cv::Exception: /build/master_pack-android/opencv/modules/imgproc/src/canny.cpp:1076: error: (-215) _dx.type() == CV_16SC1 || _dx.type() == CV_16SC3 in function void cv::Canny(cv::InputArray, cv::InputArray, cv::OutputArray, double, double, bool)
08-25 08:21:07.247  9748  9766 E AndroidRuntime: ]
08-25 08:21:07.247  9748  9766 E AndroidRuntime:    at org.opencv.imgproc.Imgproc.Canny_1(Native Method)
08-25 08:21:07.247  9748  9766 E AndroidRuntime:    at org.opencv.imgproc.Imgproc.Canny(Imgproc.java:984)
08-25 08:21:07.247  9748  9766 E AndroidRuntime:    at com.todobom.opennotescanner.ImageProcessor.findContours(ImageProcessor.java:497)
08-25 08:21:07.247  9748  9766 E AndroidRuntime:    at com.todobom.opennotescanner.ImageProcessor.detectPreviewDocument(ImageProcessor.java:213)
08-25 08:21:07.247  9748  9766 E AndroidRuntime:    at com.todobom.opennotescanner.ImageProcessor.processPreviewFrame(ImageProcessor.java:132)
08-25 08:21:07.247  9748  9766 E AndroidRuntime:    at com.todobom.opennotescanner.ImageProcessor.handleMessage(ImageProcessor.java:89)
08-25 08:21:07.247  9748  9766 E AndroidRuntime:    at android.os.Handler.dispatchMessage(Handler.java:102)
08-25 08:21:07.247  9748  9766 E AndroidRuntime:    at android.os.Looper.loop(Looper.java:154)
08-25 08:21:07.247  9748  9766 E AndroidRuntime:    at android.os.HandlerThread.run(HandlerThread.java:61)
08-25 08:21:07.248  1668  3260 W ActivityManager:   Force finishing activity com.todobom.opennotescanner/.OpenNoteScannerActivity
enaut commented 7 years ago

I'll happily help you! If you have any apk to try or something I'll do it. Thing is - I just don't want to setup the whole toolchain and get into java/android :(.

allgood commented 7 years ago

@enaut unfortunately you would need to install Android Studio and import the project. As this is probably some image type incompatibility on OpenCV, don't know what on the affected devices can generate an image with a format different than others. It is probably detectable and possible to do a conversion before passing it to the Canny() function.

OpenCV Error: Assertion failed (_dx.type() == CV_16SC1 || _dx.type() == CV_16SC3)

Up to the end of next week I will try to find a solution.

Best regards, Claudemir

enaut commented 7 years ago

Thank you so much! Don't feel pressed though I just wanted to let you know that I'm listening and willing to iterate some stuff.

allgood commented 7 years ago

No pressure. Now that it was narrowed up to this assertion, it should be simple once I get hands to the task! May be I will ask you to test the solution before putting it out!

enaut commented 7 years ago

Ok I didn't notice any update... but for me it is fixed... It might be that I had some conflicting package or something like that I really don't know. but it just works now.