nooriro · September 12, 2020 11:03
diff --git a/sunfish-update-log-200912-1959.txt b/sunfish-update-log-200912-1959.txt
 --------- beginning of system
 --------- beginning of main
 09-12 19:41:55.563  8248 13698 I SystemUpdate: [Installation,ReceiverIntentOperation] Received intent: Intent { act=com.google.gservices.intent.action.GSERVICES_CHANGED flg=0x1000010 cmp=com.google.android.gms/.chimera.GmsIntentOperationService$PersistentInternalReceiver }.
 09-12 19:41:55.641  8248 13770 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 2.
 09-12 19:41:55.647  8248 13635 I SystemUpdate: [Execution,InstallationIntentOperation] Received intent: Intent { act=com.google.android.gms.update.INSTALL_UPDATE cat=[targeted_intent_op_prefix:.update.execution.InstallationIntentOperation] cmp=com.google.android.gms/.chimera.GmsIntentOperationService }.
 09-12 19:41:55.648  8248 13635 I SystemUpdate: [Execution,ExecutionManager] Action finished-execution executed for 0.00 seconds.
 09-12 19:42:00.584  8248 13770 I SystemUpdate: [Installation,ReceiverIntentOperation] Received intent: Intent { act=com.google.gservices.intent.action.GSERVICES_CHANGED flg=0x1000010 cmp=com.google.android.gms/.chimera.GmsIntentOperationService$PersistentInternalReceiver }.
 09-12 19:42:00.682  8248 13698 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 2.
 09-12 19:42:00.687  8248 13635 I SystemUpdate: [Execution,InstallationIntentOperation] Received intent: Intent { act=com.google.android.gms.update.INSTALL_UPDATE cat=[targeted_intent_op_prefix:.update.execution.InstallationIntentOperation] cmp=com.google.android.gms/.chimera.GmsIntentOperationService }.
 09-12 19:42:00.691  8248 13635 I SystemUpdate: [Execution,ExecutionManager] Action finished-execution executed for 0.00 seconds.
 09-12 19:42:03.503  8248 13635 I SystemUpdate: [Installation,ReceiverIntentOperation] Received intent: Intent { act=com.google.gservices.intent.action.GSERVICES_CHANGED flg=0x1000010 cmp=com.google.android.gms/.chimera.GmsIntentOperationService$PersistentInternalReceiver }.
 09-12 19:42:03.538  8248 13770 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 2.
 09-12 19:42:03.540  8248 13736 I SystemUpdate: [Execution,InstallationIntentOperation] Received intent: Intent { act=com.google.android.gms.update.INSTALL_UPDATE cat=[targeted_intent_op_prefix:.update.execution.InstallationIntentOperation] cmp=com.google.android.gms/.chimera.GmsIntentOperationService }.
 09-12 19:42:03.542  8248 13736 I SystemUpdate: [Execution,ExecutionManager] Action finished-execution executed for 0.00 seconds.
 09-12 19:42:25.071  8248 15022 I SystemUpdate: [Installation,ReceiverIntentOperation] Received intent: Intent { act=com.google.android.gms.phenotype.COMMITTED flg=0x10 pkg=com.google.android.gms cmp=com.google.android.gms/.chimera.GmsIntentOperationService (has extras) }.
 09-12 19:42:25.088  8248 14896 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 2.
 09-12 19:42:25.090  8248 15716 I SystemUpdate: [Execution,InstallationIntentOperation] Received intent: Intent { act=com.google.android.gms.update.INSTALL_UPDATE cat=[targeted_intent_op_prefix:.update.execution.InstallationIntentOperation] cmp=com.google.android.gms/.chimera.GmsIntentOperationService }.
 09-12 19:42:25.096  8248 15716 I SystemUpdate: [Execution,ExecutionManager] Action finished-execution executed for 0.00 seconds.
 09-12 19:42:32.624  8248 14984 I SystemUpdate: [Installation,ReceiverIntentOperation] Received intent: Intent { act=com.google.gservices.intent.action.GSERVICES_CHANGED flg=0x1000010 cmp=com.google.android.gms/.chimera.GmsIntentOperationService$PersistentInternalReceiver }.
 09-12 19:42:32.691  8248 15022 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 2.
 09-12 19:42:32.706  8248 15022 I SystemUpdate: [Execution,InstallationIntentOperation] Received intent: Intent { act=com.google.android.gms.update.INSTALL_UPDATE cat=[targeted_intent_op_prefix:.update.execution.InstallationIntentOperation] cmp=com.google.android.gms/.chimera.GmsIntentOperationService }.
 09-12 19:42:32.709  8248 15022 I SystemUpdate: [Execution,ExecutionManager] Action finished-execution executed for 0.00 seconds.
 09-12 19:43:04.204  8248 15961 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
 09-12 19:43:04.208  8248 15962 I SystemUpdate: [Execution,InstallationIntentOperation] Received intent: Intent { act=com.google.android.gms.update.INSTALL_UPDATE cat=[targeted_intent_op_prefix:.update.execution.InstallationIntentOperation] cmp=com.google.android.gms/.chimera.GmsIntentOperationService }.
 09-12 19:43:04.212  8248 15962 I SystemUpdate: [Execution,ExecutionManager] Action finished-execution executed for 0.00 seconds.
 09-12 19:43:04.229 14897 14897 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x000, isSetupWizard=false.
 09-12 19:43:08.649  8248  8976 I SystemUpdate: [Api,CheckForConfigUpdateOperation] Checkin request finished with code Optional.of(21021).
 09-12 19:43:08.650 14897 15963 I SystemUpdate: [Common,RequestConfigUpdateLoader] Config update succeeded.
 09-12 19:43:09.427  8248 15961 I SystemUpdate: [Installation,ReceiverIntentOperation] Received intent: Intent { act=com.google.gservices.intent.action.GSERVICES_CHANGED flg=0x1000010 cmp=com.google.android.gms/.chimera.GmsIntentOperationService$PersistentInternalReceiver }.
 09-12 19:43:09.513  8248 15961 I SystemUpdate: [Control,InstallationControl] Update URL changed from "" to "https://ota.googlezip.net/packages/ota-api/google_sunfish_sunfish/3f391d83206c0d6b95f5c36de7c7b9dabee903c4.zip".
 09-12 19:43:09.722  8248 16018 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 2.
 09-12 19:43:09.726  8248 15962 I SystemUpdate: [Execution,InstallationIntentOperation] Received intent: Intent { act=com.google.android.gms.update.INSTALL_UPDATE cat=[targeted_intent_op_prefix:.update.execution.InstallationIntentOperation] cmp=com.google.android.gms/.chimera.GmsIntentOperationService }.
 09-12 19:43:09.729  8248 16018 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 102.
 09-12 19:43:09.730  8248 15962 I SystemUpdate: [Execution,ExecutionManager] Action finished-execution executed for 0.00 seconds.
 09-12 19:43:09.736  8248 15962 I SystemUpdate: [Execution,ExecutionManager] Finishing the current execution.
 09-12 19:43:09.765  8248 15962 I SystemUpdate: [Execution,SynchronizedUpdateEngine] reset()
 09-12 19:43:09.789  8248 15962 I SystemUpdate: [Execution,InstallationIntentOperation] Received intent: Intent { act=com.google.android.gms.update.INSTALL_UPDATE cat=[targeted_intent_op_prefix:.update.execution.InstallationIntentOperation] cmp=com.google.android.gms/.chimera.GmsIntentOperationService }.
 09-12 19:43:09.803  8248 15962 I SystemUpdate: [Execution,ExecutionManager] Action pending executed for 0.01 seconds.
 09-12 19:43:09.818  8248 15962 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x017, -1.000).
 09-12 19:43:09.836 14897 14897 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x017, isSetupWizard=false.
 09-12 19:43:11.173  8248 15962 I SystemUpdate: [Execution,PackageFiles] Aggressive allocating space for file /data/ota_package/payload_header.bin with size 24.
 09-12 19:43:12.813  8248 15962 I SystemUpdate: [Execution,PackageFiles] Aggressive allocating space for file /data/ota_package/payload_metadata.bin with size 105104.
 09-12 19:43:12.881  8248 15962 I SystemUpdate: [Execution,UpdateEngineDelegate] verifyPayloadMetadata()
 09-12 19:43:12.883  1145  1145 I update_engine: [INFO:binder_service_android.cc(179)] Received a request of verifying payload metadata in /data/ota_package/payload_metadata.bin.
 09-12 19:43:12.907  1145  1145 I update_engine: [INFO:payload_verifier.cc(102)] signature blob size = 523
 09-12 19:43:12.910  1145  1145 I update_engine: [INFO:payload_verifier.cc(118)] Truncating the signature to its unpadded size: 512.
 09-12 19:43:12.914  1145  1145 I update_engine: [INFO:payload_verifier.cc(129)] Verified correct signature 1 out of 1 signatures.
 09-12 19:43:12.917  1145  1145 I update_engine: [INFO:payload_metadata.cc(224)] Metadata hash signature matches value in Omaha response.
 09-12 19:43:14.254  8248 15962 I SystemUpdate: [Execution,PackageFiles] Aggressive allocating space for file /data/ota_package/metadata with size 554.
 09-12 19:43:14.267  8248 15962 I SystemUpdate: [Execution,ExecutionManager] Action pre-download-validate executed for 4.46 seconds.
 09-12 19:43:14.322  8248 15962 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x70B, -1.000).
 09-12 19:43:14.342 14897 14897 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x70B, isSetupWizard=false.
 09-12 19:43:14.465  8248 15962 I SystemUpdate: [Execution,ExecutionManager] Action streaming-download executed for 0.19 seconds.
 09-12 19:43:14.475  8248 15962 I SystemUpdate: [Execution,ExecutionManager] Action fixed-delay-execution executed for 0.01 seconds.
 09-12 19:43:33.679  8248 16084 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 103.
 09-12 19:43:33.685  8248 16082 I SystemUpdate: [Execution,InstallationIntentOperation] Received intent: Intent { act=com.google.android.gms.update.INSTALL_UPDATE cat=[targeted_intent_op_prefix:.update.execution.InstallationIntentOperation] cmp=com.google.android.gms/.chimera.GmsIntentOperationService }.
 09-12 19:43:33.736  8248 16082 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x002, -1.000).
 09-12 19:43:33.756 14897 14897 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x002, isSetupWizard=false.
 09-12 19:43:33.820  8248 16082 I SystemUpdate: [Network,NetworkRequester] Requesting network with capabilities [11, 12]...
 09-12 19:43:33.826  8248 16085 I SystemUpdate: [Network,NetworkRequester] Network acquired.
 09-12 19:43:33.829  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:43:33.830  8248  8513 I SystemUpdate: [Control,NetworkControl] Received intent: Intent { act=android.net.wifi.supplicant.STATE_CHANGE flg=0x24000010 (has extras) }.
 09-12 19:43:33.837  8248 16084 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:43:33.860  8248 16084 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 3.
 09-12 19:43:34.761  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:43:34.769  8248 16084 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:43:35.565  8248 16082 I SystemUpdate: [Execution,PackageFiles] Aggressive allocating space for file /data/ota_package/payload_properties.txt with size 156.
 09-12 19:43:37.595  8248 16082 I SystemUpdate: [Execution,PackageFiles] Aggressive allocating space for file /data/ota_package/care_map.pb with size 561.
 09-12 19:43:38.819  8248 16082 I SystemUpdate: [Execution,PackageFiles] Aggressive allocating space for file /data/ota_package/metadata with size 554.
 09-12 19:43:38.827  8248 16082 I SystemUpdate: [Execution,ExecutionManager] Action streaming-download executed for 5.14 seconds.
 09-12 19:43:38.834  8248 16082 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x003, -1.000).
 09-12 19:43:38.856 14897 14897 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x003, isSetupWizard=false.
 09-12 19:43:38.919  8248 16082 I SystemUpdate: [Execution,ExecutionManager] Action streaming-process-package executed for 0.09 seconds.
 09-12 19:43:38.926  8248 16082 I SystemUpdate: [Execution,ExecutionManager] Action ab-update-prep executed for 0.00 seconds.
 09-12 19:43:38.981  8248 16082 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x413, -1.000).
 09-12 19:43:38.998 14897 14897 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x413, isSetupWizard=false.
 09-12 19:43:39.050  8248 16082 I SystemUpdate: [Control,ChimeraGcmTaskService] Scheduling task: DeviceIdle.
 09-12 19:43:39.054  8248 16082 I SystemUpdate: [Execution,ExecutionManager] Action streaming-apply executed for 0.13 seconds.
 09-12 19:43:39.062  8248 16082 I SystemUpdate: [Execution,ExecutionManager] Action fixed-delay-execution executed for 0.00 seconds.
 09-12 19:44:04.234  8248 16102 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
 09-12 19:44:04.238  8248 16104 I SystemUpdate: [Execution,InstallationIntentOperation] Received intent: Intent { act=com.google.android.gms.update.INSTALL_UPDATE cat=[targeted_intent_op_prefix:.update.execution.InstallationIntentOperation] cmp=com.google.android.gms/.chimera.GmsIntentOperationService }.
 09-12 19:44:04.271  8248 16104 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x413, -1.000).
 09-12 19:44:04.324  8248 16104 I SystemUpdate: [Control,ChimeraGcmTaskService] Scheduling task: DeviceIdle.
 09-12 19:44:04.328  8248 16104 I SystemUpdate: [Execution,ExecutionManager] Action streaming-apply executed for 0.08 seconds.
 09-12 19:44:04.338  8248 16104 I SystemUpdate: [Execution,ExecutionManager] Action fixed-delay-execution executed for 0.01 seconds.
 09-12 19:45:12.087  8248 16140 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
 09-12 19:45:12.090  8248 16137 I SystemUpdate: [Execution,InstallationIntentOperation] Received intent: Intent { act=com.google.android.gms.update.INSTALL_UPDATE cat=[targeted_intent_op_prefix:.update.execution.InstallationIntentOperation] cmp=com.google.android.gms/.chimera.GmsIntentOperationService }.
 09-12 19:45:12.119 14897 14897 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x413, isSetupWizard=false.
 09-12 19:45:12.133  8248 16137 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x413, -1.000).
 09-12 19:45:12.190  8248 16137 I SystemUpdate: [Control,ChimeraGcmTaskService] Scheduling task: DeviceIdle.
 09-12 19:45:12.194  8248 16137 I SystemUpdate: [Execution,ExecutionManager] Action streaming-apply executed for 0.10 seconds.
 09-12 19:45:12.207  8248 16137 I SystemUpdate: [Execution,ExecutionManager] Action fixed-delay-execution executed for 0.01 seconds.
 09-12 19:45:14.434  8248 16139 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 109.
 09-12 19:45:14.438  8248 16138 I SystemUpdate: [Execution,InstallationIntentOperation] Received intent: Intent { act=com.google.android.gms.update.INSTALL_UPDATE cat=[targeted_intent_op_prefix:.update.execution.InstallationIntentOperation] cmp=com.google.android.gms/.chimera.GmsIntentOperationService }.
 09-12 19:45:14.492  8248 16138 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, -1.000).
 09-12 19:45:14.517 14897 14897 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x111, isSetupWizard=false.
 09-12 19:45:14.565  8248 16138 I SystemUpdate: [Network,NetworkRequester] Requesting network with capabilities [11, 12]...
 09-12 19:45:14.568  8248 16085 I SystemUpdate: [Network,NetworkRequester] Network acquired.
 09-12 19:45:14.572  8248  8513 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:45:14.574  8248  8976 I SystemUpdate: [Control,NetworkControl] Received intent: Intent { act=android.net.wifi.supplicant.STATE_CHANGE flg=0x24000010 (has extras) }.
 09-12 19:45:14.579  8248 16139 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:45:14.602  8248 16139 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 3.
 09-12 19:45:14.634  8248 16138 I SystemUpdate: [Execution,SynchronizedUpdateEngine] start(atul{url=https://ota.googlezip.net/packages/ota-api/google_sunfish_sunfish/3f391d83206c0d6b95f5c36de7c7b9dabee903c4.zip, payload_binary_file.offset=1260, payload_binary_file.length=1575657963, properties=[FILE_HASH=sGcPleaJ+eiQUfcIF38CohsI9tb4M+E8hgohx5xAsgk=, FILE_SIZE=1575657963, METADATA_HASH=nRRfTgsKG9LbsGhYB4DyfKQA6f94xBPwV4ytqbWCzmc=, METADATA_SIZE=104581]}, additionalProperties.size=4)
 09-12 19:45:14.634  8248 16138 I SystemUpdate: [Execution,UpdateEngineDelegate] applyPayload()
 09-12 19:45:14.643  1145  1145 I update_engine: [INFO:prefs.cc(122)] update-state-next-operation not present in /data/misc/update_engine/prefs
 09-12 19:45:14.652  1145  1145 I update_engine: [INFO:update_attempter_android.cc(280)] Using this install plan:
 09-12 19:45:14.654  1145  1145 I update_engine: [INFO:install_plan.cc(91)] InstallPlan: new_update, version: , source_slot: A, target_slot: B, url: https://ota.googlezip.net/packages/ota-api/google_sunfish_sunfish/3f391d83206c0d6b95f5c36de7c7b9dabee903c4.zip, payload: (size: 1575657963, metadata_size: 104581, metadata signature: , hash: B0670F95E689F9E89051F708177F02A21B08F6D6F833E13C860A21C79C40B209, payload type: unknown), hash_checks_mandatory: true, powerwash_required: false, switch_slot_on_reboot: false, run_post_install: true, is_rollback: false, write_verity: true
 09-12 19:45:14.656  1145  1145 I update_engine: [INFO:metrics_utils.cc(363)] Number of Reboots during current update attempt = 0
 09-12 19:45:14.658  1145  1145 I update_engine: [INFO:metrics_utils.cc(371)] Payload Attempt Number = 1
 09-12 19:45:14.659  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x002.
 09-12 19:45:14.675  1145  1145 I update_engine: [INFO:metrics_utils.cc(388)] Update Monotonic Timestamp Start = 1/1/1970 0:07:12 GMT
 09-12 19:45:14.680  1145  1145 I update_engine: [INFO:metrics_utils.cc(397)] Update Boot Timestamp Start = 1/1/1970 0:07:12 GMT
 09-12 19:45:14.688  1145  1145 I update_engine: [INFO:update_attempter_android.cc(648)] Scheduling an action processor start.
 09-12 19:45:14.691  1145  1145 I update_engine: [INFO:action_processor.cc(51)] ActionProcessor: starting UpdateBootFlagsAction
 09-12 19:45:14.696  1145  1145 I update_engine: [INFO:update_boot_flags_action.cc(45)] Marking booted slot as good.
 09-12 19:45:14.727  1145  1145 I update_engine: [INFO:action_processor.cc(116)] ActionProcessor: finished UpdateBootFlagsAction with code ErrorCode::kSuccess
 09-12 19:45:14.728  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x00B.
 09-12 19:45:14.730  1145  1145 I update_engine: [INFO:action_processor.cc(143)] ActionProcessor: starting CleanupPreviousUpdateAction
 09-12 19:45:14.734  1145  1145 I update_engine: [INFO:cleanup_previous_update_action.cc(82)] Starting/resuming CleanupPreviousUpdateAction
 09-12 19:45:14.742  1145  1145 I update_engine: [INFO:cleanup_previous_update_action.cc(137)] Boot completed, waiting on markBootSuccessful()
 09-12 19:45:14.745  1145  1145 I update_engine: EnsureMetadataMounted does nothing in Android mode.
 09-12 19:45:14.751  1145  1145 I update_engine: Read merge statistics file failed: No such file or directory
 09-12 19:45:14.759  1145  1145 I update_engine: [INFO:cleanup_previous_update_action.cc(206)] Waiting for any previous merge request to complete. This can take up to several minutes.
 09-12 19:45:14.763  1145  1145 E update_engine: Read state file failed: No such file or directory
 09-12 19:45:14.764  1145  1145 I update_engine: [INFO:cleanup_previous_update_action.cc(229)] Can't find any snapshot to merge.
 09-12 19:45:14.766  1145  1145 E update_engine: Read state file failed: No such file or directory
 09-12 19:45:14.770  1145  1145 I update_engine: [INFO:cleanup_previous_update_action.cc(397)] Not reporting merge stats because state is None
 09-12 19:45:14.775  1145  1145 I update_engine: [INFO:action_processor.cc(116)] ActionProcessor: finished CleanupPreviousUpdateAction with code ErrorCode::kSuccess
 09-12 19:45:14.776  1145  1145 I update_engine: [INFO:action_processor.cc(143)] ActionProcessor: starting InstallPlanAction
 09-12 19:45:14.778  1145  1145 I update_engine: [INFO:action_processor.cc(116)] ActionProcessor: finished InstallPlanAction with code ErrorCode::kSuccess
 09-12 19:45:14.780  1145  1145 I update_engine: [INFO:action_processor.cc(143)] ActionProcessor: starting DownloadAction
 09-12 19:45:14.781  1145  1145 I update_engine: [INFO:install_plan.cc(91)] InstallPlan: new_update, version: , source_slot: A, target_slot: B, url: https://ota.googlezip.net/packages/ota-api/google_sunfish_sunfish/3f391d83206c0d6b95f5c36de7c7b9dabee903c4.zip, payload: (size: 1575657963, metadata_size: 104581, metadata signature: , hash: B0670F95E689F9E89051F708177F02A21B08F6D6F833E13C860A21C79C40B209, payload type: unknown), hash_checks_mandatory: true, powerwash_required: false, switch_slot_on_reboot: false, run_post_install: true, is_rollback: false, write_verity: true
 09-12 19:45:14.782  1145  1145 I update_engine: [INFO:download_action.cc(199)] Marking new slot as unbootable
 09-12 19:45:14.811  1145  1145 I update_engine: [INFO:multi_range_http_fetcher.cc(45)] starting first transfer
 09-12 19:45:14.814  1145  1145 I update_engine: [INFO:multi_range_http_fetcher.cc(74)] starting transfer of range 1260+1575657963
 09-12 19:45:14.816  1145  1145 I update_engine: [INFO:libcurl_http_fetcher.cc(146)] Starting/Resuming transfer
 09-12 19:45:14.833  1145  1145 I update_engine: [INFO:libcurl_http_fetcher.cc(165)] Using proxy: no
 09-12 19:45:14.836  1145  1145 I update_engine: [INFO:libcurl_http_fetcher.cc(305)] Setting up curl options for HTTPS
 09-12 19:45:14.875  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:45:14.881  8248 16139 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:45:15.171  1145  1145 I update_engine: [INFO:prefs.cc(122)] update-server-cert-1-2 not present in /data/misc/update_engine/prefs
 09-12 19:45:15.175  1145  1145 I update_engine: [INFO:prefs.cc(122)] update-server-cert-1-1 not present in /data/misc/update_engine/prefs
 09-12 19:45:15.178  1145  1145 I update_engine: [INFO:prefs.cc(122)] update-server-cert-1-0 not present in /data/misc/update_engine/prefs
 09-12 19:45:15.673  1145  1145 I update_engine: [INFO:certificate_checker.cc(185)] Certificate changed from DFA4A0D2130A25B43A1103580E78CE40AD168B43696A3383C6800254420ADF6B to BF31924B41175BE25451C4898557F1625E678856E6CFBB4A2E2BF08FD2394384.
 09-12 19:45:16.350  1145  1145 I update_engine: [INFO:delta_performer.cc(209)] Completed 0/? operations, 16384/1575657963 bytes downloaded (0%), overall progress 0%
 09-12 19:45:16.355  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.000).
 09-12 19:45:16.382 14897 14897 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.000011.
 09-12 19:45:16.426  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:45:16.465  1145  1145 I update_engine: [INFO:delta_performer.cc(520)] Manifest size in payload matches expected value from Omaha
 09-12 19:45:16.469  1145  1145 I update_engine: [INFO:delta_performer.cc(1693)] Verifying using certificates: /system/etc/security/otacerts.zip
 09-12 19:45:16.472  1145  1145 I update_engine: [INFO:payload_verifier.cc(102)] signature blob size = 523
 09-12 19:45:16.474  1145  1145 I update_engine: [INFO:payload_verifier.cc(118)] Truncating the signature to its unpadded size: 512.
 09-12 19:45:16.477  1145  1145 I update_engine: [INFO:payload_verifier.cc(129)] Verified correct signature 1 out of 1 signatures.
 09-12 19:45:16.478  1145  1145 I update_engine: [INFO:payload_metadata.cc(224)] Metadata hash signature matches value in Omaha response.
 09-12 19:45:16.486  1145  1145 I update_engine: [INFO:delta_performer.cc(1728)] Detected a 'full' payload.
 09-12 19:45:16.497  1145  1145 I update_engine: [INFO:prefs.cc(122)] dynamic-partition-metadata-updated not present in /data/misc/update_engine/prefs
 09-12 19:45:16.500  1145  1145 I update_engine: [INFO:delta_performer.cc(985)] Preparing partitions for new update. last hash = , new hash = sGcPleaJ+eiQUfcIF38CohsI9tb4M+E8hgohx5xAsgk=nRRfTgsKG9LbsGhYB4DyfKQA6f94xBPwV4ytqbWCzmc=
 09-12 19:45:16.502  1145  1145 I update_engine: EnsureMetadataMounted does nothing in Android mode.
 09-12 19:45:16.504  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(676)] Erasing AVB footer of system_other partition before update.
 09-12 19:45:16.535  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
 09-12 19:45:16.556  1145  1145 I update_engine: [libfs_mgr]Unmapped logical partition system_b
 09-12 19:45:17.001  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:45:17.016  8248 16139 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:45:17.569  1145  1145 I update_engine: Successfully unmapped snapshot system_b
 09-12 19:45:17.573  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(249)] Successfully unmapped system_b from device mapper.
 09-12 19:45:17.611  1145  1145 I update_engine: [libfs_mgr]Created logical partition system_b on device /dev/block/dm-1
 09-12 19:45:17.616  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(515)] Zeroing /dev/block/dm-1 @ [24362944, 24363008] (64 bytes)
 09-12 19:45:17.637  1145  1145 I update_engine: [libfs_mgr]Unmapped logical partition system_b
 09-12 19:45:17.640  1145  1145 I update_engine: Successfully unmapped snapshot system_b
 09-12 19:45:17.643  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(249)] Successfully unmapped system_b from device mapper.
 09-12 19:45:17.645  1145  1145 E update_engine: Read state file failed: No such file or directory
 09-12 19:45:17.648  1145  1145 E update_engine: Read state file failed: No such file or directory
 09-12 19:45:17.678  1145  1145 I update_engine: [liblp]Partition product_b will resize from 2050846720 bytes to 2043527168 bytes
 09-12 19:45:17.681  1145  1145 I update_engine: [liblp]Partition system_ext_b will resize from 231133184 bytes to 231059456 bytes
 09-12 19:45:17.684  1145  1145 I update_engine: [liblp]Partition vendor_b will resize from 550354944 bytes to 550641664 bytes
 09-12 19:45:17.686  1145  1145 I update_engine: [liblp]Partition system_b will resize from 819929088 bytes to 819933184 bytes
 09-12 19:45:17.689  1145  1145 I update_engine: Remaining free space for COW: 6102188032 bytes
 09-12 19:45:17.748  1145  1145 I update_engine: For partition system_b, device size = 819933184, snapshot size = 819933184, cow partition size = 823140352, cow file size = 0
 09-12 19:45:17.759  1145  1145 I update_engine: [liblp]Partition system_b-cow will resize from 0 bytes to 823140352 bytes
 09-12 19:45:17.762  1145  1145 I update_engine: Successfully created snapshot partition for system_b
 09-12 19:45:17.764  1145  1145 I update_engine: Remaining free space for COW: 5278531584 bytes
 09-12 19:45:17.796  1145  1145 I update_engine: For partition vendor_b, device size = 550641664, snapshot size = 550641664, cow partition size = 552800256, cow file size = 0
 09-12 19:45:17.807  1145  1145 I update_engine: [liblp]Partition vendor_b-cow will resize from 0 bytes to 552800256 bytes
 09-12 19:45:17.811  1145  1145 I update_engine: Successfully created snapshot partition for vendor_b
 09-12 19:45:17.812  1145  1145 I update_engine: Remaining free space for COW: 4725407744 bytes
 09-12 19:45:17.903  1145  1145 I update_engine: For partition product_b, device size = 2043527168, snapshot size = 2043527168, cow partition size = 2051514368, cow file size = 0
 09-12 19:45:17.915  1145  1145 I update_engine: [liblp]Partition product_b-cow will resize from 0 bytes to 2051514368 bytes
 09-12 19:45:17.918  1145  1145 I update_engine: Successfully created snapshot partition for product_b
 09-12 19:45:17.919  1145  1145 I update_engine: Remaining free space for COW: 2673868800 bytes
 09-12 19:45:17.929  1145  1145 I update_engine: For partition system_ext_b, device size = 231059456, snapshot size = 231059456, cow partition size = 231968768, cow file size = 0
 09-12 19:45:17.938  1145  1145 I update_engine: [liblp]Partition system_ext_b-cow will resize from 0 bytes to 231968768 bytes
 09-12 19:45:17.941  1145  1145 I update_engine: Successfully created snapshot partition for system_ext_b
 09-12 19:45:17.941  1145  1145 I update_engine: Allocating CoW images.
 09-12 19:45:17.942  1145  1145 I update_engine: Successfully created snapshot for product_b
 09-12 19:45:17.943  1145  1145 I update_engine: Successfully created snapshot for system_b
 09-12 19:45:17.945  1145  1145 I update_engine: Successfully created snapshot for system_ext_b
 09-12 19:45:17.946  1145  1145 I update_engine: Successfully created snapshot for vendor_b
 09-12 19:45:17.948  1145  1145 I update_engine: Successfully unmapped snapshot system_b
 09-12 19:45:17.980  1145  1145 I update_engine: Mapped COW device for system_b at /dev/block/dm-1
 09-12 19:45:17.984  1145  1145 I update_engine: Zero-filling COW device: /dev/block/dm-1
 09-12 19:45:18.004  1145  1145 I update_engine: Successfully unmapped snapshot vendor_b
 09-12 19:45:18.037  1145  1145 I update_engine: Mapped COW device for vendor_b at /dev/block/dm-1
 09-12 19:45:18.041  1145  1145 I update_engine: Zero-filling COW device: /dev/block/dm-1
 09-12 19:45:18.075  1145  1145 I update_engine: Successfully unmapped snapshot product_b
 09-12 19:45:18.110  1145  1145 I update_engine: Mapped COW device for product_b at /dev/block/dm-1
 09-12 19:45:18.115  1145  1145 I update_engine: Zero-filling COW device: /dev/block/dm-1
 09-12 19:45:18.134  1145  1145 I update_engine: Successfully unmapped snapshot system_ext_b
 09-12 19:45:18.164  1145  1145 I update_engine: Mapped COW device for system_ext_b at /dev/block/dm-1
 09-12 19:45:18.169  1145  1145 I update_engine: Zero-filling COW device: /dev/block/dm-1
 09-12 19:45:18.194  1145  1145 I update_engine: [liblp]Updated logical partition table at slot 1 on device super
 09-12 19:45:18.196  1145  1145 I update_engine: Successfully created all snapshots for target slot _b
 09-12 19:45:18.200  1145  1145 I update_engine: [INFO:delta_performer.cc(1002)] PreparePartitionsForUpdate done.
 09-12 19:45:18.210  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.215  1145  1145 I update_engine: Successfully unmapped snapshot vendor_b
 09-12 19:45:18.254  1145  1145 I update_engine: [libfs_mgr]Created logical partition vendor_b-base on device /dev/block/dm-1
 09-12 19:45:18.285  1145  1145 I update_engine: Mapped COW device for vendor_b at /dev/block/dm-4
 09-12 19:45:18.310  1145  1145 I update_engine: Mapped vendor_b as snapshot device at /dev/block/dm-11
 09-12 19:45:18.318  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(173)] Succesfully mapped vendor_b to device mapper (force_writable = 1); device path at /dev/block/dm-11
 09-12 19:45:18.321  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.323  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] boot_b is not in super partition metadata.
 09-12 19:45:18.324  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.327  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.330  1145  1145 I update_engine: Successfully unmapped snapshot system_b
 09-12 19:45:18.358  1145  1145 I update_engine: [libfs_mgr]Created logical partition system_b-base on device /dev/block/dm-12
 09-12 19:45:18.392  1145  1145 I update_engine: Mapped COW device for system_b at /dev/block/dm-13
 09-12 19:45:18.417  1145  1145 I update_engine: Mapped system_b as snapshot device at /dev/block/dm-14
 09-12 19:45:18.425  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(173)] Succesfully mapped system_b to device mapper (force_writable = 1); device path at /dev/block/dm-14
 09-12 19:45:18.428  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.430  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] vbmeta_b is not in super partition metadata.
 09-12 19:45:18.432  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.435  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.437  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] dtbo_b is not in super partition metadata.
 09-12 19:45:18.439  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.441  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.444  1145  1145 I update_engine: Successfully unmapped snapshot product_b
 09-12 19:45:18.471  1145  1145 I update_engine: [libfs_mgr]Created logical partition product_b-base on device /dev/block/dm-15
 09-12 19:45:18.504  1145  1145 I update_engine: Mapped COW device for product_b at /dev/block/dm-16
 09-12 19:45:18.527  1145  1145 I update_engine: Mapped product_b as snapshot device at /dev/block/dm-17
 09-12 19:45:18.529  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(173)] Succesfully mapped product_b to device mapper (force_writable = 1); device path at /dev/block/dm-17
 09-12 19:45:18.533  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.536  1145  1145 I update_engine: Successfully unmapped snapshot system_ext_b
 09-12 19:45:18.563  1145  1145 I update_engine: [libfs_mgr]Created logical partition system_ext_b-base on device /dev/block/dm-18
 09-12 19:45:18.592  1145  1145 I update_engine: Mapped COW device for system_ext_b at /dev/block/dm-19
 09-12 19:45:18.613  1145  1145 I update_engine: Mapped system_ext_b as snapshot device at /dev/block/dm-20
 09-12 19:45:18.617  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(173)] Succesfully mapped system_ext_b to device mapper (force_writable = 1); device path at /dev/block/dm-20
 09-12 19:45:18.621  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.624  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] vbmeta_system_b is not in super partition metadata.
 09-12 19:45:18.626  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.629  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.631  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] abl_b is not in super partition metadata.
 09-12 19:45:18.633  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.637  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.639  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] aop_b is not in super partition metadata.
 09-12 19:45:18.641  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.644  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.646  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] devcfg_b is not in super partition metadata.
 09-12 19:45:18.648  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.651  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.653  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] hyp_b is not in super partition metadata.
 09-12 19:45:18.655  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.659  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.661  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] keymaster_b is not in super partition metadata.
 09-12 19:45:18.662  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.666  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.668  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] qupfw_b is not in super partition metadata.
 09-12 19:45:18.670  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.673  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.675  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] tz_b is not in super partition metadata.
 09-12 19:45:18.677  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.681  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.683  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] uefisecapp_b is not in super partition metadata.
 09-12 19:45:18.685  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.688  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.691  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] xbl_b is not in super partition metadata.
 09-12 19:45:18.693  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.696  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.698  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] xbl_config_b is not in super partition metadata.
 09-12 19:45:18.700  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.703  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.705  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] modem_b is not in super partition metadata.
 09-12 19:45:18.707  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
 09-12 19:45:18.708  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new vendor sha256: twC08PfZiDfBZbrthWsUDjcNfvdJX/dLS3/f0vu2uQ8= size: 550641664
 09-12 19:45:18.710  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new boot sha256: 8HVNXOpg0OyjuXodDhhKclVkHtHOnr6+X2spC3bmock= size: 67108864
 09-12 19:45:18.711  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new system sha256: QxQRFvNXfdyt2J03wwMtx7BJCL5DQIJsjj92tAZ5QVM= size: 819933184
 09-12 19:45:18.712  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new vbmeta sha256: cbGbnXu+viM6liaD8/XxphAX48PwWilmhSdrcB72pfs= size: 8192
 09-12 19:45:18.713  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new dtbo sha256: SkyxhHQ0onuwPvDRkSU9wIVUiM4qQEd79K/bJRAuvWs= size: 8388608
 09-12 19:45:18.715  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new product sha256: /0tLLyjAfr/U0q+KC7xJzxweNsknv4GmvmBLy1utLko= size: 2043527168
 09-12 19:45:18.716  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new system_ext sha256: VPltcL6s9ngnKkC02f5SgfHUnc40brFVezoNrjR3l1o= size: 231059456
 09-12 19:45:18.717  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new vbmeta_system sha256: T1A2W2DTB4Dc3dQ5cZwZ473idx3TiNBfsJ++xOzgF+g= size: 4096
 09-12 19:45:18.719  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new abl sha256: eNU69cw4jLuWHVc09Dltkra/Kfut3q5cEYxi/weP0KA= size: 1048576
 09-12 19:45:18.720  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new aop sha256: b+D3X9dYoT/xWURMXM7GxadGOIGIQDCVT19i/XJLgCk= size: 167936
 09-12 19:45:18.721  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new devcfg sha256: nO7Wjbs9T3KMROdVDpnYx6KnmHQlU49AEWpR/u39DtE= size: 45056
 09-12 19:45:18.723  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new hyp sha256: vFIs70jY6DC30Yp3Tsf/wT5Zg6ipk2yW/lVDN4L399w= size: 397312
 09-12 19:45:18.724  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new keymaster sha256: gCl03SZEY5qACY8eXlCzj2tLVNvVRXn1DO/m925dmR0= size: 241664
 09-12 19:45:18.725  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new qupfw sha256: /2vtz4Rzn4jlqylhniO02OGWmO62ZHnHijvX1pe7V1w= size: 53248
 09-12 19:45:18.727  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new tz sha256: zT5+hXSlF41ygmJx6fReBg0A5tuHsPS2LSjL4DB4BWg= size: 2060288
 09-12 19:45:18.728  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new uefisecapp sha256: 3+mbLacKzJ3dYWgYT1SFnxL5Hz2qpis3HqGIBWs2ygo= size: 126976
 09-12 19:45:18.729  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new xbl sha256: T/3gnjL13PoFQqFhC752yq3kRrX99J71NFTbMCpW1bE= size: 3371008
 09-12 19:45:18.735  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new xbl_config sha256: bTQYcJ00/h07XagoJYXL4/KZghh1C42IYxTDajOBWhY= size: 90112
 09-12 19:45:18.736  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new modem sha256: I34Jqd+1RRJfEayfd/IfcXuwl6+lI5F55PhXJWSFLcE= size: 74108928
 09-12 19:45:18.738  1145  1145 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/dm-11 partition without O_DSYNC
 09-12 19:45:18.741  1145  1145 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
 09-12 19:45:18.743  1145  1145 I update_engine: [INFO:delta_performer.cc(397)] Applying 263 operations to partition "vendor"
 09-12 19:45:18.745  1145  1145 I update_engine: [INFO:delta_performer.cc(657)] Starting to apply update payload operations
 09-12 19:45:18.900  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:45:18.909  8248 16139 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:45:20.645  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:45:20.654  8248 16139 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:45:20.746  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:45:20.757  8248 16139 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:45:22.574  8248  8779 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.010).
 09-12 19:45:22.593 14897 14897 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.010013.
 09-12 19:45:22.628  8248  8779 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:45:27.333  8248  8779 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.020).
 09-12 19:45:27.357 14897 14897 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.020016.
 09-12 19:45:27.403  8248  8779 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:45:31.451  8248  8779 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.030).
 09-12 19:45:31.472 14897 14897 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.030019.
 09-12 19:45:31.509  8248  8779 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:45:34.760  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:45:34.769  8248 16139 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:45:35.880  8248  8779 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.040).
 09-12 19:45:35.910 14897 14897 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.040022.
 09-12 19:45:35.950  8248  8779 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:45:40.051  8248  8779 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.050).
 09-12 19:45:40.070 14897 14897 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.050025.
 09-12 19:45:40.106  8248  8779 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:45:44.136  8248  8779 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.060).
 09-12 19:45:44.159 14897 14897 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.060028.
 09-12 19:45:44.197  8248  8779 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:45:44.952  8248 16139 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
 09-12 19:45:46.464  1145  1145 I update_engine: [INFO:delta_performer.cc(209)] Completed 167/1825 operations (9%), 102364349/1575657963 bytes downloaded (6%), overall progress 7%
 09-12 19:45:48.383  8248  8779 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.070).
 09-12 19:45:48.450  8248  8779 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:45:51.505  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:45:51.515  8248 16139 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:45:52.206  8248  8779 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.080).
 09-12 19:45:52.267  8248  8779 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:45:55.568  1145  1145 I update_engine: [INFO:delta_performer.cc(209)] Completed 219/1825 operations (12%), 138687389/1575657963 bytes downloaded (8%), overall progress 10%
 09-12 19:45:56.375  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:45:56.380  8248  8779 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.090).
 09-12 19:45:56.420  8248 16139 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:45:56.539  8248  8779 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:45:59.288  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:45:59.300  8248 16139 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:46:00.046  8248  8779 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.100).
 09-12 19:46:00.101  8248  8779 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:46:01.256  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:46:01.278  8248 16139 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:46:01.862  1145  1145 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/boot_b partition without O_DSYNC
 09-12 19:46:01.869  1145  1145 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
 09-12 19:46:01.872  1145  1145 I update_engine: [INFO:delta_performer.cc(397)] Applying 32 operations to partition "boot"
 09-12 19:46:03.556  8248  8779 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.110).
 09-12 19:46:03.618  8248  8779 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:46:05.743  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:46:05.756  8248 16139 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:46:06.245  8248  8779 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.120).
 09-12 19:46:06.301  8248  8779 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:46:07.142  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:46:07.233  8248 16139 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:46:07.381  1145  1145 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/dm-14 partition without O_DSYNC
 09-12 19:46:07.386  1145  1145 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
 09-12 19:46:07.389  1145  1145 I update_engine: [INFO:delta_performer.cc(397)] Applying 391 operations to partition "system"
 09-12 19:46:09.855  8248  8779 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.130).
 09-12 19:46:09.909  8248  8779 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:46:13.120  8248  8779 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.140).
 09-12 19:46:13.188  8248  8779 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:46:16.694  8248  8779 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.150).
 09-12 19:46:16.769  8248  8779 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:46:20.107  8248  8779 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.160).
 09-12 19:46:20.172  8248  8779 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:46:23.316  8248  8779 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.170).
 09-12 19:46:23.373  8248  8779 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:46:24.789  1145  1145 I update_engine: [INFO:delta_performer.cc(209)] Completed 438/1825 operations (24%), 278097792/1575657963 bytes downloaded (17%), overall progress 20%
 09-12 19:46:25.684  8248  8779 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.180).
 09-12 19:46:25.737  8248  8779 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:46:28.761  8248  8779 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.190).
 09-12 19:46:28.821  8248  8779 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:46:31.674  8248  9304 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.200).
 09-12 19:46:31.733  8248  9304 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:46:34.761  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:46:34.772  8248 16139 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:46:34.806  8248  9304 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.210).
 09-12 19:46:34.868  8248  9304 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:46:37.881  8248  9304 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.220).
 09-12 19:46:37.938  8248  9304 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:46:40.479  8248  9304 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.230).
 09-12 19:46:40.537  8248  9304 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:46:43.579  8248  9304 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.240).
 09-12 19:46:43.634  8248  9304 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:46:46.676  8248  9304 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.250).
 09-12 19:46:46.736  8248  9304 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:46:49.686  8248  9304 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.260).
 09-12 19:46:49.800  8248  9304 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:46:52.755  8248  9304 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.270).
 09-12 19:46:52.810  8248  9304 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:46:54.266  1145  1145 I update_engine: [INFO:delta_performer.cc(209)] Completed 621/1825 operations (34%), 432138973/1575657963 bytes downloaded (27%), overall progress 30%
 09-12 19:46:56.137  8248  9304 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.280).
 09-12 19:46:56.195  8248  9304 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:46:59.348  8248  9304 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.290).
 09-12 19:46:59.399  8248  9304 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:47:02.381  8248  9304 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.300).
 09-12 19:47:02.436  8248  9304 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:47:04.885  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:47:04.901  8248 16139 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:47:04.921  1145  1145 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/vbmeta_b partition without O_DSYNC
 09-12 19:47:04.927  1145  1145 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
 09-12 19:47:04.929  1145  1145 I update_engine: [INFO:delta_performer.cc(397)] Applying 1 operations to partition "vbmeta"
 09-12 19:47:04.934  1145  1145 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/dtbo_b partition without O_DSYNC
 09-12 19:47:04.937  1145  1145 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
 09-12 19:47:04.939  1145  1145 I update_engine: [INFO:delta_performer.cc(397)] Applying 4 operations to partition "dtbo"
 09-12 19:47:05.048  1145  1145 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/dm-17 partition without O_DSYNC
 09-12 19:47:05.053  1145  1145 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
 09-12 19:47:05.056  1145  1145 I update_engine: [INFO:delta_performer.cc(397)] Applying 975 operations to partition "product"
 09-12 19:47:05.448  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:47:05.457  8248 16139 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:47:06.759  8248  9304 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.310).
 09-12 19:47:06.813  8248  9304 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:47:08.953  8248  9304 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.320).
 09-12 19:47:09.007  8248  9304 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:47:12.293  8248  9304 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.330).
 09-12 19:47:12.349  8248  9304 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:47:14.818  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:47:14.830  8248 16139 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:47:14.992  8248  9304 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.340).
 09-12 19:47:15.047  8248  9304 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:47:15.947  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:47:15.965  8248 16139 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:47:17.044  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:47:17.056  8248 16139 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:47:18.226  8248  9304 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.350).
 09-12 19:47:18.297  8248  9304 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:47:21.268  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.360).
 09-12 19:47:21.317  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:47:23.759  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.370).
 09-12 19:47:23.810  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:47:24.286  1145  1145 I update_engine: [INFO:delta_performer.cc(209)] Completed 801/1825 operations (43%), 587294268/1575657963 bytes downloaded (37%), overall progress 39%
 09-12 19:47:24.635  1145  1145 I update_engine: [INFO:delta_performer.cc(209)] Completed 803/1825 operations (44%), 588867132/1575657963 bytes downloaded (37%), overall progress 40%
 09-12 19:47:26.810  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.380).
 09-12 19:47:26.868  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:47:29.599  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.390).
 09-12 19:47:29.661  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:47:32.884  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.400).
 09-12 19:47:32.936  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:47:34.767  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:47:34.781  8248 16139 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:47:34.863  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:47:34.875  8248 16139 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:47:35.886  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.410).
 09-12 19:47:35.952  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:47:38.098  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.420).
 09-12 19:47:38.168  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:47:38.774  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:47:38.789  8248 16139 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:47:41.748  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.430).
 09-12 19:47:41.827  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:47:42.827  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:47:42.838  8248 16139 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:47:45.229  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.440).
 09-12 19:47:45.298  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:47:45.489  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:47:45.499  8248 16139 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:47:48.890  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.450).
 09-12 19:47:48.970  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:47:52.249  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.460).
 09-12 19:47:52.313  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:47:54.652  1145  1145 I update_engine: [INFO:delta_performer.cc(209)] Completed 927/1825 operations (50%), 735846876/1575657963 bytes downloaded (46%), overall progress 48%
 09-12 19:47:56.021  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.470).
 09-12 19:47:56.098  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:47:59.403  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.480).
 09-12 19:47:59.467  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:48:03.213  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.490).
 09-12 19:48:03.285  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:48:05.248  1145  1145 I update_engine: [INFO:delta_performer.cc(209)] Completed 949/1825 operations (52%), 781951100/1575657963 bytes downloaded (49%), overall progress 50%
 09-12 19:48:06.609  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.500).
 09-12 19:48:06.694  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:48:10.439  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.510).
 09-12 19:48:10.484  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:48:14.740  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.520).
 09-12 19:48:14.796  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:48:16.103  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:48:16.114  8248 16139 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:48:18.199  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.530).
 09-12 19:48:18.250  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:48:19.366  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:48:19.380  8248 16139 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:48:20.768  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.540).
 09-12 19:48:20.816  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:48:24.254  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.550).
 09-12 19:48:24.321  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:48:27.466  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.560).
 09-12 19:48:27.536  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:48:30.881  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.570).
 09-12 19:48:30.959  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:48:34.456  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.580).
 09-12 19:48:34.516  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:48:34.759  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:48:34.768  8248 16139 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:48:35.248  1145  1145 I update_engine: [INFO:delta_performer.cc(209)] Completed 1096/1825 operations (60%), 919198815/1575657963 bytes downloaded (58%), overall progress 59%
 09-12 19:48:37.551  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.590).
 09-12 19:48:37.620  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:48:40.617  1145  1145 I update_engine: [INFO:delta_performer.cc(209)] Completed 1109/1825 operations (60%), 945396637/1575657963 bytes downloaded (60%), overall progress 60%
 09-12 19:48:40.637  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.600).
 09-12 19:48:40.699  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:48:44.323  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.610).
 09-12 19:48:44.372  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:48:47.285  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:48:47.327  8248 16139 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:48:47.573  8248  8265 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.620).
 09-12 19:48:47.619  8248  8265 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:48:49.006  8248 16293 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
 09-12 19:48:49.040 14897 14897 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x111, isSetupWizard=false.
 09-12 19:48:51.086  8248  8265 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.630).
 09-12 19:48:51.108 14897 14897 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.630198.
 09-12 19:48:51.162  8248  8265 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:48:51.418  8248 16293 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
 09-12 19:48:53.394  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:48:53.405  8248 16293 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:48:54.168  8248  8265 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.640).
 09-12 19:48:54.223  8248  8265 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:48:56.549  8248  9818 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.650).
 09-12 19:48:56.607  8248  9818 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:48:59.381  8248  9818 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.660).
 09-12 19:48:59.442  8248  9818 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:49:02.387  8248  9818 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.670).
 09-12 19:49:02.439  8248  9818 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:49:05.452  8248  9818 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.680).
 09-12 19:49:05.512  8248  9818 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:49:08.552  8248  9818 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.690).
 09-12 19:49:08.611  8248  9818 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:49:10.778  1145  1145 I update_engine: [INFO:delta_performer.cc(209)] Completed 1269/1825 operations (69%), 1097488139/1575657963 bytes downloaded (69%), overall progress 68%
 09-12 19:49:11.826  8248  9818 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.700).
 09-12 19:49:11.891  8248  9818 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:49:12.057  1145  1145 I update_engine: [INFO:delta_performer.cc(209)] Completed 1278/1825 operations (70%), 1103812314/1575657963 bytes downloaded (70%), overall progress 70%
 09-12 19:49:15.180  8248  9818 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.710).
 09-12 19:49:15.239  8248  9818 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:49:16.898  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:49:16.908  8248 16293 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:49:18.584  8248  9818 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.720).
 09-12 19:49:18.640  8248  9818 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:49:18.876  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:49:18.889  8248 16293 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:49:20.312  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:49:20.341  8248 16293 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:49:21.770  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.730).
 09-12 19:49:21.810  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:49:23.996  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.740).
 09-12 19:49:24.094  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:49:26.482  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:49:26.496  8248 16293 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:49:26.839  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.750).
 09-12 19:49:26.892  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:49:28.545  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:49:28.556  8248 16293 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:49:29.717  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.760).
 09-12 19:49:29.770  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:49:32.857  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.770).
 09-12 19:49:32.898  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:49:34.767  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:49:34.778  8248 16293 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:49:35.235  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.780).
 09-12 19:49:35.282  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:49:38.755  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.790).
 09-12 19:49:38.800  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:49:41.522  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.800).
 09-12 19:49:41.576  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:49:42.211  1145  1145 I update_engine: [INFO:delta_performer.cc(209)] Completed 1456/1825 operations (79%), 1268748795/1575657963 bytes downloaded (80%), overall progress 79%
 09-12 19:49:43.404  1145  1145 I update_engine: [INFO:delta_performer.cc(209)] Completed 1460/1825 operations (80%), 1275154875/1575657963 bytes downloaded (80%), overall progress 80%
 09-12 19:49:43.474  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.810).
 09-12 19:49:43.528  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:49:46.427  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.820).
 09-12 19:49:46.485  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:49:50.052  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.830).
 09-12 19:49:50.107  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:49:53.137  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.840).
 09-12 19:49:53.210  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:49:53.508  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:49:53.518  8248 16293 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:49:56.468  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.850).
 09-12 19:49:56.532  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:50:00.139  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.860).
 09-12 19:50:00.231  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:50:02.924  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.870).
 09-12 19:50:02.976  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:50:07.416  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.880).
 09-12 19:50:07.490  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:50:09.532  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.890).
 09-12 19:50:09.587  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:50:12.953  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.900).
 09-12 19:50:13.017  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:50:13.502  1145  1145 I update_engine: [INFO:delta_performer.cc(209)] Completed 1637/1825 operations (89%), 1420774762/1575657963 bytes downloaded (90%), overall progress 89%
 09-12 19:50:14.326  1145  1145 I update_engine: [INFO:delta_performer.cc(209)] Completed 1643/1825 operations (90%), 1422871898/1575657963 bytes downloaded (90%), overall progress 90%
 09-12 19:50:16.403  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.910).
 09-12 19:50:16.457  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:50:19.543  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.920).
 09-12 19:50:19.618  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:50:22.781  1145  1145 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/dm-20 partition without O_DSYNC
 09-12 19:50:22.788  1145  1145 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
 09-12 19:50:22.791  1145  1145 I update_engine: [INFO:delta_performer.cc(397)] Applying 111 operations to partition "system_ext"
 09-12 19:50:25.374  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.930).
 09-12 19:50:25.433  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:50:27.883  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.940).
 09-12 19:50:27.955  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:50:31.451  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.950).
 09-12 19:50:31.528  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:50:34.760  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:50:34.783  8248 16329 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:50:36.932  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.960).
 09-12 19:50:36.985  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:50:40.151  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.970).
 09-12 19:50:40.193  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:50:41.998  1145  1145 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/vbmeta_system_b partition without O_DSYNC
 09-12 19:50:42.003  1145  1145 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
 09-12 19:50:42.005  1145  1145 I update_engine: [INFO:delta_performer.cc(397)] Applying 1 operations to partition "vbmeta_system"
 09-12 19:50:42.008  1145  1145 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/abl_b partition without O_DSYNC
 09-12 19:50:42.011  1145  1145 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
 09-12 19:50:42.013  1145  1145 I update_engine: [INFO:delta_performer.cc(397)] Applying 1 operations to partition "abl"
 09-12 19:50:42.057  1145  1145 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/aop_b partition without O_DSYNC
 09-12 19:50:42.061  1145  1145 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
 09-12 19:50:42.063  1145  1145 I update_engine: [INFO:delta_performer.cc(397)] Applying 1 operations to partition "aop"
 09-12 19:50:42.082  1145  1145 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/devcfg_b partition without O_DSYNC
 09-12 19:50:42.087  1145  1145 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
 09-12 19:50:42.089  1145  1145 I update_engine: [INFO:delta_performer.cc(397)] Applying 1 operations to partition "devcfg"
 09-12 19:50:42.095  1145  1145 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/hyp_b partition without O_DSYNC
 09-12 19:50:42.098  1145  1145 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
 09-12 19:50:42.100  1145  1145 I update_engine: [INFO:delta_performer.cc(397)] Applying 1 operations to partition "hyp"
 09-12 19:50:42.128  1145  1145 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/keymaster_b partition without O_DSYNC
 09-12 19:50:42.132  1145  1145 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
 09-12 19:50:42.135  1145  1145 I update_engine: [INFO:delta_performer.cc(397)] Applying 1 operations to partition "keymaster"
 09-12 19:50:42.156  1145  1145 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/qupfw_b partition without O_DSYNC
 09-12 19:50:42.160  1145  1145 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
 09-12 19:50:42.163  1145  1145 I update_engine: [INFO:delta_performer.cc(397)] Applying 1 operations to partition "qupfw"
 09-12 19:50:42.171  1145  1145 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/tz_b partition without O_DSYNC
 09-12 19:50:42.174  1145  1145 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
 09-12 19:50:42.176  1145  1145 I update_engine: [INFO:delta_performer.cc(397)] Applying 1 operations to partition "tz"
 09-12 19:50:42.292  1145  1145 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/uefisecapp_b partition without O_DSYNC
 09-12 19:50:42.297  1145  1145 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
 09-12 19:50:42.299  1145  1145 I update_engine: [INFO:delta_performer.cc(397)] Applying 1 operations to partition "uefisecapp"
 09-12 19:50:42.315  1145  1145 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/xbl_b partition without O_DSYNC
 09-12 19:50:42.318  1145  1145 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
 09-12 19:50:42.320  1145  1145 I update_engine: [INFO:delta_performer.cc(397)] Applying 2 operations to partition "xbl"
 09-12 19:50:42.771  1145  1145 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/xbl_config_b partition without O_DSYNC
 09-12 19:50:42.778  1145  1145 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
 09-12 19:50:42.781  1145  1145 I update_engine: [INFO:delta_performer.cc(397)] Applying 1 operations to partition "xbl_config"
 09-12 19:50:42.802  1145  1145 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/modem_b partition without O_DSYNC
 09-12 19:50:42.810  1145  1145 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
 09-12 19:50:42.813  1145  1145 I update_engine: [INFO:delta_performer.cc(397)] Applying 36 operations to partition "modem"
 09-12 19:50:44.337  1145  1145 I update_engine: [INFO:delta_performer.cc(209)] Completed 1806/1825 operations (98%), 1543572756/1575657963 bytes downloaded (97%), overall progress 97%
 09-12 19:50:44.415  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.980).
 09-12 19:50:44.467  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:50:47.021  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.990).
 09-12 19:50:47.298  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
 09-12 19:50:49.051  8248 16329 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
 09-12 19:50:49.083 14897 14897 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x111, isSetupWizard=false.
 09-12 19:50:50.094  1145  1145 I update_engine: [INFO:delta_performer.cc(209)] Completed 1825/1825 operations (100%), 1575657963/1575657963 bytes downloaded (100%), overall progress 100%
 09-12 19:50:50.099  1145  1145 I update_engine: [INFO:delta_performer.cc(1665)] Extracted signature data of size 523 at 1575552336
 09-12 19:50:50.101  1145  1145 I update_engine: [INFO:multi_range_http_fetcher.cc(115)] Terminating transfer.
 09-12 19:50:50.103  1145  1145 I update_engine: [INFO:libcurl_http_fetcher.cc(548)] Requesting libcurl to terminate transfer.
 09-12 19:50:50.111  1145  1145 I update_engine: [INFO:multi_range_http_fetcher.cc(177)] Received transfer terminated.
 09-12 19:50:50.114  1145  1145 I update_engine: [INFO:multi_range_http_fetcher.cc(129)] TransferEnded w/ code 206
 09-12 19:50:50.116  1145  1145 I update_engine: [INFO:multi_range_http_fetcher.cc(163)] Done w/ all transfers
 09-12 19:50:50.247  1145  1145 I update_engine: [INFO:delta_performer.cc(1693)] Verifying using certificates: /system/etc/security/otacerts.zip
 09-12 19:50:50.251  1145  1145 I update_engine: [INFO:payload_verifier.cc(102)] signature blob size = 523
 09-12 19:50:50.252  1145  1145 I update_engine: [INFO:payload_verifier.cc(118)] Truncating the signature to its unpadded size: 512.
 09-12 19:50:50.254  1145  1145 I update_engine: [INFO:payload_verifier.cc(129)] Verified correct signature 1 out of 1 signatures.
 09-12 19:50:50.255  1145  1145 I update_engine: [INFO:delta_performer.cc(1915)] Payload hash matches value in payload.
 09-12 19:50:50.258  1145  1145 I update_engine: [INFO:download_action.cc(400)] Collections of histograms for UpdateEngine.DownloadAction.
 09-12 19:50:50.258  1145  1145 I update_engine: Histogram: UpdateEngine.DownloadAction.InstallOperation::REPLACE.Duration recorded 1825 samples, mean = 122.2
 09-12 19:50:50.258  1145  1145 I update_engine: 0    -O                                                                        (8 = 0.4%)
 09-12 19:50:50.258  1145  1145 I update_engine: 10   --------O                                                                 (105 = 5.8%) {0.4%}
 09-12 19:50:50.258  1145  1145 I update_engine: 18   ------O                                                                   (78 = 4.3%) {6.2%}
 09-12 19:50:50.258  1145  1145 I update_engine: 32   ----O                                                                     (47 = 2.6%) {10.5%}
 09-12 19:50:50.258  1145  1145 I update_engine: 57   --------------------------------O                                         (396 = 21.7%) {13.0%}
 09-12 19:50:50.258  1145  1145 I update_engine: 101  ------------------------------------------------------------------------O (904 = 49.5%) {34.7%}
 09-12 19:50:50.258  1145  1145 I update_engine: 179  -----------------------O                                                  (284 = 15.6%) {84.3%}
 09-12 19:50:50.258  1145  1145 I update_engine: 317  O                                                                         (3 = 0.2%) {99.8%}
 09-12 19:50:50.258  1145  1145 I update_engine: 561  ... 
 09-12 19:50:50.258  1145  1145 I update_engine: 
 09-12 19:50:50.263  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.000).
 09-12 19:50:50.269  1145  1145 I update_engine: [INFO:action_processor.cc(116)] ActionProcessor: finished DownloadAction with code ErrorCode::kSuccess
 09-12 19:50:50.276  1145  1145 I update_engine: [INFO:action_processor.cc(143)] ActionProcessor: starting FilesystemVerifierAction
 09-12 19:50:50.277  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 0 (vendor) on device /dev/block/dm-11
 09-12 19:50:50.288 14897 14897 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x211, isSetupWizard=false.
 09-12 19:50:50.342  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:50:52.467  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of vendor: twC08PfZiDfBZbrthWsUDjcNfvdJX/dLS3/f0vu2uQ8=
 09-12 19:50:52.656  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 1 (boot) on device /dev/block/bootdevice/by-name/boot_b
 09-12 19:50:52.868  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of boot: 8HVNXOpg0OyjuXodDhhKclVkHtHOnr6+X2spC3bmock=
 09-12 19:50:52.896  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 2 (system) on device /dev/block/dm-14
 09-12 19:50:56.001  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of system: QxQRFvNXfdyt2J03wwMtx7BJCL5DQIJsjj92tAZ5QVM=
 09-12 19:50:56.261  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 3 (vbmeta) on device /dev/block/bootdevice/by-name/vbmeta_b
 09-12 19:50:56.264  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of vbmeta: cbGbnXu+viM6liaD8/XxphAX48PwWilmhSdrcB72pfs=
 09-12 19:50:56.266  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 4 (dtbo) on device /dev/block/bootdevice/by-name/dtbo_b
 09-12 19:50:56.291  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of dtbo: SkyxhHQ0onuwPvDRkSU9wIVUiM4qQEd79K/bJRAuvWs=
 09-12 19:50:56.296  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 5 (product) on device /dev/block/dm-17
 09-12 19:51:04.128  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of product: /0tLLyjAfr/U0q+KC7xJzxweNsknv4GmvmBLy1utLko=
 09-12 19:51:04.736  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 6 (system_ext) on device /dev/block/dm-20
 09-12 19:51:05.679  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of system_ext: VPltcL6s9ngnKkC02f5SgfHUnc40brFVezoNrjR3l1o=
 09-12 19:51:05.776  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 7 (vbmeta_system) on device /dev/block/bootdevice/by-name/vbmeta_system_b
 09-12 19:51:05.780  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of vbmeta_system: T1A2W2DTB4Dc3dQ5cZwZ473idx3TiNBfsJ++xOzgF+g=
 09-12 19:51:05.782  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 8 (abl) on device /dev/block/bootdevice/by-name/abl_b
 09-12 19:51:05.788  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of abl: eNU69cw4jLuWHVc09Dltkra/Kfut3q5cEYxi/weP0KA=
 09-12 19:51:05.790  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 9 (aop) on device /dev/block/bootdevice/by-name/aop_b
 09-12 19:51:05.794  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of aop: b+D3X9dYoT/xWURMXM7GxadGOIGIQDCVT19i/XJLgCk=
 09-12 19:51:05.795  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 10 (devcfg) on device /dev/block/bootdevice/by-name/devcfg_b
 09-12 19:51:05.799  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of devcfg: nO7Wjbs9T3KMROdVDpnYx6KnmHQlU49AEWpR/u39DtE=
 09-12 19:51:05.800  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 11 (hyp) on device /dev/block/bootdevice/by-name/hyp_b
 09-12 19:51:05.804  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of hyp: vFIs70jY6DC30Yp3Tsf/wT5Zg6ipk2yW/lVDN4L399w=
 09-12 19:51:05.806  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 12 (keymaster) on device /dev/block/bootdevice/by-name/keymaster_b
 09-12 19:51:05.809  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of keymaster: gCl03SZEY5qACY8eXlCzj2tLVNvVRXn1DO/m925dmR0=
 09-12 19:51:05.817  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 13 (qupfw) on device /dev/block/bootdevice/by-name/qupfw_b
 09-12 19:51:05.827  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of qupfw: /2vtz4Rzn4jlqylhniO02OGWmO62ZHnHijvX1pe7V1w=
 09-12 19:51:05.835  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 14 (tz) on device /dev/block/bootdevice/by-name/tz_b
 09-12 19:51:05.853  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of tz: zT5+hXSlF41ygmJx6fReBg0A5tuHsPS2LSjL4DB4BWg=
 09-12 19:51:05.856  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 15 (uefisecapp) on device /dev/block/bootdevice/by-name/uefisecapp_b
 09-12 19:51:05.859  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of uefisecapp: 3+mbLacKzJ3dYWgYT1SFnxL5Hz2qpis3HqGIBWs2ygo=
 09-12 19:51:05.860  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 16 (xbl) on device /dev/block/bootdevice/by-name/xbl_b
 09-12 19:51:05.874  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of xbl: T/3gnjL13PoFQqFhC752yq3kRrX99J71NFTbMCpW1bE=
 09-12 19:51:05.877  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 17 (xbl_config) on device /dev/block/bootdevice/by-name/xbl_config_b
 09-12 19:51:05.880  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of xbl_config: bTQYcJ00/h07XagoJYXL4/KZghh1C42IYxTDajOBWhY=
 09-12 19:51:05.881  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 18 (modem) on device /dev/block/bootdevice/by-name/modem_b
 09-12 19:51:06.347  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of modem: I34Jqd+1RRJfEayfd/IfcXuwl6+lI5F55PhXJWSFLcE=
 09-12 19:51:06.376  1145  1145 I update_engine: [INFO:action_processor.cc(116)] ActionProcessor: finished FilesystemVerifierAction with code ErrorCode::kSuccess
 09-12 19:51:06.377  1145  1145 I update_engine: [INFO:action_processor.cc(143)] ActionProcessor: starting PostinstallRunnerAction
 09-12 19:51:06.379  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.000).
 09-12 19:51:06.390  1145  1145 I update_engine: [INFO:postinstall_runner_action.cc(174)] Performing postinst (bin/checkpoint_gc at /postinstall/bin/checkpoint_gc) installed on device /dev/block/dm-11 and mountable device /dev/block/dm-11
 09-12 19:51:06.403  1145  1145 I update_engine: [INFO:postinstall_runner_action.cc(181)] Format file for new bin/checkpoint_gc is: data
 09-12 19:51:06.421  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:51:06.493  1145  1145 I update_engine: [INFO:subprocess.cc(157)] Subprocess output:
 09-12 19:51:06.493  1145  1145 I update_engine: realpath: /dev/block/dm-10: Permission denied
 09-12 19:51:06.500  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:51:06.503  1145  1145 I update_engine: [INFO:postinstall_runner_action.cc(174)] Performing postinst (system/bin/otapreopt_script at /postinstall/system/bin/otapreopt_script) installed on device /dev/block/dm-14 and mountable device /dev/block/dm-14
 09-12 19:51:06.508  1145  1145 I update_engine: [INFO:postinstall_runner_action.cc(181)] Format file for new system/bin/otapreopt_script is: data
 09-12 19:51:15.697  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.510).
 09-12 19:51:15.722 14897 14897 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.510000.
 09-12 19:51:15.757  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:51:24.117  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.520).
 09-12 19:51:24.147 14897 14897 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.520000.
 09-12 19:51:24.186  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:51:32.534  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.530).
 09-12 19:51:32.562 14897 14897 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.530000.
 09-12 19:51:32.593  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:51:34.769  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:51:34.781  8248 16864 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:51:42.999  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.540).
 09-12 19:51:43.023 14897 14897 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.540000.
 09-12 19:51:43.059  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:51:51.284  8248  9818 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.550).
 09-12 19:51:51.312 14897 14897 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.550000.
 09-12 19:51:51.354  8248  9818 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:51:59.833  8248  8937 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.560).
 09-12 19:51:59.858 14897 14897 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.560000.
 09-12 19:51:59.893  8248  8937 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:52:05.462  8248 17483 I SystemUpdate: [Installation,ReceiverIntentOperation] Received intent: Intent { act=com.google.gservices.intent.action.GSERVICES_CHANGED flg=0x1000010 cmp=com.google.android.gms/.chimera.GmsIntentOperationService$PersistentInternalReceiver }.
 09-12 19:52:05.493  8248 17486 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 2.
 09-12 19:52:09.920  8248 17483 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
 09-12 19:52:11.572  8248  9449 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.570).
 09-12 19:52:11.645  8248  9449 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:52:20.389  8248 17796 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
 09-12 19:52:20.450 14897 14897 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x211, isSetupWizard=false.
 09-12 19:52:21.683  8248  8981 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.580).
 09-12 19:52:21.705 14897 14897 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.580000.
 09-12 19:52:21.741  8248  8981 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:52:23.613  8248 17808 I SystemUpdate: [Installation,ReceiverIntentOperation] Received intent: Intent { act=com.google.gservices.intent.action.GSERVICES_CHANGED flg=0x1000010 cmp=com.google.android.gms/.chimera.GmsIntentOperationService$PersistentInternalReceiver }.
 09-12 19:52:23.650  8248 17806 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 2.
 09-12 19:52:32.014  8248  9303 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.590).
 09-12 19:52:32.056 14897 14897 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.590000.
 09-12 19:52:32.098  8248  9303 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:52:34.764  8248  8976 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:52:34.774  8248 17706 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:52:43.017  8248  8265 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.600).
 09-12 19:52:43.084 14897 14897 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.600000.
 09-12 19:52:43.119  8248  8265 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:53:27.342 19456 19616 I SystemUpdate: [Installation,ReceiverIntentOperation] Received intent: Intent { act=com.google.android.gms.update.BASE_MODULE_INIT cat=[targeted_intent_op_prefix:.update.control.ReceiverIntentOperation] cmp=com.google.android.gms/.chimera.GmsIntentOperationService }.
 09-12 19:53:27.475 19456 19616 I SystemUpdate: [Control,ChimeraGcmTaskService] Scheduling task: LogStatus.
 09-12 19:53:27.692 19456 19606 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 1.
 09-12 19:53:27.847 19456 19545 I SystemUpdate: [Execution,InstallationIntentOperation] Received intent: Intent { act=com.google.android.gms.update.INSTALL_UPDATE cat=[targeted_intent_op_prefix:.update.execution.InstallationIntentOperation] cmp=com.google.android.gms/.chimera.GmsIntentOperationService }.
 09-12 19:53:27.932 19456 19545 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, -1.000).
 09-12 19:53:28.058 19456 19545 I SystemUpdate: [Network,NetworkRequester] Requesting network with capabilities [11, 12]...
 09-12 19:53:28.061 19456 19664 I SystemUpdate: [Network,NetworkRequester] Network acquired.
 09-12 19:53:28.110 19456 19496 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.640).
 09-12 19:53:28.164 19456 19672 I SystemUpdate: [Control,NetworkControl] Received intent: Intent { act=android.net.wifi.supplicant.STATE_CHANGE flg=0x24000010 (has extras) }.
 09-12 19:53:28.164 19456 19671 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:53:28.220 19456 19496 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:53:28.301 19456 19614 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:53:28.336 19456 19545 I SystemUpdate: [Execution,SynchronizedUpdateEngine] start(avxv{url=https://ota.googlezip.net/packages/ota-api/google_sunfish_sunfish/3f391d83206c0d6b95f5c36de7c7b9dabee903c4.zip, payload_binary_file.offset=1260, payload_binary_file.length=1575657963, properties=[FILE_HASH=sGcPleaJ+eiQUfcIF38CohsI9tb4M+E8hgohx5xAsgk=, FILE_SIZE=1575657963, METADATA_HASH=nRRfTgsKG9LbsGhYB4DyfKQA6f94xBPwV4ytqbWCzmc=, METADATA_SIZE=104581]}, additionalProperties.size=4)
 09-12 19:53:28.339 19456 19614 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 3.
 09-12 19:53:32.714 19456 19965 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.650).
 09-12 19:53:33.175 19456 19965 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:53:33.241 19456 19878 I SystemUpdate: [Installation,ReceiverIntentOperation] Received intent: Intent { act=com.google.gservices.intent.action.GSERVICES_CHANGED flg=0x1000010 cmp=com.google.android.gms/.chimera.GmsIntentOperationService$PersistentInternalReceiver }.
 09-12 19:53:33.295 19456 19546 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 2.
 09-12 19:53:34.764 19456 19756 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:53:34.772 19456 19616 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:53:44.056 19456 19495 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.660).
 09-12 19:53:44.176 19456 19495 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:53:52.792 19456 20298 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.670).
 09-12 19:53:52.902 19456 20298 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:54:03.619 19456 19476 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.680).
 09-12 19:54:03.728 19456 19476 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:54:10.242 19456 19495 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.690).
 09-12 19:54:10.340 19456 19495 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:54:22.190 19456 20298 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.700).
 09-12 19:54:22.299 19456 20298 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:54:30.601 19456 19495 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.710).
 09-12 19:54:30.694 19456 19495 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:54:34.758 19456 19671 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:54:34.765 19456 21077 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:54:40.020 19456 19471 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.720).
 09-12 19:54:40.120 19456 19471 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:54:50.622 19456 19495 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.725).
 09-12 19:54:50.694 19456 19495 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:54:53.860 19456 21808 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
 09-12 19:54:53.921 19686 19686 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x211, isSetupWizard=false.
 09-12 19:54:57.303 19456 19476 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.735).
 09-12 19:54:57.342 19686 19686 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.735000.
 09-12 19:54:57.418 19456 19476 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:55:05.842 19456 19495 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.745).
 09-12 19:55:05.879 19686 19686 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.745000.
 09-12 19:55:05.959 19456 19495 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:55:16.417 19456 19965 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.755).
 09-12 19:55:16.454 19686 19686 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.755000.
 09-12 19:55:16.545 19456 19965 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:55:24.817 19456 19495 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.765).
 09-12 19:55:24.854 19686 19686 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.765000.
 09-12 19:55:24.929 19456 19495 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:55:33.168 19456 19495 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.775).
 09-12 19:55:33.210 19686 19686 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.775000.
 09-12 19:55:33.279 19456 19495 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:55:34.763 19456 19644 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:55:34.780 19456 22680 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:55:43.965 19456 19495 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.785).
 09-12 19:55:44.000 19686 19686 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.785000.
 09-12 19:55:44.065 19456 19495 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:55:52.516 19456 19495 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.795).
 09-12 19:55:52.560 19686 19686 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.795000.
 09-12 19:55:52.635 19456 19495 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:56:01.081 19456 19495 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.805).
 09-12 19:56:01.114 19686 19686 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.805000.
 09-12 19:56:01.175 19456 19495 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:56:09.603 19456 19495 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.815).
 09-12 19:56:09.637 19686 19686 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.815000.
 09-12 19:56:09.700 19456 19495 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:56:20.183 19456 19495 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.825).
 09-12 19:56:20.224 19686 19686 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.825000.
 09-12 19:56:20.308 19456 19495 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:56:28.660 19456 19965 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.835).
 09-12 19:56:28.701 19686 19686 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.835000.
 09-12 19:56:28.784 19456 19965 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:56:34.768 19456 19672 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:56:34.779 19456 23713 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:56:37.092 19456 19495 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.845).
 09-12 19:56:37.134 19686 19686 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.845000.
 09-12 19:56:37.227 19456 19495 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:56:47.791 19456 19495 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.855).
 09-12 19:56:47.832 19686 19686 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.855000.
 09-12 19:56:47.919 19456 19495 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:56:56.328 19456 19495 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.865).
 09-12 19:56:56.364 19686 19686 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.865000.
 09-12 19:56:56.453 19456 19495 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:57:04.801 19456 19965 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.875).
 09-12 19:57:04.838 19686 19686 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.875000.
 09-12 19:57:04.914 19456 19965 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:57:09.194 19456 24294 I SystemUpdate: [Installation,ReceiverIntentOperation] Received intent: Intent { act=com.google.android.gms.phenotype.com.google.android.gms.update.COMMITTED flg=0x10 cmp=com.google.android.gms/.chimera.GmsIntentOperationService (has extras) }.
 09-12 19:57:09.216 19456 24300 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 2.
 09-12 19:57:15.295 19456 19471 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.880).
 09-12 19:57:15.344 19686 19686 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.880000.
 09-12 19:57:15.414 19456 19471 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:57:21.777 19456 19495 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.890).
 09-12 19:57:21.811 19686 19686 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.890000.
 09-12 19:57:21.881 19456 19495 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:57:30.487 19456 19495 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.900).
 09-12 19:57:30.529 19686 19686 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.900000.
 09-12 19:57:30.609 19456 19495 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:57:34.759 19456 19644 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:57:34.799 19456 24669 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:57:41.040 19456 19495 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.910).
 09-12 19:57:41.079 19686 19686 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.910000.
 09-12 19:57:41.156 19456 19495 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:57:49.688 19456 19495 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.920).
 09-12 19:57:49.726 19686 19686 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.920000.
 09-12 19:57:49.827 19456 19495 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:57:58.314 19456 19471 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.930).
 09-12 19:57:58.352 19686 19686 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.930000.
 09-12 19:57:58.428 19456 19471 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:58:07.043 19456 19471 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.940).
 09-12 19:58:07.083 19686 19686 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.940000.
 09-12 19:58:07.158 19456 19471 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:58:17.777 19456 19471 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.950).
 09-12 19:58:17.811 19686 19686 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.950000.
 09-12 19:58:17.875 19456 19471 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:58:26.460 19456 19471 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.960).
 09-12 19:58:26.496 19686 19686 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.960000.
 09-12 19:58:26.567 19456 19471 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:58:34.754 19456 19471 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.970).
 09-12 19:58:34.763 19456 19644 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
 09-12 19:58:34.773 19456 25754 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
 09-12 19:58:34.809 19686 19686 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.970000.
 09-12 19:58:34.879 19456 19471 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:58:45.167 19456 19471 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.980).
 09-12 19:58:45.207 19686 19686 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.980000.
 09-12 19:58:45.278 19456 19471 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:58:53.630 19456 19471 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.990).
 09-12 19:58:53.662 19686 19686 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.990000.
 09-12 19:58:53.725 19456 19471 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:59:02.030 19456 19471 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 1.000).
 09-12 19:59:02.061 19686 19686 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=1.000000.
 09-12 19:59:02.132 19456 19471 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:59:04.098 19456 19471 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 1.000).
 09-12 19:59:04.167  1145  1145 I update_engine: [INFO:subprocess.cc(157)] Subprocess output:
 09-12 19:59:04.167  1145  1145 I update_engine: Complete or error.
 09-12 19:59:04.188  1145  1145 I update_engine: [INFO:postinstall_runner_action.cc(371)] All post-install commands succeeded
 09-12 19:59:04.194  1145  1145 I update_engine: [INFO:action_processor.cc(116)] ActionProcessor: finished last action PostinstallRunnerAction with code ErrorCode::kUpdatedButNotActive
 09-12 19:59:04.196  1145  1145 I update_engine: [INFO:update_attempter_android.cc(522)] Processing Done.
 09-12 19:59:04.202 19456 19471 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:59:04.202 19456 19471 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:59:04.203 19456 19495 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
 09-12 19:59:04.204  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(263)] Destroying [product_b, system_b, system_ext_b, vendor_b] from device mapper
 09-12 19:59:04.216  1145  1145 I update_engine: [libfs_mgr]Unmapped logical partition product_b
 09-12 19:59:04.257  1145  1145 I update_engine: Successfully unmapped snapshot product_b
 09-12 19:59:04.260  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(249)] Successfully unmapped product_b from device mapper.
 09-12 19:59:04.273  1145  1145 I update_engine: [libfs_mgr]Unmapped logical partition system_b
 09-12 19:59:04.310  1145  1145 I update_engine: Successfully unmapped snapshot system_b
 09-12 19:59:04.313  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(249)] Successfully unmapped system_b from device mapper.
 09-12 19:59:04.330  1145  1145 I update_engine: [libfs_mgr]Unmapped logical partition system_ext_b
 09-12 19:59:04.380  1145  1145 I update_engine: Successfully unmapped snapshot system_ext_b
 09-12 19:59:04.384  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(249)] Successfully unmapped system_ext_b from device mapper.
 09-12 19:59:04.400  1145  1145 I update_engine: [libfs_mgr]Unmapped logical partition vendor_b
 09-12 19:59:04.430  1145  1145 I update_engine: Successfully unmapped snapshot vendor_b
 09-12 19:59:04.433  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(249)] Successfully unmapped vendor_b from device mapper.
 09-12 19:59:04.437 19456 19495 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.000).
 09-12 19:59:04.446  1145  1145 I update_engine: [INFO:metrics_reporter_android.cc(131)] Current update attempt downloads 1502 bytes data
 09-12 19:59:04.472 19686 19686 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x111, isSetupWizard=false.
 09-12 19:59:04.573 19456 19495 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x000.
 09-12 19:59:04.607 19456 19495 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x000.
 09-12 19:59:04.649 19456 19545 I SystemUpdate: [Execution,SynchronizedUpdateEngine] stop()
 09-12 19:59:04.649 19456 19545 I SystemUpdate: [Execution,ExecutionManager] Action streaming-apply executed for 336.80 seconds.
 09-12 19:59:04.673 19456 19545 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x110, -1.000).
 09-12 19:59:04.700 19686 19686 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x110, isSetupWizard=false.
 09-12 19:59:04.831 19456 19545 I SystemUpdate: [Execution,ExecutionManager] Action ab-reboot executed for 0.18 seconds.
 09-12 19:59:10.784 19456 19545 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 105.
 09-12 19:59:10.789 19456 26270 I SystemUpdate: [Execution,InstallationIntentOperation] Received intent: Intent { act=com.google.android.gms.update.INSTALL_UPDATE cat=[targeted_intent_op_prefix:.update.execution.InstallationIntentOperation] cmp=com.google.android.gms/.chimera.GmsIntentOperationService }.
 09-12 19:59:10.822 19456 26270 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x310, -1.000).
 09-12 19:59:10.850 19686 19686 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x310, isSetupWizard=false.
 09-12 19:59:10.963 19456 26270 I SystemUpdate: [Execution,SynchronizedUpdateEngine] start(avxv{url=file:///data/ota_package/payload_metadata.bin, payload_binary_file.offset=0, payload_binary_file.length=1575657963, properties=[FILE_HASH=sGcPleaJ+eiQUfcIF38CohsI9tb4M+E8hgohx5xAsgk=, FILE_SIZE=1575657963, METADATA_HASH=nRRfTgsKG9LbsGhYB4DyfKQA6f94xBPwV4ytqbWCzmc=, METADATA_SIZE=104581]}, additionalProperties.size=3)
 09-12 19:59:10.963 19456 26270 I SystemUpdate: [Execution,UpdateEngineDelegate] applyPayload()
 09-12 19:59:10.967  1145  1145 I update_engine: [INFO:update_attempter_android.cc(280)] Using this install plan:
 09-12 19:59:10.970  1145  1145 I update_engine: [INFO:install_plan.cc(91)] InstallPlan: resume, version: , source_slot: A, target_slot: B, url: file:///data/ota_package/payload_metadata.bin, payload: (size: 1575657963, metadata_size: 104581, metadata signature: , hash: B0670F95E689F9E89051F708177F02A21B08F6D6F833E13C860A21C79C40B209, payload type: unknown), hash_checks_mandatory: true, powerwash_required: false, switch_slot_on_reboot: true, run_post_install: false, is_rollback: false, write_verity: false
 09-12 19:59:10.972  1145  1145 I update_engine: [INFO:metrics_utils.cc(371)] Payload Attempt Number = 2
 09-12 19:59:10.973  1145  1145 I update_engine: [INFO:metrics_utils.cc(388)] Update Monotonic Timestamp Start = 1/1/1970 0:21:08 GMT
 09-12 19:59:10.975  1145  1145 I update_engine: [INFO:metrics_utils.cc(397)] Update Boot Timestamp Start = 1/1/1970 0:21:08 GMT
 09-12 19:59:10.976  1145  1145 I update_engine: [INFO:update_attempter_android.cc(648)] Scheduling an action processor start.
 09-12 19:59:10.977  1145  1145 I update_engine: [INFO:action_processor.cc(51)] ActionProcessor: starting UpdateBootFlagsAction
 09-12 19:59:10.978  1145  1145 I update_engine: [INFO:update_boot_flags_action.cc(36)] Already updated boot flags. Skipping.
 09-12 19:59:10.983  1145  1145 I update_engine: [INFO:action_processor.cc(116)] ActionProcessor: finished UpdateBootFlagsAction with code ErrorCode::kSuccess
 09-12 19:59:10.984  1145  1145 I update_engine: [INFO:action_processor.cc(143)] ActionProcessor: starting CleanupPreviousUpdateAction
 09-12 19:59:10.985  1145  1145 I update_engine: [INFO:cleanup_previous_update_action.cc(82)] Starting/resuming CleanupPreviousUpdateAction
 09-12 19:59:10.988  1145  1145 I update_engine: [INFO:cleanup_previous_update_action.cc(137)] Boot completed, waiting on markBootSuccessful()
 09-12 19:59:10.991  1145  1145 I update_engine: EnsureMetadataMounted does nothing in Android mode.
 09-12 19:59:10.992  1145  1145 I update_engine: Read merge statistics file failed: No such file or directory
 09-12 19:59:11.003  1145  1145 I update_engine: [INFO:cleanup_previous_update_action.cc(206)] Waiting for any previous merge request to complete. This can take up to several minutes.
 09-12 19:59:11.007  1145  1145 E update_engine: [ERROR:cleanup_previous_update_action.cc(240)] Previous update has not been completed, not cleaning up
 09-12 19:59:11.014  1145  1145 I update_engine: [INFO:cleanup_previous_update_action.cc(397)] Not reporting merge stats because state is Initiated
 09-12 19:59:11.017  1145  1145 I update_engine: [INFO:action_processor.cc(116)] ActionProcessor: finished CleanupPreviousUpdateAction with code ErrorCode::kSuccess
 09-12 19:59:11.018  1145  1145 I update_engine: [INFO:action_processor.cc(143)] ActionProcessor: starting InstallPlanAction
 09-12 19:59:11.020  1145  1145 I update_engine: [INFO:action_processor.cc(116)] ActionProcessor: finished InstallPlanAction with code ErrorCode::kSuccess
 09-12 19:59:11.022  1145  1145 I update_engine: [INFO:action_processor.cc(143)] ActionProcessor: starting DownloadAction
 09-12 19:59:11.023  1145  1145 I update_engine: [INFO:install_plan.cc(91)] InstallPlan: resume, version: , source_slot: A, target_slot: B, url: file:///data/ota_package/payload_metadata.bin, payload: (size: 1575657963, metadata_size: 104581, metadata signature: , hash: B0670F95E689F9E89051F708177F02A21B08F6D6F833E13C860A21C79C40B209, payload type: unknown), hash_checks_mandatory: true, powerwash_required: false, switch_slot_on_reboot: true, run_post_install: false, is_rollback: false, write_verity: false
 09-12 19:59:11.025  1145  1145 I update_engine: [INFO:prefs.cc(122)] update-state-payload-index not present in /data/misc/update_engine/prefs
 09-12 19:59:11.026  1145  1145 I update_engine: [INFO:download_action.cc(199)] Marking new slot as unbootable
 09-12 19:59:11.057  1145  1145 I update_engine: [INFO:multi_range_http_fetcher.cc(45)] starting first transfer
 09-12 19:59:11.059  1145  1145 I update_engine: [INFO:multi_range_http_fetcher.cc(74)] starting transfer of range 0+105104
 09-12 19:59:11.062  1145  1145 I update_engine: [INFO:delta_performer.cc(209)] Completed 0/? operations, 16384/1575657963 bytes downloaded (0%), overall progress 0%
 09-12 19:59:11.067  1145  1145 I update_engine: [INFO:delta_performer.cc(520)] Manifest size in payload matches expected value from Omaha
 09-12 19:59:11.069  1145  1145 I update_engine: [INFO:delta_performer.cc(1693)] Verifying using certificates: /system/etc/security/otacerts.zip
 09-12 19:59:11.071  1145  1145 I update_engine: [INFO:payload_verifier.cc(102)] signature blob size = 523
 09-12 19:59:11.073  1145  1145 I update_engine: [INFO:payload_verifier.cc(118)] Truncating the signature to its unpadded size: 512.
 09-12 19:59:11.075  1145  1145 I update_engine: [INFO:payload_verifier.cc(129)] Verified correct signature 1 out of 1 signatures.
 09-12 19:59:11.077  1145  1145 I update_engine: [INFO:payload_metadata.cc(224)] Metadata hash signature matches value in Omaha response.
 09-12 19:59:11.084  1145  1145 I update_engine: [INFO:delta_performer.cc(1728)] Detected a 'full' payload.
 09-12 19:59:11.093  1145  1145 I update_engine: [INFO:delta_performer.cc(982)] Using previously prepared partitions for update. hash = sGcPleaJ+eiQUfcIF38CohsI9tb4M+E8hgohx5xAsgk=nRRfTgsKG9LbsGhYB4DyfKQA6f94xBPwV4ytqbWCzmc=
 09-12 19:59:11.095  1145  1145 I update_engine: EnsureMetadataMounted does nothing in Android mode.
 09-12 19:59:11.097  1145  1145 I update_engine: [INFO:delta_performer.cc(1002)] PreparePartitionsForUpdate done.
 09-12 19:59:11.103  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.106  1145  1145 I update_engine: Successfully unmapped snapshot vendor_b
 09-12 19:59:11.141  1145  1145 I update_engine: [libfs_mgr]Created logical partition vendor_b-base on device /dev/block/dm-1
 09-12 19:59:11.175  1145  1145 I update_engine: Mapped COW device for vendor_b at /dev/block/dm-4
 09-12 19:59:11.236  1145  1145 I update_engine: Mapped vendor_b as snapshot device at /dev/block/dm-11
 09-12 19:59:11.238  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(173)] Succesfully mapped vendor_b to device mapper (force_writable = 1); device path at /dev/block/dm-11
 09-12 19:59:11.240  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.242  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] boot_b is not in super partition metadata.
 09-12 19:59:11.244  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.246  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.248  1145  1145 I update_engine: Successfully unmapped snapshot system_b
 09-12 19:59:11.275  1145  1145 I update_engine: [libfs_mgr]Created logical partition system_b-base on device /dev/block/dm-12
 09-12 19:59:11.304  1145  1145 I update_engine: Mapped COW device for system_b at /dev/block/dm-13
 09-12 19:59:11.378  1145  1145 I update_engine: Mapped system_b as snapshot device at /dev/block/dm-14
 09-12 19:59:11.380  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(173)] Succesfully mapped system_b to device mapper (force_writable = 1); device path at /dev/block/dm-14
 09-12 19:59:11.382  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.384  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] vbmeta_b is not in super partition metadata.
 09-12 19:59:11.385  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.388  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.390  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] dtbo_b is not in super partition metadata.
 09-12 19:59:11.392  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.394  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.396  1145  1145 I update_engine: Successfully unmapped snapshot product_b
 09-12 19:59:11.424  1145  1145 I update_engine: [libfs_mgr]Created logical partition product_b-base on device /dev/block/dm-15
 09-12 19:59:11.455  1145  1145 I update_engine: Mapped COW device for product_b at /dev/block/dm-16
 09-12 19:59:11.611  1145  1145 I update_engine: Mapped product_b as snapshot device at /dev/block/dm-17
 09-12 19:59:11.613  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(173)] Succesfully mapped product_b to device mapper (force_writable = 1); device path at /dev/block/dm-17
 09-12 19:59:11.616  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.618  1145  1145 I update_engine: Successfully unmapped snapshot system_ext_b
 09-12 19:59:11.646  1145  1145 I update_engine: [libfs_mgr]Created logical partition system_ext_b-base on device /dev/block/dm-18
 09-12 19:59:11.677  1145  1145 I update_engine: Mapped COW device for system_ext_b at /dev/block/dm-19
 09-12 19:59:11.710  1145  1145 I update_engine: Mapped system_ext_b as snapshot device at /dev/block/dm-20
 09-12 19:59:11.716  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(173)] Succesfully mapped system_ext_b to device mapper (force_writable = 1); device path at /dev/block/dm-20
 09-12 19:59:11.718  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.720  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] vbmeta_system_b is not in super partition metadata.
 09-12 19:59:11.722  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.724  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.726  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] abl_b is not in super partition metadata.
 09-12 19:59:11.727  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.730  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.732  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] aop_b is not in super partition metadata.
 09-12 19:59:11.733  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.735  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.737  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] devcfg_b is not in super partition metadata.
 09-12 19:59:11.739  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.742  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.743  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] hyp_b is not in super partition metadata.
 09-12 19:59:11.745  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.747  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.749  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] keymaster_b is not in super partition metadata.
 09-12 19:59:11.751  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.754  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.756  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] qupfw_b is not in super partition metadata.
 09-12 19:59:11.758  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.761  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.763  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] tz_b is not in super partition metadata.
 09-12 19:59:11.764  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.767  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.769  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] uefisecapp_b is not in super partition metadata.
 09-12 19:59:11.771  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.774  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.776  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] xbl_b is not in super partition metadata.
 09-12 19:59:11.778  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.781  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.783  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] xbl_config_b is not in super partition metadata.
 09-12 19:59:11.784  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.787  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.789  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] modem_b is not in super partition metadata.
 09-12 19:59:11.791  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
 09-12 19:59:11.792  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new vendor sha256: twC08PfZiDfBZbrthWsUDjcNfvdJX/dLS3/f0vu2uQ8= size: 550641664
 09-12 19:59:11.793  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new boot sha256: 8HVNXOpg0OyjuXodDhhKclVkHtHOnr6+X2spC3bmock= size: 67108864
 09-12 19:59:11.794  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new system sha256: QxQRFvNXfdyt2J03wwMtx7BJCL5DQIJsjj92tAZ5QVM= size: 819933184
 09-12 19:59:11.795  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new vbmeta sha256: cbGbnXu+viM6liaD8/XxphAX48PwWilmhSdrcB72pfs= size: 8192
 09-12 19:59:11.796  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new dtbo sha256: SkyxhHQ0onuwPvDRkSU9wIVUiM4qQEd79K/bJRAuvWs= size: 8388608
 09-12 19:59:11.797  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new product sha256: /0tLLyjAfr/U0q+KC7xJzxweNsknv4GmvmBLy1utLko= size: 2043527168
 09-12 19:59:11.798  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new system_ext sha256: VPltcL6s9ngnKkC02f5SgfHUnc40brFVezoNrjR3l1o= size: 231059456
 09-12 19:59:11.799  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new vbmeta_system sha256: T1A2W2DTB4Dc3dQ5cZwZ473idx3TiNBfsJ++xOzgF+g= size: 4096
 09-12 19:59:11.800  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new abl sha256: eNU69cw4jLuWHVc09Dltkra/Kfut3q5cEYxi/weP0KA= size: 1048576
 09-12 19:59:11.801  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new aop sha256: b+D3X9dYoT/xWURMXM7GxadGOIGIQDCVT19i/XJLgCk= size: 167936
 09-12 19:59:11.802  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new devcfg sha256: nO7Wjbs9T3KMROdVDpnYx6KnmHQlU49AEWpR/u39DtE= size: 45056
 09-12 19:59:11.803  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new hyp sha256: vFIs70jY6DC30Yp3Tsf/wT5Zg6ipk2yW/lVDN4L399w= size: 397312
 09-12 19:59:11.804  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new keymaster sha256: gCl03SZEY5qACY8eXlCzj2tLVNvVRXn1DO/m925dmR0= size: 241664
 09-12 19:59:11.805  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new qupfw sha256: /2vtz4Rzn4jlqylhniO02OGWmO62ZHnHijvX1pe7V1w= size: 53248
 09-12 19:59:11.806  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new tz sha256: zT5+hXSlF41ygmJx6fReBg0A5tuHsPS2LSjL4DB4BWg= size: 2060288
 09-12 19:59:11.807  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new uefisecapp sha256: 3+mbLacKzJ3dYWgYT1SFnxL5Hz2qpis3HqGIBWs2ygo= size: 126976
 09-12 19:59:11.808  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new xbl sha256: T/3gnjL13PoFQqFhC752yq3kRrX99J71NFTbMCpW1bE= size: 3371008
 09-12 19:59:11.809  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new xbl_config sha256: bTQYcJ00/h07XagoJYXL4/KZghh1C42IYxTDajOBWhY= size: 90112
 09-12 19:59:11.810  1145  1145 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new modem sha256: I34Jqd+1RRJfEayfd/IfcXuwl6+lI5F55PhXJWSFLcE= size: 74108928
 09-12 19:59:11.812  1145  1145 I update_engine: [INFO:delta_performer.cc(209)] Resuming after 1825/1825 operations (100%), 1575657963/1575657963 bytes downloaded (100%), overall progress 100%
 09-12 19:59:11.812  1145  1145 I update_engine: [INFO:delta_performer.cc(657)] Starting to apply update payload operations
 09-12 19:59:11.813  1145  1145 I update_engine: [INFO:multi_range_http_fetcher.cc(115)] Terminating transfer.
 09-12 19:59:11.814  1145  1145 I update_engine: [INFO:multi_range_http_fetcher.cc(177)] Received transfer terminated.
 09-12 19:59:11.815  1145  1145 I update_engine: [INFO:multi_range_http_fetcher.cc(129)] TransferEnded w/ code 200
 09-12 19:59:11.816  1145  1145 I update_engine: [INFO:multi_range_http_fetcher.cc(163)] Done w/ all transfers
 09-12 19:59:11.817  1145  1145 I update_engine: [INFO:delta_performer.cc(1693)] Verifying using certificates: /system/etc/security/otacerts.zip
 09-12 19:59:11.819  1145  1145 I update_engine: [INFO:payload_verifier.cc(102)] signature blob size = 523
 09-12 19:59:11.820  1145  1145 I update_engine: [INFO:payload_verifier.cc(118)] Truncating the signature to its unpadded size: 512.
 09-12 19:59:11.822  1145  1145 I update_engine: [INFO:payload_verifier.cc(129)] Verified correct signature 1 out of 1 signatures.
 09-12 19:59:11.823  1145  1145 I update_engine: [INFO:delta_performer.cc(1915)] Payload hash matches value in payload.
 09-12 19:59:11.824  1145  1145 I update_engine: [INFO:download_action.cc(400)] Collections of histograms for UpdateEngine.DownloadAction.
 09-12 19:59:11.824  1145  1145 I update_engine: Histogram: UpdateEngine.DownloadAction.InstallOperation::REPLACE.Duration recorded 1825 samples, mean = 122.2
 09-12 19:59:11.824  1145  1145 I update_engine: 0    -O                                                                        (8 = 0.4%)
 09-12 19:59:11.824  1145  1145 I update_engine: 10   --------O                                                                 (105 = 5.8%) {0.4%}
 09-12 19:59:11.824  1145  1145 I update_engine: 18   ------O                                                                   (78 = 4.3%) {6.2%}
 09-12 19:59:11.824  1145  1145 I update_engine: 32   ----O                                                                     (47 = 2.6%) {10.5%}
 09-12 19:59:11.824  1145  1145 I update_engine: 57   --------------------------------O                                         (396 = 21.7%) {13.0%}
 09-12 19:59:11.824  1145  1145 I update_engine: 101  ------------------------------------------------------------------------O (904 = 49.5%) {34.7%}
 09-12 19:59:11.824  1145  1145 I update_engine: 179  -----------------------O                                                  (284 = 15.6%) {84.3%}
 09-12 19:59:11.824  1145  1145 I update_engine: 317  O                                                                         (3 = 0.2%) {99.8%}
 09-12 19:59:11.824  1145  1145 I update_engine: 561  ... 
 09-12 19:59:11.824  1145  1145 I update_engine: 
 09-12 19:59:11.832  1145  1145 I update_engine: [INFO:action_processor.cc(116)] ActionProcessor: finished DownloadAction with code ErrorCode::kSuccess
 09-12 19:59:11.833  1145  1145 I update_engine: [INFO:action_processor.cc(143)] ActionProcessor: starting FilesystemVerifierAction
 09-12 19:59:11.834  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 0 (vendor) on device /dev/block/dm-11
 09-12 19:59:13.900  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of vendor: twC08PfZiDfBZbrthWsUDjcNfvdJX/dLS3/f0vu2uQ8=
 09-12 19:59:14.075  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 1 (boot) on device /dev/block/bootdevice/by-name/boot_b
 09-12 19:59:14.258  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of boot: 8HVNXOpg0OyjuXodDhhKclVkHtHOnr6+X2spC3bmock=
 09-12 19:59:14.278  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 2 (system) on device /dev/block/dm-14
 09-12 19:59:17.319  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of system: QxQRFvNXfdyt2J03wwMtx7BJCL5DQIJsjj92tAZ5QVM=
 09-12 19:59:17.595  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 3 (vbmeta) on device /dev/block/bootdevice/by-name/vbmeta_b
 09-12 19:59:17.600  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of vbmeta: cbGbnXu+viM6liaD8/XxphAX48PwWilmhSdrcB72pfs=
 09-12 19:59:17.601  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 4 (dtbo) on device /dev/block/bootdevice/by-name/dtbo_b
 09-12 19:59:17.628  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of dtbo: SkyxhHQ0onuwPvDRkSU9wIVUiM4qQEd79K/bJRAuvWs=
 09-12 19:59:17.632  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 5 (product) on device /dev/block/dm-17
 09-12 19:59:25.504  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of product: /0tLLyjAfr/U0q+KC7xJzxweNsknv4GmvmBLy1utLko=
 09-12 19:59:25.960  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 6 (system_ext) on device /dev/block/dm-20
 09-12 19:59:26.871  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of system_ext: VPltcL6s9ngnKkC02f5SgfHUnc40brFVezoNrjR3l1o=
 09-12 19:59:26.959  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 7 (vbmeta_system) on device /dev/block/bootdevice/by-name/vbmeta_system_b
 09-12 19:59:26.964  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of vbmeta_system: T1A2W2DTB4Dc3dQ5cZwZ473idx3TiNBfsJ++xOzgF+g=
 09-12 19:59:26.965  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 8 (abl) on device /dev/block/bootdevice/by-name/abl_b
 09-12 19:59:26.971  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of abl: eNU69cw4jLuWHVc09Dltkra/Kfut3q5cEYxi/weP0KA=
 09-12 19:59:26.972  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 9 (aop) on device /dev/block/bootdevice/by-name/aop_b
 09-12 19:59:26.975  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of aop: b+D3X9dYoT/xWURMXM7GxadGOIGIQDCVT19i/XJLgCk=
 09-12 19:59:26.977  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 10 (devcfg) on device /dev/block/bootdevice/by-name/devcfg_b
 09-12 19:59:26.980  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of devcfg: nO7Wjbs9T3KMROdVDpnYx6KnmHQlU49AEWpR/u39DtE=
 09-12 19:59:26.981  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 11 (hyp) on device /dev/block/bootdevice/by-name/hyp_b
 09-12 19:59:26.984  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of hyp: vFIs70jY6DC30Yp3Tsf/wT5Zg6ipk2yW/lVDN4L399w=
 09-12 19:59:26.985  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 12 (keymaster) on device /dev/block/bootdevice/by-name/keymaster_b
 09-12 19:59:26.988  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of keymaster: gCl03SZEY5qACY8eXlCzj2tLVNvVRXn1DO/m925dmR0=
 09-12 19:59:26.990  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 13 (qupfw) on device /dev/block/bootdevice/by-name/qupfw_b
 09-12 19:59:26.992  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of qupfw: /2vtz4Rzn4jlqylhniO02OGWmO62ZHnHijvX1pe7V1w=
 09-12 19:59:26.993  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 14 (tz) on device /dev/block/bootdevice/by-name/tz_b
 09-12 19:59:27.003  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of tz: zT5+hXSlF41ygmJx6fReBg0A5tuHsPS2LSjL4DB4BWg=
 09-12 19:59:27.005  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 15 (uefisecapp) on device /dev/block/bootdevice/by-name/uefisecapp_b
 09-12 19:59:27.008  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of uefisecapp: 3+mbLacKzJ3dYWgYT1SFnxL5Hz2qpis3HqGIBWs2ygo=
 09-12 19:59:27.009  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 16 (xbl) on device /dev/block/bootdevice/by-name/xbl_b
 09-12 19:59:27.022  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of xbl: T/3gnjL13PoFQqFhC752yq3kRrX99J71NFTbMCpW1bE=
 09-12 19:59:27.025  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 17 (xbl_config) on device /dev/block/bootdevice/by-name/xbl_config_b
 09-12 19:59:27.028  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of xbl_config: bTQYcJ00/h07XagoJYXL4/KZghh1C42IYxTDajOBWhY=
 09-12 19:59:27.029  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 18 (modem) on device /dev/block/bootdevice/by-name/modem_b
 09-12 19:59:27.262  1145  1145 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of modem: I34Jqd+1RRJfEayfd/IfcXuwl6+lI5F55PhXJWSFLcE=
 09-12 19:59:27.295  1145  1145 I update_engine: [INFO:action_processor.cc(116)] ActionProcessor: finished FilesystemVerifierAction with code ErrorCode::kSuccess
 09-12 19:59:27.297  1145  1145 I update_engine: [INFO:action_processor.cc(143)] ActionProcessor: starting PostinstallRunnerAction
 09-12 19:59:27.298  1145  1145 I update_engine: [INFO:postinstall_runner_action.cc(76)] Skipping optional post-install for partition vendor according to install plan.
 09-12 19:59:27.299  1145  1145 I update_engine: [INFO:postinstall_runner_action.cc(76)] Skipping optional post-install for partition system according to install plan.
 09-12 19:59:27.300  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(863)] Snapshot writes are done.
 09-12 19:59:27.302  1145  1145 I update_engine: Wipe is not scheduled. Deleting forward merge indicator.
 09-12 19:59:27.342  1145  1145 I update_engine: [INFO:postinstall_runner_action.cc(371)] All post-install commands succeeded
 09-12 19:59:27.345  1145  1145 I update_engine: [INFO:action_processor.cc(116)] ActionProcessor: finished last action PostinstallRunnerAction with code ErrorCode::kSuccess
 09-12 19:59:27.347  1145  1145 I update_engine: [INFO:update_attempter_android.cc(522)] Processing Done.
 09-12 19:59:27.349  1145  1145 I update_engine: [INFO:update_attempter_android.cc(535)] Update successfully applied, waiting to reboot.
 09-12 19:59:27.350  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(263)] Destroying [product_b, system_b, system_ext_b, vendor_b] from device mapper
 09-12 19:59:27.366  1145  1145 I update_engine: [libfs_mgr]Unmapped logical partition product_b
 09-12 19:59:27.410  1145  1145 I update_engine: Successfully unmapped snapshot product_b
 09-12 19:59:27.413  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(249)] Successfully unmapped product_b from device mapper.
 09-12 19:59:27.436  1145  1145 I update_engine: [libfs_mgr]Unmapped logical partition system_b
 09-12 19:59:27.491  1145  1145 I update_engine: Successfully unmapped snapshot system_b
 09-12 19:59:27.495  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(249)] Successfully unmapped system_b from device mapper.
 09-12 19:59:27.516  1145  1145 I update_engine: [libfs_mgr]Unmapped logical partition system_ext_b
 09-12 19:59:27.550  1145  1145 I update_engine: Successfully unmapped snapshot system_ext_b
 09-12 19:59:27.553  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(249)] Successfully unmapped system_ext_b from device mapper.
 09-12 19:59:27.576  1145  1145 I update_engine: [libfs_mgr]Unmapped logical partition vendor_b
 09-12 19:59:27.620  1145  1145 I update_engine: Successfully unmapped snapshot vendor_b
 09-12 19:59:27.622  1145  1145 I update_engine: [INFO:dynamic_partition_control_android.cc(249)] Successfully unmapped vendor_b from device mapper.
 09-12 19:59:27.626  1145  1145 I update_engine: [INFO:metrics_reporter_android.cc(131)] Current update attempt downloads 0 bytes data
 09-12 19:59:27.636  1145  1145 I update_engine: [INFO:metrics_utils.cc(380)] Updated Marker = 1/1/1970 0:21:25 GMT
 09-12 19:59:27.644 19456 26270 I SystemUpdate: [Execution,ExecutionManager] Action ab-reboot executed for 16.85 seconds.
 09-12 19:59:27.853 19456 26325 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
 09-12 19:59:28.861  1145  1145 I update_engine: [INFO:main.cc(71)] A/B Update Engine terminating with exit code 0