Skip to content

Instantly share code, notes, and snippets.

@nooriro
Created February 1, 2021 20:59
Show Gist options
  • Save nooriro/14525306097b7b7556d911507c265b87 to your computer and use it in GitHub Desktop.
Save nooriro/14525306097b7b7556d911507c265b87 to your computer and use it in GitHub Desktop.
sunfish update log (SUCCEEDED LOG) / from RQ1A.201205.008 to RQ1A.210105.002 / Update URL (Incremental OTA Image): https://ota.googlezip.net/packages/ota-api/package/d6b7090173dddeaf73ca43a9a51252e4508c7c80.zip
--------- beginning of crash
--------- beginning of system
--------- beginning of main
02-02 05:28:53.627 3414 7191 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
02-02 05:28:53.632 3414 7192 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 }.
02-02 05:28:53.634 3414 7192 I SystemUpdate: [Execution,ExecutionManager] Action finished-execution executed for 0.00 seconds.
02-02 05:28:53.679 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x000, isSetupWizard=false.
02-02 05:29:00.024 3414 3516 I SystemUpdate: [Api,CheckForConfigUpdateOperation] Checkin request finished with code Optional.of(21021).
02-02 05:29:00.028 7152 7194 I SystemUpdate: [Common,RequestConfigUpdateLoader] Config update succeeded.
02-02 05:29:00.036 3414 3516 I SystemUpdate: [Control,InstallationControl] Update URL changed from "" to "https://ota.googlezip.net/packages/ota-api/package/d6b7090173dddeaf73ca43a9a51252e4508c7c80.zip".
02-02 05:29:00.157 3414 7192 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 102.
02-02 05:29:00.163 3414 7192 I SystemUpdate: [Execution,ExecutionManager] Finishing the current execution.
02-02 05:29:00.187 3414 7192 I SystemUpdate: [Execution,SynchronizedUpdateEngine] reset()
02-02 05:29:00.188 3414 3516 I SystemUpdate: [Control,ChimeraGcmTaskService] Scheduling task: AutomaticUpdateFlagChanged.
02-02 05:29:00.198 3414 3516 I SystemUpdate: [Control,ChimeraGcmTaskService] Scheduling task: AutomaticUpdateFlagChanged.
02-02 05:29:00.207 3414 7192 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 }.
02-02 05:29:00.229 3414 7192 I SystemUpdate: [Execution,ExecutionManager] Action pending executed for 0.02 seconds.
02-02 05:29:00.271 3414 7192 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x017, -1.000).
02-02 05:29:00.309 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x017, isSetupWizard=false.
02-02 05:29:00.345 3414 7192 I SystemUpdate: [Control,DeviceControl] Prepare resume on reboot.
02-02 05:29:01.461 3414 7311 I SystemUpdate: [Installation,ReceiverIntentOperation] Received intent: Intent { act=com.google.gservices.intent.action.GSERVICES_CHANGED flg=0x1000010 pkg=com.google.android.gms cmp=com.google.android.gms/.chimera.GmsIntentOperationService$PersistentInternalReceiver }.
02-02 05:29:01.490 3414 7191 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 2.
02-02 05:29:02.234 3414 7192 I SystemUpdate: [Execution,PackageFiles] Aggressive allocating space for file /data/ota_package/payload_header.bin with size 24.
02-02 05:29:03.866 3414 7192 I SystemUpdate: [Execution,PackageFiles] Aggressive allocating space for file /data/ota_package/payload_metadata.bin with size 268096.
02-02 05:29:03.958 3414 7192 I SystemUpdate: [Execution,UpdateEngineDelegate] verifyPayloadMetadata()
02-02 05:29:03.966 1242 1242 I update_engine: [INFO:binder_service_android.cc(179)] Received a request of verifying payload metadata in /data/ota_package/payload_metadata.bin.
02-02 05:29:03.976 1242 1242 I update_engine: [INFO:payload_verifier.cc(102)] signature blob size = 523
02-02 05:29:03.977 1242 1242 I update_engine: [INFO:payload_verifier.cc(118)] Truncating the signature to its unpadded size: 512.
02-02 05:29:03.980 1242 1242 I update_engine: [INFO:payload_verifier.cc(129)] Verified correct signature 1 out of 1 signatures.
02-02 05:29:03.982 1242 1242 I update_engine: [INFO:payload_metadata.cc(224)] Metadata hash signature matches value in Omaha response.
02-02 05:29:04.028 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:04.030 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(957)] vendor_b is mapped on device mapper: /dev/block/dm-1
02-02 05:29:07.959 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:07.963 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] boot_b is not in super partition metadata.
02-02 05:29:07.964 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:08.059 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:08.061 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(957)] system_b is mapped on device mapper: /dev/block/dm-0
02-02 05:29:14.581 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:14.584 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] vbmeta_b is not in super partition metadata.
02-02 05:29:14.586 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:14.598 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:14.604 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] dtbo_b is not in super partition metadata.
02-02 05:29:14.606 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:14.635 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:14.638 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(957)] product_b is mapped on device mapper: /dev/block/dm-2
02-02 05:29:27.430 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:27.433 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(957)] system_ext_b is mapped on device mapper: /dev/block/dm-3
02-02 05:29:29.348 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:29.351 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] vbmeta_system_b is not in super partition metadata.
02-02 05:29:29.353 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:29.360 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:29.364 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] abl_b is not in super partition metadata.
02-02 05:29:29.366 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:29.377 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:29.380 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] aop_b is not in super partition metadata.
02-02 05:29:29.382 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:29.395 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:29.398 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] devcfg_b is not in super partition metadata.
02-02 05:29:29.400 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:29.407 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:29.410 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] hyp_b is not in super partition metadata.
02-02 05:29:29.411 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:29.421 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:29.423 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] keymaster_b is not in super partition metadata.
02-02 05:29:29.425 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:29.437 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:29.439 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] qupfw_b is not in super partition metadata.
02-02 05:29:29.441 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:29.449 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:29.451 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] tz_b is not in super partition metadata.
02-02 05:29:29.453 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:29.505 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:29.508 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] uefisecapp_b is not in super partition metadata.
02-02 05:29:29.509 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:29.521 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:29.523 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] xbl_b is not in super partition metadata.
02-02 05:29:29.525 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:29.559 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:29.561 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] xbl_config_b is not in super partition metadata.
02-02 05:29:29.563 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:29.577 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:29.580 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] modem_b is not in super partition metadata.
02-02 05:29:29.582 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:35.652 3414 7192 I SystemUpdate: [Execution,PackageFiles] Aggressive allocating space for file /data/ota_package/metadata with size 650.
02-02 05:29:35.664 3414 7192 I SystemUpdate: [Execution,ExecutionManager] Action pre-download-validate executed for 35.43 seconds.
02-02 05:29:35.802 3414 7192 I SystemUpdate: [Network,NetworkRequester] Requesting network with capabilities [11, 12]...
02-02 05:29:35.808 3414 5163 I SystemUpdate: [Network,NetworkRequester] Network acquired.
02-02 05:29:35.813 3414 3516 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
02-02 05:29:35.815 3414 4769 I SystemUpdate: [Control,NetworkControl] Received intent: Intent { act=android.net.wifi.supplicant.STATE_CHANGE flg=0x24000010 (has extras) }.
02-02 05:29:35.831 3414 7432 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
02-02 05:29:35.943 3414 7432 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 3.
02-02 05:29:36.010 3414 7192 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x002, -1.000).
02-02 05:29:36.053 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x002, isSetupWizard=false.
02-02 05:29:38.690 3414 7192 I SystemUpdate: [Execution,PackageFiles] Aggressive allocating space for file /data/ota_package/payload_properties.txt with size 154.
02-02 05:29:38.736 3414 7192 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x002, -1.000).
02-02 05:29:40.541 3414 7192 I SystemUpdate: [Execution,PackageFiles] Aggressive allocating space for file /data/ota_package/care_map.pb with size 519.
02-02 05:29:40.590 3414 7192 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x002, -1.000).
02-02 05:29:41.394 3414 4769 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
02-02 05:29:41.408 3414 7432 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
02-02 05:29:41.967 3414 7192 I SystemUpdate: [Execution,PackageFiles] Aggressive allocating space for file /data/ota_package/metadata with size 650.
02-02 05:29:41.975 3414 7192 I SystemUpdate: [Execution,ExecutionManager] Action streaming-download executed for 6.31 seconds.
02-02 05:29:41.989 3414 7192 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x003, -1.000).
02-02 05:29:42.025 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x003, isSetupWizard=false.
02-02 05:29:42.291 3414 7192 I SystemUpdate: [Execution,ExecutionManager] Action streaming-process-package executed for 0.31 seconds.
02-02 05:29:42.303 3414 7192 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x913, -1.000).
02-02 05:29:42.339 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x913, isSetupWizard=false.
02-02 05:29:42.530 3414 7192 I SystemUpdate: [Execution,UpdateEngineDelegate] cleanupAppliedPayload()
02-02 05:29:42.536 1242 1242 I update_engine: [INFO:update_attempter_android.cc(983)] CleanupSuccessfulUpdate has previously completed with ErrorCode::kSuccess
02-02 05:29:42.539 3414 7192 I SystemUpdate: [Execution,UpdateEngineDelegate] allocateSpace()
02-02 05:29:42.540 1242 1242 I update_engine: [INFO:binder_service_android.cc(211)] Received a request of allocating space for /data/ota_package/payload_metadata.bin.
02-02 05:29:42.549 1242 1242 I update_engine: [INFO:payload_verifier.cc(102)] signature blob size = 523
02-02 05:29:42.553 1242 1242 I update_engine: [INFO:payload_verifier.cc(118)] Truncating the signature to its unpadded size: 512.
02-02 05:29:42.557 1242 1242 I update_engine: [INFO:payload_verifier.cc(129)] Verified correct signature 1 out of 1 signatures.
02-02 05:29:42.560 1242 1242 I update_engine: [INFO:payload_metadata.cc(224)] Metadata hash signature matches value in Omaha response.
02-02 05:29:42.583 1242 1242 I update_engine: [INFO:prefs.cc(122)] dynamic-partition-metadata-updated not present in /data/misc/update_engine/prefs
02-02 05:29:42.585 1242 1242 I update_engine: [INFO:delta_performer.cc(985)] Preparing partitions for new update. last hash = , new hash = wg/Tl36M4QHpc0Suqw5jV6QXqftXk/VrGzQBRm31wy0=DJIX8ufxy9HSEsFGHqO/yQOeL5vkpSsGh+FUQmIi4a0=
02-02 05:29:42.588 1242 1242 I update_engine: EnsureMetadataMounted does nothing in Android mode.
02-02 05:29:42.590 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(676)] Erasing AVB footer of system_other partition before update.
02-02 05:29:42.595 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:42.598 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(629)] Can't find system_a in metadata source slot, skip erasing.
02-02 05:29:43.661 1242 1242 I update_engine: [liblp]Partition vendor_a will resize from 555978752 bytes to 555986944 bytes
02-02 05:29:43.665 1242 1242 I update_engine: [liblp]Partition system_a will resize from 822075392 bytes to 822083584 bytes
02-02 05:29:43.670 1242 1242 I update_engine: [liblp]Partition product_a will resize from 2062725120 bytes to 2068152320 bytes
02-02 05:29:43.675 1242 1242 I update_engine: [liblp]Partition system_ext_a will resize from 232345600 bytes to 232349696 bytes
02-02 05:29:43.784 1242 1242 I update_engine: Remaining free space for COW: 6075449344 bytes
02-02 05:29:43.808 1242 1242 I update_engine: For partition system_a, device size = 822083584, snapshot size = 822083584, cow partition size = 613715968, cow file size = 0
02-02 05:29:43.820 1242 1242 I update_engine: [liblp]Partition system_a-cow will resize from 0 bytes to 613715968 bytes
02-02 05:29:43.824 1242 1242 I update_engine: Successfully created snapshot partition for system_a
02-02 05:29:43.828 1242 1242 I update_engine: Remaining free space for COW: 5461508096 bytes
02-02 05:29:43.845 1242 1242 I update_engine: For partition vendor_a, device size = 555986944, snapshot size = 555986944, cow partition size = 490717184, cow file size = 0
02-02 05:29:43.856 1242 1242 I update_engine: [liblp]Partition vendor_a-cow will resize from 0 bytes to 490717184 bytes
02-02 05:29:43.861 1242 1242 I update_engine: Successfully created snapshot partition for vendor_a
02-02 05:29:43.863 1242 1242 I update_engine: Remaining free space for COW: 4970774528 bytes
02-02 05:29:43.906 1242 1242 I update_engine: For partition product_a, device size = 2068152320, snapshot size = 2068152320, cow partition size = 1426231296, cow file size = 0
02-02 05:29:43.916 1242 1242 I update_engine: [liblp]Partition product_a-cow will resize from 0 bytes to 1426231296 bytes
02-02 05:29:43.920 1242 1242 I update_engine: Successfully created snapshot partition for product_a
02-02 05:29:43.922 1242 1242 I update_engine: Remaining free space for COW: 3544186880 bytes
02-02 05:29:43.925 1242 1242 I update_engine: For partition system_ext_a, device size = 232349696, snapshot size = 232349696, cow partition size = 42942464, cow file size = 0
02-02 05:29:43.935 1242 1242 I update_engine: [liblp]Partition system_ext_a-cow will resize from 0 bytes to 42942464 bytes
02-02 05:29:43.939 1242 1242 I update_engine: Successfully created snapshot partition for system_ext_a
02-02 05:29:43.941 1242 1242 I update_engine: Allocating CoW images.
02-02 05:29:43.943 1242 1242 I update_engine: Successfully created snapshot for product_a
02-02 05:29:43.945 1242 1242 I update_engine: Successfully created snapshot for system_a
02-02 05:29:43.947 1242 1242 I update_engine: Successfully created snapshot for system_ext_a
02-02 05:29:43.948 1242 1242 I update_engine: Successfully created snapshot for vendor_a
02-02 05:29:43.950 1242 1242 I update_engine: Successfully unmapped snapshot system_a
02-02 05:29:43.979 1242 1242 I update_engine: Mapped COW device for system_a at /dev/block/dm-4
02-02 05:29:43.983 1242 1242 I update_engine: Zero-filling COW device: /dev/block/dm-4
02-02 05:29:43.999 1242 1242 I update_engine: Successfully unmapped snapshot vendor_a
02-02 05:29:44.029 1242 1242 I update_engine: Mapped COW device for vendor_a at /dev/block/dm-4
02-02 05:29:44.031 1242 1242 I update_engine: Zero-filling COW device: /dev/block/dm-4
02-02 05:29:44.049 1242 1242 I update_engine: Successfully unmapped snapshot product_a
02-02 05:29:44.075 1242 1242 I update_engine: Mapped COW device for product_a at /dev/block/dm-4
02-02 05:29:44.077 1242 1242 I update_engine: Zero-filling COW device: /dev/block/dm-4
02-02 05:29:44.089 1242 1242 I update_engine: Successfully unmapped snapshot system_ext_a
02-02 05:29:44.120 1242 1242 I update_engine: Mapped COW device for system_ext_a at /dev/block/dm-4
02-02 05:29:44.126 1242 1242 I update_engine: Zero-filling COW device: /dev/block/dm-4
02-02 05:29:44.145 1242 1242 I update_engine: [liblp]Updated logical partition table at slot 0 on device super
02-02 05:29:44.148 1242 1242 I update_engine: Successfully created all snapshots for target slot _a
02-02 05:29:44.150 1242 1242 I update_engine: [INFO:delta_performer.cc(1002)] PreparePartitionsForUpdate done.
02-02 05:29:44.152 1242 1242 I update_engine: [INFO:update_attempter_android.cc(975)] Successfully allocated space for payload.
02-02 05:29:44.169 3414 7192 I SystemUpdate: [Execution,ExecutionManager] Action ab-update-prep executed for 1.88 seconds.
02-02 05:29:44.287 3414 7192 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x413, -1.000).
02-02 05:29:44.319 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x413, isSetupWizard=false.
02-02 05:29:44.511 3414 7192 I SystemUpdate: [Control,ChimeraGcmTaskService] Scheduling task: DeviceIdle.
02-02 05:29:44.519 3414 7192 I SystemUpdate: [Execution,ExecutionManager] Action streaming-apply executed for 0.35 seconds.
02-02 05:29:44.555 3414 7192 I SystemUpdate: [Execution,ExecutionManager] Action fixed-delay-execution executed for 0.03 seconds.
02-02 05:29:44.566 3414 7192 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 }.
02-02 05:29:44.633 3414 7192 I SystemUpdate: [Control,ChimeraGcmTaskService] Scheduling task: DeviceIdle.
02-02 05:29:44.636 3414 7192 I SystemUpdate: [Execution,ExecutionManager] Action streaming-apply executed for 0.07 seconds.
02-02 05:29:44.648 3414 7192 I SystemUpdate: [Execution,ExecutionManager] Action fixed-delay-execution executed for 0.01 seconds.
02-02 05:29:48.628 3414 7192 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 109.
02-02 05:29:48.635 3414 7192 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 }.
02-02 05:29:48.736 3414 7192 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, -1.000).
02-02 05:29:48.779 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x111, isSetupWizard=false.
02-02 05:29:48.987 3414 7192 I SystemUpdate: [Network,NetworkRequester] Requesting network with capabilities [11, 12]...
02-02 05:29:48.992 3414 5163 I SystemUpdate: [Network,NetworkRequester] Network acquired.
02-02 05:29:48.997 3414 3516 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
02-02 05:29:48.999 3414 4769 I SystemUpdate: [Control,NetworkControl] Received intent: Intent { act=android.net.wifi.supplicant.STATE_CHANGE flg=0x24000010 (has extras) }.
02-02 05:29:49.015 3414 7432 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
02-02 05:29:49.138 3414 7432 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 3.
02-02 05:29:49.283 3414 7192 I SystemUpdate: [Execution,SynchronizedUpdateEngine] start(axof{url=https://ota.googlezip.net/packages/ota-api/package/d6b7090173dddeaf73ca43a9a51252e4508c7c80.zip, payload_binary_file.offset=1314, payload_binary_file.length=25334902, properties=[FILE_HASH=wg/Tl36M4QHpc0Suqw5jV6QXqftXk/VrGzQBRm31wy0=, FILE_SIZE=25334902, METADATA_HASH=DJIX8ufxy9HSEsFGHqO/yQOeL5vkpSsGh+FUQmIi4a0=, METADATA_SIZE=267573]}, additionalProperties.size=4)
02-02 05:29:49.283 3414 7192 I SystemUpdate: [Execution,UpdateEngineDelegate] applyPayload()
02-02 05:29:49.297 1242 1242 I update_engine: [INFO:update_attempter_android.cc(280)] Using this install plan:
02-02 05:29:49.301 1242 1242 I update_engine: [INFO:install_plan.cc(91)] InstallPlan: new_update, version: , source_slot: B, target_slot: A, url: https://ota.googlezip.net/packages/ota-api/package/d6b7090173dddeaf73ca43a9a51252e4508c7c80.zip, payload: (size: 25334902, metadata_size: 267573, metadata signature: , hash: C20FD3977E8CE101E97344AEAB0E6357A417A9FB5793F56B1B3401466DF5C32D, 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
02-02 05:29:49.303 1242 1242 I update_engine: [INFO:metrics_utils.cc(363)] Number of Reboots during current update attempt = 0
02-02 05:29:49.312 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x002.
02-02 05:29:49.314 1242 1242 I update_engine: [INFO:metrics_utils.cc(371)] Payload Attempt Number = 1
02-02 05:29:49.329 1242 1242 I update_engine: [INFO:metrics_utils.cc(388)] Update Monotonic Timestamp Start = 1/1/1970 9:22:55 GMT
02-02 05:29:49.351 1242 1242 I update_engine: [INFO:metrics_utils.cc(397)] Update Boot Timestamp Start = 1/2/1970 16:31:44 GMT
02-02 05:29:49.357 1242 1242 I update_engine: [INFO:update_attempter_android.cc(648)] Scheduling an action processor start.
02-02 05:29:49.359 1242 1242 I update_engine: [INFO:action_processor.cc(51)] ActionProcessor: starting UpdateBootFlagsAction
02-02 05:29:49.364 1242 1242 I update_engine: [INFO:update_boot_flags_action.cc(45)] Marking booted slot as good.
02-02 05:29:49.408 1242 1242 I update_engine: [INFO:action_processor.cc(116)] ActionProcessor: finished UpdateBootFlagsAction with code ErrorCode::kSuccess
02-02 05:29:49.408 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x00B.
02-02 05:29:49.417 1242 1242 I update_engine: [INFO:action_processor.cc(143)] ActionProcessor: starting CleanupPreviousUpdateAction
02-02 05:29:49.425 1242 1242 I update_engine: [INFO:cleanup_previous_update_action.cc(82)] Starting/resuming CleanupPreviousUpdateAction
02-02 05:29:49.434 1242 1242 I update_engine: [INFO:cleanup_previous_update_action.cc(137)] Boot completed, waiting on markBootSuccessful()
02-02 05:29:49.440 1242 1242 I update_engine: EnsureMetadataMounted does nothing in Android mode.
02-02 05:29:49.458 1242 1242 I update_engine: Read merge statistics file failed: No such file or directory
02-02 05:29:49.467 1242 1242 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.
02-02 05:29:49.476 1242 1242 E update_engine: [ERROR:cleanup_previous_update_action.cc(240)] Previous update has not been completed, not cleaning up
02-02 05:29:49.494 1242 1242 I update_engine: [INFO:cleanup_previous_update_action.cc(397)] Not reporting merge stats because state is Initiated
02-02 05:29:49.499 1242 1242 I update_engine: [INFO:action_processor.cc(116)] ActionProcessor: finished CleanupPreviousUpdateAction with code ErrorCode::kSuccess
02-02 05:29:49.510 1242 1242 I update_engine: [INFO:action_processor.cc(143)] ActionProcessor: starting InstallPlanAction
02-02 05:29:49.511 1242 1242 I update_engine: [INFO:action_processor.cc(116)] ActionProcessor: finished InstallPlanAction with code ErrorCode::kSuccess
02-02 05:29:49.513 1242 1242 I update_engine: [INFO:action_processor.cc(143)] ActionProcessor: starting DownloadAction
02-02 05:29:49.515 1242 1242 I update_engine: [INFO:install_plan.cc(91)] InstallPlan: new_update, version: , source_slot: B, target_slot: A, url: https://ota.googlezip.net/packages/ota-api/package/d6b7090173dddeaf73ca43a9a51252e4508c7c80.zip, payload: (size: 25334902, metadata_size: 267573, metadata signature: , hash: C20FD3977E8CE101E97344AEAB0E6357A417A9FB5793F56B1B3401466DF5C32D, 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
02-02 05:29:49.516 1242 1242 I update_engine: [INFO:download_action.cc(199)] Marking new slot as unbootable
02-02 05:29:49.546 1242 1242 I update_engine: [INFO:multi_range_http_fetcher.cc(45)] starting first transfer
02-02 05:29:49.548 1242 1242 I update_engine: [INFO:multi_range_http_fetcher.cc(74)] starting transfer of range 1314+25334902
02-02 05:29:49.553 1242 1242 I update_engine: [INFO:libcurl_http_fetcher.cc(146)] Starting/Resuming transfer
02-02 05:29:49.561 1242 1242 I update_engine: [INFO:libcurl_http_fetcher.cc(165)] Using proxy: no
02-02 05:29:49.563 1242 1242 I update_engine: [INFO:libcurl_http_fetcher.cc(305)] Setting up curl options for HTTPS
02-02 05:29:50.001 1242 1242 I update_engine: [INFO:certificate_checker.cc(185)] Certificate changed from DEE3C1D71AB6BC55B3945D1C84F4B9F9E5A40BEC155B264A71972984600E50B3 to E1736772716C48FF5DF024FC0EAFFEA5F0B1597DAB9A0B7A71738800FEC5D36C.
02-02 05:29:50.449 1242 1242 I update_engine: [INFO:certificate_checker.cc(185)] Certificate changed from E1736772716C48FF5DF024FC0EAFFEA5F0B1597DAB9A0B7A71738800FEC5D36C to A4C886A7F4CED1C2178F1847AF1545848095CD452FF0B0273B8DB184C8C1F93F.
02-02 05:29:51.105 1242 1242 I update_engine: [INFO:delta_performer.cc(209)] Completed 0/? operations, 16384/25334902 bytes downloaded (0%), overall progress 0%
02-02 05:29:51.105 3414 5172 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.001).
02-02 05:29:51.148 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.000699.
02-02 05:29:51.286 3414 5172 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:29:51.313 1242 1242 I update_engine: [INFO:delta_performer.cc(520)] Manifest size in payload matches expected value from Omaha
02-02 05:29:51.320 1242 1242 I update_engine: [INFO:delta_performer.cc(1693)] Verifying using certificates: /system/etc/security/otacerts.zip
02-02 05:29:51.323 1242 1242 I update_engine: [INFO:payload_verifier.cc(102)] signature blob size = 523
02-02 05:29:51.328 1242 1242 I update_engine: [INFO:payload_verifier.cc(118)] Truncating the signature to its unpadded size: 512.
02-02 05:29:51.334 1242 1242 I update_engine: [INFO:payload_verifier.cc(129)] Verified correct signature 1 out of 1 signatures.
02-02 05:29:51.342 1242 1242 I update_engine: [INFO:payload_metadata.cc(224)] Metadata hash signature matches value in Omaha response.
02-02 05:29:51.361 1242 1242 I update_engine: [INFO:delta_performer.cc(1728)] Detected a 'delta' payload.
02-02 05:29:51.378 3414 5172 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:29:51.388 1242 1242 I update_engine: [INFO:delta_performer.cc(982)] Using previously prepared partitions for update. hash = wg/Tl36M4QHpc0Suqw5jV6QXqftXk/VrGzQBRm31wy0=DJIX8ufxy9HSEsFGHqO/yQOeL5vkpSsGh+FUQmIi4a0=
02-02 05:29:51.391 1242 1242 I update_engine: [INFO:delta_performer.cc(1002)] PreparePartitionsForUpdate done.
02-02 05:29:51.404 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:51.407 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(957)] vendor_b is mapped on device mapper: /dev/block/dm-1
02-02 05:29:51.410 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:29:51.413 1242 1242 I update_engine: Successfully unmapped snapshot vendor_a
02-02 05:29:51.442 1242 1242 I update_engine: [libfs_mgr]Created logical partition vendor_a-base on device /dev/block/dm-4
02-02 05:29:51.473 1242 1242 I update_engine: Mapped COW device for vendor_a at /dev/block/dm-5
02-02 05:29:51.519 1242 1242 I update_engine: Mapped vendor_a as snapshot device at /dev/block/dm-6
02-02 05:29:51.522 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(173)] Succesfully mapped vendor_a to device mapper (force_writable = 1); device path at /dev/block/dm-6
02-02 05:29:51.526 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:51.530 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] boot_b is not in super partition metadata.
02-02 05:29:51.533 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:51.538 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:29:51.541 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] boot_a is not in super partition metadata.
02-02 05:29:51.544 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:51.549 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:51.555 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(957)] system_b is mapped on device mapper: /dev/block/dm-0
02-02 05:29:51.559 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:29:51.563 1242 1242 I update_engine: Successfully unmapped snapshot system_a
02-02 05:29:51.594 1242 1242 I update_engine: [libfs_mgr]Created logical partition system_a-base on device /dev/block/dm-7
02-02 05:29:51.626 1242 1242 I update_engine: Mapped COW device for system_a at /dev/block/dm-25
02-02 05:29:51.664 1242 1242 I update_engine: Mapped system_a as snapshot device at /dev/block/dm-26
02-02 05:29:51.669 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(173)] Succesfully mapped system_a to device mapper (force_writable = 1); device path at /dev/block/dm-26
02-02 05:29:51.672 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:51.674 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] vbmeta_b is not in super partition metadata.
02-02 05:29:51.676 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:51.679 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:29:51.682 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] vbmeta_a is not in super partition metadata.
02-02 05:29:51.684 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:51.688 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:51.690 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] dtbo_b is not in super partition metadata.
02-02 05:29:51.692 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:51.696 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:29:51.705 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] dtbo_a is not in super partition metadata.
02-02 05:29:51.707 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:51.710 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:51.713 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(957)] product_b is mapped on device mapper: /dev/block/dm-2
02-02 05:29:51.717 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:29:51.720 1242 1242 I update_engine: Successfully unmapped snapshot product_a
02-02 05:29:51.751 1242 1242 I update_engine: [libfs_mgr]Created logical partition product_a-base on device /dev/block/dm-27
02-02 05:29:51.779 1242 1242 I update_engine: Mapped COW device for product_a at /dev/block/dm-28
02-02 05:29:51.800 1242 1242 I update_engine: Mapped product_a as snapshot device at /dev/block/dm-29
02-02 05:29:51.803 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(173)] Succesfully mapped product_a to device mapper (force_writable = 1); device path at /dev/block/dm-29
02-02 05:29:51.806 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:51.811 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(957)] system_ext_b is mapped on device mapper: /dev/block/dm-3
02-02 05:29:51.813 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:29:51.816 1242 1242 I update_engine: Successfully unmapped snapshot system_ext_a
02-02 05:29:51.844 1242 1242 I update_engine: [libfs_mgr]Created logical partition system_ext_a-base on device /dev/block/dm-30
02-02 05:29:51.871 1242 1242 I update_engine: Mapped COW device for system_ext_a at /dev/block/dm-31
02-02 05:29:51.886 1242 1242 I update_engine: Mapped system_ext_a as snapshot device at /dev/block/dm-32
02-02 05:29:51.889 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(173)] Succesfully mapped system_ext_a to device mapper (force_writable = 1); device path at /dev/block/dm-32
02-02 05:29:51.893 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:51.895 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] vbmeta_system_b is not in super partition metadata.
02-02 05:29:51.897 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:51.901 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:29:51.904 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] vbmeta_system_a is not in super partition metadata.
02-02 05:29:51.907 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:51.911 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:51.913 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] abl_b is not in super partition metadata.
02-02 05:29:51.916 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:51.920 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:29:51.922 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] abl_a is not in super partition metadata.
02-02 05:29:51.924 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:51.927 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:51.929 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] aop_b is not in super partition metadata.
02-02 05:29:51.932 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:51.935 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:29:51.938 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] aop_a is not in super partition metadata.
02-02 05:29:51.940 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:51.943 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:51.945 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] devcfg_b is not in super partition metadata.
02-02 05:29:51.946 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:51.950 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:29:51.952 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] devcfg_a is not in super partition metadata.
02-02 05:29:51.954 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:51.957 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:51.959 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] hyp_b is not in super partition metadata.
02-02 05:29:51.961 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:51.964 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:29:51.966 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] hyp_a is not in super partition metadata.
02-02 05:29:51.969 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:51.971 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:51.974 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] keymaster_b is not in super partition metadata.
02-02 05:29:51.976 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:51.978 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:29:51.981 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] keymaster_a is not in super partition metadata.
02-02 05:29:51.983 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:51.986 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:51.988 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] qupfw_b is not in super partition metadata.
02-02 05:29:51.990 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:51.993 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:29:51.996 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] qupfw_a is not in super partition metadata.
02-02 05:29:51.998 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:52.003 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:52.005 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] tz_b is not in super partition metadata.
02-02 05:29:52.007 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:52.010 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:29:52.012 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] tz_a is not in super partition metadata.
02-02 05:29:52.015 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:52.019 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:52.021 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] uefisecapp_b is not in super partition metadata.
02-02 05:29:52.023 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:52.026 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:29:52.028 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] uefisecapp_a is not in super partition metadata.
02-02 05:29:52.030 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:52.035 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:52.037 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] xbl_b is not in super partition metadata.
02-02 05:29:52.039 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:52.043 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:29:52.045 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] xbl_a is not in super partition metadata.
02-02 05:29:52.048 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:52.052 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:52.054 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] xbl_config_b is not in super partition metadata.
02-02 05:29:52.056 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:52.059 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:29:52.061 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] xbl_config_a is not in super partition metadata.
02-02 05:29:52.062 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:52.065 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:52.068 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] modem_b is not in super partition metadata.
02-02 05:29:52.070 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:52.074 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:29:52.076 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] modem_a is not in super partition metadata.
02-02 05:29:52.078 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:29:52.080 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old vendor sha256: PP6hwqvrz39WLV77uLr7oHNz3NTR2qvWHyOEYoVq21I= size: 555978752
02-02 05:29:52.081 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new vendor sha256: nkXGFVj5g3oUiS23XIhHZNbEKwb8xRbStSmNj6jh1EY= size: 555986944
02-02 05:29:52.083 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old boot sha256: vH9WnWS79CjwYu/lKt48ejpe7ha1RmdH3DjjYLF12SU= size: 67108864
02-02 05:29:52.084 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new boot sha256: UClelbkDimmYpCgV7UDVwxpyjFySTL+IvyXoig0KwfU= size: 67108864
02-02 05:29:52.085 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old system sha256: G/r19LtYGlIpWhdN8l+HKlT12TUVvUQJ+FgSMtNiIys= size: 822075392
02-02 05:29:52.087 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new system sha256: bcGrxKcPJL8vR0AjamVHBSJ9B1COHZn3kGjayJCDwaY= size: 822083584
02-02 05:29:52.088 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old vbmeta sha256: CPkwVpNFXtPBxWgMWwwpVOdDjZY68X5DAhWYDpSfBvU= size: 8192
02-02 05:29:52.089 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new vbmeta sha256: aLrhKe9ZWIZOc+PBqUO1+oePd82cpwQLQTzJJv7+1nY= size: 8192
02-02 05:29:52.091 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old dtbo sha256: Rgh6CyZaCx1ZSm/LN/X2rDgZwCxXMUwLSsJ91APZD+c= size: 8388608
02-02 05:29:52.092 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new dtbo sha256: 66/1wDxGbrC2iVD+V5Lyu7KNBCw7BYvFeE/KXPLNk94= size: 8388608
02-02 05:29:52.094 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old product sha256: Ik8h8aeCmY6Z9E8DZdI31RvaWm0KgaizPpRpU0jcPDI= size: 2062725120
02-02 05:29:52.095 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new product sha256: TwjPeEUDfYhox6CZJT67cYsk0rIN4+ZhmeWiPxzTwDk= size: 2068152320
02-02 05:29:52.097 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old system_ext sha256: Sj5dC0RZG/4vWa4DatC69zFVRQhNrI7DkIaYEFg/uTw= size: 232345600
02-02 05:29:52.098 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new system_ext sha256: IV0/ghxwFoZfG/VC3SlFBZHOrSCwSe+IvBjY+RR+TAA= size: 232349696
02-02 05:29:52.099 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old vbmeta_system sha256: Mth0DxHFBNea5c+fT/9Ez6WYwL4EU0hEL7/8XxsFs7U= size: 4096
02-02 05:29:52.101 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new vbmeta_system sha256: R1BPXOJPxW9SH9NctW6F6462cYHvNtkbr0y3iO02Q5I= size: 4096
02-02 05:29:52.102 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old abl sha256: W8NsPY7wEsLnb0DtdRvRNavELUlM49tih6IQUny9k8U= size: 1048576
02-02 05:29:52.104 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new abl sha256: W8NsPY7wEsLnb0DtdRvRNavELUlM49tih6IQUny9k8U= size: 1048576
02-02 05:29:52.105 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old aop sha256: nv52IezE2GymX7Kh2WyWUXEQJru9KzKtFW+GIVyrdcw= size: 167936
02-02 05:29:52.107 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new aop sha256: nv52IezE2GymX7Kh2WyWUXEQJru9KzKtFW+GIVyrdcw= size: 167936
02-02 05:29:52.109 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old devcfg sha256: Y4T5Ec4X7Wlc6HQaBiDikI09QGfTkCkevC9wrdZoCRg= size: 45056
02-02 05:29:52.110 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new devcfg sha256: Y4T5Ec4X7Wlc6HQaBiDikI09QGfTkCkevC9wrdZoCRg= size: 45056
02-02 05:29:52.112 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old hyp sha256: ChQcVcq4Y4K/D3CI1VBg595eez80/LgGrnxiOLXyQCI= size: 397312
02-02 05:29:52.113 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new hyp sha256: ChQcVcq4Y4K/D3CI1VBg595eez80/LgGrnxiOLXyQCI= size: 397312
02-02 05:29:52.116 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old keymaster sha256: wBeSJbT58X2LnZ+w4l9AjXIxY7gSevO1SigmXvq/M0A= size: 241664
02-02 05:29:52.118 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new keymaster sha256: wBeSJbT58X2LnZ+w4l9AjXIxY7gSevO1SigmXvq/M0A= size: 241664
02-02 05:29:52.120 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old qupfw sha256: 1nx7e7VXr82GSMK1PjPjpt7GEfIZ3GkD72VqjQTVK28= size: 53248
02-02 05:29:52.121 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new qupfw sha256: 1nx7e7VXr82GSMK1PjPjpt7GEfIZ3GkD72VqjQTVK28= size: 53248
02-02 05:29:52.122 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old tz sha256: rtREhZEcIb6+wHomTDWh2IiFGd3GO4NX99kH0TdyBmI= size: 2060288
02-02 05:29:52.124 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new tz sha256: rtREhZEcIb6+wHomTDWh2IiFGd3GO4NX99kH0TdyBmI= size: 2060288
02-02 05:29:52.125 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old uefisecapp sha256: mq1jqWvJERSIqxpQ7jk+GO1El1t/EsZBS544pMBsojM= size: 126976
02-02 05:29:52.126 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new uefisecapp sha256: mq1jqWvJERSIqxpQ7jk+GO1El1t/EsZBS544pMBsojM= size: 126976
02-02 05:29:52.128 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old xbl sha256: ub1giiWDFWmS4nUkmlAf7A6f5Z8no94BNBe444nfqz8= size: 3371008
02-02 05:29:52.129 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new xbl sha256: ub1giiWDFWmS4nUkmlAf7A6f5Z8no94BNBe444nfqz8= size: 3371008
02-02 05:29:52.130 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old xbl_config sha256: fxMUUD3raEcR/HTxlrpBhuhgEzoV5IaLut+UDYlvvk4= size: 90112
02-02 05:29:52.132 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new xbl_config sha256: fxMUUD3raEcR/HTxlrpBhuhgEzoV5IaLut+UDYlvvk4= size: 90112
02-02 05:29:52.135 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old modem sha256: jHw8Rv8xhX7ly2GbboL6/dcz1sZ/JSa9rbn/eKvfGVA= size: 74108928
02-02 05:29:52.137 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new modem sha256: jHw8Rv8xhX7ly2GbboL6/dcz1sZ/JSa9rbn/eKvfGVA= size: 74108928
02-02 05:29:52.139 1242 1242 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/dm-6 partition without O_DSYNC
02-02 05:29:52.142 1242 1242 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
02-02 05:29:52.144 1242 1242 I update_engine: [INFO:delta_performer.cc(397)] Applying 470 operations to partition "vendor"
02-02 05:29:52.146 1242 1242 I update_engine: [INFO:delta_performer.cc(657)] Starting to apply update payload operations
02-02 05:29:53.914 3414 4769 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
02-02 05:29:53.933 3414 7432 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
02-02 05:30:00.661 1242 1242 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/boot_a partition without O_DSYNC
02-02 05:30:00.667 1242 1242 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
02-02 05:30:00.670 1242 1242 I update_engine: [INFO:delta_performer.cc(397)] Applying 24 operations to partition "boot"
02-02 05:30:00.692 3414 8102 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.021).
02-02 05:30:00.732 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.021393.
02-02 05:30:00.877 3414 8102 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:00.880 3414 8102 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:00.884 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:00.888 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:00.893 3414 8102 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:00.897 3414 8102 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:00.901 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:00.906 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:02.012 1242 1242 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/dm-26 partition without O_DSYNC
02-02 05:30:02.019 1242 1242 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
02-02 05:30:02.026 1242 1242 I update_engine: [INFO:delta_performer.cc(397)] Applying 790 operations to partition "system"
02-02 05:30:03.664 1242 1242 I update_engine: [INFO:delta_performer.cc(209)] Completed 597/4975 operations (12%), 2505422/25334902 bytes downloaded (9%), overall progress 10%
02-02 05:30:05.532 3414 8008 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.104).
02-02 05:30:05.574 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.104118.
02-02 05:30:05.877 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:06.432 3414 4769 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
02-02 05:30:06.451 3414 7531 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
02-02 05:30:07.259 3414 8008 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.114).
02-02 05:30:07.308 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.114465.
02-02 05:30:07.459 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:08.389 3414 8008 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.125).
02-02 05:30:08.429 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.124812.
02-02 05:30:08.555 1242 1242 I update_engine: [INFO:delta_performer.cc(209)] Completed 1099/4975 operations (22%), 4569790/25334902 bytes downloaded (18%), overall progress 20%
02-02 05:30:08.560 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:08.569 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:08.572 3414 6083 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:08.576 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:08.579 3414 6083 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:08.582 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:08.586 3414 6083 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:08.590 3414 6083 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:09.021 3414 6083 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:09.383 3414 6083 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:10.395 3414 6083 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.270).
02-02 05:30:10.458 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.269671.
02-02 05:30:10.661 3414 6083 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:10.667 3414 6083 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:14.453 1242 1242 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/vbmeta_a partition without O_DSYNC
02-02 05:30:14.458 1242 1242 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
02-02 05:30:14.461 1242 1242 I update_engine: [INFO:delta_performer.cc(397)] Applying 2 operations to partition "vbmeta"
02-02 05:30:14.477 1242 1242 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/dtbo_a partition without O_DSYNC
02-02 05:30:14.481 1242 1242 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
02-02 05:30:14.484 1242 1242 I update_engine: [INFO:delta_performer.cc(397)] Applying 7 operations to partition "dtbo"
02-02 05:30:14.561 1242 1242 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/dm-29 partition without O_DSYNC
02-02 05:30:14.566 1242 1242 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
02-02 05:30:14.569 1242 1242 I update_engine: [INFO:delta_performer.cc(397)] Applying 1450 operations to partition "product"
02-02 05:30:18.894 1242 1242 I update_engine: [INFO:delta_performer.cc(209)] Completed 1592/4975 operations (32%), 7256750/25334902 bytes downloaded (28%), overall progress 30%
02-02 05:30:18.954 3414 4769 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
02-02 05:30:18.974 3414 7579 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
02-02 05:30:19.716 3414 8008 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.290).
02-02 05:30:19.754 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.290365.
02-02 05:30:19.810 1242 1242 I update_engine: [INFO:delta_performer.cc(209)] Completed 1647/4975 operations (33%), 12171918/25334902 bytes downloaded (48%), overall progress 40%
02-02 05:30:19.884 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:19.891 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:19.895 3414 6083 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:19.898 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:19.901 3414 6083 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:19.905 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:19.910 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:19.914 3414 6083 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:19.918 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:19.922 3414 6083 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:19.927 3414 6083 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:19.931 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:19.936 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:19.940 3414 6083 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:19.945 3414 6083 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:19.949 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:19.953 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:19.957 3414 6083 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:19.961 3414 6083 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:19.966 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:19.973 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:19.977 3414 6083 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:19.980 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:20.083 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:20.149 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:20.605 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:20.630 1242 1242 I update_engine: [INFO:delta_performer.cc(209)] Completed 1647/4975 operations (33%), 17234526/25334902 bytes downloaded (68%), overall progress 50%
02-02 05:30:20.648 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:20.686 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:20.724 3414 8008 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.704).
02-02 05:30:20.785 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.704248.
02-02 05:30:20.929 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:20.936 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:20.940 3414 6083 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:20.944 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:20.947 3414 6083 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:20.951 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:20.955 3414 6083 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:20.990 3414 6083 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:29.386 1242 1242 I update_engine: [INFO:delta_performer.cc(209)] Completed 2090/4975 operations (42%), 20167246/25334902 bytes downloaded (79%), overall progress 60%
02-02 05:30:29.588 3414 6083 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.797).
02-02 05:30:29.631 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.797371.
02-02 05:30:29.825 3414 6083 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:29.830 3414 6083 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:29.835 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:29.839 3414 6083 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:29.844 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:29.848 3414 6083 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:29.853 3414 6083 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:29.858 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:29.863 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:29.868 3414 6083 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:29.874 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:29.878 3414 6083 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:29.883 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:31.478 3414 4769 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
02-02 05:30:31.496 3414 7587 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
02-02 05:30:31.580 3414 3516 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
02-02 05:30:31.658 3414 7587 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
02-02 05:30:34.952 3414 3516 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
02-02 05:30:34.982 3414 7587 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
02-02 05:30:35.639 1242 1242 I update_engine: [INFO:delta_performer.cc(209)] Completed 2388/4975 operations (48%), 23476782/25334902 bytes downloaded (92%), overall progress 70%
02-02 05:30:43.815 1242 1242 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/dm-32 partition without O_DSYNC
02-02 05:30:43.820 1242 1242 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
02-02 05:30:43.823 1242 1242 I update_engine: [INFO:delta_performer.cc(397)] Applying 274 operations to partition "system_ext"
02-02 05:30:43.999 3414 3516 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
02-02 05:30:44.022 3414 7590 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
02-02 05:30:46.146 3414 8008 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.928).
02-02 05:30:46.195 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.928003.
02-02 05:30:46.356 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:46.360 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:47.189 3414 8008 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.949).
02-02 05:30:47.234 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.948697.
02-02 05:30:47.393 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:47.398 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:47.403 3414 6083 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:47.408 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:47.412 3414 6083 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
02-02 05:30:47.529 1242 1242 I update_engine: [INFO:delta_performer.cc(209)] Completed 3000/4975 operations (60%), 25334902/25334902 bytes downloaded (100%), overall progress 80%
02-02 05:30:48.132 1242 1242 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/vbmeta_system_a partition without O_DSYNC
02-02 05:30:48.139 1242 1242 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
02-02 05:30:48.143 1242 1242 I update_engine: [INFO:delta_performer.cc(397)] Applying 1 operations to partition "vbmeta_system"
02-02 05:30:48.161 1242 1242 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/abl_a partition without O_DSYNC
02-02 05:30:48.166 1242 1242 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
02-02 05:30:48.169 1242 1242 I update_engine: [INFO:delta_performer.cc(397)] Applying 1 operations to partition "abl"
02-02 05:30:48.199 1242 1242 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/aop_a partition without O_DSYNC
02-02 05:30:48.205 1242 1242 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
02-02 05:30:48.208 1242 1242 I update_engine: [INFO:delta_performer.cc(397)] Applying 3 operations to partition "aop"
02-02 05:30:48.229 1242 1242 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/devcfg_a partition without O_DSYNC
02-02 05:30:48.234 1242 1242 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
02-02 05:30:48.237 1242 1242 I update_engine: [INFO:delta_performer.cc(397)] Applying 1 operations to partition "devcfg"
02-02 05:30:48.249 1242 1242 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/hyp_a partition without O_DSYNC
02-02 05:30:48.255 1242 1242 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
02-02 05:30:48.258 1242 1242 I update_engine: [INFO:delta_performer.cc(397)] Applying 2 operations to partition "hyp"
02-02 05:30:48.274 1242 1242 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/keymaster_a partition without O_DSYNC
02-02 05:30:48.279 1242 1242 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
02-02 05:30:48.281 1242 1242 I update_engine: [INFO:delta_performer.cc(397)] Applying 3 operations to partition "keymaster"
02-02 05:30:48.300 1242 1242 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/qupfw_a partition without O_DSYNC
02-02 05:30:48.304 1242 1242 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
02-02 05:30:48.307 1242 1242 I update_engine: [INFO:delta_performer.cc(397)] Applying 1 operations to partition "qupfw"
02-02 05:30:48.317 1242 1242 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/tz_a partition without O_DSYNC
02-02 05:30:48.321 1242 1242 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
02-02 05:30:48.324 1242 1242 I update_engine: [INFO:delta_performer.cc(397)] Applying 21 operations to partition "tz"
02-02 05:30:48.420 1242 1242 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/uefisecapp_a partition without O_DSYNC
02-02 05:30:48.424 1242 1242 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
02-02 05:30:48.428 1242 1242 I update_engine: [INFO:delta_performer.cc(397)] Applying 3 operations to partition "uefisecapp"
02-02 05:30:48.447 1242 1242 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/xbl_a partition without O_DSYNC
02-02 05:30:48.452 1242 1242 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
02-02 05:30:48.455 1242 1242 I update_engine: [INFO:delta_performer.cc(397)] Applying 6 operations to partition "xbl"
02-02 05:30:48.615 1242 1242 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/xbl_config_a partition without O_DSYNC
02-02 05:30:48.625 1242 1242 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
02-02 05:30:48.629 1242 1242 I update_engine: [INFO:delta_performer.cc(397)] Applying 4 operations to partition "xbl_config"
02-02 05:30:48.663 1242 1242 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/modem_a partition without O_DSYNC
02-02 05:30:48.671 1242 1242 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
02-02 05:30:48.675 1242 1242 I update_engine: [INFO:delta_performer.cc(397)] Applying 1912 operations to partition "modem"
02-02 05:30:51.427 1242 1242 I update_engine: [INFO:delta_performer.cc(209)] Completed 3980/4975 operations (80%), 25334902/25334902 bytes downloaded (100%), overall progress 90%
02-02 05:30:54.351 1242 1242 I update_engine: [INFO:delta_performer.cc(209)] Completed 4975/4975 operations (100%), 25334902/25334902 bytes downloaded (100%), overall progress 100%
02-02 05:30:54.355 1242 1242 I update_engine: [INFO:delta_performer.cc(1665)] Extracted signature data of size 523 at 25066283
02-02 05:30:54.358 1242 1242 I update_engine: [INFO:multi_range_http_fetcher.cc(115)] Terminating transfer.
02-02 05:30:54.360 1242 1242 I update_engine: [INFO:libcurl_http_fetcher.cc(548)] Requesting libcurl to terminate transfer.
02-02 05:30:54.367 1242 1242 I update_engine: [INFO:multi_range_http_fetcher.cc(177)] Received transfer terminated.
02-02 05:30:54.372 1242 1242 I update_engine: [INFO:multi_range_http_fetcher.cc(129)] TransferEnded w/ code 206
02-02 05:30:54.373 1242 1242 I update_engine: [INFO:multi_range_http_fetcher.cc(163)] Done w/ all transfers
02-02 05:30:54.646 1242 1242 I update_engine: [INFO:delta_performer.cc(1693)] Verifying using certificates: /system/etc/security/otacerts.zip
02-02 05:30:54.653 1242 1242 I update_engine: [INFO:payload_verifier.cc(102)] signature blob size = 523
02-02 05:30:54.656 1242 1242 I update_engine: [INFO:payload_verifier.cc(118)] Truncating the signature to its unpadded size: 512.
02-02 05:30:54.659 1242 1242 I update_engine: [INFO:payload_verifier.cc(129)] Verified correct signature 1 out of 1 signatures.
02-02 05:30:54.663 1242 1242 I update_engine: [INFO:delta_performer.cc(1915)] Payload hash matches value in payload.
02-02 05:30:54.667 1242 1242 I update_engine: [INFO:download_action.cc(400)] Collections of histograms for UpdateEngine.DownloadAction.
02-02 05:30:54.667 1242 1242 I update_engine: Histogram: UpdateEngine.DownloadAction.InstallOperation::PUFFDIFF.Duration recorded 6 samples, mean = 950.2
02-02 05:30:54.667 1242 1242 I update_engine: 0 ...
02-02 05:30:54.667 1242 1242 I update_engine: 32 ------------------------------------------------------------------------O (1 = 16.7%) {0.0%}
02-02 05:30:54.667 1242 1242 I update_engine: 57 ------------------------------------------------------------------------O (1 = 16.7%) {16.7%}
02-02 05:30:54.667 1242 1242 I update_engine: 101 O (0 = 0.0%) {33.3%}
02-02 05:30:54.667 1242 1242 I update_engine: 179 ------------------------------------------------------------------------O (1 = 16.7%) {33.3%}
02-02 05:30:54.667 1242 1242 I update_engine: 317 O (0 = 0.0%) {50.0%}
02-02 05:30:54.667 1242 1242 I update_engine: 561 ------------------------------------------------------------------------O (1 = 16.7%) {50.0%}
02-02 05:30:54.667 1242 1242 I update_engine: 993 ------------------------------------------------------------------------O (1 = 16.7%) {66.7%}
02-02 05:30:54.667 1242 1242 I update_engine: 1758 O (0 = 0.0%) {83.3%}
02-02 05:30:54.667 1242 1242 I update_engine: 3112 ------------------------------------------------------------------------O (1 = 16.7%) {83.3%}
02-02 05:30:54.667 1242 1242 I update_engine: 5509 ...
02-02 05:30:54.667 1242 1242 I update_engine:
02-02 05:30:54.667 1242 1242 I update_engine: Histogram: UpdateEngine.DownloadAction.InstallOperation::REPLACE.Duration recorded 99 samples, mean = 0.6
02-02 05:30:54.667 1242 1242 I update_engine: 0 ------------------------------------------------------------------------O (97 = 98.0%)
02-02 05:30:54.667 1242 1242 I update_engine: 10 -O (1 = 1.0%) {98.0%}
02-02 05:30:54.667 1242 1242 I update_engine: 18 O (0 = 0.0%) {99.0%}
02-02 05:30:54.667 1242 1242 I update_engine: 32 -O (1 = 1.0%) {99.0%}
02-02 05:30:54.667 1242 1242 I update_engine: 57 ...
02-02 05:30:54.667 1242 1242 I update_engine:
02-02 05:30:54.667 1242 1242 I update_engine: Histogram: UpdateEngine.DownloadAction.InstallOperation::SOURCE_BSDIFF.Duration recorded 465 samples, mean = 13.2
02-02 05:30:54.667 1242 1242 I update_engine: 0 ------------------------------------------------------------------------O (401 = 86.2%)
02-02 05:30:54.667 1242 1242 I update_engine: 10 -------O (39 = 8.4%) {86.2%}
02-02 05:30:54.667 1242 1242 I update_engine: 18 --O (11 = 2.4%) {94.6%}
02-02 05:30:54.667 1242 1242 I update_engine: 32 O (1 = 0.2%) {97.0%}
02-02 05:30:54.667 1242 1242 I update_engine: 57 -O (4 = 0.9%) {97.2%}
02-02 05:30:54.667 1242 1242 I update_engine: 101 -O (4 = 0.9%) {98.1%}
02-02 05:30:54.667 1242 1242 I update_engine: 179 O (2 = 0.4%) {98.9%}
02-02 05:30:54.667 1242 1242 I update_engine: 317 O (2 = 0.4%) {99.4%}
02-02 05:30:54.667 1242 1242 I update_engine: 561 O (1 = 0.2%) {99.8%}
02-02 05:30:54.667 1242 1242 I update_engine: 993 ...
02-02 05:30:54.667 1242 1242 I update_engine:
02-02 05:30:54.667 1242 1242 I update_engine: Histogram: UpdateEngine.DownloadAction.InstallOperation::SOURCE_COPY.Duration recorded 3405 samples, mean = 10.8
02-02 05:30:54.667 1242 1242 I update_engine: 0 ------------------------------------------------------------------------O (1767 = 51.9%)
02-02 05:30:54.667 1242 1242 I update_engine: 10 -----------------------------------------O (1007 = 29.6%) {51.9%}
02-02 05:30:54.667 1242 1242 I update_engine: 18 ------------------------O (596 = 17.5%) {81.5%}
02-02 05:30:54.667 1242 1242 I update_engine: 32 -O (34 = 1.0%) {99.0%}
02-02 05:30:54.667 1242 1242 I update_engine: 57 O (1 = 0.0%) {100.0%}
02-02 05:30:54.667 1242 1242 I update_engine: 101 ...
02-02 05:30:54.667 1242 1242 I update_engine:
02-02 05:30:54.667 1242 1242 I update_engine: Histogram: UpdateEngine.DownloadAction.InstallOperation::ZERO_OR_DISCARD.Duration recorded 1000 samples, mean = 1.3
02-02 05:30:54.667 1242 1242 I update_engine: 0 ------------------------------------------------------------------------O (976 = 97.6%)
02-02 05:30:54.667 1242 1242 I update_engine: 10 -O (11 = 1.1%) {97.6%}
02-02 05:30:54.667 1242 1242 I update_engine: 18 O (6 = 0.6%) {98.7%}
02-02 05:30:54.667 1242 1242 I update_engine: 32 O (0 = 0.0%) {99.3%}
02-02 05:30:54.667 1242 1242 I update_engine: 57 O (3 = 0.3%) {99.3%}
02-02 05:30:54.667 1242 1242 I update_engine: 101 O (4 = 0.4%) {99.6%}
02-02 05:30:54.667 1242 1242 I update_engine: 179 ...
02-02 05:30:54.667 1242 1242 I update_engine:
02-02 05:30:54.676 3414 8008 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.000).
02-02 05:30:54.717 1242 1242 I update_engine: [INFO:action_processor.cc(116)] ActionProcessor: finished DownloadAction with code ErrorCode::kSuccess
02-02 05:30:54.728 1242 1242 I update_engine: [INFO:action_processor.cc(143)] ActionProcessor: starting FilesystemVerifierAction
02-02 05:30:54.730 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x211, isSetupWizard=false.
02-02 05:30:54.731 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 0 (vendor) on device /dev/block/dm-6
02-02 05:30:54.960 3414 8008 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:30:56.512 3414 3516 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
02-02 05:30:56.522 3414 7597 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
02-02 05:30:58.230 1242 1242 I update_engine: [INFO:verity_writer_android.cc(93)] Writing verity hash tree to /dev/block/dm-6
02-02 05:30:58.253 1242 1242 I update_engine: [INFO:verity_writer_android.cc(105)] Writing verity FEC to /dev/block/dm-6
02-02 05:31:09.039 3414 3516 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
02-02 05:31:09.060 3414 7623 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
02-02 05:31:21.559 3414 3516 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
02-02 05:31:21.573 3414 7627 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
02-02 05:31:28.251 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of vendor: nkXGFVj5g3oUiS23XIhHZNbEKwb8xRbStSmNj6jh1EY=
02-02 05:31:28.533 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 1 (boot) on device /dev/block/bootdevice/by-name/boot_a
02-02 05:31:28.742 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of boot: UClelbkDimmYpCgV7UDVwxpyjFySTL+IvyXoig0KwfU=
02-02 05:31:28.768 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 2 (system) on device /dev/block/dm-26
02-02 05:31:33.477 1242 1242 I update_engine: [INFO:verity_writer_android.cc(93)] Writing verity hash tree to /dev/block/dm-26
02-02 05:31:33.514 1242 1242 I update_engine: [INFO:verity_writer_android.cc(105)] Writing verity FEC to /dev/block/dm-26
02-02 05:31:34.953 3414 3516 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
02-02 05:31:34.969 3414 7644 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
02-02 05:32:18.020 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of system: bcGrxKcPJL8vR0AjamVHBSJ9B1COHZn3kGjayJCDwaY=
02-02 05:32:18.331 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 3 (vbmeta) on device /dev/block/bootdevice/by-name/vbmeta_a
02-02 05:32:18.334 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of vbmeta: aLrhKe9ZWIZOc+PBqUO1+oePd82cpwQLQTzJJv7+1nY=
02-02 05:32:18.336 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 4 (dtbo) on device /dev/block/bootdevice/by-name/dtbo_a
02-02 05:32:18.365 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of dtbo: 66/1wDxGbrC2iVD+V5Lyu7KNBCw7BYvFeE/KXPLNk94=
02-02 05:32:18.370 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 5 (product) on device /dev/block/dm-29
02-02 05:32:30.294 1242 1242 I update_engine: [INFO:verity_writer_android.cc(93)] Writing verity hash tree to /dev/block/dm-29
02-02 05:32:30.379 1242 1242 I update_engine: [INFO:verity_writer_android.cc(105)] Writing verity FEC to /dev/block/dm-29
02-02 05:32:33.717 3414 3516 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
02-02 05:32:33.735 3414 7703 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
02-02 05:32:46.232 3414 3516 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
02-02 05:32:46.242 3414 7719 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
02-02 05:33:27.126 3414 3516 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
02-02 05:33:27.151 3414 7744 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
02-02 05:33:34.951 3414 3516 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
02-02 05:33:34.971 3414 7746 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
02-02 05:33:39.650 3414 3516 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
02-02 05:33:39.669 3414 7746 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
02-02 05:33:52.176 3414 3516 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
02-02 05:33:52.189 3414 7748 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
02-02 05:34:08.200 3414 7759 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
02-02 05:34:10.597 3414 7759 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
02-02 05:34:10.790 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x211, isSetupWizard=false.
02-02 05:34:25.644 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of product: TwjPeEUDfYhox6CZJT67cYsk0rIN4+ZhmeWiPxzTwDk=
02-02 05:34:26.573 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 6 (system_ext) on device /dev/block/dm-32
02-02 05:34:27.861 1242 1242 I update_engine: [INFO:verity_writer_android.cc(93)] Writing verity hash tree to /dev/block/dm-32
02-02 05:34:27.872 1242 1242 I update_engine: [INFO:verity_writer_android.cc(105)] Writing verity FEC to /dev/block/dm-32
02-02 05:34:34.958 3414 3516 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
02-02 05:34:34.984 3414 7785 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
02-02 05:34:40.408 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of system_ext: IV0/ghxwFoZfG/VC3SlFBZHOrSCwSe+IvBjY+RR+TAA=
02-02 05:34:40.515 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 7 (vbmeta_system) on device /dev/block/bootdevice/by-name/vbmeta_system_a
02-02 05:34:40.519 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of vbmeta_system: R1BPXOJPxW9SH9NctW6F6462cYHvNtkbr0y3iO02Q5I=
02-02 05:34:40.521 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 8 (abl) on device /dev/block/bootdevice/by-name/abl_a
02-02 05:34:40.526 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of abl: W8NsPY7wEsLnb0DtdRvRNavELUlM49tih6IQUny9k8U=
02-02 05:34:40.528 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 9 (aop) on device /dev/block/bootdevice/by-name/aop_a
02-02 05:34:40.532 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of aop: nv52IezE2GymX7Kh2WyWUXEQJru9KzKtFW+GIVyrdcw=
02-02 05:34:40.534 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 10 (devcfg) on device /dev/block/bootdevice/by-name/devcfg_a
02-02 05:34:40.537 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of devcfg: Y4T5Ec4X7Wlc6HQaBiDikI09QGfTkCkevC9wrdZoCRg=
02-02 05:34:40.538 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 11 (hyp) on device /dev/block/bootdevice/by-name/hyp_a
02-02 05:34:40.542 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of hyp: ChQcVcq4Y4K/D3CI1VBg595eez80/LgGrnxiOLXyQCI=
02-02 05:34:40.544 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 12 (keymaster) on device /dev/block/bootdevice/by-name/keymaster_a
02-02 05:34:40.549 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of keymaster: wBeSJbT58X2LnZ+w4l9AjXIxY7gSevO1SigmXvq/M0A=
02-02 05:34:40.550 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 13 (qupfw) on device /dev/block/bootdevice/by-name/qupfw_a
02-02 05:34:40.552 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of qupfw: 1nx7e7VXr82GSMK1PjPjpt7GEfIZ3GkD72VqjQTVK28=
02-02 05:34:40.554 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 14 (tz) on device /dev/block/bootdevice/by-name/tz_a
02-02 05:34:40.563 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of tz: rtREhZEcIb6+wHomTDWh2IiFGd3GO4NX99kH0TdyBmI=
02-02 05:34:40.565 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 15 (uefisecapp) on device /dev/block/bootdevice/by-name/uefisecapp_a
02-02 05:34:40.568 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of uefisecapp: mq1jqWvJERSIqxpQ7jk+GO1El1t/EsZBS544pMBsojM=
02-02 05:34:40.569 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 16 (xbl) on device /dev/block/bootdevice/by-name/xbl_a
02-02 05:34:40.582 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of xbl: ub1giiWDFWmS4nUkmlAf7A6f5Z8no94BNBe444nfqz8=
02-02 05:34:40.585 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 17 (xbl_config) on device /dev/block/bootdevice/by-name/xbl_config_a
02-02 05:34:40.587 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of xbl_config: fxMUUD3raEcR/HTxlrpBhuhgEzoV5IaLut+UDYlvvk4=
02-02 05:34:40.588 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 18 (modem) on device /dev/block/bootdevice/by-name/modem_a
02-02 05:34:40.817 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of modem: jHw8Rv8xhX7ly2GbboL6/dcz1sZ/JSa9rbn/eKvfGVA=
02-02 05:34:40.851 1242 1242 I update_engine: [INFO:action_processor.cc(116)] ActionProcessor: finished FilesystemVerifierAction with code ErrorCode::kSuccess
02-02 05:34:40.852 1242 1242 I update_engine: [INFO:action_processor.cc(143)] ActionProcessor: starting PostinstallRunnerAction
02-02 05:34:40.856 3414 17425 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.000).
02-02 05:34:40.858 1242 1242 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-6 and mountable device /dev/block/dm-6
02-02 05:34:40.862 1242 1242 I update_engine: [INFO:postinstall_runner_action.cc(181)] Format file for new bin/checkpoint_gc is: data
02-02 05:34:41.026 1242 1242 I update_engine: [INFO:subprocess.cc(157)] Subprocess output:
02-02 05:34:41.026 1242 1242 I update_engine: realpath: /dev/block/dm-8: Permission denied
02-02 05:34:41.052 3414 17425 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:34:41.055 3414 17425 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:34:41.059 1242 1242 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-26 and mountable device /dev/block/dm-26
02-02 05:34:41.064 1242 1242 I update_engine: [INFO:postinstall_runner_action.cc(181)] Format file for new system/bin/otapreopt_script is: data
02-02 05:34:48.691 3414 3516 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
02-02 05:34:48.708 3414 7791 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
02-02 05:34:51.336 3414 17426 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.510).
02-02 05:34:51.369 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.510000.
02-02 05:34:51.485 3414 17426 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:35:02.875 3414 17425 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.520).
02-02 05:35:02.918 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.520000.
02-02 05:35:03.044 3414 17425 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:35:12.406 3414 17425 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.530).
02-02 05:35:12.450 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.530000.
02-02 05:35:12.582 3414 17425 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:35:21.873 3414 17425 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.540).
02-02 05:35:21.920 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.540000.
02-02 05:35:22.070 3414 17425 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:35:31.257 3414 17425 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.550).
02-02 05:35:31.302 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.550000.
02-02 05:35:31.431 3414 17425 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:35:34.955 3414 3516 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
02-02 05:35:34.971 3414 8722 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
02-02 05:35:42.532 3414 17425 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.560).
02-02 05:35:42.576 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.560000.
02-02 05:35:42.782 3414 17425 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:35:51.941 3414 17425 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.570).
02-02 05:35:51.984 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.570000.
02-02 05:35:52.110 3414 17425 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:36:03.598 3414 17426 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.580).
02-02 05:36:03.643 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.580000.
02-02 05:36:03.797 3414 17426 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:36:11.494 3414 17426 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.590).
02-02 05:36:11.541 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.590000.
02-02 05:36:11.664 3414 17426 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:36:22.922 3414 17426 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.600).
02-02 05:36:22.965 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.600000.
02-02 05:36:23.085 3414 17426 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:36:32.518 3414 17426 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.610).
02-02 05:36:32.568 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.610000.
02-02 05:36:32.718 3414 17426 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:36:34.956 3414 3516 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
02-02 05:36:34.983 3414 9906 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
02-02 05:36:42.408 3414 4801 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.620).
02-02 05:36:42.454 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.620000.
02-02 05:36:42.588 3414 4801 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:36:52.051 3414 4801 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.630).
02-02 05:36:52.097 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.630000.
02-02 05:36:52.253 3414 4801 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:37:03.481 3414 17425 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.640).
02-02 05:37:03.524 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.640000.
02-02 05:37:03.664 3414 17425 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:37:13.096 3414 17425 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.650).
02-02 05:37:13.140 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.650000.
02-02 05:37:13.282 3414 17425 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:37:22.678 3414 17425 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.660).
02-02 05:37:22.723 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.660000.
02-02 05:37:22.863 3414 17425 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:37:32.200 3414 4801 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.670).
02-02 05:37:32.248 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.670000.
02-02 05:37:32.384 3414 4801 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:37:34.966 3414 3516 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
02-02 05:37:34.990 3414 11196 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
02-02 05:37:43.838 3414 4801 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.680).
02-02 05:37:43.883 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.680000.
02-02 05:37:44.017 3414 4801 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:37:53.410 3414 4801 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.690).
02-02 05:37:53.459 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.690000.
02-02 05:37:53.596 3414 4801 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:38:02.966 3414 4801 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.700).
02-02 05:38:03.011 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.700000.
02-02 05:38:03.146 3414 4801 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:38:12.609 3414 4801 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.710).
02-02 05:38:12.653 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.710000.
02-02 05:38:12.789 3414 4801 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:38:22.215 3414 4801 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.720).
02-02 05:38:22.260 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.720000.
02-02 05:38:22.398 3414 4801 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:38:33.615 3414 17425 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.730).
02-02 05:38:33.661 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.730000.
02-02 05:38:33.801 3414 17425 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:38:34.955 3414 3516 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
02-02 05:38:34.975 3414 12377 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
02-02 05:38:42.911 3414 17425 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.740).
02-02 05:38:42.959 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.740000.
02-02 05:38:43.094 3414 17425 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:38:52.531 3414 17425 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.750).
02-02 05:38:52.577 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.750000.
02-02 05:38:52.720 3414 17425 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:39:01.894 3414 4801 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.760).
02-02 05:39:01.942 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.760000.
02-02 05:39:02.091 3414 4801 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:39:11.553 3414 3516 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
02-02 05:39:11.572 3414 13146 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
02-02 05:39:13.391 3414 4801 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.770).
02-02 05:39:13.437 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.770000.
02-02 05:39:13.578 3414 4801 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:39:21.781 3414 13344 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
02-02 05:39:23.084 3414 17425 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.780).
02-02 05:39:23.252 3414 17425 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:39:25.299 3414 13344 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
02-02 05:39:25.365 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x211, isSetupWizard=false.
02-02 05:39:28.912 3414 13344 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
02-02 05:39:31.796 3414 13344 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
02-02 05:39:31.889 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x211, isSetupWizard=false.
02-02 05:39:32.544 3414 17426 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.790).
02-02 05:39:32.586 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.790000.
02-02 05:39:32.733 3414 17426 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:39:34.964 3414 3516 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
02-02 05:39:34.987 3414 13344 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
02-02 05:39:42.197 3414 3447 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.800).
02-02 05:39:42.241 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.800000.
02-02 05:39:42.377 3414 3447 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:39:53.454 3414 5172 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.810).
02-02 05:39:53.500 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.810000.
02-02 05:39:53.644 3414 5172 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:40:02.243 3414 14172 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
02-02 05:40:03.011 3414 17426 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.820).
02-02 05:40:03.177 3414 17426 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:40:03.944 3414 14172 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
02-02 05:40:04.101 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x211, isSetupWizard=false.
02-02 05:40:12.530 3414 17425 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.830).
02-02 05:40:12.576 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.830000.
02-02 05:40:12.728 3414 17425 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:40:14.057 3414 3516 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
02-02 05:40:14.082 3414 14396 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
02-02 05:40:22.261 3414 17426 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.840).
02-02 05:40:22.306 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.840000.
02-02 05:40:22.462 3414 17426 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:40:34.035 3414 17425 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.850).
02-02 05:40:34.078 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.850000.
02-02 05:40:34.231 3414 17425 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:40:34.964 3414 3516 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
02-02 05:40:34.990 3414 14795 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
02-02 05:40:43.564 3414 17425 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.860).
02-02 05:40:43.616 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.860000.
02-02 05:40:43.775 3414 17425 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:40:53.180 3414 17425 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.870).
02-02 05:40:53.224 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.870000.
02-02 05:40:53.367 3414 17425 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:41:02.945 3414 17425 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.880).
02-02 05:41:02.994 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.880000.
02-02 05:41:03.138 3414 17425 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:41:14.230 3414 17425 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.890).
02-02 05:41:14.271 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.890000.
02-02 05:41:14.402 3414 17425 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:41:23.678 3414 17425 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.900).
02-02 05:41:23.726 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.900000.
02-02 05:41:23.861 3414 17425 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:41:34.956 3414 3516 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
02-02 05:41:34.968 3414 16023 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
02-02 05:41:35.399 3414 17426 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.910).
02-02 05:41:35.439 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.910000.
02-02 05:41:35.564 3414 17426 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:41:42.915 3414 17426 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.920).
02-02 05:41:42.955 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.920000.
02-02 05:41:43.072 3414 17426 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:41:54.316 3414 17426 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.930).
02-02 05:41:54.360 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.930000.
02-02 05:41:54.506 3414 17426 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:42:03.870 3414 17426 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.940).
02-02 05:42:03.924 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.940000.
02-02 05:42:04.079 3414 17426 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:42:13.482 3414 17426 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.950).
02-02 05:42:13.534 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.950000.
02-02 05:42:13.693 3414 17426 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:42:23.090 3414 17425 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.960).
02-02 05:42:23.133 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.960000.
02-02 05:42:23.292 3414 17425 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:42:32.778 3414 17425 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.970).
02-02 05:42:32.821 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.970000.
02-02 05:42:32.957 3414 17425 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:42:44.360 3414 17426 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.980).
02-02 05:42:44.408 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.980000.
02-02 05:42:44.554 3414 17426 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:42:54.068 3414 17425 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.990).
02-02 05:42:54.113 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.990000.
02-02 05:42:54.238 3414 17425 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:42:57.264 3414 17496 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
02-02 05:43:04.001 3414 17425 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 1.000).
02-02 05:43:04.192 3414 17425 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:43:05.869 3414 17425 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 1.000).
02-02 05:43:05.952 1242 1242 I update_engine: [INFO:subprocess.cc(157)] Subprocess output:
02-02 05:43:05.952 1242 1242 I update_engine: Complete or error.
02-02 05:43:05.958 1242 1242 I update_engine: [INFO:postinstall_runner_action.cc(371)] All post-install commands succeeded
02-02 05:43:05.969 1242 1242 I update_engine: [INFO:action_processor.cc(116)] ActionProcessor: finished last action PostinstallRunnerAction with code ErrorCode::kUpdatedButNotActive
02-02 05:43:05.974 1242 1242 I update_engine: [INFO:update_attempter_android.cc(522)] Processing Done.
02-02 05:43:05.976 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(263)] Destroying [product_a, system_a, system_ext_a, vendor_a] from device mapper
02-02 05:43:05.999 1242 1242 I update_engine: [libfs_mgr]Unmapped logical partition product_a
02-02 05:43:06.055 1242 1242 I update_engine: Successfully unmapped snapshot product_a
02-02 05:43:06.061 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(249)] Successfully unmapped product_a from device mapper.
02-02 05:43:06.073 3414 17425 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:43:06.074 3414 17425 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
02-02 05:43:06.086 1242 1242 I update_engine: [libfs_mgr]Unmapped logical partition system_a
02-02 05:43:06.126 1242 1242 I update_engine: Successfully unmapped snapshot system_a
02-02 05:43:06.130 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(249)] Successfully unmapped system_a from device mapper.
02-02 05:43:06.149 1242 1242 I update_engine: [libfs_mgr]Unmapped logical partition system_ext_a
02-02 05:43:06.196 1242 1242 I update_engine: Successfully unmapped snapshot system_ext_a
02-02 05:43:06.201 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(249)] Successfully unmapped system_ext_a from device mapper.
02-02 05:43:06.216 1242 1242 I update_engine: [libfs_mgr]Unmapped logical partition vendor_a
02-02 05:43:06.263 1242 1242 I update_engine: Successfully unmapped snapshot vendor_a
02-02 05:43:06.267 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(249)] Successfully unmapped vendor_a from device mapper.
02-02 05:43:06.274 3414 17425 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.000).
02-02 05:43:06.291 1242 1242 I update_engine: [INFO:metrics_reporter_android.cc(131)] Current update attempt downloads 24 bytes data
02-02 05:43:06.579 3414 17425 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x000.
02-02 05:43:06.665 3414 17425 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x000.
02-02 05:43:06.751 3414 7192 I SystemUpdate: [Execution,SynchronizedUpdateEngine] stop()
02-02 05:43:06.751 3414 7192 I SystemUpdate: [Execution,ExecutionManager] Action streaming-apply executed for 798.11 seconds.
02-02 05:43:06.796 3414 7192 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x110, -1.000).
02-02 05:43:07.174 3414 7192 I SystemUpdate: [Execution,ExecutionManager] Action ab-reboot executed for 0.42 seconds.
02-02 05:43:28.555 3414 17854 I SystemUpdate: [Installation,ReceiverIntentOperation] Received intent: Intent { act=com.google.android.gms.update.RESUME_ON_REBOOOT_LSKF_CAPTURED cat=[targeted_intent_op_prefix:.update.control.ReceiverIntentOperation] cmp=com.google.android.gms/.chimera.GmsIntentOperationService }.
02-02 05:43:28.575 3414 17855 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 12.
02-02 05:43:28.581 3414 17855 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 }.
02-02 05:43:28.610 3414 17855 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x110, -1.000).
02-02 05:43:28.770 3414 17855 I SystemUpdate: [Execution,ExecutionManager] Action ab-reboot executed for 0.19 seconds.
02-02 05:43:59.764 3414 17898 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
02-02 05:43:59.773 3414 17898 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 }.
02-02 05:43:59.822 3414 17898 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x110, -1.000).
02-02 05:43:59.859 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x110, isSetupWizard=false.
02-02 05:44:00.031 3414 17898 I SystemUpdate: [Execution,ExecutionManager] Action ab-reboot executed for 0.26 seconds.
02-02 05:44:32.574 3414 17917 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
02-02 05:44:32.581 3414 17917 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 }.
02-02 05:44:32.624 3414 17917 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x110, -1.000).
02-02 05:44:32.824 3414 17917 I SystemUpdate: [Execution,ExecutionManager] Action ab-reboot executed for 0.24 seconds.
02-02 05:45:33.937 3414 17935 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
02-02 05:45:33.946 3414 17938 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 }.
02-02 05:45:34.039 3414 17938 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x110, -1.000).
02-02 05:45:34.093 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x110, isSetupWizard=false.
02-02 05:45:34.246 3414 17938 I SystemUpdate: [Execution,ExecutionManager] Action ab-reboot executed for 0.29 seconds.
02-02 05:45:40.462 3414 17938 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 105.
02-02 05:45:40.470 3414 17938 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 }.
02-02 05:45:40.526 3414 17938 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x310, -1.000).
02-02 05:45:40.571 7152 7152 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x310, isSetupWizard=false.
02-02 05:45:40.843 3414 17938 I SystemUpdate: [Execution,SynchronizedUpdateEngine] start(axof{url=file:///data/ota_package/payload_metadata.bin, payload_binary_file.offset=0, payload_binary_file.length=25334902, properties=[FILE_HASH=wg/Tl36M4QHpc0Suqw5jV6QXqftXk/VrGzQBRm31wy0=, FILE_SIZE=25334902, METADATA_HASH=DJIX8ufxy9HSEsFGHqO/yQOeL5vkpSsGh+FUQmIi4a0=, METADATA_SIZE=267573]}, additionalProperties.size=3)
02-02 05:45:40.843 3414 17938 I SystemUpdate: [Execution,UpdateEngineDelegate] applyPayload()
02-02 05:45:40.858 1242 1242 I update_engine: [INFO:update_attempter_android.cc(280)] Using this install plan:
02-02 05:45:40.862 1242 1242 I update_engine: [INFO:install_plan.cc(91)] InstallPlan: resume, version: , source_slot: B, target_slot: A, url: file:///data/ota_package/payload_metadata.bin, payload: (size: 25334902, metadata_size: 267573, metadata signature: , hash: C20FD3977E8CE101E97344AEAB0E6357A417A9FB5793F56B1B3401466DF5C32D, 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
02-02 05:45:40.864 1242 1242 I update_engine: [INFO:metrics_utils.cc(371)] Payload Attempt Number = 2
02-02 05:45:40.869 1242 1242 I update_engine: [INFO:metrics_utils.cc(388)] Update Monotonic Timestamp Start = 1/1/1970 9:38:47 GMT
02-02 05:45:40.871 1242 1242 I update_engine: [INFO:metrics_utils.cc(397)] Update Boot Timestamp Start = 1/2/1970 16:47:35 GMT
02-02 05:45:40.873 1242 1242 I update_engine: [INFO:update_attempter_android.cc(648)] Scheduling an action processor start.
02-02 05:45:40.875 1242 1242 I update_engine: [INFO:action_processor.cc(51)] ActionProcessor: starting UpdateBootFlagsAction
02-02 05:45:40.884 1242 1242 I update_engine: [INFO:update_boot_flags_action.cc(36)] Already updated boot flags. Skipping.
02-02 05:45:40.886 1242 1242 I update_engine: [INFO:action_processor.cc(116)] ActionProcessor: finished UpdateBootFlagsAction with code ErrorCode::kSuccess
02-02 05:45:40.888 1242 1242 I update_engine: [INFO:action_processor.cc(143)] ActionProcessor: starting CleanupPreviousUpdateAction
02-02 05:45:40.892 1242 1242 I update_engine: [INFO:cleanup_previous_update_action.cc(82)] Starting/resuming CleanupPreviousUpdateAction
02-02 05:45:40.893 1242 1242 I update_engine: [INFO:cleanup_previous_update_action.cc(137)] Boot completed, waiting on markBootSuccessful()
02-02 05:45:40.897 1242 1242 I update_engine: EnsureMetadataMounted does nothing in Android mode.
02-02 05:45:40.908 1242 1242 I update_engine: Read merge statistics file failed: No such file or directory
02-02 05:45:40.918 1242 1242 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.
02-02 05:45:40.921 1242 1242 E update_engine: [ERROR:cleanup_previous_update_action.cc(240)] Previous update has not been completed, not cleaning up
02-02 05:45:40.926 1242 1242 I update_engine: [INFO:cleanup_previous_update_action.cc(397)] Not reporting merge stats because state is Initiated
02-02 05:45:40.930 1242 1242 I update_engine: [INFO:action_processor.cc(116)] ActionProcessor: finished CleanupPreviousUpdateAction with code ErrorCode::kSuccess
02-02 05:45:40.931 1242 1242 I update_engine: [INFO:action_processor.cc(143)] ActionProcessor: starting InstallPlanAction
02-02 05:45:40.932 1242 1242 I update_engine: [INFO:action_processor.cc(116)] ActionProcessor: finished InstallPlanAction with code ErrorCode::kSuccess
02-02 05:45:40.936 1242 1242 I update_engine: [INFO:action_processor.cc(143)] ActionProcessor: starting DownloadAction
02-02 05:45:40.938 1242 1242 I update_engine: [INFO:install_plan.cc(91)] InstallPlan: resume, version: , source_slot: B, target_slot: A, url: file:///data/ota_package/payload_metadata.bin, payload: (size: 25334902, metadata_size: 267573, metadata signature: , hash: C20FD3977E8CE101E97344AEAB0E6357A417A9FB5793F56B1B3401466DF5C32D, 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
02-02 05:45:40.939 1242 1242 I update_engine: [INFO:prefs.cc(122)] update-state-payload-index not present in /data/misc/update_engine/prefs
02-02 05:45:40.940 1242 1242 I update_engine: [INFO:download_action.cc(199)] Marking new slot as unbootable
02-02 05:45:40.973 1242 1242 I update_engine: [INFO:multi_range_http_fetcher.cc(45)] starting first transfer
02-02 05:45:40.975 1242 1242 I update_engine: [INFO:multi_range_http_fetcher.cc(74)] starting transfer of range 0+268096
02-02 05:45:40.979 1242 1242 I update_engine: [INFO:delta_performer.cc(209)] Completed 0/? operations, 16384/25334902 bytes downloaded (0%), overall progress 0%
02-02 05:45:40.988 1242 1242 I update_engine: [INFO:delta_performer.cc(520)] Manifest size in payload matches expected value from Omaha
02-02 05:45:40.990 1242 1242 I update_engine: [INFO:delta_performer.cc(1693)] Verifying using certificates: /system/etc/security/otacerts.zip
02-02 05:45:40.993 1242 1242 I update_engine: [INFO:payload_verifier.cc(102)] signature blob size = 523
02-02 05:45:40.995 1242 1242 I update_engine: [INFO:payload_verifier.cc(118)] Truncating the signature to its unpadded size: 512.
02-02 05:45:40.997 1242 1242 I update_engine: [INFO:payload_verifier.cc(129)] Verified correct signature 1 out of 1 signatures.
02-02 05:45:40.998 1242 1242 I update_engine: [INFO:payload_metadata.cc(224)] Metadata hash signature matches value in Omaha response.
02-02 05:45:41.014 1242 1242 I update_engine: [INFO:delta_performer.cc(1728)] Detected a 'delta' payload.
02-02 05:45:41.035 1242 1242 I update_engine: [INFO:delta_performer.cc(982)] Using previously prepared partitions for update. hash = wg/Tl36M4QHpc0Suqw5jV6QXqftXk/VrGzQBRm31wy0=DJIX8ufxy9HSEsFGHqO/yQOeL5vkpSsGh+FUQmIi4a0=
02-02 05:45:41.036 1242 1242 I update_engine: EnsureMetadataMounted does nothing in Android mode.
02-02 05:45:41.038 1242 1242 I update_engine: [INFO:delta_performer.cc(1002)] PreparePartitionsForUpdate done.
02-02 05:45:41.048 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.050 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(957)] vendor_b is mapped on device mapper: /dev/block/dm-1
02-02 05:45:41.053 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:45:41.055 1242 1242 I update_engine: Successfully unmapped snapshot vendor_a
02-02 05:45:41.087 1242 1242 I update_engine: [libfs_mgr]Created logical partition vendor_a-base on device /dev/block/dm-4
02-02 05:45:41.114 1242 1242 I update_engine: Mapped COW device for vendor_a at /dev/block/dm-5
02-02 05:45:41.169 1242 1242 I update_engine: Mapped vendor_a as snapshot device at /dev/block/dm-6
02-02 05:45:41.171 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(173)] Succesfully mapped vendor_a to device mapper (force_writable = 1); device path at /dev/block/dm-6
02-02 05:45:41.173 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.176 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] boot_b is not in super partition metadata.
02-02 05:45:41.177 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.183 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:45:41.187 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] boot_a is not in super partition metadata.
02-02 05:45:41.189 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.192 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.194 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(957)] system_b is mapped on device mapper: /dev/block/dm-0
02-02 05:45:41.197 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:45:41.201 1242 1242 I update_engine: Successfully unmapped snapshot system_a
02-02 05:45:41.230 1242 1242 I update_engine: [libfs_mgr]Created logical partition system_a-base on device /dev/block/dm-7
02-02 05:45:41.257 1242 1242 I update_engine: Mapped COW device for system_a at /dev/block/dm-25
02-02 05:45:41.313 1242 1242 I update_engine: Mapped system_a as snapshot device at /dev/block/dm-26
02-02 05:45:41.315 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(173)] Succesfully mapped system_a to device mapper (force_writable = 1); device path at /dev/block/dm-26
02-02 05:45:41.318 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.321 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] vbmeta_b is not in super partition metadata.
02-02 05:45:41.322 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.325 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:45:41.327 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] vbmeta_a is not in super partition metadata.
02-02 05:45:41.329 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.331 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.334 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] dtbo_b is not in super partition metadata.
02-02 05:45:41.335 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.338 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:45:41.340 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] dtbo_a is not in super partition metadata.
02-02 05:45:41.342 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.344 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.347 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(957)] product_b is mapped on device mapper: /dev/block/dm-2
02-02 05:45:41.350 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:45:41.352 1242 1242 I update_engine: Successfully unmapped snapshot product_a
02-02 05:45:41.379 1242 1242 I update_engine: [libfs_mgr]Created logical partition product_a-base on device /dev/block/dm-27
02-02 05:45:41.412 1242 1242 I update_engine: Mapped COW device for product_a at /dev/block/dm-28
02-02 05:45:41.519 1242 1242 I update_engine: Mapped product_a as snapshot device at /dev/block/dm-29
02-02 05:45:41.521 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(173)] Succesfully mapped product_a to device mapper (force_writable = 1); device path at /dev/block/dm-29
02-02 05:45:41.524 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.526 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(957)] system_ext_b is mapped on device mapper: /dev/block/dm-3
02-02 05:45:41.529 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:45:41.531 1242 1242 I update_engine: Successfully unmapped snapshot system_ext_a
02-02 05:45:41.560 1242 1242 I update_engine: [libfs_mgr]Created logical partition system_ext_a-base on device /dev/block/dm-30
02-02 05:45:41.587 1242 1242 I update_engine: Mapped COW device for system_ext_a at /dev/block/dm-31
02-02 05:45:41.609 1242 1242 I update_engine: Mapped system_ext_a as snapshot device at /dev/block/dm-32
02-02 05:45:41.612 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(173)] Succesfully mapped system_ext_a to device mapper (force_writable = 1); device path at /dev/block/dm-32
02-02 05:45:41.616 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.618 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] vbmeta_system_b is not in super partition metadata.
02-02 05:45:41.619 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.622 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:45:41.624 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] vbmeta_system_a is not in super partition metadata.
02-02 05:45:41.626 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.629 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.632 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] abl_b is not in super partition metadata.
02-02 05:45:41.635 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.637 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:45:41.639 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] abl_a is not in super partition metadata.
02-02 05:45:41.641 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.644 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.646 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] aop_b is not in super partition metadata.
02-02 05:45:41.649 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.652 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:45:41.654 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] aop_a is not in super partition metadata.
02-02 05:45:41.656 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.659 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.661 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] devcfg_b is not in super partition metadata.
02-02 05:45:41.663 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.666 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:45:41.669 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] devcfg_a is not in super partition metadata.
02-02 05:45:41.671 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.673 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.675 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] hyp_b is not in super partition metadata.
02-02 05:45:41.677 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.679 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:45:41.683 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] hyp_a is not in super partition metadata.
02-02 05:45:41.685 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.688 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.690 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] keymaster_b is not in super partition metadata.
02-02 05:45:41.692 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.694 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:45:41.697 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] keymaster_a is not in super partition metadata.
02-02 05:45:41.699 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.702 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.705 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] qupfw_b is not in super partition metadata.
02-02 05:45:41.706 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.709 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:45:41.711 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] qupfw_a is not in super partition metadata.
02-02 05:45:41.714 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.718 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.720 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] tz_b is not in super partition metadata.
02-02 05:45:41.721 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.724 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:45:41.726 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] tz_a is not in super partition metadata.
02-02 05:45:41.728 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.733 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.735 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] uefisecapp_b is not in super partition metadata.
02-02 05:45:41.737 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.740 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:45:41.742 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] uefisecapp_a is not in super partition metadata.
02-02 05:45:41.743 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.747 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.749 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] xbl_b is not in super partition metadata.
02-02 05:45:41.751 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.754 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:45:41.756 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] xbl_a is not in super partition metadata.
02-02 05:45:41.758 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.760 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.763 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] xbl_config_b is not in super partition metadata.
02-02 05:45:41.767 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.770 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:45:41.772 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] xbl_config_a is not in super partition metadata.
02-02 05:45:41.774 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.777 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.780 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] modem_b is not in super partition metadata.
02-02 05:45:41.782 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.786 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super
02-02 05:45:41.788 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] modem_a is not in super partition metadata.
02-02 05:45:41.790 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super
02-02 05:45:41.791 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old vendor sha256: PP6hwqvrz39WLV77uLr7oHNz3NTR2qvWHyOEYoVq21I= size: 555978752
02-02 05:45:41.792 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new vendor sha256: nkXGFVj5g3oUiS23XIhHZNbEKwb8xRbStSmNj6jh1EY= size: 555986944
02-02 05:45:41.794 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old boot sha256: vH9WnWS79CjwYu/lKt48ejpe7ha1RmdH3DjjYLF12SU= size: 67108864
02-02 05:45:41.795 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new boot sha256: UClelbkDimmYpCgV7UDVwxpyjFySTL+IvyXoig0KwfU= size: 67108864
02-02 05:45:41.796 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old system sha256: G/r19LtYGlIpWhdN8l+HKlT12TUVvUQJ+FgSMtNiIys= size: 822075392
02-02 05:45:41.798 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new system sha256: bcGrxKcPJL8vR0AjamVHBSJ9B1COHZn3kGjayJCDwaY= size: 822083584
02-02 05:45:41.800 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old vbmeta sha256: CPkwVpNFXtPBxWgMWwwpVOdDjZY68X5DAhWYDpSfBvU= size: 8192
02-02 05:45:41.801 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new vbmeta sha256: aLrhKe9ZWIZOc+PBqUO1+oePd82cpwQLQTzJJv7+1nY= size: 8192
02-02 05:45:41.803 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old dtbo sha256: Rgh6CyZaCx1ZSm/LN/X2rDgZwCxXMUwLSsJ91APZD+c= size: 8388608
02-02 05:45:41.804 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new dtbo sha256: 66/1wDxGbrC2iVD+V5Lyu7KNBCw7BYvFeE/KXPLNk94= size: 8388608
02-02 05:45:41.805 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old product sha256: Ik8h8aeCmY6Z9E8DZdI31RvaWm0KgaizPpRpU0jcPDI= size: 2062725120
02-02 05:45:41.806 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new product sha256: TwjPeEUDfYhox6CZJT67cYsk0rIN4+ZhmeWiPxzTwDk= size: 2068152320
02-02 05:45:41.808 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old system_ext sha256: Sj5dC0RZG/4vWa4DatC69zFVRQhNrI7DkIaYEFg/uTw= size: 232345600
02-02 05:45:41.809 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new system_ext sha256: IV0/ghxwFoZfG/VC3SlFBZHOrSCwSe+IvBjY+RR+TAA= size: 232349696
02-02 05:45:41.810 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old vbmeta_system sha256: Mth0DxHFBNea5c+fT/9Ez6WYwL4EU0hEL7/8XxsFs7U= size: 4096
02-02 05:45:41.811 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new vbmeta_system sha256: R1BPXOJPxW9SH9NctW6F6462cYHvNtkbr0y3iO02Q5I= size: 4096
02-02 05:45:41.811 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old abl sha256: W8NsPY7wEsLnb0DtdRvRNavELUlM49tih6IQUny9k8U= size: 1048576
02-02 05:45:41.813 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new abl sha256: W8NsPY7wEsLnb0DtdRvRNavELUlM49tih6IQUny9k8U= size: 1048576
02-02 05:45:41.814 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old aop sha256: nv52IezE2GymX7Kh2WyWUXEQJru9KzKtFW+GIVyrdcw= size: 167936
02-02 05:45:41.816 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new aop sha256: nv52IezE2GymX7Kh2WyWUXEQJru9KzKtFW+GIVyrdcw= size: 167936
02-02 05:45:41.817 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old devcfg sha256: Y4T5Ec4X7Wlc6HQaBiDikI09QGfTkCkevC9wrdZoCRg= size: 45056
02-02 05:45:41.819 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new devcfg sha256: Y4T5Ec4X7Wlc6HQaBiDikI09QGfTkCkevC9wrdZoCRg= size: 45056
02-02 05:45:41.820 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old hyp sha256: ChQcVcq4Y4K/D3CI1VBg595eez80/LgGrnxiOLXyQCI= size: 397312
02-02 05:45:41.822 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new hyp sha256: ChQcVcq4Y4K/D3CI1VBg595eez80/LgGrnxiOLXyQCI= size: 397312
02-02 05:45:41.823 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old keymaster sha256: wBeSJbT58X2LnZ+w4l9AjXIxY7gSevO1SigmXvq/M0A= size: 241664
02-02 05:45:41.824 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new keymaster sha256: wBeSJbT58X2LnZ+w4l9AjXIxY7gSevO1SigmXvq/M0A= size: 241664
02-02 05:45:41.825 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old qupfw sha256: 1nx7e7VXr82GSMK1PjPjpt7GEfIZ3GkD72VqjQTVK28= size: 53248
02-02 05:45:41.826 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new qupfw sha256: 1nx7e7VXr82GSMK1PjPjpt7GEfIZ3GkD72VqjQTVK28= size: 53248
02-02 05:45:41.827 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old tz sha256: rtREhZEcIb6+wHomTDWh2IiFGd3GO4NX99kH0TdyBmI= size: 2060288
02-02 05:45:41.829 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new tz sha256: rtREhZEcIb6+wHomTDWh2IiFGd3GO4NX99kH0TdyBmI= size: 2060288
02-02 05:45:41.830 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old uefisecapp sha256: mq1jqWvJERSIqxpQ7jk+GO1El1t/EsZBS544pMBsojM= size: 126976
02-02 05:45:41.832 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new uefisecapp sha256: mq1jqWvJERSIqxpQ7jk+GO1El1t/EsZBS544pMBsojM= size: 126976
02-02 05:45:41.834 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old xbl sha256: ub1giiWDFWmS4nUkmlAf7A6f5Z8no94BNBe444nfqz8= size: 3371008
02-02 05:45:41.835 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new xbl sha256: ub1giiWDFWmS4nUkmlAf7A6f5Z8no94BNBe444nfqz8= size: 3371008
02-02 05:45:41.836 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old xbl_config sha256: fxMUUD3raEcR/HTxlrpBhuhgEzoV5IaLut+UDYlvvk4= size: 90112
02-02 05:45:41.837 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new xbl_config sha256: fxMUUD3raEcR/HTxlrpBhuhgEzoV5IaLut+UDYlvvk4= size: 90112
02-02 05:45:41.839 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo old modem sha256: jHw8Rv8xhX7ly2GbboL6/dcz1sZ/JSa9rbn/eKvfGVA= size: 74108928
02-02 05:45:41.840 1242 1242 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new modem sha256: jHw8Rv8xhX7ly2GbboL6/dcz1sZ/JSa9rbn/eKvfGVA= size: 74108928
02-02 05:45:41.843 1242 1242 I update_engine: [INFO:delta_performer.cc(209)] Resuming after 4975/4975 operations (100%), 25334902/25334902 bytes downloaded (100%), overall progress 100%
02-02 05:45:41.844 1242 1242 I update_engine: [INFO:delta_performer.cc(657)] Starting to apply update payload operations
02-02 05:45:41.849 1242 1242 I update_engine: [INFO:multi_range_http_fetcher.cc(115)] Terminating transfer.
02-02 05:45:41.850 1242 1242 I update_engine: [INFO:multi_range_http_fetcher.cc(177)] Received transfer terminated.
02-02 05:45:41.851 1242 1242 I update_engine: [INFO:multi_range_http_fetcher.cc(129)] TransferEnded w/ code 200
02-02 05:45:41.853 1242 1242 I update_engine: [INFO:multi_range_http_fetcher.cc(163)] Done w/ all transfers
02-02 05:45:41.854 1242 1242 I update_engine: [INFO:delta_performer.cc(1693)] Verifying using certificates: /system/etc/security/otacerts.zip
02-02 05:45:41.855 1242 1242 I update_engine: [INFO:payload_verifier.cc(102)] signature blob size = 523
02-02 05:45:41.856 1242 1242 I update_engine: [INFO:payload_verifier.cc(118)] Truncating the signature to its unpadded size: 512.
02-02 05:45:41.858 1242 1242 I update_engine: [INFO:payload_verifier.cc(129)] Verified correct signature 1 out of 1 signatures.
02-02 05:45:41.860 1242 1242 I update_engine: [INFO:delta_performer.cc(1915)] Payload hash matches value in payload.
02-02 05:45:41.863 1242 1242 I update_engine: [INFO:download_action.cc(400)] Collections of histograms for UpdateEngine.DownloadAction.
02-02 05:45:41.863 1242 1242 I update_engine: Histogram: UpdateEngine.DownloadAction.InstallOperation::PUFFDIFF.Duration recorded 6 samples, mean = 950.2
02-02 05:45:41.863 1242 1242 I update_engine: 0 ...
02-02 05:45:41.863 1242 1242 I update_engine: 32 ------------------------------------------------------------------------O (1 = 16.7%) {0.0%}
02-02 05:45:41.863 1242 1242 I update_engine: 57 ------------------------------------------------------------------------O (1 = 16.7%) {16.7%}
02-02 05:45:41.863 1242 1242 I update_engine: 101 O (0 = 0.0%) {33.3%}
02-02 05:45:41.863 1242 1242 I update_engine: 179 ------------------------------------------------------------------------O (1 = 16.7%) {33.3%}
02-02 05:45:41.863 1242 1242 I update_engine: 317 O (0 = 0.0%) {50.0%}
02-02 05:45:41.863 1242 1242 I update_engine: 561 ------------------------------------------------------------------------O (1 = 16.7%) {50.0%}
02-02 05:45:41.863 1242 1242 I update_engine: 993 ------------------------------------------------------------------------O (1 = 16.7%) {66.7%}
02-02 05:45:41.863 1242 1242 I update_engine: 1758 O (0 = 0.0%) {83.3%}
02-02 05:45:41.863 1242 1242 I update_engine: 3112 ------------------------------------------------------------------------O (1 = 16.7%) {83.3%}
02-02 05:45:41.863 1242 1242 I update_engine: 5509 ...
02-02 05:45:41.863 1242 1242 I update_engine:
02-02 05:45:41.863 1242 1242 I update_engine: Histogram: UpdateEngine.DownloadAction.InstallOperation::REPLACE.Duration recorded 99 samples, mean = 0.6
02-02 05:45:41.863 1242 1242 I update_engine: 0 ------------------------------------------------------------------------O (97 = 98.0%)
02-02 05:45:41.863 1242 1242 I update_engine: 10 -O (1 = 1.0%) {98.0%}
02-02 05:45:41.863 1242 1242 I update_engine: 18 O (0 = 0.0%) {99.0%}
02-02 05:45:41.863 1242 1242 I update_engine: 32 -O (1 = 1.0%) {99.0%}
02-02 05:45:41.863 1242 1242 I update_engine: 57 ...
02-02 05:45:41.863 1242 1242 I update_engine:
02-02 05:45:41.863 1242 1242 I update_engine: Histogram: UpdateEngine.DownloadAction.InstallOperation::SOURCE_BSDIFF.Duration recorded 465 samples, mean = 13.2
02-02 05:45:41.863 1242 1242 I update_engine: 0 ------------------------------------------------------------------------O (401 = 86.2%)
02-02 05:45:41.863 1242 1242 I update_engine: 10 -------O (39 = 8.4%) {86.2%}
02-02 05:45:41.863 1242 1242 I update_engine: 18 --O (11 = 2.4%) {94.6%}
02-02 05:45:41.863 1242 1242 I update_engine: 32 O (1 = 0.2%) {97.0%}
02-02 05:45:41.863 1242 1242 I update_engine: 57 -O (4 = 0.9%) {97.2%}
02-02 05:45:41.863 1242 1242 I update_engine: 101 -O (4 = 0.9%) {98.1%}
02-02 05:45:41.863 1242 1242 I update_engine: 179 O (2 = 0.4%) {98.9%}
02-02 05:45:41.863 1242 1242 I update_engine: 317 O (2 = 0.4%) {99.4%}
02-02 05:45:41.863 1242 1242 I update_engine: 561 O (1 = 0.2%) {99.8%}
02-02 05:45:41.863 1242 1242 I update_engine: 993 ...
02-02 05:45:41.863 1242 1242 I update_engine:
02-02 05:45:41.863 1242 1242 I update_engine: Histogram: UpdateEngine.DownloadAction.InstallOperation::SOURCE_COPY.Duration recorded 3405 samples, mean = 10.8
02-02 05:45:41.863 1242 1242 I update_engine: 0 ------------------------------------------------------------------------O (1767 = 51.9%)
02-02 05:45:41.863 1242 1242 I update_engine: 10 -----------------------------------------O (1007 = 29.6%) {51.9%}
02-02 05:45:41.863 1242 1242 I update_engine: 18 ------------------------O (596 = 17.5%) {81.5%}
02-02 05:45:41.863 1242 1242 I update_engine: 32 -O (34 = 1.0%) {99.0%}
02-02 05:45:41.863 1242 1242 I update_engine: 57 O (1 = 0.0%) {100.0%}
02-02 05:45:41.863 1242 1242 I update_engine: 101 ...
02-02 05:45:41.863 1242 1242 I update_engine:
02-02 05:45:41.863 1242 1242 I update_engine: Histogram: UpdateEngine.DownloadAction.InstallOperation::ZERO_OR_DISCARD.Duration recorded 1000 samples, mean = 1.3
02-02 05:45:41.863 1242 1242 I update_engine: 0 ------------------------------------------------------------------------O (976 = 97.6%)
02-02 05:45:41.863 1242 1242 I update_engine: 10 -O (11 = 1.1%) {97.6%}
02-02 05:45:41.863 1242 1242 I update_engine: 18 O (6 = 0.6%) {98.7%}
02-02 05:45:41.863 1242 1242 I update_engine: 32 O (0 = 0.0%) {99.3%}
02-02 05:45:41.863 1242 1242 I update_engine: 57 O (3 = 0.3%) {99.3%}
02-02 05:45:41.863 1242 1242 I update_engine: 101 O (4 = 0.4%) {99.6%}
02-02 05:45:41.863 1242 1242 I update_engine: 179 ...
02-02 05:45:41.863 1242 1242 I update_engine:
02-02 05:45:41.889 1242 1242 I update_engine: [INFO:action_processor.cc(116)] ActionProcessor: finished DownloadAction with code ErrorCode::kSuccess
02-02 05:45:41.891 1242 1242 I update_engine: [INFO:action_processor.cc(143)] ActionProcessor: starting FilesystemVerifierAction
02-02 05:45:41.892 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 0 (vendor) on device /dev/block/dm-6
02-02 05:45:44.172 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of vendor: nkXGFVj5g3oUiS23XIhHZNbEKwb8xRbStSmNj6jh1EY=
02-02 05:45:44.355 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 1 (boot) on device /dev/block/bootdevice/by-name/boot_a
02-02 05:45:44.546 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of boot: UClelbkDimmYpCgV7UDVwxpyjFySTL+IvyXoig0KwfU=
02-02 05:45:44.568 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 2 (system) on device /dev/block/dm-26
02-02 05:45:47.892 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of system: bcGrxKcPJL8vR0AjamVHBSJ9B1COHZn3kGjayJCDwaY=
02-02 05:45:48.160 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 3 (vbmeta) on device /dev/block/bootdevice/by-name/vbmeta_a
02-02 05:45:48.167 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of vbmeta: aLrhKe9ZWIZOc+PBqUO1+oePd82cpwQLQTzJJv7+1nY=
02-02 05:45:48.170 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 4 (dtbo) on device /dev/block/bootdevice/by-name/dtbo_a
02-02 05:45:48.198 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of dtbo: 66/1wDxGbrC2iVD+V5Lyu7KNBCw7BYvFeE/KXPLNk94=
02-02 05:45:48.203 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 5 (product) on device /dev/block/dm-29
02-02 05:45:57.208 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of product: TwjPeEUDfYhox6CZJT67cYsk0rIN4+ZhmeWiPxzTwDk=
02-02 05:45:57.931 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 6 (system_ext) on device /dev/block/dm-32
02-02 05:45:58.881 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of system_ext: IV0/ghxwFoZfG/VC3SlFBZHOrSCwSe+IvBjY+RR+TAA=
02-02 05:45:58.961 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 7 (vbmeta_system) on device /dev/block/bootdevice/by-name/vbmeta_system_a
02-02 05:45:58.965 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of vbmeta_system: R1BPXOJPxW9SH9NctW6F6462cYHvNtkbr0y3iO02Q5I=
02-02 05:45:58.967 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 8 (abl) on device /dev/block/bootdevice/by-name/abl_a
02-02 05:45:58.972 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of abl: W8NsPY7wEsLnb0DtdRvRNavELUlM49tih6IQUny9k8U=
02-02 05:45:58.975 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 9 (aop) on device /dev/block/bootdevice/by-name/aop_a
02-02 05:45:58.979 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of aop: nv52IezE2GymX7Kh2WyWUXEQJru9KzKtFW+GIVyrdcw=
02-02 05:45:58.980 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 10 (devcfg) on device /dev/block/bootdevice/by-name/devcfg_a
02-02 05:45:58.982 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of devcfg: Y4T5Ec4X7Wlc6HQaBiDikI09QGfTkCkevC9wrdZoCRg=
02-02 05:45:58.984 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 11 (hyp) on device /dev/block/bootdevice/by-name/hyp_a
02-02 05:45:58.989 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of hyp: ChQcVcq4Y4K/D3CI1VBg595eez80/LgGrnxiOLXyQCI=
02-02 05:45:58.994 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 12 (keymaster) on device /dev/block/bootdevice/by-name/keymaster_a
02-02 05:45:58.997 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of keymaster: wBeSJbT58X2LnZ+w4l9AjXIxY7gSevO1SigmXvq/M0A=
02-02 05:45:58.999 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 13 (qupfw) on device /dev/block/bootdevice/by-name/qupfw_a
02-02 05:45:59.001 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of qupfw: 1nx7e7VXr82GSMK1PjPjpt7GEfIZ3GkD72VqjQTVK28=
02-02 05:45:59.003 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 14 (tz) on device /dev/block/bootdevice/by-name/tz_a
02-02 05:45:59.012 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of tz: rtREhZEcIb6+wHomTDWh2IiFGd3GO4NX99kH0TdyBmI=
02-02 05:45:59.014 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 15 (uefisecapp) on device /dev/block/bootdevice/by-name/uefisecapp_a
02-02 05:45:59.016 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of uefisecapp: mq1jqWvJERSIqxpQ7jk+GO1El1t/EsZBS544pMBsojM=
02-02 05:45:59.018 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 16 (xbl) on device /dev/block/bootdevice/by-name/xbl_a
02-02 05:45:59.030 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of xbl: ub1giiWDFWmS4nUkmlAf7A6f5Z8no94BNBe444nfqz8=
02-02 05:45:59.032 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 17 (xbl_config) on device /dev/block/bootdevice/by-name/xbl_config_a
02-02 05:45:59.035 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of xbl_config: fxMUUD3raEcR/HTxlrpBhuhgEzoV5IaLut+UDYlvvk4=
02-02 05:45:59.036 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 18 (modem) on device /dev/block/bootdevice/by-name/modem_a
02-02 05:45:59.238 1242 1242 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of modem: jHw8Rv8xhX7ly2GbboL6/dcz1sZ/JSa9rbn/eKvfGVA=
02-02 05:45:59.265 1242 1242 I update_engine: [INFO:action_processor.cc(116)] ActionProcessor: finished FilesystemVerifierAction with code ErrorCode::kSuccess
02-02 05:45:59.267 1242 1242 I update_engine: [INFO:action_processor.cc(143)] ActionProcessor: starting PostinstallRunnerAction
02-02 05:45:59.269 1242 1242 I update_engine: [INFO:postinstall_runner_action.cc(76)] Skipping optional post-install for partition vendor according to install plan.
02-02 05:45:59.270 1242 1242 I update_engine: [INFO:postinstall_runner_action.cc(76)] Skipping optional post-install for partition system according to install plan.
02-02 05:45:59.271 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(863)] Snapshot writes are done.
02-02 05:45:59.273 1242 1242 I update_engine: Wipe is not scheduled. Deleting forward merge indicator.
02-02 05:45:59.327 1242 1242 I update_engine: [INFO:postinstall_runner_action.cc(371)] All post-install commands succeeded
02-02 05:45:59.330 1242 1242 I update_engine: [INFO:action_processor.cc(116)] ActionProcessor: finished last action PostinstallRunnerAction with code ErrorCode::kSuccess
02-02 05:45:59.332 1242 1242 I update_engine: [INFO:update_attempter_android.cc(522)] Processing Done.
02-02 05:45:59.335 1242 1242 I update_engine: [INFO:update_attempter_android.cc(535)] Update successfully applied, waiting to reboot.
02-02 05:45:59.336 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(263)] Destroying [product_a, system_a, system_ext_a, vendor_a] from device mapper
02-02 05:45:59.352 1242 1242 I update_engine: [libfs_mgr]Unmapped logical partition product_a
02-02 05:45:59.399 1242 1242 I update_engine: Successfully unmapped snapshot product_a
02-02 05:45:59.401 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(249)] Successfully unmapped product_a from device mapper.
02-02 05:45:59.432 1242 1242 I update_engine: [libfs_mgr]Unmapped logical partition system_a
02-02 05:45:59.472 1242 1242 I update_engine: Successfully unmapped snapshot system_a
02-02 05:45:59.475 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(249)] Successfully unmapped system_a from device mapper.
02-02 05:45:59.492 1242 1242 I update_engine: [libfs_mgr]Unmapped logical partition system_ext_a
02-02 05:45:59.539 1242 1242 I update_engine: Successfully unmapped snapshot system_ext_a
02-02 05:45:59.541 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(249)] Successfully unmapped system_ext_a from device mapper.
02-02 05:45:59.572 1242 1242 I update_engine: [libfs_mgr]Unmapped logical partition vendor_a
02-02 05:45:59.623 1242 1242 I update_engine: Successfully unmapped snapshot vendor_a
02-02 05:45:59.626 1242 1242 I update_engine: [INFO:dynamic_partition_control_android.cc(249)] Successfully unmapped vendor_a from device mapper.
02-02 05:45:59.630 1242 1242 I update_engine: [INFO:metrics_reporter_android.cc(131)] Current update attempt downloads 0 bytes data
02-02 05:45:59.638 1242 1242 I update_engine: [INFO:metrics_utils.cc(380)] Updated Marker = 1/1/1970 9:39:06 GMT
02-02 05:45:59.673 3414 17938 I SystemUpdate: [Execution,ExecutionManager] Action ab-reboot executed for 19.20 seconds.
02-02 05:45:59.687 3414 17938 I SystemUpdate: [Control,DeviceControl] Reboot with resume.
02-02 05:46:10.020 3414 18038 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
02-02 05:46:11.984 1242 1242 I update_engine: [INFO:main.cc(71)] A/B Update Engine terminating with exit code 0
--------- beginning of system
--------- beginning of main
02-02 05:47:07.934 1317 1317 I update_engine: [INFO:main.cc(54)] A/B Update Engine starting
02-02 05:47:07.955 1317 1317 I update_engine: [INFO:boot_control_android.cc(70)] Loaded boot control hidl hal.
02-02 05:47:07.963 1317 1317 E update_engine: [ERROR:metrics_utils.cc(414)] time_to_reboot is negative - system_updated_at: 1/1/1970 9:39:06 GMT
02-02 05:47:07.966 1317 1317 I update_engine: [INFO:delta_performer.cc(1997)] Resetting recorded hash for prepared partitions.
02-02 05:47:07.967 1317 1317 I update_engine: [INFO:update_attempter_android.cc(1010)] Scheduling CleanupPreviousUpdateAction.
02-02 05:47:07.967 1317 1317 I update_engine: [INFO:action_processor.cc(51)] ActionProcessor: starting CleanupPreviousUpdateAction
02-02 05:47:07.967 1317 1317 I update_engine: [INFO:cleanup_previous_update_action.cc(82)] Starting/resuming CleanupPreviousUpdateAction
02-02 05:47:44.003 1317 1317 I update_engine: [INFO:cleanup_previous_update_action.cc(137)] Boot completed, waiting on markBootSuccessful()
02-02 05:47:44.008 1317 1317 I update_engine: EnsureMetadataMounted does nothing in Android mode.
02-02 05:47:44.013 1317 1317 I update_engine: Read merge statistics file failed: No such file or directory
02-02 05:47:44.021 1317 1317 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.
02-02 05:47:44.033 1317 1317 I update_engine: Update state is being processed while booting at target slot, taking no action.
02-02 05:47:44.044 1317 1317 I update_engine: [INFO:cleanup_previous_update_action.cc(338)] Attempting to initiate merge.
02-02 05:47:44.101 1317 1317 I update_engine: Successfully switched snapshot device to a merge target: product_a
02-02 05:47:44.162 1317 1317 I update_engine: Successfully switched snapshot device to a merge target: system_a
02-02 05:47:44.243 1317 1317 I update_engine: Successfully switched snapshot device to a merge target: system_ext_a
02-02 05:47:44.393 1317 1317 I update_engine: Successfully switched snapshot device to a merge target: vendor_a
02-02 05:47:44.529 1317 1317 I update_engine: [INFO:cleanup_previous_update_action.cc(302)] Waiting for merge to complete: 1%.
02-02 05:47:49.811 1317 1317 I update_engine: [INFO:cleanup_previous_update_action.cc(302)] Waiting for merge to complete: 17%.
02-02 05:47:51.847 1317 1317 I update_engine: [INFO:cleanup_previous_update_action.cc(302)] Waiting for merge to complete: 22%.
02-02 05:47:53.866 1317 1317 I update_engine: [INFO:cleanup_previous_update_action.cc(302)] Waiting for merge to complete: 27%.
02-02 05:47:55.886 1317 1317 I update_engine: [INFO:cleanup_previous_update_action.cc(302)] Waiting for merge to complete: 32%.
02-02 05:47:57.966 1317 1317 I update_engine: [INFO:cleanup_previous_update_action.cc(302)] Waiting for merge to complete: 37%.
02-02 05:48:00.012 1317 1317 I update_engine: [INFO:cleanup_previous_update_action.cc(302)] Waiting for merge to complete: 44%.
02-02 05:48:02.048 1317 1317 I update_engine: [INFO:cleanup_previous_update_action.cc(302)] Waiting for merge to complete: 50%.
02-02 05:48:04.104 1317 1317 I update_engine: [INFO:cleanup_previous_update_action.cc(302)] Waiting for merge to complete: 57%.
02-02 05:48:06.141 1317 1317 I update_engine: [INFO:cleanup_previous_update_action.cc(302)] Waiting for merge to complete: 64%.
02-02 05:48:08.303 1317 1317 I update_engine: [INFO:cleanup_previous_update_action.cc(302)] Waiting for merge to complete: 71%.
02-02 05:48:10.496 1317 1317 I update_engine: [INFO:cleanup_previous_update_action.cc(302)] Waiting for merge to complete: 78%.
02-02 05:48:12.514 1317 1317 I update_engine: [INFO:cleanup_previous_update_action.cc(302)] Waiting for merge to complete: 83%.
02-02 05:48:14.528 1317 1317 I update_engine: [INFO:cleanup_previous_update_action.cc(302)] Waiting for merge to complete: 89%.
02-02 05:48:16.544 1317 1317 I update_engine: [INFO:cleanup_previous_update_action.cc(302)] Waiting for merge to complete: 95%.
02-02 05:48:18.632 1317 1317 I update_engine: Removing all update state.
02-02 05:48:18.656 1317 1317 I update_engine: [INFO:cleanup_previous_update_action.cc(262)] Merge finished with state MergeCompleted.
02-02 05:48:18.663 1317 1317 I update_engine: [INFO:cleanup_previous_update_action.cc(409)] Reporting merge stats: MergeCompleted in 34646ms (resumed 0 times), using 0 bytes of COW image.
02-02 05:48:18.667 1317 1317 I update_engine: [INFO:action_processor.cc(116)] ActionProcessor: finished last action CleanupPreviousUpdateAction with code ErrorCode::kSuccess
02-02 05:48:18.668 1317 1317 I update_engine: [INFO:update_attempter_android.cc(522)] Processing Done.
02-02 05:48:18.669 1317 1317 I update_engine: [INFO:update_attempter_android.cc(662)] Terminating cleanup previous update.
02-02 05:48:47.680 4280 8558 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 }.
02-02 05:48:47.733 4280 8558 I SystemUpdate: [Control,ChimeraGcmTaskService] Scheduling task: LogStatus.
02-02 05:48:47.888 4280 8558 I SystemUpdate: [Control,DeviceControl] Prepare resume on reboot.
02-02 05:48:48.096 4280 8557 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 1.
02-02 05:48:48.118 4280 9003 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 }.
02-02 05:48:48.182 4280 9003 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x005, -1.000).
02-02 05:48:48.370 4280 9003 I SystemUpdate: [Control,DeviceControl] Cancel resume on reboot.
02-02 05:48:48.728 4280 9003 I SystemUpdate: [Execution,ExecutionManager] Action ab-reboot executed for 0.59 seconds.
02-02 05:48:48.734 4280 9003 I SystemUpdate: [Execution,ExecutionManager] Action finished-execution executed for 0.00 seconds.
--------- beginning of crash
02-02 05:49:16.878 4280 11047 I SystemUpdate: [Installation,ReceiverIntentOperation] Received intent: Intent { act=com.google.gservices.intent.action.GSERVICES_CHANGED flg=0x1000010 pkg=com.google.android.gms cmp=com.google.android.gms/.chimera.GmsIntentOperationService$PersistentInternalReceiver }.
02-02 05:49:16.993 4280 11047 I SystemUpdate: [Control,InstallationControl] Update URL changed from "https://ota.googlezip.net/packages/ota-api/package/d6b7090173dddeaf73ca43a9a51252e4508c7c80.zip" to "".
02-02 05:49:17.234 4280 11041 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 2.
02-02 05:49:17.242 4280 11041 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 102.
02-02 05:49:17.245 4280 10277 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 }.
02-02 05:49:17.246 4280 11041 I SystemUpdate: [Execution,ExecutionManager] Finishing the current execution.
02-02 05:49:17.255 4280 11047 I SystemUpdate: [Control,ChimeraGcmTaskService] Scheduling task: AutomaticUpdateFlagChanged.
02-02 05:49:17.259 4280 11047 I SystemUpdate: [Control,ChimeraGcmTaskService] Scheduling task: AutomaticUpdateFlagChanged.
02-02 05:49:17.304 4280 11041 I SystemUpdate: [Execution,SynchronizedUpdateEngine] reset()
02-02 05:49:17.426 4280 10277 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x000, -1.000).
02-02 05:49:17.685 4280 10277 I SystemUpdate: [Execution,ExecutionManager] Action pending executed for 0.30 seconds.
02-02 05:49:17.688 4280 10277 I SystemUpdate: [Execution,ExecutionManager] Action finished-execution executed for 0.00 seconds.
02-02 05:49:17.690 4280 10277 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 }.
02-02 05:49:17.691 4280 10277 I SystemUpdate: [Execution,ExecutionManager] Action finished-execution executed for 0.00 seconds.
02-02 05:49:18.071 4280 11053 I SystemUpdate: [Installation,ReceiverIntentOperation] Received intent: Intent { act=com.google.gservices.intent.action.GSERVICES_CHANGED flg=0x1000010 pkg=com.google.android.gms cmp=com.google.android.gms/.chimera.GmsIntentOperationService$PersistentInternalReceiver }.
02-02 05:49:18.102 4280 10279 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 2.
02-02 05:49:18.117 4280 10279 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 }.
02-02 05:49:18.118 4280 10279 I SystemUpdate: [Execution,ExecutionManager] Action finished-execution executed for 0.00 seconds.
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment