I've been experiencing a delay of > 1s between pressing the shutter button and getting a responsive user interface again for a few months now. Inspecting the output of logcat under a new profile I see a fair amount of variation. I took two samples, measuring from ImageCapture: takePictureWithNode to MediaProvider: Moving:
595 ms
```
03-12 16:21:10.107 17459 17459 D ImageCapture: takePictureWithNode
03-12 16:21:10.110 17459 17459 D CameraOrientationUtil: getRelativeImageRotation: destRotationDegrees=0, sourceRotationDegrees=90, isOppositeFacing=true, result=90
03-12 16:21:10.110 17459 17459 D TakePictureManager: Issue the next TakePictureRequest.
03-12 16:21:10.119 17459 17529 D Camera2CameraImpl: {Camera@ac8066[id=0]} Issue capture request
03-12 16:21:10.119 17459 17529 D CaptureSession: Issuing capture request.
03-12 16:21:10.126 17459 17529 D Camera2CaptureRequestBuilder: createCaptureRequest
03-12 16:21:10.144 28289 28291 I GCH_HdrplusCaptureSession: ProcessRequest: hdrplus snapshot (6895), output stream size:1
03-12 16:21:10.145 28289 28291 W GCH_InternalStreamManager: GetMostRecentStreamBuffer: payload frames 1 is smaller than min filled buffers 3
03-12 16:21:10.145 28289 28291 D GCH_HdrplusRequestProcessor: ProcessRequest: frame number 6895 is an HDR+ request.
03-12 16:21:10.147 28289 28291 I GCH_CameraPipelineHwl: CreateChiRequest (6895) set PowerHint CAMERA_SHOT
03-12 16:21:10.149 28289 28291 E CamX : [ERROR][META ] camxmetabuffer.cpp:2615 SetTag() Cannot set 110006 size 0 max 160
03-12 16:21:10.149 28289 28291 E CamX : [ERROR][META ] camxmetabuffer.cpp:2615 SetTag() Cannot set 110007 size 0 max 10
03-12 16:21:10.410 1006 1088 D VSC : @ 446030.398: [WO] Proposed rotation: 0, flat angle threshold: 65
03-12 16:21:10.410 1006 1088 D VSC : @ 446030.398: [WO] orientation angle 0, orientation 0
03-12 16:21:10.410 1006 1088 D VSC : @ 446030.398: [WO] Gyro angle integrated: 3.817096
03-12 16:21:10.410 1006 1088 D VSC : @ 446030.398: [WO] Gyro angle integrated: 3.817096
03-12 16:21:10.560 28289 17538 W GCH_ZslBufferManager: IsPendingBufferEmpty: Pending buffer is not empty:1.
03-12 16:21:10.560 28289 17538 I GCH_HdrplusResultProcessor: ProcessResult: (6895)ReturnZslStreamBuffers ok
03-12 16:21:10.563 17459 17459 D TakePictureManager: Issue the next TakePictureRequest.
03-12 16:21:10.563 17459 17459 D TakePictureManager: No new request.
03-12 16:21:10.595 1305 17859 D MediaCodec: keep callback message for reclaim
03-12 16:21:10.596 1305 17860 I CCodecConfig: query failed after returning 7 values (BAD_INDEX)
03-12 16:21:10.596 1305 17860 W Codec2Client: query -- param skipped: index = 1342179345.
03-12 16:21:10.596 1305 17860 W Codec2Client: query -- param skipped: index = 2415921170.
03-12 16:21:10.597 1037 17357 W AudioFlinger: The package name(android) provided does not correspond to the uid 1041
03-12 16:21:10.597 1305 17860 D BufferPoolAccessor2.0: bufferpool2 0xdcdc0c88 : 5(163840 size) total buffers - 5(163840 size) used buffers - 22/31 (recycle/alloc) - 8/56 (fetch/transfer)
03-12 16:21:10.598 1330 1379 D BufferPoolAccessor2.0: bufferpool2 0xb400d9802d7f5028 : 0(0 size) total buffers - 0(0 size) used buffers - 23/26 (recycle/alloc) - 3/25 (fetch/transfer)
03-12 16:21:10.599 1330 17861 D C2SoftVorbisDec: vorbis_dsp_synthesis returned -135; ignored
03-12 16:21:10.600 1330 17861 D C2SoftVorbisDec: vorbis_dsp_synthesis returned -135; ignored
03-12 16:21:10.604 973 1008 I EffectsFactory: EffectCreate() create_effect
03-12 16:21:10.608 1037 17357 W AudioFlinger: moveEffectChain_l() effect chain for session 0 not on source thread 0xb400c5e43a090000
03-12 16:21:10.608 16521 16666 W MediaProvider: isAppCloneUserPair failed. Users: 0 and 10
03-12 16:21:10.609 16521 16666 W MediaProvider: isAppCloneUserPair for user 10: false
03-12 16:21:10.615 16521 16666 V MediaProvider: Inserted id:1000000023 less than next row id backup:1000001000.
03-12 16:21:10.643 16521 16666 I MediaProvider: Open with lower FS for /storage/emulated/10/DCIM/Camera/.pending-1679239270-IMG_20230312_162110_104.jpg. Uid: 1010081
03-12 16:21:10.645 973 6357 D audio_hw_primary: adev_create_audio_patch: enter: num sources 1, num_sinks 1, handle 2
03-12 16:21:10.645 973 6357 D audio_hw_primary: adev_create_audio_patch: Playback patch from mix handle 21 to device 2
03-12 16:21:10.645 973 6357 D audio_hw_primary: route_output_stream: enter: usecase(1: low-latency-playback) devices 2
03-12 16:21:10.656 973 1008 E volume_listener: check_and_set_gain_dep_cal: Failed to set gain dep cal level
03-12 16:21:10.656 973 31393 D audio_hw_primary: start_output_stream: enter: stream(0xe3600010)usecase(1: low-latency-playback) devices(0x2) is_haptic_usecase(0)
03-12 16:21:10.656 973 31393 D audio_hw_primary: select_devices for use case (low-latency-playback)
03-12 16:21:10.656 973 31393 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)
03-12 16:21:10.656 973 31393 I msm8974_platform: platform_check_and_set_codec_backend_cfg: new_snd_devices[0] is 2
03-12 16:21:10.656 973 31393 I msm8974_platform: platform_check_codec_backend_cfg:becf: afe: bitwidth 24, samplerate 48000 channels 2, backend_idx 0 usecase = 1 device (speaker)
03-12 16:21:10.659 973 31393 D msm8974_platform: platform_check_codec_backend_cfg:becf: updated afe: bitwidth 24, samplerate 48000 channels 2,backend_idx 0 usecase = 1 device (speaker)
03-12 16:21:10.659 973 31393 I msm8974_platform: platform_check_codec_backend_cfg:becf: afe: Codec selected backend: 0 updated bit width: 24 and sample rate: 48000
03-12 16:21:10.659 973 31393 I msm8974_platform: platform_check_codec_backend_cfg:becf: afe: Codec backend needs to be updated. new bit width: 24new sample rate: 48000 new channels: 2
03-12 16:21:10.659 973 31393 I msm8974_platform: platform_set_codec_backend_cfg:becf: afe: bitwidth 24, samplerate 48000 channels 2 format 1, backend_idx 0 device (speaker)
03-12 16:21:10.659 973 31393 E msm8974_platform: platform_set_codec_backend_cfg:becf: afe: Could not get ctl for mixer command - SLIM_0_RX Format
03-12 16:21:10.659 973 31393 D audio_hw_primary: check_usecases_codec_backend:becf: force routing 0
03-12 16:21:10.659 973 31393 D audio_hw_primary: check_usecases_codec_backend:becf: (78) check_usecases curr device: speaker, usecase device: backends match 0
03-12 16:21:10.659 973 31393 D audio_hw_primary: check_usecases_codec_backend:becf: check_usecases num.of Usecases to switch 0
03-12 16:21:10.659 973 31393 D hardware_info: hw_info_append_hw_type : device_name = speaker
03-12 16:21:10.660 973 31393 D audio_route: Apply path: speaker
03-12 16:21:10.687 973 31393 D hardware_info: hw_info_append_hw_type : device_name = vi-feedback
03-12 16:21:10.687 973 31393 D audio_hw_primary: enable_snd_device: snd_device(222: vi-feedback)
03-12 16:21:10.687 973 31393 D msm8974_platform: platform_get_island_cfg_on_device:island cfg status on snd_device = (vi-feedback 0)
03-12 16:21:10.687 973 31393 I soundtrigger: audio_extn_sound_trigger_update_device_status: device 0xde of type 1 for Event 1, with Raise=0
03-12 16:21:10.687 973 31393 D audio_route: Apply path: vi-feedback
03-12 16:21:10.687 973 31393 D soundtrigger: audio_extn_sound_trigger_update_stream_status: uc_info->id 53 of type 1 for Event 3, with Raise=0
03-12 16:21:10.687 973 31393 D audio_hw_utils: audio_extn_utils_send_app_type_cfg: usecase->in_snd_device vi-feedback
03-12 16:21:10.687 973 31393 E audio_hw_utils: send_app_type_cfg_for_device: Could not get ctl for mixer cmd - Audio Stream Capture 103 App Type Cfg
03-12 16:21:10.687 973 31393 D audio_hw_waves: ma_set_device: 53 is not supported usecase
03-12 16:21:10.687 973 31393 D ACDB-LOADER: ACDB -> send_audio_cal, acdb_id = 512, path = 1, app id = 0x11132, sample rate = 8000, afe_sample_rate = 8000
03-12 16:21:10.687 973 31393 D ACDB-LOADER: ACDB -> send_asm_topology
03-12 16:21:10.687 973 31393 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_STREAM_TOPOLOGY_ID
03-12 16:21:10.687 973 31393 D ACDB-LOADER: ACDB -> send_adm_topology
03-12 16:21:10.687 973 31393 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_COMMON_TOPOLOGY_ID
03-12 16:21:10.687 973 31393 D ACDB-LOADER: ACDB -> send_audtable
03-12 16:21:10.687 973 31393 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_INSTANCE_COMMON_TABLE_SIZE
03-12 16:21:10.687 973 31393 D android.hardware.audio.service: Failed to fetch the lookup information of the device 00000200
03-12 16:21:10.687 973 31393 D ACDB-LOADER: Error: ACDB_CMD_GET_AUDPROC_INSTANCE_COMMON_TABLE_SIZE Returned = -19
03-12 16:21:10.687 973 31393 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_INSTANCE_COMMON_TABLE
03-12 16:21:10.687 973 31393 D android.hardware.audio.service: Failed to fetch the lookup information of the device 00000200
03-12 16:21:10.687 973 31393 D ACDB-LOADER: Error: ACDB audproc returned = -19
03-12 16:21:10.687 973 31393 D ACDB-LOADER: ACDB -> AUDIO_SET_AUDPROC_CAL cal_type[11] acdb_id[512] app_type[69938]
03-12 16:21:10.687 973 31393 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_INSTANCE_STREAM_TABLE_SIZE
03-12 16:21:10.687 973 31393 D ACDB-LOADER: ACDB -> send_audstrmtable
03-12 16:21:10.687 973 31393 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_INSTANCE_STREAM_TABLE
03-12 16:21:10.687 973 31393 D ACDB-LOADER: ACDB -> audstrm_cal->cal_type.cal_data.cal_size = 20
03-12 16:21:10.687 973 31393 D ACDB-LOADER: ACDB -> send_afe_topology
03-12 16:21:10.688 973 31393 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_TOPOLOGY_ID
03-12 16:21:10.688 973 31393 D ACDB-LOADER: ACDB -> GET_AFE_TOPOLOGY_ID for adcd_id 512, Topology Id 112fb
03-12 16:21:10.688 973 31393 D ACDB-LOADER: ACDB -> send_afe_cal
03-12 16:21:10.688 973 31393 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_INSTANCE_COMMON_TABLE_SIZE
03-12 16:21:10.688 973 31393 D android.hardware.audio.service: Failed to fetch the lookup information of the device 00000200
03-12 16:21:10.688 973 31393 D ACDB-LOADER: Error: ACDB_CMD_GET_AFE_INSTANCE_COMMON_TABLE_SIZE Returned = -19
03-12 16:21:10.688 973 31393 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_INSTANCE_COMMON_TABLE
03-12 16:21:10.688 973 31393 D android.hardware.audio.service: Failed to fetch the lookup information of the device 00000200
03-12 16:21:10.688 973 31393 D ACDB-LOADER: Error: ACDB AFE returned = -19
03-12 16:21:10.688 973 31393 D ACDB-LOADER: ACDB -> AUDIO_SET_AFE_CAL cal_type[17] acdb_id[512]
03-12 16:21:10.688 973 31393 D ACDB-LOADER: ACDB -> send_hw_delay : acdb_id = 512 path = 1
03-12 16:21:10.688 973 31393 D ACDB-LOADER: ACDB -> ACDB_AVSYNC_INFO: ACDB_CMD_GET_DEVICE_PROPERTY
03-12 16:21:10.688 973 31393 D audio_hw_primary: enable_audio_route: apply mixer and update path: spkr-vi-record vi-feedback
03-12 16:21:10.688 973 31393 D audio_route: Apply path: spkr-vi-record vi-feedback
03-12 16:21:10.693 1305 17860 D CCodecBufferChannel: [c2.android.vorbis.decoder#641] buffers after EOS ignored (0 us)
03-12 16:21:10.693 1305 17860 D CCodecBufferChannel: [c2.android.vorbis.decoder#641] buffers after EOS ignored (0 us)
03-12 16:21:10.693 1305 17860 D CCodecBufferChannel: [c2.android.vorbis.decoder#641] buffers after EOS ignored (0 us)
03-12 16:21:10.695 1305 17858 D AudioTrack: stop(120): called with 18213 frames delivered
03-12 16:21:10.702 16521 16666 D MediaProvider: Moving /storage/emulated/10/DCIM/Camera/.pending-1679239270-IMG_20230312_162110_104.jpg to /storage/emulated/10/DCIM/Camera/IMG_20230312_162110_104.jpg
```
1946 ms
```
03-12 16:20:01.164 17459 17459 D ImageCapture: takePictureWithNode
03-12 16:20:01.169 17459 17459 D CameraOrientationUtil: getRelativeImageRotation: destRotationDegrees=0, sourceRotationDegrees=90, isOppositeFacing=true, result=90
03-12 16:20:01.170 17459 17459 D TakePictureManager: Issue the next TakePictureRequest.
03-12 16:20:01.180 17459 17520 D Camera2CameraImpl: {Camera@ac8066[id=0]} Issue capture request
03-12 16:20:01.181 17459 17520 D CaptureSession: Issuing capture request.
03-12 16:20:01.181 17459 17520 D Camera2CaptureRequestBuilder: createCaptureRequest
03-12 16:20:01.274 28289 28291 I GCH_CameraDeviceSession: ProcessCaptureRequest: [sbc] Stream 1 1st req arrived, notify SBC Manager.
03-12 16:20:01.275 28289 28291 I GCH_HdrplusCaptureSession: ProcessRequest: hdrplus snapshot (5779), output stream size:1
03-12 16:20:01.279 28289 28291 W GCH_InternalStreamManager: GetMostRecentStreamBuffer: payload frames 1 is smaller than min filled buffers 3
03-12 16:20:01.281 28289 28291 D GCH_HdrplusRequestProcessor: ProcessRequest: frame number 5779 is an HDR+ request.
03-12 16:20:01.281 28289 28291 I GCH_CameraPipelineHwl: CreateChiRequest (5779) set PowerHint CAMERA_SHOT
03-12 16:20:01.287 28289 28291 E CamX : [ERROR][META ] camxmetabuffer.cpp:2615 SetTag() Cannot set 110006 size 0 max 160
03-12 16:20:01.287 28289 28291 E CamX : [ERROR][META ] camxmetabuffer.cpp:2615 SetTag() Cannot set 110007 size 0 max 10
03-12 16:20:01.290 28289 28291 D CamX : [DEBUG][SENSOR ] camximagesensordata.cpp:2049 PopulateSensorModeData() integrationInfoExists: 1,integrationTimeMargin: 16,minVerticalBlanking: 98,i: 0
03-12 16:20:01.290 28289 28291 D CamX : [DEBUG][SENSOR ] camximagesensordata.cpp:2049 PopulateSensorModeData() integrationInfoExists: 1,integrationTimeMargin: 16,minVerticalBlanking: 166,i: 1
03-12 16:20:01.290 28289 28291 D CamX : [DEBUG][SENSOR ] camximagesensordata.cpp:2049 PopulateSensorModeData() integrationInfoExists: 1,integrationTimeMargin: 16,minVerticalBlanking: 86,i: 2
03-12 16:20:01.290 28289 28291 D CamX : [DEBUG][SENSOR ] camximagesensordata.cpp:2049 PopulateSensorModeData() integrationInfoExists: 1,integrationTimeMargin: 16,minVerticalBlanking: 98,i: 3
03-12 16:20:01.290 28289 28291 D CamX : [DEBUG][SENSOR ] camximagesensordata.cpp:2049 PopulateSensorModeData() integrationInfoExists: 1,integrationTimeMargin: 16,minVerticalBlanking: 90,i: 4
03-12 16:20:01.290 28289 28291 D CamX : [DEBUG][SENSOR ] camximagesensordata.cpp:2049 PopulateSensorModeData() integrationInfoExists: 1,integrationTimeMargin: 16,minVerticalBlanking: 90,i: 5
03-12 16:20:01.290 28289 28291 D CamX : [DEBUG][SENSOR ] camximagesensordata.cpp:2049 PopulateSensorModeData() integrationInfoExists: 1,integrationTimeMargin: 16,minVerticalBlanking: 90,i: 6
03-12 16:20:01.290 28289 28291 D CamX : [DEBUG][SENSOR ] camximagesensordata.cpp:2049 PopulateSensorModeData() integrationInfoExists: 1,integrationTimeMargin: 16,minVerticalBlanking: 98,i: 7
03-12 16:20:01.290 28289 28291 D CamX : [DEBUG][SENSOR ] camximagesensordata.cpp:2049 PopulateSensorModeData() integrationInfoExists: 1,integrationTimeMargin: 16,minVerticalBlanking: 90,i: 8
03-12 16:20:01.290 28289 28291 D CamX : [DEBUG][SENSOR ] camximagesensordata.cpp:2049 PopulateSensorModeData() integrationInfoExists: 1,integrationTimeMargin: 16,minVerticalBlanking: 342,i: 9
03-12 16:20:01.290 28289 28291 E CamX : [ERROR][CORE ] camxnode.cpp:6727 FinalizeInitialization() Node::GooglePhotoRearOfflineBPS_ChiNodeWrapper_14 maxImageBuffers(8) from link properties should be atleast requiredMaxImageBuffers(11). So replacing maxImageBuffers with requiredMaxImageBuffers
03-12 16:20:01.290 28289 28291 E CamX : [ERROR][CORE ] camxnode.cpp:6727 FinalizeInitialization() Node::GooglePhotoRearOfflineBPS_ChiNodeWrapper_14 maxImageBuffers(8) from link properties should be atleast requiredMaxImageBuffers(11). So replacing maxImageBuffers with requiredMaxImageBuffers
03-12 16:20:01.291 28289 28291 E CamX : [ERROR][CORE ] camxnode.cpp:6727 FinalizeInitialization() Node::GooglePhotoRearOfflineBPS_ChiNodeWrapper_14 maxImageBuffers(8) from link properties should be atleast requiredMaxImageBuffers(11). So replacing maxImageBuffers with requiredMaxImageBuffers
03-12 16:20:01.291 28289 28291 E CamX : [ERROR][CORE ] camxnode.cpp:6727 FinalizeInitialization() Node::GooglePhotoRearOfflineBPS_ChiNodeWrapper_14 maxImageBuffers(8) from link properties should be atleast requiredMaxImageBuffers(11). So replacing maxImageBuffers with requiredMaxImageBuffers
03-12 16:20:01.291 28289 28291 E CamX : [ERROR][CORE ] camxnode.cpp:6727 FinalizeInitialization() Node::GooglePhotoRearOfflineBPS_JPEG_Encoder_0 maxImageBuffers(8) from link properties should be atleast requiredMaxImageBuffers(11). So replacing maxImageBuffers with requiredMaxImageBuffers
03-12 16:20:01.291 28289 28291 E CamX : [ERROR][CORE ] camxnode.cpp:6727 FinalizeInitialization() Node::GooglePhotoRearOfflineBPS_JPEG_Encoder_1 maxImageBuffers(8) from link properties should be atleast requiredMaxImageBuffers(11). So replacing maxImageBuffers with requiredMaxImageBuffers
03-12 16:20:01.291 28289 28291 E CamX : [ERROR][CORE ] camxnode.cpp:6727 FinalizeInitialization() Node::GooglePhotoRearOfflineBPS_IPE_2 maxImageBuffers(8) from link properties should be atleast requiredMaxImageBuffers(11). So replacing maxImageBuffers with requiredMaxImageBuffers
03-12 16:20:01.291 28289 28291 E CamX : [ERROR][CORE ] camxnode.cpp:6727 FinalizeInitialization() Node::GooglePhotoRearOfflineBPS_IPE_2 maxImageBuffers(8) from link properties should be atleast requiredMaxImageBuffers(11). So replacing maxImageBuffers with requiredMaxImageBuffers
03-12 16:20:01.291 28289 28291 E CamX : [ERROR][CORE ] camxnode.cpp:6727 FinalizeInitialization() Node::GooglePhotoRearOfflineBPS_IPE_3 maxImageBuffers(8) from link properties should be atleast requiredMaxImageBuffers(11). So replacing maxImageBuffers with requiredMaxImageBuffers
03-12 16:20:01.292 28289 28291 E CamX : [ERROR][CORE ] camxnode.cpp:6727 FinalizeInitialization() Node::GooglePhotoRearOfflineBPS_BPS_0 maxImageBuffers(8) from link properties should be atleast requiredMaxImageBuffers(11). So replacing maxImageBuffers with requiredMaxImageBuffers
03-12 16:20:01.292 28289 28291 E CamX : [ERROR][CORE ] camxnode.cpp:6727 FinalizeInitialization() Node::GooglePhotoRearOfflineBPS_BPS_0 maxImageBuffers(8) from link properties should be atleast requiredMaxImageBuffers(11). So replacing maxImageBuffers with requiredMaxImageBuffers
03-12 16:20:01.292 28289 28291 E CamX : [ERROR][CORE ] camxnode.cpp:6727 FinalizeInitialization() Node::GooglePhotoRearOfflineBPS_BPS_0 maxImageBuffers(8) from link properties should be atleast requiredMaxImageBuffers(11). So replacing maxImageBuffers with requiredMaxImageBuffers
03-12 16:20:01.292 28289 28291 E CamX : [ERROR][CORE ] camxnode.cpp:6727 FinalizeInitialization() Node::GooglePhotoRearOfflineBPS_BPS_0 maxImageBuffers(8) from link properties should be atleast requiredMaxImageBuffers(11). So replacing maxImageBuffers with requiredMaxImageBuffers
03-12 16:20:01.294 28289 28291 I CamX : [CONFIG][CORE ] camxnode.cpp:741 InitializeSourcePortBufferFormat() Topology: Node::GooglePhotoRearOfflineBPS_BPS_0 has a source port id 0 using format 9 dim 4032x3024
03-12 16:20:01.296 28289 28291 I google_hdrnet: SetBufferInfo 381
03-12 16:20:01.296 28289 28291 I google_hdrnet: SetBufferInfo 381
03-12 16:20:01.296 28289 28291 I google_hdrnet: SetBufferInfo 381
03-12 16:20:01.297 28289 28291 I google_hdrnet: SetBufferInfo 381
03-12 16:20:01.302 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_ChiNodeWrapper_14_OutputPortId0_ ] width=4032, height = 3024, format = 12 stride 5376 scanline 3024 GetTotalSize 24576000
03-12 16:20:01.302 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_ChiNodeWrapper_14_OutputPortId0_ ] width=4032, height = 3024, format = 12 stride 5376 scanline 1520 GetTotalSize 24576000
03-12 16:20:01.302 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_ChiNodeWrapper_14_OutputPortId1_ ] width=1008, height = 756, format = 18 stride 4032 scanline 380 GetTotalSize 1532160
03-12 16:20:01.303 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_ChiNodeWrapper_14_OutputPortId2_ ] width=252, height = 190, format = 18 stride 1152 scanline 96 GetTotalSize 110592
03-12 16:20:01.303 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_ChiNodeWrapper_14_OutputPortId3_ ] width=64, height = 48, format = 18 stride 384 scanline 24 GetTotalSize 9216
03-12 16:20:01.303 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_JPEG_Aggregator_0_OutputPortId2_ ] width=4032, height = 3024, format = 0 stride 0 scanline 0 GetTotalSize 18289160
03-12 16:20:01.303 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_JPEG_Encoder_0_OutputPortId1_ ] width=4032, height = 3024, format = 3 stride 4032 scanline 3024 GetTotalSize 18289152
03-12 16:20:01.303 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_JPEG_Encoder_0_OutputPortId1_ ] width=4032, height = 3024, format = 3 stride 4032 scanline 1512 GetTotalSize 18289152
03-12 16:20:01.303 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_JPEG_Encoder_1_OutputPortId1_ ] width=320, height = 240, format = 3 stride 320 scanline 240 GetTotalSize 115200
03-12 16:20:01.303 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_JPEG_Encoder_1_OutputPortId1_ ] width=320, height = 240, format = 3 stride 320 scanline 120 GetTotalSize 115200
03-12 16:20:01.303 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_IPE_2_OutputPortId9_Video] width=4032, height = 3024, format = 3 stride 4032 scanline 3024 GetTotalSize 18289152
03-12 16:20:01.303 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_IPE_2_OutputPortId9_Video] width=4032, height = 3024, format = 3 stride 4032 scanline 1512 GetTotalSize 18289152
03-12 16:20:01.303 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_IPE_2_OutputPortId8_Display] width=640, height = 480, format = 3 stride 640 scanline 480 GetTotalSize 460800
03-12 16:20:01.303 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_IPE_2_OutputPortId8_Display] width=640, height = 480, format = 3 stride 640 scanline 240 GetTotalSize 460800
03-12 16:20:01.303 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_IPE_3_OutputPortId8_Display] width=1600, height = 1200, format = 3 stride 1664 scanline 1216 GetTotalSize 3035136
03-12 16:20:01.303 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_IPE_3_OutputPortId8_Display] width=1600, height = 1200, format = 3 stride 1664 scanline 608 GetTotalSize 3035136
03-12 16:20:01.303 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_IPE_3_OutputPortId9_Video] width=640, height = 480, format = 3 stride 640 scanline 480 GetTotalSize 460800
03-12 16:20:01.304 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_IPE_3_OutputPortId9_Video] width=640, height = 480, format = 3 stride 640 scanline 240 GetTotalSize 460800
03-12 16:20:01.304 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_IPE_4_OutputPortId9_Video] width=640, height = 480, format = 4 stride 640 scanline 512 GetTotalSize 491520
03-12 16:20:01.304 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_IPE_4_OutputPortId9_Video] width=640, height = 480, format = 4 stride 640 scanline 256 GetTotalSize 491520
03-12 16:20:01.304 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_IPE_4_OutputPortId8_Display] width=640, height = 480, format = 4 stride 640 scanline 512 GetTotalSize 491520
03-12 16:20:01.304 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_IPE_4_OutputPortId8_Display] width=640, height = 480, format = 4 stride 640 scanline 256 GetTotalSize 491520
03-12 16:20:01.304 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_BPS_0_OutputPortId1_Full] width=4032, height = 3024, format = 12 stride 5376 scanline 3024 GetTotalSize 24576000
03-12 16:20:01.304 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_BPS_0_OutputPortId1_Full] width=4032, height = 3024, format = 12 stride 5376 scanline 1520 GetTotalSize 24576000
03-12 16:20:01.305 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_BPS_0_OutputPortId2_DS4] width=1008, height = 756, format = 18 stride 4032 scanline 380 GetTotalSize 1532160
03-12 16:20:01.305 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_BPS_0_OutputPortId3_DS16] width=252, height = 190, format = 18 stride 1152 scanline 96 GetTotalSize 110592
03-12 16:20:01.305 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_BPS_0_OutputPortId4_DS64] width=64, height = 48, format = 18 stride 384 scanline 24 GetTotalSize 9216
03-12 16:20:01.307 627 627 I lowmemorykiller: Kill 'com.android.keychain' (16539), uid 1001000, oom_score_adj 995 to free 76640kB rss, 140kB swap; reason: low watermark is breached and swap is low (0kB < 209712kB)
03-12 16:20:01.320 1668 1693 D CompatibilityChangeReporter: Compat change id reported: 161145287; UID 10149; state: DISABLED
03-12 16:20:01.328 1006 1088 D VSC : @ 445961.317: [WO] Proposed rotation: 0, flat angle threshold: 65
03-12 16:20:01.329 1006 1088 D VSC : @ 445961.317: [WO] orientation angle 0, orientation 0
03-12 16:20:01.329 1006 1088 D VSC : @ 445961.317: [WO] Gyro angle integrated: 11.489001
03-12 16:20:01.329 1006 1088 D VSC : @ 445961.317: [WO] Gyro angle integrated: 11.489001
03-12 16:20:01.343 2587 2587 D wpa_supplicant: Control interface recv command from: /data/vendor/wifi/wpa/sockets/wpa_ctrl_1319-51\x00
03-12 16:20:01.343 2587 2587 D wpa_supplicant: wlan0: Control interface command 'VENDOR 0x001374 13'
03-12 16:20:01.345 2587 2587 D wpa_supplicant: CTRL-DEBUG: ctrl_sock-sendto: sock=14 sndbuf=229376 outq=0 send_len=0
03-12 16:20:01.348 2587 2587 D wpa_supplicant: nl80211: Event message available
03-12 16:20:01.348 1342 1342 I cnss-daemon: nl80211 response handler invoked
03-12 16:20:01.349 1342 1342 I cnss-daemon: nl80211_response_handler: cmd 103, vendorID 4980, subcmd 13 received
03-12 16:20:01.348 1367 31926 D LOWI-8.6.0.75: [LOWI-Scan] wait_event:Wait done with Cmd 103
03-12 16:20:01.349 1367 31926 D LOWI-8.6.0.75: [LOWI-Scan] do_listen_events: Rcvd valid Netlink Cmd 0 Err 0
03-12 16:20:01.349 2587 2587 D wpa_supplicant: nl80211: Drv Event 103 (NL80211_CMD_VENDOR) received for wlan0
03-12 16:20:01.349 2587 2587 D wpa_supplicant: nl80211: Vendor event: wiphy=0 vendor_id=0x1374 subcmd=13
03-12 16:20:01.349 2587 2587 D wpa_supplicant: nl80211: Vendor data - hexdump(len=180): 08 00 04 00 1e 00 00 00 ac 00 03 00 00 00 00 00 b8 f3 00 00 a3 00 00 00 00 00 00 00 09 34 02 00 ...
03-12 16:20:01.349 2587 2587 D wpa_supplicant: nl80211: Ignore unsupported QCA vendor event 13
03-12 16:20:01.349 17817 17849 D CompatibilityChangeReporter: Compat change id reported: 160794467; UID 10149; state: ENABLED
03-12 16:20:01.350 1014 2505 I WifiHAL : event received NL80211_CMD_VENDOR, vendor_id = 0x1374, subcmd = 0xd
03-12 16:20:01.378 1668 23453 I ActivityManager: Process com.android.keychain (pid 16539) has died: cch+95 CEM
03-12 16:20:01.379 955 955 I Zygote : Process 16539 exited due to signal 9 (Killed)
03-12 16:20:01.381 1668 1891 I libprocessgroup: Successfully killed process cgroup uid 1001000 pid 16539 in 3ms
03-12 16:20:01.411 28289 28291 I DyscoWrap: DyscoCoreCreate: dysco_wrapper 0xb400c9e0b4f65a00
03-12 16:20:01.411 28289 28291 D DyscoWrap: tuning_manager_params->sensor_id=0
03-12 16:20:01.422 28289 28291 I google_hdrnet: PrepareStreamOn 436: start
03-12 16:20:01.464 627 627 I lowmemorykiller: Kill 'com.stevesoltys.seedvault' (16895), uid 1010030, oom_score_adj 985 to free 76396kB rss, 136kB swap; reason: low watermark is breached and swap is low (4kB < 209712kB)
03-12 16:20:01.510 1668 23453 I ActivityManager: Process com.stevesoltys.seedvault (pid 16895) has died: cch+85 CEM
03-12 16:20:01.511 1668 1891 I libprocessgroup: Successfully killed process cgroup uid 1010030 pid 16895 in 0ms
03-12 16:20:01.512 955 955 I Zygote : Process 16895 exited due to signal 9 (Killed)
03-12 16:20:01.616 627 627 I lowmemorykiller: Kill 'com.android.localtransport' (16820), uid 1001000, oom_score_adj 985 to free 74164kB rss, 40kB swap; reason: low watermark is breached and swap is low (0kB < 209712kB)
03-12 16:20:01.641 17817 17817 D org.wikipedia: Create notification channels skipped.
03-12 16:20:01.657 1668 2630 I ActivityManager: Process com.android.localtransport (pid 16820) has died: cch+85 CEM
03-12 16:20:01.657 1668 1891 I libprocessgroup: Successfully killed process cgroup uid 1001000 pid 16820 in 0ms
03-12 16:20:01.677 955 955 I Zygote : Process 16820 exited due to signal 9 (Killed)
03-12 16:20:01.742 627 627 I lowmemorykiller: Kill 'app.grapheneos.apps' (16836), uid 1010075, oom_score_adj 985 to free 81060kB rss, 72kB swap; reason: low watermark is breached and swap is low (0kB < 209712kB)
03-12 16:20:01.786 1668 11265 I ActivityManager: Process app.grapheneos.apps (pid 16836) has died: cch+85 CEM
03-12 16:20:01.799 1668 1891 I libprocessgroup: Successfully killed process cgroup uid 1010075 pid 16836 in 2ms
03-12 16:20:01.871 627 627 I lowmemorykiller: Kill 'com.android.contacts' (16988), uid 1010077, oom_score_adj 975 to free 75688kB rss, 68kB swap; reason: low watermark is breached and swap is low (0kB < 209712kB)
03-12 16:20:01.908 955 955 I Zygote : Process 16836 exited due to signal 9 (Killed)
03-12 16:20:01.921 955 955 I Zygote : Process 16988 exited due to signal 9 (Killed)
03-12 16:20:01.924 20351 20351 I MemoryController: onTrimMemory(10)
03-12 16:20:01.924 30189 30189 I FenixApplication: onTrimMemory(), level=10, main=false
03-12 16:20:01.936 1668 1668 W Looper : Slow dispatch took 123ms main h=android.app.ActivityThread$H c= m=0
03-12 16:20:01.941 1668 11265 I ActivityManager: Process com.android.contacts (pid 16988) has died: cch+75 CEM
03-12 16:20:01.944 20351 20351 I FenixApplication: onTrimMemory(), level=10, main=true
03-12 16:20:01.945 1668 1844 W Looper : Slow dispatch took 158ms android.ui h=com.android.server.am.ActivityManagerService$UiHandler c=com.android.server.am.UidObserverController$$ExternalSyntheticLambda0@475cfb2 m=0
03-12 16:20:01.951 28289 17546 W GCH_ResultDispatcher: [HdrplusDispatcher] PrintTimeoutMessages: pending shutter for frame 5779 ready 0
03-12 16:20:01.951 28289 17546 W GCH_ResultDispatcher: [HdrplusDispatcher] PrintTimeoutMessages: pending final result metadaata for frame 5779 ready 0
03-12 16:20:01.951 28289 17546 W GCH_ResultDispatcher: [HdrplusDispatcher] PrintTimeoutMessages: pending buffer of stream 1 for frame 5779 ready 0
03-12 16:20:01.965 627 627 I lowmemorykiller: Kill 'com.android.cellbroadcastreceiver.module' (16378), uid 1010115, oom_score_adj 975 to free 76132kB rss, 744kB swap; reason: low watermark is breached and swap is low (12kB < 209712kB)
03-12 16:20:01.974 1668 1891 I libprocessgroup: Successfully killed process cgroup uid 1010077 pid 16988 in 14ms
03-12 16:20:01.979 30189 30189 I MemoryController: onTrimMemory(10)
03-12 16:20:01.979 30189 30189 I FenixApplication: onTrimMemory(), level=15, main=false
03-12 16:20:01.979 30189 30189 I MemoryController: onTrimMemory(15)
03-12 16:20:02.011 1668 2630 I ActivityManager: Process com.android.cellbroadcastreceiver.module (pid 16378) has died: cch+75 CEM
03-12 16:20:02.011 1668 1891 I libprocessgroup: Successfully killed process cgroup uid 1010115 pid 16378 in 0ms
03-12 16:20:02.014 955 955 I Zygote : Process 16378 exited due to signal 9 (Killed)
03-12 16:20:02.046 20351 20351 I MemoryController: onTrimMemory(15)
03-12 16:20:02.046 20351 20351 I FenixApplication: onTrimMemory(), level=15, main=true
03-12 16:20:02.049 28289 28291 I google_hdrnet: PrepareStreamOn 440: done
03-12 16:20:02.056 627 627 I lowmemorykiller: Kill 'com.android.calendar' (16949), uid 1010089, oom_score_adj 975 to free 76192kB rss, 844kB swap; reason: low watermark is breached and swap is low (880kB < 209712kB)
03-12 16:20:02.069 28289 28291 I CamX : [CONFIG][CORE ] camxpipeline.h:2186 SetPipelineStatus() GooglePhotoRearOfflineBPS_0 status is now PipelineStatus::FINALIZED
03-12 16:20:02.071 28289 28291 I CamX : [CONFIG][CORE ] camxpipeline.h:2186 SetPipelineStatus() GooglePhotoRearOfflineBPS_0 status is now PipelineStatus::RESOURCES_ACQUIRED
03-12 16:20:02.071 28289 28291 I CamX : [CONFIG][CORE ] camxpipeline.cpp:712 StreamOn() [GooglePhotoRearOfflineBPS_0] StreamingOn for pipeline: 0xb400cbd0c802f000
03-12 16:20:02.071 28289 28291 I CamX : [CONFIG][CORE ] camxpipeline.h:2186 SetPipelineStatus() GooglePhotoRearOfflineBPS_0 status is now PipelineStatus::STREAM_ON
03-12 16:20:02.092 1668 2596 I ActivityManager: Process com.android.calendar (pid 16949) has died: cch+75 CEM
03-12 16:20:02.095 955 955 I Zygote : Process 16949 exited due to signal 9 (Killed)
03-12 16:20:02.101 1668 1891 I libprocessgroup: Successfully killed process cgroup uid 1010089 pid 16949 in 0ms
03-12 16:20:02.105 627 627 I lowmemorykiller: Kill 'com.android.dynsystem' (17019), uid 1001000, oom_score_adj 965 to free 73720kB rss, 2024kB swap; reason: low watermark is breached and swap is low (1784kB < 209712kB)
03-12 16:20:02.145 1668 2596 I ActivityManager: Process com.android.dynsystem (pid 17019) has died: cch+65 CEM
03-12 16:20:02.146 1668 1891 I libprocessgroup: Successfully killed process cgroup uid 1001000 pid 17019 in 0ms
03-12 16:20:02.147 955 955 I Zygote : Process 17019 exited due to signal 9 (Killed)
03-12 16:20:02.203 28289 28341 E android.hardware.camera.provider@2.7-service-google: g3a_data_manager_module.cc:Write:129 DataManagerModule2: write request_id 5781 pipeline 1: reverse
03-12 16:20:02.203 28289 28341 E android.hardware.camera.provider@2.7-service-google: g3a_data_manager_module.cc:Write:129 DataManagerModule2: write request_id 5782 pipeline 1: reverse
03-12 16:20:02.210 627 627 I lowmemorykiller: Kill 'com.android.dialer' (16695), uid 1010076, oom_score_adj 995 to free 79088kB rss, 664kB swap; reason: low watermark is breached and swap is low (2104kB < 209712kB)
03-12 16:20:02.254 28289 28343 I native : hdrnet_node.cc:1698 IFE Gamma is SRGB curve.
03-12 16:20:02.260 1668 2596 I ActivityManager: Process com.android.dialer (pid 16695) has died: cch+95 CEM
03-12 16:20:02.261 955 955 I Zygote : Process 16695 exited due to signal 9 (Killed)
03-12 16:20:02.262 28289 28343 E native : hdrnet_node.cc:267 stat(/data/vendor/camera/hdrnet) failed: (errno: 13).
03-12 16:20:02.263 1668 1891 I libprocessgroup: Successfully killed process cgroup uid 1010076 pid 16695 in 0ms
03-12 16:20:02.263 17376 17376 W libc : Access denied finding property "ro.factorytest"
03-12 16:20:02.264 17376 17376 W libc : Access denied finding property "ro.hdmi.cec_audio_device_forward_volume_keys_system_audio_mode_off"
03-12 16:20:02.264 17376 17376 W libc : Access denied finding property "ro.fw.system_user_split"
03-12 16:20:02.265 17376 17376 W libc : Access denied finding property "ro.fw.mu.headless_system_user"
03-12 16:20:02.268 28289 28343 I native : shared_mapping_pool.cc:45 New YuvImage mapping for 288 type = 4 width = 4032 height = 3024 stride = 4032 access = 4
03-12 16:20:02.269 28289 28343 I native : shared_mapping_pool.cc:82 New Buffer mapping for 289 size = 1532160 access = 2
03-12 16:20:02.272 28289 28343 I native : shared_mapping_pool.cc:45 New YuvImage mapping for 292 type = 4 width = 4032 height = 3024 stride = 4032 access = 1
03-12 16:20:02.258 28289 28289 W SoloThreadMana: type=1400 audit(0.0:510429): avc: denied { search } for name="camera" dev="dm-16" ino=232 scontext=u:r:hal_camera_default:s0 tcontext=u:object_r:camera_vendor_data_file:s0 tclass=dir permissive=0
03-12 16:20:02.261 17376 17376 W com.qti.phone: type=1400 audit(0.0:510430): avc: denied { read } for name="u:object_r:default_prop:s0" dev="tmpfs" ino=19799 scontext=u:r:qtelephony:s0:c79,c256,c522,c768 tcontext=u:object_r:default_prop:s0 tclass=file permissive=0
03-12 16:20:02.261 17376 17376 W com.qti.phone: type=1400 audit(0.0:510431): avc: denied { read } for name="u:object_r:hdmi_config_prop:s0" dev="tmpfs" ino=19854 scontext=u:r:qtelephony:s0:c79,c256,c522,c768 tcontext=u:object_r:hdmi_config_prop:s0 tclass=file permissive=0
03-12 16:20:02.261 17376 17376 W com.qti.phone: type=1400 audit(0.0:510432): avc: denied { read } for name="u:object_r:default_prop:s0" dev="tmpfs" ino=19799 scontext=u:r:qtelephony:s0:c79,c256,c522,c768 tcontext=u:object_r:default_prop:s0 tclass=file permissive=0
03-12 16:20:02.261 17376 17376 W com.qti.phone: type=1400 audit(0.0:510433): avc: denied { read } for name="u:object_r:default_prop:s0" dev="tmpfs" ino=19799 scontext=u:r:qtelephony:s0:c79,c256,c522,c768 tcontext=u:object_r:default_prop:s0 tclass=file permissive=0
03-12 16:20:02.330 28289 28340 I GoogleFDNode: RunEnsembleTrack: [FD] ensemble is still busy, requestId [5781] is skipped for face tracking.
03-12 16:20:02.348 28289 28343 I native : shared_mapping_pool.cc:82 New Buffer mapping for 293 size = 1532160 access = 2
03-12 16:20:02.348 28289 28343 I native : shared_mapping_pool.cc:82 New Buffer mapping for 294 size = 110592 access = 2
03-12 16:20:02.348 28289 28343 I native : shared_mapping_pool.cc:82 New Buffer mapping for 295 size = 9216 access = 2
03-12 16:20:02.362 28289 28342 I GoogleFDNode: RunEnsembleTrack: [FD] ensemble is still busy, requestId [5782] is skipped for face tracking.
03-12 16:20:02.402 28289 28342 I GoogleFDNode: RunEnsembleTrack: [FD] ensemble is still busy, requestId [5783] is skipped for face tracking.
03-12 16:20:02.518 627 627 I lowmemorykiller: Kill 'com.android.deskclock' (16198), uid 1010084, oom_score_adj 995 to free 78356kB rss, 680kB swap; reason: low watermark is breached and swap is low (1492kB < 209712kB)
03-12 16:20:02.523 17817 17854 D org.wikipedia: Create dynamic shortcuts skipped.
03-12 16:20:02.585 1668 2596 I ActivityManager: Process com.android.deskclock (pid 16198) has died: cch+95 CEM
03-12 16:20:02.585 1668 1891 I libprocessgroup: Successfully killed process cgroup uid 1010084 pid 16198 in 0ms
03-12 16:20:02.587 955 955 I Zygote : Process 16198 exited due to signal 9 (Killed)
03-12 16:20:02.671 28289 17538 W GCH_ZslBufferManager: IsPendingBufferEmpty: Pending buffer is not empty:1.
03-12 16:20:02.671 28289 17538 I GCH_HdrplusResultProcessor: ProcessResult: (5779)ReturnZslStreamBuffers ok
03-12 16:20:02.673 627 627 I lowmemorykiller: Kill 'com.android.dynsystem:dynsystem' (17056), uid 1000, oom_score_adj 985 to free 73232kB rss, 88kB swap; reason: low watermark is breached and swap is low (0kB < 209712kB)
03-12 16:20:02.723 1668 2596 I ActivityManager: Process com.android.dynsystem:dynsystem (pid 17056) has died: cch+85 CEM
03-12 16:20:02.723 1668 1891 I libprocessgroup: Successfully killed process cgroup uid 1000 pid 17056 in 0ms
03-12 16:20:02.725 955 955 I Zygote : Process 17056 exited due to signal 9 (Killed)
03-12 16:20:02.732 17459 17459 D TakePictureManager: Issue the next TakePictureRequest.
03-12 16:20:02.732 17459 17459 D TakePictureManager: No new request.
03-12 16:20:02.834 1305 17495 I GenericSource: start
03-12 16:20:02.935 1305 17860 D CCodec : allocate(c2.android.vorbis.decoder)
03-12 16:20:02.935 16521 16666 W MediaProvider: isAppCloneUserPair failed. Users: 0 and 10
03-12 16:20:02.935 16521 16666 W MediaProvider: isAppCloneUserPair for user 10: false
03-12 16:20:02.955 627 627 I lowmemorykiller: Kill 'com.android.printspooler' (16555), uid 1010059, oom_score_adj 985 to free 75868kB rss, 168kB swap; reason: low watermark is breached and swap is low (444kB < 209712kB)
03-12 16:20:03.009 1305 17860 I CCodec : setting up 'default' as default (vendor) store
03-12 16:20:03.010 1668 2596 I ActivityManager: Process com.android.printspooler (pid 16555) has died: cch+85 CEM
03-12 16:20:03.011 1668 1891 I libprocessgroup: Successfully killed process cgroup uid 1010059 pid 16555 in 0ms
03-12 16:20:03.012 955 955 I Zygote : Process 16555 exited due to signal 9 (Killed)
03-12 16:20:03.014 16521 16666 V MediaProvider: Inserted id:1000000022 less than next row id backup:1000001000.
03-12 16:20:03.021 30189 30189 I FenixApplication: onTrimMemory(), level=10, main=false
03-12 16:20:03.021 30189 30189 I MemoryController: onTrimMemory(10)
03-12 16:20:03.037 20351 20351 I MemoryController: onTrimMemory(10)
03-12 16:20:03.037 20351 20351 I FenixApplication: onTrimMemory(), level=10, main=true
03-12 16:20:03.040 1330 1379 V C2Store : in init
03-12 16:20:03.040 1330 1379 V C2Store : loading dll
03-12 16:20:03.053 16521 16666 I MediaProvider: Open with lower FS for /storage/emulated/10/DCIM/Camera/.pending-1679239202-IMG_20230312_162001_161.jpg. Uid: 1010081
03-12 16:20:03.080 1305 17860 I CCodec : Created component [c2.android.vorbis.decoder]
03-12 16:20:03.080 1305 17860 D CCodecConfig: read media type: audio/vorbis
03-12 16:20:03.090 1305 17860 D ReflectedParamUpdater: extent() != 1 for single value type: algo.buffers.max-count.values
03-12 16:20:03.090 1305 17860 D ReflectedParamUpdater: extent() != 1 for single value type: output.subscribed-indices.values
03-12 16:20:03.091 1305 17860 D ReflectedParamUpdater: extent() != 1 for single value type: input.buffers.allocator-ids.values
03-12 16:20:03.091 1305 17860 D ReflectedParamUpdater: extent() != 1 for single value type: output.buffers.allocator-ids.values
03-12 16:20:03.091 1305 17860 D ReflectedParamUpdater: extent() != 1 for single value type: algo.buffers.allocator-ids.values
03-12 16:20:03.091 1305 17860 D ReflectedParamUpdater: extent() != 1 for single value type: output.buffers.pool-ids.values
03-12 16:20:03.091 1305 17860 D ReflectedParamUpdater: extent() != 1 for single value type: algo.buffers.pool-ids.values
03-12 16:20:03.100 1305 17860 I CCodecConfig: query failed after returning 7 values (BAD_INDEX)
03-12 16:20:03.104 1305 17860 D CCodecConfig: c2 config diff is Dict {
03-12 16:20:03.104 1305 17860 D CCodecConfig: c2::u32 coded.bitrate.value = 64000
03-12 16:20:03.104 1305 17860 D CCodecConfig: c2::u32 input.buffers.max-size.value = 32768
03-12 16:20:03.104 1305 17860 D CCodecConfig: c2::u32 input.delay.value = 0
03-12 16:20:03.104 1305 17860 D CCodecConfig: string input.media-type.value = "audio/vorbis"
03-12 16:20:03.104 1305 17860 D CCodecConfig: string output.media-type.value = "audio/raw"
03-12 16:20:03.104 1305 17860 D CCodecConfig: c2::u32 raw.channel-count.value = 1
03-12 16:20:03.104 1305 17860 D CCodecConfig: c2::u32 raw.sample-rate.value = 48000
03-12 16:20:03.104 1305 17860 D CCodecConfig: }
03-12 16:20:03.105 1305 17860 D MediaCodec: flushMediametrics
03-12 16:20:03.107 1305 17860 D CCodec : [c2.android.vorbis.decoder] buffers are bound to CCodec for this session
03-12 16:20:03.107 1305 17860 D CCodecConfig: no c2 equivalents for durationUs
03-12 16:20:03.107 1305 17860 D CCodecConfig: no c2 equivalents for csd-1
03-12 16:20:03.107 1305 17860 D CCodecConfig: no c2 equivalents for flags
03-12 16:20:03.109 1305 17860 D CCodecConfig: c2 config diff is c2::u32 coded.bitrate.value = 80000
03-12 16:20:03.109 1305 17860 D CCodecConfig: c2::u32 raw.channel-count.value = 2
03-12 16:20:03.109 1305 17860 D CCodecConfig: c2::u32 raw.sample-rate.value = 44100
03-12 16:20:03.110 1305 17860 W Codec2Client: query -- param skipped: index = 1107298332.
03-12 16:20:03.110 1305 17860 D CCodec : encoding statistics level = 0
03-12 16:20:03.110 1305 17860 D CCodec : setup formats input: AMessage(what = 0x00000000) = {
03-12 16:20:03.110 1305 17860 D CCodec : int32_t bitrate = 80000
03-12 16:20:03.110 1305 17860 D CCodec : int32_t channel-count = 2
03-12 16:20:03.110 1305 17860 D CCodec : int32_t max-input-size = 32768
03-12 16:20:03.110 1305 17860 D CCodec : string mime = "audio/vorbis"
03-12 16:20:03.110 1305 17860 D CCodec : int32_t sample-rate = 44100
03-12 16:20:03.110 1305 17860 D CCodec : }
03-12 16:20:03.110 16521 16666 D MediaProvider: Moving /storage/emulated/10/DCIM/Camera/.pending-1679239202-IMG_20230312_162001_161.jpg to /storage/emulated/10/DCIM/Camera/IMG_20230312_162001_161.jpg
```
I use version 60 on a Pixel 4a. I did not change any of the settings or install any applications for the user I used for testing.
I've been experiencing a delay of > 1s between pressing the shutter button and getting a responsive user interface again for a few months now. Inspecting the output of
logcat
under a new profile I see a fair amount of variation. I took two samples, measuring fromImageCapture: takePictureWithNode
toMediaProvider: Moving
:595 ms
``` 03-12 16:21:10.107 17459 17459 D ImageCapture: takePictureWithNode 03-12 16:21:10.110 17459 17459 D CameraOrientationUtil: getRelativeImageRotation: destRotationDegrees=0, sourceRotationDegrees=90, isOppositeFacing=true, result=90 03-12 16:21:10.110 17459 17459 D TakePictureManager: Issue the next TakePictureRequest. 03-12 16:21:10.119 17459 17529 D Camera2CameraImpl: {Camera@ac8066[id=0]} Issue capture request 03-12 16:21:10.119 17459 17529 D CaptureSession: Issuing capture request. 03-12 16:21:10.126 17459 17529 D Camera2CaptureRequestBuilder: createCaptureRequest 03-12 16:21:10.144 28289 28291 I GCH_HdrplusCaptureSession: ProcessRequest: hdrplus snapshot (6895), output stream size:1 03-12 16:21:10.145 28289 28291 W GCH_InternalStreamManager: GetMostRecentStreamBuffer: payload frames 1 is smaller than min filled buffers 3 03-12 16:21:10.145 28289 28291 D GCH_HdrplusRequestProcessor: ProcessRequest: frame number 6895 is an HDR+ request. 03-12 16:21:10.147 28289 28291 I GCH_CameraPipelineHwl: CreateChiRequest (6895) set PowerHint CAMERA_SHOT 03-12 16:21:10.149 28289 28291 E CamX : [ERROR][META ] camxmetabuffer.cpp:2615 SetTag() Cannot set 110006 size 0 max 160 03-12 16:21:10.149 28289 28291 E CamX : [ERROR][META ] camxmetabuffer.cpp:2615 SetTag() Cannot set 110007 size 0 max 10 03-12 16:21:10.410 1006 1088 D VSC : @ 446030.398: [WO] Proposed rotation: 0, flat angle threshold: 65 03-12 16:21:10.410 1006 1088 D VSC : @ 446030.398: [WO] orientation angle 0, orientation 0 03-12 16:21:10.410 1006 1088 D VSC : @ 446030.398: [WO] Gyro angle integrated: 3.817096 03-12 16:21:10.410 1006 1088 D VSC : @ 446030.398: [WO] Gyro angle integrated: 3.817096 03-12 16:21:10.560 28289 17538 W GCH_ZslBufferManager: IsPendingBufferEmpty: Pending buffer is not empty:1. 03-12 16:21:10.560 28289 17538 I GCH_HdrplusResultProcessor: ProcessResult: (6895)ReturnZslStreamBuffers ok 03-12 16:21:10.563 17459 17459 D TakePictureManager: Issue the next TakePictureRequest. 03-12 16:21:10.563 17459 17459 D TakePictureManager: No new request. 03-12 16:21:10.595 1305 17859 D MediaCodec: keep callback message for reclaim 03-12 16:21:10.596 1305 17860 I CCodecConfig: query failed after returning 7 values (BAD_INDEX) 03-12 16:21:10.596 1305 17860 W Codec2Client: query -- param skipped: index = 1342179345. 03-12 16:21:10.596 1305 17860 W Codec2Client: query -- param skipped: index = 2415921170. 03-12 16:21:10.597 1037 17357 W AudioFlinger: The package name(android) provided does not correspond to the uid 1041 03-12 16:21:10.597 1305 17860 D BufferPoolAccessor2.0: bufferpool2 0xdcdc0c88 : 5(163840 size) total buffers - 5(163840 size) used buffers - 22/31 (recycle/alloc) - 8/56 (fetch/transfer) 03-12 16:21:10.598 1330 1379 D BufferPoolAccessor2.0: bufferpool2 0xb400d9802d7f5028 : 0(0 size) total buffers - 0(0 size) used buffers - 23/26 (recycle/alloc) - 3/25 (fetch/transfer) 03-12 16:21:10.599 1330 17861 D C2SoftVorbisDec: vorbis_dsp_synthesis returned -135; ignored 03-12 16:21:10.600 1330 17861 D C2SoftVorbisDec: vorbis_dsp_synthesis returned -135; ignored 03-12 16:21:10.604 973 1008 I EffectsFactory: EffectCreate() create_effect 03-12 16:21:10.608 1037 17357 W AudioFlinger: moveEffectChain_l() effect chain for session 0 not on source thread 0xb400c5e43a090000 03-12 16:21:10.608 16521 16666 W MediaProvider: isAppCloneUserPair failed. Users: 0 and 10 03-12 16:21:10.609 16521 16666 W MediaProvider: isAppCloneUserPair for user 10: false 03-12 16:21:10.615 16521 16666 V MediaProvider: Inserted id:1000000023 less than next row id backup:1000001000. 03-12 16:21:10.643 16521 16666 I MediaProvider: Open with lower FS for /storage/emulated/10/DCIM/Camera/.pending-1679239270-IMG_20230312_162110_104.jpg. Uid: 1010081 03-12 16:21:10.645 973 6357 D audio_hw_primary: adev_create_audio_patch: enter: num sources 1, num_sinks 1, handle 2 03-12 16:21:10.645 973 6357 D audio_hw_primary: adev_create_audio_patch: Playback patch from mix handle 21 to device 2 03-12 16:21:10.645 973 6357 D audio_hw_primary: route_output_stream: enter: usecase(1: low-latency-playback) devices 2 03-12 16:21:10.656 973 1008 E volume_listener: check_and_set_gain_dep_cal: Failed to set gain dep cal level 03-12 16:21:10.656 973 31393 D audio_hw_primary: start_output_stream: enter: stream(0xe3600010)usecase(1: low-latency-playback) devices(0x2) is_haptic_usecase(0) 03-12 16:21:10.656 973 31393 D audio_hw_primary: select_devices for use case (low-latency-playback) 03-12 16:21:10.656 973 31393 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) 03-12 16:21:10.656 973 31393 I msm8974_platform: platform_check_and_set_codec_backend_cfg: new_snd_devices[0] is 2 03-12 16:21:10.656 973 31393 I msm8974_platform: platform_check_codec_backend_cfg:becf: afe: bitwidth 24, samplerate 48000 channels 2, backend_idx 0 usecase = 1 device (speaker) 03-12 16:21:10.659 973 31393 D msm8974_platform: platform_check_codec_backend_cfg:becf: updated afe: bitwidth 24, samplerate 48000 channels 2,backend_idx 0 usecase = 1 device (speaker) 03-12 16:21:10.659 973 31393 I msm8974_platform: platform_check_codec_backend_cfg:becf: afe: Codec selected backend: 0 updated bit width: 24 and sample rate: 48000 03-12 16:21:10.659 973 31393 I msm8974_platform: platform_check_codec_backend_cfg:becf: afe: Codec backend needs to be updated. new bit width: 24new sample rate: 48000 new channels: 2 03-12 16:21:10.659 973 31393 I msm8974_platform: platform_set_codec_backend_cfg:becf: afe: bitwidth 24, samplerate 48000 channels 2 format 1, backend_idx 0 device (speaker) 03-12 16:21:10.659 973 31393 E msm8974_platform: platform_set_codec_backend_cfg:becf: afe: Could not get ctl for mixer command - SLIM_0_RX Format 03-12 16:21:10.659 973 31393 D audio_hw_primary: check_usecases_codec_backend:becf: force routing 0 03-12 16:21:10.659 973 31393 D audio_hw_primary: check_usecases_codec_backend:becf: (78) check_usecases curr device: speaker, usecase device: backends match 0 03-12 16:21:10.659 973 31393 D audio_hw_primary: check_usecases_codec_backend:becf: check_usecases num.of Usecases to switch 0 03-12 16:21:10.659 973 31393 D hardware_info: hw_info_append_hw_type : device_name = speaker 03-12 16:21:10.660 973 31393 D audio_route: Apply path: speaker 03-12 16:21:10.687 973 31393 D hardware_info: hw_info_append_hw_type : device_name = vi-feedback 03-12 16:21:10.687 973 31393 D audio_hw_primary: enable_snd_device: snd_device(222: vi-feedback) 03-12 16:21:10.687 973 31393 D msm8974_platform: platform_get_island_cfg_on_device:island cfg status on snd_device = (vi-feedback 0) 03-12 16:21:10.687 973 31393 I soundtrigger: audio_extn_sound_trigger_update_device_status: device 0xde of type 1 for Event 1, with Raise=0 03-12 16:21:10.687 973 31393 D audio_route: Apply path: vi-feedback 03-12 16:21:10.687 973 31393 D soundtrigger: audio_extn_sound_trigger_update_stream_status: uc_info->id 53 of type 1 for Event 3, with Raise=0 03-12 16:21:10.687 973 31393 D audio_hw_utils: audio_extn_utils_send_app_type_cfg: usecase->in_snd_device vi-feedback 03-12 16:21:10.687 973 31393 E audio_hw_utils: send_app_type_cfg_for_device: Could not get ctl for mixer cmd - Audio Stream Capture 103 App Type Cfg 03-12 16:21:10.687 973 31393 D audio_hw_waves: ma_set_device: 53 is not supported usecase 03-12 16:21:10.687 973 31393 D ACDB-LOADER: ACDB -> send_audio_cal, acdb_id = 512, path = 1, app id = 0x11132, sample rate = 8000, afe_sample_rate = 8000 03-12 16:21:10.687 973 31393 D ACDB-LOADER: ACDB -> send_asm_topology 03-12 16:21:10.687 973 31393 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_STREAM_TOPOLOGY_ID 03-12 16:21:10.687 973 31393 D ACDB-LOADER: ACDB -> send_adm_topology 03-12 16:21:10.687 973 31393 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_COMMON_TOPOLOGY_ID 03-12 16:21:10.687 973 31393 D ACDB-LOADER: ACDB -> send_audtable 03-12 16:21:10.687 973 31393 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_INSTANCE_COMMON_TABLE_SIZE 03-12 16:21:10.687 973 31393 D android.hardware.audio.service: Failed to fetch the lookup information of the device 00000200 03-12 16:21:10.687 973 31393 D ACDB-LOADER: Error: ACDB_CMD_GET_AUDPROC_INSTANCE_COMMON_TABLE_SIZE Returned = -19 03-12 16:21:10.687 973 31393 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_INSTANCE_COMMON_TABLE 03-12 16:21:10.687 973 31393 D android.hardware.audio.service: Failed to fetch the lookup information of the device 00000200 03-12 16:21:10.687 973 31393 D ACDB-LOADER: Error: ACDB audproc returned = -19 03-12 16:21:10.687 973 31393 D ACDB-LOADER: ACDB -> AUDIO_SET_AUDPROC_CAL cal_type[11] acdb_id[512] app_type[69938] 03-12 16:21:10.687 973 31393 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_INSTANCE_STREAM_TABLE_SIZE 03-12 16:21:10.687 973 31393 D ACDB-LOADER: ACDB -> send_audstrmtable 03-12 16:21:10.687 973 31393 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AUDPROC_INSTANCE_STREAM_TABLE 03-12 16:21:10.687 973 31393 D ACDB-LOADER: ACDB -> audstrm_cal->cal_type.cal_data.cal_size = 20 03-12 16:21:10.687 973 31393 D ACDB-LOADER: ACDB -> send_afe_topology 03-12 16:21:10.688 973 31393 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_TOPOLOGY_ID 03-12 16:21:10.688 973 31393 D ACDB-LOADER: ACDB -> GET_AFE_TOPOLOGY_ID for adcd_id 512, Topology Id 112fb 03-12 16:21:10.688 973 31393 D ACDB-LOADER: ACDB -> send_afe_cal 03-12 16:21:10.688 973 31393 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_INSTANCE_COMMON_TABLE_SIZE 03-12 16:21:10.688 973 31393 D android.hardware.audio.service: Failed to fetch the lookup information of the device 00000200 03-12 16:21:10.688 973 31393 D ACDB-LOADER: Error: ACDB_CMD_GET_AFE_INSTANCE_COMMON_TABLE_SIZE Returned = -19 03-12 16:21:10.688 973 31393 D ACDB-LOADER: ACDB -> ACDB_CMD_GET_AFE_INSTANCE_COMMON_TABLE 03-12 16:21:10.688 973 31393 D android.hardware.audio.service: Failed to fetch the lookup information of the device 00000200 03-12 16:21:10.688 973 31393 D ACDB-LOADER: Error: ACDB AFE returned = -19 03-12 16:21:10.688 973 31393 D ACDB-LOADER: ACDB -> AUDIO_SET_AFE_CAL cal_type[17] acdb_id[512] 03-12 16:21:10.688 973 31393 D ACDB-LOADER: ACDB -> send_hw_delay : acdb_id = 512 path = 1 03-12 16:21:10.688 973 31393 D ACDB-LOADER: ACDB -> ACDB_AVSYNC_INFO: ACDB_CMD_GET_DEVICE_PROPERTY 03-12 16:21:10.688 973 31393 D audio_hw_primary: enable_audio_route: apply mixer and update path: spkr-vi-record vi-feedback 03-12 16:21:10.688 973 31393 D audio_route: Apply path: spkr-vi-record vi-feedback 03-12 16:21:10.693 1305 17860 D CCodecBufferChannel: [c2.android.vorbis.decoder#641] buffers after EOS ignored (0 us) 03-12 16:21:10.693 1305 17860 D CCodecBufferChannel: [c2.android.vorbis.decoder#641] buffers after EOS ignored (0 us) 03-12 16:21:10.693 1305 17860 D CCodecBufferChannel: [c2.android.vorbis.decoder#641] buffers after EOS ignored (0 us) 03-12 16:21:10.695 1305 17858 D AudioTrack: stop(120): called with 18213 frames delivered 03-12 16:21:10.702 16521 16666 D MediaProvider: Moving /storage/emulated/10/DCIM/Camera/.pending-1679239270-IMG_20230312_162110_104.jpg to /storage/emulated/10/DCIM/Camera/IMG_20230312_162110_104.jpg ```1946 ms
``` 03-12 16:20:01.164 17459 17459 D ImageCapture: takePictureWithNode 03-12 16:20:01.169 17459 17459 D CameraOrientationUtil: getRelativeImageRotation: destRotationDegrees=0, sourceRotationDegrees=90, isOppositeFacing=true, result=90 03-12 16:20:01.170 17459 17459 D TakePictureManager: Issue the next TakePictureRequest. 03-12 16:20:01.180 17459 17520 D Camera2CameraImpl: {Camera@ac8066[id=0]} Issue capture request 03-12 16:20:01.181 17459 17520 D CaptureSession: Issuing capture request. 03-12 16:20:01.181 17459 17520 D Camera2CaptureRequestBuilder: createCaptureRequest 03-12 16:20:01.274 28289 28291 I GCH_CameraDeviceSession: ProcessCaptureRequest: [sbc] Stream 1 1st req arrived, notify SBC Manager. 03-12 16:20:01.275 28289 28291 I GCH_HdrplusCaptureSession: ProcessRequest: hdrplus snapshot (5779), output stream size:1 03-12 16:20:01.279 28289 28291 W GCH_InternalStreamManager: GetMostRecentStreamBuffer: payload frames 1 is smaller than min filled buffers 3 03-12 16:20:01.281 28289 28291 D GCH_HdrplusRequestProcessor: ProcessRequest: frame number 5779 is an HDR+ request. 03-12 16:20:01.281 28289 28291 I GCH_CameraPipelineHwl: CreateChiRequest (5779) set PowerHint CAMERA_SHOT 03-12 16:20:01.287 28289 28291 E CamX : [ERROR][META ] camxmetabuffer.cpp:2615 SetTag() Cannot set 110006 size 0 max 160 03-12 16:20:01.287 28289 28291 E CamX : [ERROR][META ] camxmetabuffer.cpp:2615 SetTag() Cannot set 110007 size 0 max 10 03-12 16:20:01.290 28289 28291 D CamX : [DEBUG][SENSOR ] camximagesensordata.cpp:2049 PopulateSensorModeData() integrationInfoExists: 1,integrationTimeMargin: 16,minVerticalBlanking: 98,i: 0 03-12 16:20:01.290 28289 28291 D CamX : [DEBUG][SENSOR ] camximagesensordata.cpp:2049 PopulateSensorModeData() integrationInfoExists: 1,integrationTimeMargin: 16,minVerticalBlanking: 166,i: 1 03-12 16:20:01.290 28289 28291 D CamX : [DEBUG][SENSOR ] camximagesensordata.cpp:2049 PopulateSensorModeData() integrationInfoExists: 1,integrationTimeMargin: 16,minVerticalBlanking: 86,i: 2 03-12 16:20:01.290 28289 28291 D CamX : [DEBUG][SENSOR ] camximagesensordata.cpp:2049 PopulateSensorModeData() integrationInfoExists: 1,integrationTimeMargin: 16,minVerticalBlanking: 98,i: 3 03-12 16:20:01.290 28289 28291 D CamX : [DEBUG][SENSOR ] camximagesensordata.cpp:2049 PopulateSensorModeData() integrationInfoExists: 1,integrationTimeMargin: 16,minVerticalBlanking: 90,i: 4 03-12 16:20:01.290 28289 28291 D CamX : [DEBUG][SENSOR ] camximagesensordata.cpp:2049 PopulateSensorModeData() integrationInfoExists: 1,integrationTimeMargin: 16,minVerticalBlanking: 90,i: 5 03-12 16:20:01.290 28289 28291 D CamX : [DEBUG][SENSOR ] camximagesensordata.cpp:2049 PopulateSensorModeData() integrationInfoExists: 1,integrationTimeMargin: 16,minVerticalBlanking: 90,i: 6 03-12 16:20:01.290 28289 28291 D CamX : [DEBUG][SENSOR ] camximagesensordata.cpp:2049 PopulateSensorModeData() integrationInfoExists: 1,integrationTimeMargin: 16,minVerticalBlanking: 98,i: 7 03-12 16:20:01.290 28289 28291 D CamX : [DEBUG][SENSOR ] camximagesensordata.cpp:2049 PopulateSensorModeData() integrationInfoExists: 1,integrationTimeMargin: 16,minVerticalBlanking: 90,i: 8 03-12 16:20:01.290 28289 28291 D CamX : [DEBUG][SENSOR ] camximagesensordata.cpp:2049 PopulateSensorModeData() integrationInfoExists: 1,integrationTimeMargin: 16,minVerticalBlanking: 342,i: 9 03-12 16:20:01.290 28289 28291 E CamX : [ERROR][CORE ] camxnode.cpp:6727 FinalizeInitialization() Node::GooglePhotoRearOfflineBPS_ChiNodeWrapper_14 maxImageBuffers(8) from link properties should be atleast requiredMaxImageBuffers(11). So replacing maxImageBuffers with requiredMaxImageBuffers 03-12 16:20:01.290 28289 28291 E CamX : [ERROR][CORE ] camxnode.cpp:6727 FinalizeInitialization() Node::GooglePhotoRearOfflineBPS_ChiNodeWrapper_14 maxImageBuffers(8) from link properties should be atleast requiredMaxImageBuffers(11). So replacing maxImageBuffers with requiredMaxImageBuffers 03-12 16:20:01.291 28289 28291 E CamX : [ERROR][CORE ] camxnode.cpp:6727 FinalizeInitialization() Node::GooglePhotoRearOfflineBPS_ChiNodeWrapper_14 maxImageBuffers(8) from link properties should be atleast requiredMaxImageBuffers(11). So replacing maxImageBuffers with requiredMaxImageBuffers 03-12 16:20:01.291 28289 28291 E CamX : [ERROR][CORE ] camxnode.cpp:6727 FinalizeInitialization() Node::GooglePhotoRearOfflineBPS_ChiNodeWrapper_14 maxImageBuffers(8) from link properties should be atleast requiredMaxImageBuffers(11). So replacing maxImageBuffers with requiredMaxImageBuffers 03-12 16:20:01.291 28289 28291 E CamX : [ERROR][CORE ] camxnode.cpp:6727 FinalizeInitialization() Node::GooglePhotoRearOfflineBPS_JPEG_Encoder_0 maxImageBuffers(8) from link properties should be atleast requiredMaxImageBuffers(11). So replacing maxImageBuffers with requiredMaxImageBuffers 03-12 16:20:01.291 28289 28291 E CamX : [ERROR][CORE ] camxnode.cpp:6727 FinalizeInitialization() Node::GooglePhotoRearOfflineBPS_JPEG_Encoder_1 maxImageBuffers(8) from link properties should be atleast requiredMaxImageBuffers(11). So replacing maxImageBuffers with requiredMaxImageBuffers 03-12 16:20:01.291 28289 28291 E CamX : [ERROR][CORE ] camxnode.cpp:6727 FinalizeInitialization() Node::GooglePhotoRearOfflineBPS_IPE_2 maxImageBuffers(8) from link properties should be atleast requiredMaxImageBuffers(11). So replacing maxImageBuffers with requiredMaxImageBuffers 03-12 16:20:01.291 28289 28291 E CamX : [ERROR][CORE ] camxnode.cpp:6727 FinalizeInitialization() Node::GooglePhotoRearOfflineBPS_IPE_2 maxImageBuffers(8) from link properties should be atleast requiredMaxImageBuffers(11). So replacing maxImageBuffers with requiredMaxImageBuffers 03-12 16:20:01.291 28289 28291 E CamX : [ERROR][CORE ] camxnode.cpp:6727 FinalizeInitialization() Node::GooglePhotoRearOfflineBPS_IPE_3 maxImageBuffers(8) from link properties should be atleast requiredMaxImageBuffers(11). So replacing maxImageBuffers with requiredMaxImageBuffers 03-12 16:20:01.292 28289 28291 E CamX : [ERROR][CORE ] camxnode.cpp:6727 FinalizeInitialization() Node::GooglePhotoRearOfflineBPS_BPS_0 maxImageBuffers(8) from link properties should be atleast requiredMaxImageBuffers(11). So replacing maxImageBuffers with requiredMaxImageBuffers 03-12 16:20:01.292 28289 28291 E CamX : [ERROR][CORE ] camxnode.cpp:6727 FinalizeInitialization() Node::GooglePhotoRearOfflineBPS_BPS_0 maxImageBuffers(8) from link properties should be atleast requiredMaxImageBuffers(11). So replacing maxImageBuffers with requiredMaxImageBuffers 03-12 16:20:01.292 28289 28291 E CamX : [ERROR][CORE ] camxnode.cpp:6727 FinalizeInitialization() Node::GooglePhotoRearOfflineBPS_BPS_0 maxImageBuffers(8) from link properties should be atleast requiredMaxImageBuffers(11). So replacing maxImageBuffers with requiredMaxImageBuffers 03-12 16:20:01.292 28289 28291 E CamX : [ERROR][CORE ] camxnode.cpp:6727 FinalizeInitialization() Node::GooglePhotoRearOfflineBPS_BPS_0 maxImageBuffers(8) from link properties should be atleast requiredMaxImageBuffers(11). So replacing maxImageBuffers with requiredMaxImageBuffers 03-12 16:20:01.294 28289 28291 I CamX : [CONFIG][CORE ] camxnode.cpp:741 InitializeSourcePortBufferFormat() Topology: Node::GooglePhotoRearOfflineBPS_BPS_0 has a source port id 0 using format 9 dim 4032x3024 03-12 16:20:01.296 28289 28291 I google_hdrnet: SetBufferInfo 381 03-12 16:20:01.296 28289 28291 I google_hdrnet: SetBufferInfo 381 03-12 16:20:01.296 28289 28291 I google_hdrnet: SetBufferInfo 381 03-12 16:20:01.297 28289 28291 I google_hdrnet: SetBufferInfo 381 03-12 16:20:01.302 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_ChiNodeWrapper_14_OutputPortId0_ ] width=4032, height = 3024, format = 12 stride 5376 scanline 3024 GetTotalSize 24576000 03-12 16:20:01.302 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_ChiNodeWrapper_14_OutputPortId0_ ] width=4032, height = 3024, format = 12 stride 5376 scanline 1520 GetTotalSize 24576000 03-12 16:20:01.302 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_ChiNodeWrapper_14_OutputPortId1_ ] width=1008, height = 756, format = 18 stride 4032 scanline 380 GetTotalSize 1532160 03-12 16:20:01.303 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_ChiNodeWrapper_14_OutputPortId2_ ] width=252, height = 190, format = 18 stride 1152 scanline 96 GetTotalSize 110592 03-12 16:20:01.303 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_ChiNodeWrapper_14_OutputPortId3_ ] width=64, height = 48, format = 18 stride 384 scanline 24 GetTotalSize 9216 03-12 16:20:01.303 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_JPEG_Aggregator_0_OutputPortId2_ ] width=4032, height = 3024, format = 0 stride 0 scanline 0 GetTotalSize 18289160 03-12 16:20:01.303 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_JPEG_Encoder_0_OutputPortId1_ ] width=4032, height = 3024, format = 3 stride 4032 scanline 3024 GetTotalSize 18289152 03-12 16:20:01.303 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_JPEG_Encoder_0_OutputPortId1_ ] width=4032, height = 3024, format = 3 stride 4032 scanline 1512 GetTotalSize 18289152 03-12 16:20:01.303 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_JPEG_Encoder_1_OutputPortId1_ ] width=320, height = 240, format = 3 stride 320 scanline 240 GetTotalSize 115200 03-12 16:20:01.303 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_JPEG_Encoder_1_OutputPortId1_ ] width=320, height = 240, format = 3 stride 320 scanline 120 GetTotalSize 115200 03-12 16:20:01.303 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_IPE_2_OutputPortId9_Video] width=4032, height = 3024, format = 3 stride 4032 scanline 3024 GetTotalSize 18289152 03-12 16:20:01.303 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_IPE_2_OutputPortId9_Video] width=4032, height = 3024, format = 3 stride 4032 scanline 1512 GetTotalSize 18289152 03-12 16:20:01.303 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_IPE_2_OutputPortId8_Display] width=640, height = 480, format = 3 stride 640 scanline 480 GetTotalSize 460800 03-12 16:20:01.303 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_IPE_2_OutputPortId8_Display] width=640, height = 480, format = 3 stride 640 scanline 240 GetTotalSize 460800 03-12 16:20:01.303 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_IPE_3_OutputPortId8_Display] width=1600, height = 1200, format = 3 stride 1664 scanline 1216 GetTotalSize 3035136 03-12 16:20:01.303 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_IPE_3_OutputPortId8_Display] width=1600, height = 1200, format = 3 stride 1664 scanline 608 GetTotalSize 3035136 03-12 16:20:01.303 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_IPE_3_OutputPortId9_Video] width=640, height = 480, format = 3 stride 640 scanline 480 GetTotalSize 460800 03-12 16:20:01.304 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_IPE_3_OutputPortId9_Video] width=640, height = 480, format = 3 stride 640 scanline 240 GetTotalSize 460800 03-12 16:20:01.304 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_IPE_4_OutputPortId9_Video] width=640, height = 480, format = 4 stride 640 scanline 512 GetTotalSize 491520 03-12 16:20:01.304 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_IPE_4_OutputPortId9_Video] width=640, height = 480, format = 4 stride 640 scanline 256 GetTotalSize 491520 03-12 16:20:01.304 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_IPE_4_OutputPortId8_Display] width=640, height = 480, format = 4 stride 640 scanline 512 GetTotalSize 491520 03-12 16:20:01.304 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_IPE_4_OutputPortId8_Display] width=640, height = 480, format = 4 stride 640 scanline 256 GetTotalSize 491520 03-12 16:20:01.304 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_BPS_0_OutputPortId1_Full] width=4032, height = 3024, format = 12 stride 5376 scanline 3024 GetTotalSize 24576000 03-12 16:20:01.304 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_BPS_0_OutputPortId1_Full] width=4032, height = 3024, format = 12 stride 5376 scanline 1520 GetTotalSize 24576000 03-12 16:20:01.305 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_BPS_0_OutputPortId2_DS4] width=1008, height = 756, format = 18 stride 4032 scanline 380 GetTotalSize 1532160 03-12 16:20:01.305 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_BPS_0_OutputPortId3_DS16] width=252, height = 190, format = 18 stride 1152 scanline 96 GetTotalSize 110592 03-12 16:20:01.305 28289 28291 I CamX : [CONFIG][MEMMGR ] camxnode.cpp:6537 CreateBufferManagers() BufferMgrCreate ,[GooglePhotoRearOfflineBPS_BPS_0_OutputPortId4_DS64] width=64, height = 48, format = 18 stride 384 scanline 24 GetTotalSize 9216 03-12 16:20:01.307 627 627 I lowmemorykiller: Kill 'com.android.keychain' (16539), uid 1001000, oom_score_adj 995 to free 76640kB rss, 140kB swap; reason: low watermark is breached and swap is low (0kB < 209712kB) 03-12 16:20:01.320 1668 1693 D CompatibilityChangeReporter: Compat change id reported: 161145287; UID 10149; state: DISABLED 03-12 16:20:01.328 1006 1088 D VSC : @ 445961.317: [WO] Proposed rotation: 0, flat angle threshold: 65 03-12 16:20:01.329 1006 1088 D VSC : @ 445961.317: [WO] orientation angle 0, orientation 0 03-12 16:20:01.329 1006 1088 D VSC : @ 445961.317: [WO] Gyro angle integrated: 11.489001 03-12 16:20:01.329 1006 1088 D VSC : @ 445961.317: [WO] Gyro angle integrated: 11.489001 03-12 16:20:01.343 2587 2587 D wpa_supplicant: Control interface recv command from: /data/vendor/wifi/wpa/sockets/wpa_ctrl_1319-51\x00 03-12 16:20:01.343 2587 2587 D wpa_supplicant: wlan0: Control interface command 'VENDOR 0x001374 13' 03-12 16:20:01.345 2587 2587 D wpa_supplicant: CTRL-DEBUG: ctrl_sock-sendto: sock=14 sndbuf=229376 outq=0 send_len=0 03-12 16:20:01.348 2587 2587 D wpa_supplicant: nl80211: Event message available 03-12 16:20:01.348 1342 1342 I cnss-daemon: nl80211 response handler invoked 03-12 16:20:01.349 1342 1342 I cnss-daemon: nl80211_response_handler: cmd 103, vendorID 4980, subcmd 13 received 03-12 16:20:01.348 1367 31926 D LOWI-8.6.0.75: [LOWI-Scan] wait_event:Wait done with Cmd 103 03-12 16:20:01.349 1367 31926 D LOWI-8.6.0.75: [LOWI-Scan] do_listen_events: Rcvd valid Netlink Cmd 0 Err 0 03-12 16:20:01.349 2587 2587 D wpa_supplicant: nl80211: Drv Event 103 (NL80211_CMD_VENDOR) received for wlan0 03-12 16:20:01.349 2587 2587 D wpa_supplicant: nl80211: Vendor event: wiphy=0 vendor_id=0x1374 subcmd=13 03-12 16:20:01.349 2587 2587 D wpa_supplicant: nl80211: Vendor data - hexdump(len=180): 08 00 04 00 1e 00 00 00 ac 00 03 00 00 00 00 00 b8 f3 00 00 a3 00 00 00 00 00 00 00 09 34 02 00 ... 03-12 16:20:01.349 2587 2587 D wpa_supplicant: nl80211: Ignore unsupported QCA vendor event 13 03-12 16:20:01.349 17817 17849 D CompatibilityChangeReporter: Compat change id reported: 160794467; UID 10149; state: ENABLED 03-12 16:20:01.350 1014 2505 I WifiHAL : event received NL80211_CMD_VENDOR, vendor_id = 0x1374, subcmd = 0xd 03-12 16:20:01.378 1668 23453 I ActivityManager: Process com.android.keychain (pid 16539) has died: cch+95 CEM 03-12 16:20:01.379 955 955 I Zygote : Process 16539 exited due to signal 9 (Killed) 03-12 16:20:01.381 1668 1891 I libprocessgroup: Successfully killed process cgroup uid 1001000 pid 16539 in 3ms 03-12 16:20:01.411 28289 28291 I DyscoWrap: DyscoCoreCreate: dysco_wrapper 0xb400c9e0b4f65a00 03-12 16:20:01.411 28289 28291 D DyscoWrap: tuning_manager_params->sensor_id=0 03-12 16:20:01.422 28289 28291 I google_hdrnet: PrepareStreamOn 436: start 03-12 16:20:01.464 627 627 I lowmemorykiller: Kill 'com.stevesoltys.seedvault' (16895), uid 1010030, oom_score_adj 985 to free 76396kB rss, 136kB swap; reason: low watermark is breached and swap is low (4kB < 209712kB) 03-12 16:20:01.510 1668 23453 I ActivityManager: Process com.stevesoltys.seedvault (pid 16895) has died: cch+85 CEM 03-12 16:20:01.511 1668 1891 I libprocessgroup: Successfully killed process cgroup uid 1010030 pid 16895 in 0ms 03-12 16:20:01.512 955 955 I Zygote : Process 16895 exited due to signal 9 (Killed) 03-12 16:20:01.616 627 627 I lowmemorykiller: Kill 'com.android.localtransport' (16820), uid 1001000, oom_score_adj 985 to free 74164kB rss, 40kB swap; reason: low watermark is breached and swap is low (0kB < 209712kB) 03-12 16:20:01.641 17817 17817 D org.wikipedia: Create notification channels skipped. 03-12 16:20:01.657 1668 2630 I ActivityManager: Process com.android.localtransport (pid 16820) has died: cch+85 CEM 03-12 16:20:01.657 1668 1891 I libprocessgroup: Successfully killed process cgroup uid 1001000 pid 16820 in 0ms 03-12 16:20:01.677 955 955 I Zygote : Process 16820 exited due to signal 9 (Killed) 03-12 16:20:01.742 627 627 I lowmemorykiller: Kill 'app.grapheneos.apps' (16836), uid 1010075, oom_score_adj 985 to free 81060kB rss, 72kB swap; reason: low watermark is breached and swap is low (0kB < 209712kB) 03-12 16:20:01.786 1668 11265 I ActivityManager: Process app.grapheneos.apps (pid 16836) has died: cch+85 CEM 03-12 16:20:01.799 1668 1891 I libprocessgroup: Successfully killed process cgroup uid 1010075 pid 16836 in 2ms 03-12 16:20:01.871 627 627 I lowmemorykiller: Kill 'com.android.contacts' (16988), uid 1010077, oom_score_adj 975 to free 75688kB rss, 68kB swap; reason: low watermark is breached and swap is low (0kB < 209712kB) 03-12 16:20:01.908 955 955 I Zygote : Process 16836 exited due to signal 9 (Killed) 03-12 16:20:01.921 955 955 I Zygote : Process 16988 exited due to signal 9 (Killed) 03-12 16:20:01.924 20351 20351 I MemoryController: onTrimMemory(10) 03-12 16:20:01.924 30189 30189 I FenixApplication: onTrimMemory(), level=10, main=false 03-12 16:20:01.936 1668 1668 W Looper : Slow dispatch took 123ms main h=android.app.ActivityThread$H c=I use version 60 on a Pixel 4a. I did not change any of the settings or install any applications for the user I used for testing.