Skip to content

Instantly share code, notes, and snippets.

@nooriro

nooriro/crosshatch-update-log-200424-1041.txt

Last active April 27, 2020 01:05
Show Gist options
  • Save nooriro/61d8de9afcc38685910cb7d5a19884e8 to your computer and use it in GitHub Desktop.
Save nooriro/61d8de9afcc38685910cb7d5a19884e8 to your computer and use it in GitHub Desktop.
Download ZIP
crosshatch update log (succeeded) / from RPP2.200227.014 to RPP3.200320.017 / Update URL: https://ota.googlezip.net/packages/ota-api/google_crosshatch_crosshatch/f1e9e3a55118faf0f116fbafe4fb4ab541b9d0c4.zip
Raw
crosshatch-update-log-200424-1041.txt
--------- beginning of system
--------- beginning of main
04-24 10:05:13.727 2778 6036 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 }.
04-24 10:05:13.968 2778 6042 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 1.
04-24 10:05:13.977 2778 6041 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 }.
04-24 10:05:13.984 2778 6041 I SystemUpdate: [Execution,ExecutionManager] Action finished-execution executed for 0.00 seconds.
04-24 10:05:43.230 2778 8261 I SystemUpdate: [Installation,ReceiverIntentOperation] Received intent: Intent { act=com.google.gservices.intent.action.GSERVICES_CHANGED flg=0x1000010 cmp=com.google.android.gms/.chimera.GmsIntentOperationService$PersistentInternalReceiver }.
04-24 10:05:43.411 2778 8261 I SystemUpdate: [Control,InstallationControl] Update URL changed from "" to "https://ota.googlezip.net/packages/ota-api/google_crosshatch_crosshatch/f1e9e3a55118faf0f116fbafe4fb4ab541b9d0c4.zip".
04-24 10:05:43.505 2778 8807 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 2.
04-24 10:05:43.508 2778 8620 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 }.
04-24 10:05:43.511 2778 8807 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 102.
04-24 10:05:43.512 2778 8620 I SystemUpdate: [Execution,ExecutionManager] Action finished-execution executed for 0.00 seconds.
04-24 10:05:43.516 2778 8620 I SystemUpdate: [Execution,ExecutionManager] Finishing the current execution.
04-24 10:05:43.565 2778 8620 I SystemUpdate: [Execution,SynchronizedUpdateEngine] reset()
04-24 10:05:43.573 2778 8261 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 }.
04-24 10:05:43.584 2778 8261 I SystemUpdate: [Execution,ExecutionManager] Action pending executed for 0.01 seconds.
04-24 10:05:43.593 2778 8261 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x017, -1.000).
04-24 10:05:45.009 2778 8261 I SystemUpdate: [Execution,PackageFiles] Aggressive allocating space for file /data/ota_package/payload_header.bin with size 24.
04-24 10:05:45.601 2778 8261 I SystemUpdate: [Execution,PackageFiles] Aggressive allocating space for file /data/ota_package/payload_metadata.bin with size 639538.
04-24 10:05:45.774 2778 8261 I SystemUpdate: [Execution,UpdateEngineDelegate] verifyPayloadMetadata()
04-24 10:05:45.775 1251 1251 I update_engine: [0424/100545.774620:INFO:binder_service_android.cc(177)] Received a request of verifying payload metadata in /data/ota_package/payload_metadata.bin.
04-24 10:05:45.785 1251 1251 I update_engine: [0424/100545.785387:INFO:payload_verifier.cc(102)] signature blob size = 267
04-24 10:05:45.785 1251 1251 I update_engine: [0424/100545.785735:INFO:payload_verifier.cc(118)] Truncating the signature to its unpadded size: 256.
04-24 10:05:45.786 1251 1251 I update_engine: [0424/100545.786198:INFO:payload_verifier.cc(129)] Verified correct signature 1 out of 1 signatures.
04-24 10:05:45.786 1251 1251 I update_engine: [0424/100545.786354:INFO:payload_metadata.cc(224)] Metadata hash signature matches value in Omaha response.
04-24 10:05:45.832 1251 1251 W update_engine: type=1400 audit(0.0:850): avc: denied { search } for name="/" dev="sda20" ino=2 scontext=u:r:update_engine:s0 tcontext=u:object_r:metadata_file:s0 tclass=dir permissive=0
04-24 10:05:45.851 1251 1251 I update_engine: [0424/100545.851616:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:05:45.851 1251 1251 I update_engine: [0424/100545.851869:INFO:dynamic_partition_control_android.cc(716)] vendor_b is mapped on device mapper: /dev/block/dm-1
04-24 10:05:54.726 1251 1251 W update_engine: type=1400 audit(0.0:852): avc: denied { search } for name="/" dev="sda20" ino=2 scontext=u:r:update_engine:s0 tcontext=u:object_r:metadata_file:s0 tclass=dir permissive=0
04-24 10:05:54.743 1251 1251 I update_engine: [0424/100554.743075:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:05:54.744 1251 1251 I update_engine: [0424/100554.744214:INFO:dynamic_partition_control_android.cc(697)] boot_b is not in super partition metadata.
04-24 10:05:54.744 1251 1251 I update_engine: [0424/100554.744949:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:05:54.889 1251 1251 W update_engine: type=1400 audit(0.0:853): avc: denied { search } for name="/" dev="sda20" ino=2 scontext=u:r:update_engine:s0 tcontext=u:object_r:metadata_file:s0 tclass=dir permissive=0
04-24 10:05:54.894 1251 1251 I update_engine: [0424/100554.894230:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:05:54.894 1251 1251 I update_engine: [0424/100554.894442:INFO:dynamic_partition_control_android.cc(716)] system_b is mapped on device mapper: /dev/block/dm-0
04-24 10:06:09.652 1251 1251 W update_engine: type=1400 audit(0.0:854): avc: denied { search } for name="/" dev="sda20" ino=2 scontext=u:r:update_engine:s0 tcontext=u:object_r:metadata_file:s0 tclass=dir permissive=0
04-24 10:06:09.658 1251 1251 I update_engine: [0424/100609.658740:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:06:09.660 1251 1251 I update_engine: [0424/100609.660356:INFO:dynamic_partition_control_android.cc(697)] vbmeta_b is not in super partition metadata.
04-24 10:06:09.661 1251 1251 I update_engine: [0424/100609.661208:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:06:09.666 1251 1251 W update_engine: type=1400 audit(0.0:855): avc: denied { search } for name="/" dev="sda20" ino=2 scontext=u:r:update_engine:s0 tcontext=u:object_r:metadata_file:s0 tclass=dir permissive=0
04-24 10:06:09.671 1251 1251 I update_engine: [0424/100609.671855:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:06:09.672 1251 1251 I update_engine: [0424/100609.671982:INFO:dynamic_partition_control_android.cc(697)] dtbo_b is not in super partition metadata.
04-24 10:06:09.672 1251 1251 I update_engine: [0424/100609.672480:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:06:09.686 1251 1251 W update_engine: type=1400 audit(0.0:856): avc: denied { search } for name="/" dev="sda20" ino=2 scontext=u:r:update_engine:s0 tcontext=u:object_r:metadata_file:s0 tclass=dir permissive=0
04-24 10:06:09.692 1251 1251 I update_engine: [0424/100609.692371:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:06:09.692 1251 1251 I update_engine: [0424/100609.692683:INFO:dynamic_partition_control_android.cc(716)] product_b is mapped on device mapper: /dev/block/dm-2
04-24 10:06:22.599 1251 1251 W update_engine: type=1400 audit(0.0:858): avc: denied { search } for name="/" dev="sda20" ino=2 scontext=u:r:update_engine:s0 tcontext=u:object_r:metadata_file:s0 tclass=dir permissive=0
04-24 10:06:22.606 1251 1251 I update_engine: [0424/100622.606844:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:06:22.608 1251 1251 I update_engine: [0424/100622.608193:INFO:dynamic_partition_control_android.cc(716)] system_ext_b is mapped on device mapper: /dev/block/dm-3
04-24 10:06:24.699 1251 1251 W update_engine: type=1400 audit(0.0:862): avc: denied { search } for name="/" dev="sda20" ino=2 scontext=u:r:update_engine:s0 tcontext=u:object_r:metadata_file:s0 tclass=dir permissive=0
04-24 10:06:24.705 1251 1251 I update_engine: [0424/100624.705367:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:06:24.705 1251 1251 I update_engine: [0424/100624.705578:INFO:dynamic_partition_control_android.cc(697)] abl_b is not in super partition metadata.
04-24 10:06:24.706 1251 1251 I update_engine: [0424/100624.706168:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:06:24.709 1251 1251 W update_engine: type=1400 audit(0.0:863): avc: denied { search } for name="/" dev="sda20" ino=2 scontext=u:r:update_engine:s0 tcontext=u:object_r:metadata_file:s0 tclass=dir permissive=0
04-24 10:06:24.714 1251 1251 I update_engine: [0424/100624.714929:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:06:24.715 1251 1251 I update_engine: [0424/100624.715042:INFO:dynamic_partition_control_android.cc(697)] aop_b is not in super partition metadata.
04-24 10:06:24.715 1251 1251 I update_engine: [0424/100624.715506:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:06:24.719 1251 1251 W update_engine: type=1400 audit(0.0:864): avc: denied { search } for name="/" dev="sda20" ino=2 scontext=u:r:update_engine:s0 tcontext=u:object_r:metadata_file:s0 tclass=dir permissive=0
04-24 10:06:24.726 1251 1251 I update_engine: [0424/100624.726331:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:06:24.726 1251 1251 I update_engine: [0424/100624.726466:INFO:dynamic_partition_control_android.cc(697)] cmnlib_b is not in super partition metadata.
04-24 10:06:24.726 1251 1251 I update_engine: [0424/100624.726916:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:06:24.729 1251 1251 W update_engine: type=1400 audit(0.0:865): avc: denied { search } for name="/" dev="sda20" ino=2 scontext=u:r:update_engine:s0 tcontext=u:object_r:metadata_file:s0 tclass=dir permissive=0
04-24 10:06:24.734 1251 1251 I update_engine: [0424/100624.734202:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:06:24.734 1251 1251 I update_engine: [0424/100624.734360:INFO:dynamic_partition_control_android.cc(697)] cmnlib64_b is not in super partition metadata.
04-24 10:06:24.734 1251 1251 I update_engine: [0424/100624.734833:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:06:24.742 1251 1251 I update_engine: [0424/100624.742549:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:06:24.742 1251 1251 I update_engine: [0424/100624.742694:INFO:dynamic_partition_control_android.cc(697)] devcfg_b is not in super partition metadata.
04-24 10:06:24.743 1251 1251 I update_engine: [0424/100624.743160:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:06:24.748 1251 1251 I update_engine: [0424/100624.748791:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:06:24.748 1251 1251 I update_engine: [0424/100624.748890:INFO:dynamic_partition_control_android.cc(697)] hyp_b is not in super partition metadata.
04-24 10:06:24.749 1251 1251 I update_engine: [0424/100624.749395:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:06:24.757 1251 1251 I update_engine: [0424/100624.757288:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:06:24.757 1251 1251 I update_engine: [0424/100624.757434:INFO:dynamic_partition_control_android.cc(697)] keymaster_b is not in super partition metadata.
04-24 10:06:24.757 1251 1251 I update_engine: [0424/100624.757884:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:06:24.767 1251 1251 I update_engine: [0424/100624.767820:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:06:24.767 1251 1251 I update_engine: [0424/100624.767953:INFO:dynamic_partition_control_android.cc(697)] qupfw_b is not in super partition metadata.
04-24 10:06:24.768 1251 1251 I update_engine: [0424/100624.768415:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:06:24.774 1251 1251 I update_engine: [0424/100624.774285:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:06:24.774 1251 1251 I update_engine: [0424/100624.774417:INFO:dynamic_partition_control_android.cc(697)] tz_b is not in super partition metadata.
04-24 10:06:24.774 1251 1251 I update_engine: [0424/100624.774868:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:06:24.825 1251 1251 I update_engine: [0424/100624.825687:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:06:24.825 1251 1251 I update_engine: [0424/100624.825849:INFO:dynamic_partition_control_android.cc(697)] xbl_b is not in super partition metadata.
04-24 10:06:24.826 1251 1251 I update_engine: [0424/100624.826333:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:06:24.857 1251 1251 I update_engine: [0424/100624.857630:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:06:24.857 1251 1251 I update_engine: [0424/100624.857798:INFO:dynamic_partition_control_android.cc(697)] xbl_config_b is not in super partition metadata.
04-24 10:06:24.858 1251 1251 I update_engine: [0424/100624.858245:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:06:24.864 1251 1251 I update_engine: [0424/100624.864318:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:06:24.864 1251 1251 I update_engine: [0424/100624.864404:INFO:dynamic_partition_control_android.cc(697)] modem_b is not in super partition metadata.
04-24 10:06:24.864 1251 1251 I update_engine: [0424/100624.864843:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:06:28.697 2778 8261 I SystemUpdate: [Execution,PackageFiles] Aggressive allocating space for file /data/ota_package/metadata with size 671.
04-24 10:06:28.706 2778 8261 I SystemUpdate: [Execution,ExecutionManager] Action pre-download-validate executed for 45.12 seconds.
04-24 10:06:28.750 2778 8261 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x70B, -1.000).
04-24 10:06:28.830 2778 8261 I SystemUpdate: [Execution,ExecutionManager] Action streaming-download executed for 0.12 seconds.
04-24 10:06:28.838 2778 8261 I SystemUpdate: [Execution,ExecutionManager] Action fixed-delay-execution executed for 0.00 seconds.
04-24 10:07:22.630 2778 9559 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
04-24 10:07:22.634 2778 9560 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 }.
04-24 10:07:22.676 2778 9560 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x70B, -1.000).
04-24 10:07:22.749 8915 8915 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x70B, isSetupWizard=false.
04-24 10:07:22.750 2778 9560 I SystemUpdate: [Execution,ExecutionManager] Action streaming-download executed for 0.11 seconds.
04-24 10:07:22.758 2778 9560 I SystemUpdate: [Execution,ExecutionManager] Action fixed-delay-execution executed for 0.00 seconds.
04-24 10:07:46.432 2778 9605 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
04-24 10:07:46.438 2778 9615 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 }.
04-24 10:07:46.457 2778 9615 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x70B, -1.000).
04-24 10:07:46.500 2778 9615 I SystemUpdate: [Execution,ExecutionManager] Action streaming-download executed for 0.06 seconds.
04-24 10:07:46.506 2778 9615 I SystemUpdate: [Execution,ExecutionManager] Action fixed-delay-execution executed for 0.00 seconds.
04-24 10:13:36.942 2778 10210 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
04-24 10:13:36.945 2778 10210 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 }.
04-24 10:13:36.964 2778 10210 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x70B, -1.000).
04-24 10:13:36.965 8915 8915 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x70B, isSetupWizard=false.
04-24 10:13:36.991 2778 10210 I SystemUpdate: [Execution,ExecutionManager] Action streaming-download executed for 0.05 seconds.
04-24 10:13:36.995 2778 10210 I SystemUpdate: [Execution,ExecutionManager] Action fixed-delay-execution executed for 0.00 seconds.
04-24 10:13:38.620 2778 10210 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 103.
04-24 10:13:38.621 2778 10211 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 }.
04-24 10:13:38.656 2778 10211 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x002, -1.000).
04-24 10:13:38.683 8915 8915 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x002, isSetupWizard=false.
04-24 10:13:38.696 2778 10211 I SystemUpdate: [Network,NetworkRequester] Requesting network with capabilities [11, 12]...
04-24 10:13:38.700 2778 4463 I SystemUpdate: [Network,NetworkRequester] Network acquired.
04-24 10:13:38.702 2778 3215 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
04-24 10:13:38.702 2778 3239 I SystemUpdate: [Control,NetworkControl] Received intent: Intent { act=android.net.wifi.supplicant.STATE_CHANGE flg=0x24000010 (has extras) }.
04-24 10:13:38.707 2778 10210 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
04-24 10:13:38.716 2778 10210 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 3.
04-24 10:13:40.013 2778 10211 I SystemUpdate: [Execution,PackageFiles] Aggressive allocating space for file /data/ota_package/payload_properties.txt with size 155.
04-24 10:13:41.195 2778 10211 I SystemUpdate: [Execution,PackageFiles] Aggressive allocating space for file /data/ota_package/care_map.pb with size 565.
04-24 10:13:42.397 2778 10211 I SystemUpdate: [Execution,PackageFiles] Aggressive allocating space for file /data/ota_package/metadata with size 671.
04-24 10:13:42.404 2778 10211 I SystemUpdate: [Execution,ExecutionManager] Action streaming-download executed for 3.78 seconds.
04-24 10:13:42.409 2778 10211 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x003, -1.000).
04-24 10:13:42.431 8915 8915 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x003, isSetupWizard=false.
04-24 10:13:42.466 2778 10211 I SystemUpdate: [Execution,ExecutionManager] Action streaming-process-package executed for 0.06 seconds.
04-24 10:13:42.499 2778 10211 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x413, -1.000).
04-24 10:13:42.506 8915 8915 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x413, isSetupWizard=false.
04-24 10:13:42.527 2778 10211 I SystemUpdate: [Control,ChimeraGcmTaskService] Scheduling task: DeviceIdle.
04-24 10:13:42.528 2778 10211 I SystemUpdate: [Execution,ExecutionManager] Action streaming-apply executed for 0.06 seconds.
04-24 10:13:42.539 2778 10211 I SystemUpdate: [Execution,ExecutionManager] Action fixed-delay-execution executed for 0.01 seconds.
04-24 10:13:49.117 2778 10211 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 109.
04-24 10:13:49.121 2778 10269 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 }.
04-24 10:13:49.156 2778 10269 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, -1.000).
04-24 10:13:49.176 8915 8915 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x111, isSetupWizard=false.
04-24 10:13:49.201 2778 10269 I SystemUpdate: [Network,NetworkRequester] Requesting network with capabilities [11, 12]...
04-24 10:13:49.203 2778 4463 I SystemUpdate: [Network,NetworkRequester] Network acquired.
04-24 10:13:49.208 2778 3239 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
04-24 10:13:49.208 2778 3215 I SystemUpdate: [Control,NetworkControl] Received intent: Intent { act=android.net.wifi.supplicant.STATE_CHANGE flg=0x24000010 (has extras) }.
04-24 10:13:49.215 2778 10211 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
04-24 10:13:49.231 2778 10211 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 3.
04-24 10:13:49.246 2778 10269 I SystemUpdate: [Execution,SynchronizedUpdateEngine] start(aweq{url=https://ota.googlezip.net/packages/ota-api/google_crosshatch_crosshatch/f1e9e3a55118faf0f116fbafe4fb4ab541b9d0c4.zip, payload_binary_file.offset=1381, payload_binary_file.length=264404200, properties=[FILE_HASH=RGZPFVSzneJzeO5fDCztYjzZHknYK0grsHdaBUkE5JU=, FILE_SIZE=264404200, METADATA_HASH=Usv6XeEjLVrUMqD0ATtWG706zqJwulW8sux55FSVIQU=, METADATA_SIZE=639271]}, additionalProperties.size=4)
04-24 10:13:49.246 2778 10269 I SystemUpdate: [Execution,UpdateEngineDelegate] applyPayload()
04-24 10:13:49.291 1251 1251 I update_engine: [0424/101349.291292:INFO:update_attempter_android.cc(273)] Using this install plan:
04-24 10:13:49.293 1251 1251 I update_engine: [0424/101349.293729:INFO:install_plan.cc(91)] InstallPlan: new_update, version: , source_slot: B, target_slot: A, url: https://ota.googlezip.net/packages/ota-api/google_crosshatch_crosshatch/f1e9e3a55118faf0f116fbafe4fb4ab541b9d0c4.zip, payload: (size: 264404200, metadata_size: 639271, metadata signature: , hash: 44664F1554B39DE27378EE5F0C2CED623CD91E49D82B482BB0775A054904E495, 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
04-24 10:13:49.294 1251 1251 I update_engine: [0424/101349.294478:INFO:metrics_utils.cc(363)] Number of Reboots during current update attempt = 0
04-24 10:13:49.295 1251 1251 I update_engine: [0424/101349.295800:INFO:metrics_utils.cc(371)] Payload Attempt Number = 1
04-24 10:13:49.297 2778 4635 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x002.
04-24 10:13:49.312 1251 1251 I update_engine: [0424/101349.296170:INFO:metrics_utils.cc(388)] Update Monotonic Timestamp Start = 1/1/1970 0:09:32 GMT
04-24 10:13:49.313 1251 1251 I update_engine: [0424/101349.313335:INFO:metrics_utils.cc(397)] Update Boot Timestamp Start = 1/1/1970 0:09:32 GMT
04-24 10:13:49.313 1251 1251 I update_engine: [0424/101349.313548:INFO:update_attempter_android.cc(615)] Scheduling an action processor start.
04-24 10:13:49.313 1251 1251 I update_engine: [0424/101349.313965:INFO:action_processor.cc(51)] ActionProcessor: starting UpdateBootFlagsAction
04-24 10:13:49.314 1251 1251 I update_engine: [0424/101349.314014:INFO:update_boot_flags_action.cc(45)] Marking booted slot as good.
04-24 10:13:49.364 1251 1251 I update_engine: [0424/101349.364527:INFO:action_processor.cc(116)] ActionProcessor: finished UpdateBootFlagsAction with code ErrorCode::kSuccess
04-24 10:13:49.364 1251 1251 I update_engine: [0424/101349.364818:INFO:action_processor.cc(143)] ActionProcessor: starting InstallPlanAction
04-24 10:13:49.364 1251 1251 I update_engine: [0424/101349.364894:INFO:action_processor.cc(116)] ActionProcessor: finished InstallPlanAction with code ErrorCode::kSuccess
04-24 10:13:49.364 1251 1251 I update_engine: [0424/101349.364946:INFO:action_processor.cc(143)] ActionProcessor: starting DownloadAction
04-24 10:13:49.365 1251 1251 I update_engine: [0424/101349.365034:INFO:install_plan.cc(91)] InstallPlan: new_update, version: , source_slot: B, target_slot: A, url: https://ota.googlezip.net/packages/ota-api/google_crosshatch_crosshatch/f1e9e3a55118faf0f116fbafe4fb4ab541b9d0c4.zip, payload: (size: 264404200, metadata_size: 639271, metadata signature: , hash: 44664F1554B39DE27378EE5F0C2CED623CD91E49D82B482BB0775A054904E495, 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
04-24 10:13:49.365 1251 1251 I update_engine: [0424/101349.365148:INFO:download_action.cc(199)] Marking new slot as unbootable
04-24 10:13:49.413 1251 1251 I update_engine: [0424/101349.413738:INFO:multi_range_http_fetcher.cc(45)] starting first transfer
04-24 10:13:49.414 1251 1251 I update_engine: [0424/101349.414078:INFO:multi_range_http_fetcher.cc(74)] starting transfer of range 1381+264404200
04-24 10:13:49.414 1251 1251 I update_engine: [0424/101349.414463:INFO:libcurl_http_fetcher.cc(146)] Starting/Resuming transfer
04-24 10:13:49.421 1251 1251 I update_engine: [0424/101349.421342:INFO:libcurl_http_fetcher.cc(165)] Using proxy: no
04-24 10:13:49.421 1251 1251 I update_engine: [0424/101349.421540:INFO:libcurl_http_fetcher.cc(305)] Setting up curl options for HTTPS
04-24 10:13:49.628 1251 1251 I update_engine: [0424/101349.628662:INFO:certificate_checker.cc(185)] Certificate changed from 6FB1A0E7467BCC4CEB0A4276D1F78CD3A97C1987D64BBAC9CE9CC625D62FF4F3 to 3E3F903022D1407292F4654CA1F281C892910DA6D28A678F04983F5471F38433.
04-24 10:13:50.004 1251 1251 I update_engine: [0424/101350.003570:INFO:certificate_checker.cc(185)] Certificate changed from 3E3F903022D1407292F4654CA1F281C892910DA6D28A678F04983F5471F38433 to 00CE9A06B876CF090C0D703C702E22F0E46AB54AF7BFD39A97CA0FB8E7F601D7.
04-24 10:13:50.543 2778 4635 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.000).
04-24 10:13:50.546 1251 1251 I update_engine: [0424/101350.546382:INFO:delta_performer.cc(209)] Completed 0/? operations, 16384/264404200 bytes downloaded (0%), overall progress 0%
04-24 10:13:50.560 8915 8915 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.000067.
04-24 10:13:50.577 2778 4635 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:13:50.759 1251 1251 I update_engine: [0424/101350.758907:INFO:delta_performer.cc(520)] Manifest size in payload matches expected value from Omaha
04-24 10:13:50.759 1251 1251 I update_engine: [0424/101350.759544:INFO:delta_performer.cc(1677)] Verifying using certificates: /system/etc/security/otacerts.zip
04-24 10:13:50.779 1251 1251 I update_engine: [0424/101350.779638:INFO:payload_verifier.cc(102)] signature blob size = 267
04-24 10:13:50.782 1251 1251 I update_engine: [0424/101350.782236:INFO:payload_verifier.cc(118)] Truncating the signature to its unpadded size: 256.
04-24 10:13:50.783 1251 1251 I update_engine: [0424/101350.783070:INFO:payload_verifier.cc(129)] Verified correct signature 1 out of 1 signatures.
04-24 10:13:50.783 1251 1251 I update_engine: [0424/101350.783336:INFO:payload_metadata.cc(224)] Metadata hash signature matches value in Omaha response.
04-24 10:13:50.837 1251 1251 I update_engine: [0424/101350.837543:INFO:delta_performer.cc(1712)] Detected a 'delta' payload.
04-24 10:13:50.896 1251 1251 I update_engine: [0424/101350.896718:INFO:prefs.cc(122)] dynamic-partition-metadata-updated not present in /data/misc/update_engine/prefs
04-24 10:13:50.897 1251 1251 I update_engine: [0424/101350.896991:INFO:delta_performer.cc(985)] Preparing partitions for new update. last hash = , new hash = RGZPFVSzneJzeO5fDCztYjzZHknYK0grsHdaBUkE5JU=Usv6XeEjLVrUMqD0ATtWG706zqJwulW8sux55FSVIQU=
04-24 10:13:50.899 1251 1251 W update_engine: type=1400 audit(0.0:901): avc: denied { search } for name="/" dev="sda20" ino=2 scontext=u:r:update_engine:s0 tcontext=u:object_r:metadata_file:s0 tclass=dir permissive=0
04-24 10:13:50.908 1251 1251 I update_engine: [0424/101350.908315:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:50.908 1251 1251 I update_engine: [0424/101350.908518:INFO:dynamic_partition_control_android.cc(587)] Added group google_dynamic_partitions_a with size 4069523456
04-24 10:13:50.909 1251 1251 I update_engine: [liblp]Partition system_a will resize from 0 bytes to 833884160 bytes
04-24 10:13:50.909 1251 1251 I update_engine: [0424/101350.909651:INFO:dynamic_partition_control_android.cc(615)] Added partition system_a to group google_dynamic_partitions_a with size 833884160
04-24 10:13:50.909 1251 1251 I update_engine: [liblp]Partition vendor_a will resize from 0 bytes to 463802368 bytes
04-24 10:13:50.909 1251 1251 I update_engine: [0424/101350.909794:INFO:dynamic_partition_control_android.cc(615)] Added partition vendor_a to group google_dynamic_partitions_a with size 463802368
04-24 10:13:50.909 1251 1251 I update_engine: [liblp]Partition product_a will resize from 0 bytes to 1914433536 bytes
04-24 10:13:50.909 1251 1251 I update_engine: [0424/101350.909873:INFO:dynamic_partition_control_android.cc(615)] Added partition product_a to group google_dynamic_partitions_a with size 1914433536
04-24 10:13:50.909 1251 1251 I update_engine: [liblp]Partition system_ext_a will resize from 0 bytes to 184561664 bytes
04-24 10:13:50.909 1251 1251 I update_engine: [0424/101350.909947:INFO:dynamic_partition_control_android.cc(615)] Added partition system_ext_a to group google_dynamic_partitions_a with size 184561664
04-24 10:13:50.913 1251 1251 W update_engine: [liblp]Flashing new logical partition geometry to /dev/block/bootdevice/by-name/system_a
04-24 10:13:50.919 1251 1251 I update_engine: [0424/101350.919159:INFO:dynamic_partition_control_android.cc(329)] Written metadata to /dev/block/bootdevice/by-name/system_a
04-24 10:13:50.919 1251 1251 I update_engine: [0424/101350.919639:INFO:delta_performer.cc(1002)] PreparePartitionsForUpdate done.
04-24 10:13:50.942 1251 1251 W update_engine: type=1400 audit(0.0:902): avc: denied { search } for name="/" dev="sda20" ino=2 scontext=u:r:update_engine:s0 tcontext=u:object_r:metadata_file:s0 tclass=dir permissive=0
04-24 10:13:50.947 1251 1251 I update_engine: [0424/101350.947797:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:50.947 1251 1251 I update_engine: [0424/101350.947960:INFO:dynamic_partition_control_android.cc(716)] vendor_b is mapped on device mapper: /dev/block/dm-1
04-24 10:13:50.942 1251 1251 W update_engine: type=1400 audit(0.0:903): avc: denied { search } for name="/" dev="sda20" ino=2 scontext=u:r:update_engine:s0 tcontext=u:object_r:metadata_file:s0 tclass=dir permissive=0
04-24 10:13:50.950 1251 1251 I update_engine: [0424/101350.950436:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:13:50.978 1251 1251 I update_engine: [libfs_mgr]Created logical partition vendor_a on device /dev/block/dm-19
04-24 10:13:50.979 1251 1251 I update_engine: [0424/101350.979115:INFO:dynamic_partition_control_android.cc(163)] Succesfully mapped vendor_a to device mapper (force_writable = 1); device path at /dev/block/dm-19
04-24 10:13:50.976 1251 1251 W update_engine: type=1400 audit(0.0:904): avc: denied { search } for name="/" dev="sda20" ino=2 scontext=u:r:update_engine:s0 tcontext=u:object_r:metadata_file:s0 tclass=dir permissive=0
04-24 10:13:50.981 1251 1251 I update_engine: [0424/101350.981389:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:50.981 1251 1251 I update_engine: [0424/101350.981506:INFO:dynamic_partition_control_android.cc(697)] boot_b is not in super partition metadata.
04-24 10:13:50.982 1251 1251 I update_engine: [0424/101350.982069:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:50.979 1251 1251 W update_engine: type=1400 audit(0.0:905): avc: denied { search } for name="/" dev="sda20" ino=2 scontext=u:r:update_engine:s0 tcontext=u:object_r:metadata_file:s0 tclass=dir permissive=0
04-24 10:13:50.984 1251 1251 I update_engine: [0424/101350.984655:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:13:50.984 1251 1251 I update_engine: [0424/101350.984789:INFO:dynamic_partition_control_android.cc(697)] boot_a is not in super partition metadata.
04-24 10:13:50.985 1251 1251 I update_engine: [0424/101350.985391:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:50.982 1251 1251 W update_engine: type=1400 audit(0.0:906): avc: denied { search } for name="/" dev="sda20" ino=2 scontext=u:r:update_engine:s0 tcontext=u:object_r:metadata_file:s0 tclass=dir permissive=0
04-24 10:13:50.986 1251 1251 I update_engine: [0424/101350.986823:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:50.986 1251 1251 I update_engine: [0424/101350.986954:INFO:dynamic_partition_control_android.cc(716)] system_b is mapped on device mapper: /dev/block/dm-0
04-24 10:13:50.982 1251 1251 W update_engine: type=1400 audit(0.0:907): avc: denied { search } for name="/" dev="sda20" ino=2 scontext=u:r:update_engine:s0 tcontext=u:object_r:metadata_file:s0 tclass=dir permissive=0
04-24 10:13:50.988 1251 1251 I update_engine: [0424/101350.988234:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:13:51.015 1251 1251 I update_engine: [libfs_mgr]Created logical partition system_a on device /dev/block/dm-20
04-24 10:13:51.015 1251 1251 I update_engine: [0424/101351.015812:INFO:dynamic_partition_control_android.cc(163)] Succesfully mapped system_a to device mapper (force_writable = 1); device path at /dev/block/dm-20
04-24 10:13:51.012 1251 1251 W update_engine: type=1400 audit(0.0:908): avc: denied { search } for name="/" dev="sda20" ino=2 scontext=u:r:update_engine:s0 tcontext=u:object_r:metadata_file:s0 tclass=dir permissive=0
04-24 10:13:51.018 1251 1251 I update_engine: [0424/101351.017979:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.018 1251 1251 I update_engine: [0424/101351.018105:INFO:dynamic_partition_control_android.cc(697)] vbmeta_b is not in super partition metadata.
04-24 10:13:51.018 1251 1251 I update_engine: [0424/101351.018864:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.020 1251 1251 I update_engine: [0424/101351.020747:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:13:51.020 1251 1251 I update_engine: [0424/101351.020832:INFO:dynamic_partition_control_android.cc(697)] vbmeta_a is not in super partition metadata.
04-24 10:13:51.021 1251 1251 I update_engine: [0424/101351.021330:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.023 1251 1251 I update_engine: [0424/101351.022973:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.023 1251 1251 I update_engine: [0424/101351.023155:INFO:dynamic_partition_control_android.cc(697)] dtbo_b is not in super partition metadata.
04-24 10:13:51.023 1251 1251 I update_engine: [0424/101351.023669:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.024 1251 1251 I update_engine: [0424/101351.024880:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:13:51.024 1251 1251 I update_engine: [0424/101351.024951:INFO:dynamic_partition_control_android.cc(697)] dtbo_a is not in super partition metadata.
04-24 10:13:51.025 1251 1251 I update_engine: [0424/101351.025412:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.027 1251 1251 I update_engine: [0424/101351.027015:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.027 1251 1251 I update_engine: [0424/101351.027148:INFO:dynamic_partition_control_android.cc(716)] product_b is mapped on device mapper: /dev/block/dm-2
04-24 10:13:51.028 1251 1251 I update_engine: [0424/101351.028570:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:13:51.071 1251 1251 I update_engine: [libfs_mgr]Created logical partition product_a on device /dev/block/dm-21
04-24 10:13:51.071 1251 1251 I update_engine: [0424/101351.071278:INFO:dynamic_partition_control_android.cc(163)] Succesfully mapped product_a to device mapper (force_writable = 1); device path at /dev/block/dm-21
04-24 10:13:51.074 1251 1251 I update_engine: [0424/101351.074397:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.074 1251 1251 I update_engine: [0424/101351.074634:INFO:dynamic_partition_control_android.cc(716)] system_ext_b is mapped on device mapper: /dev/block/dm-3
04-24 10:13:51.076 1251 1251 I update_engine: [0424/101351.076373:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:13:51.110 1251 1251 I update_engine: [libfs_mgr]Created logical partition system_ext_a on device /dev/block/dm-22
04-24 10:13:51.111 1251 1251 I update_engine: [0424/101351.110972:INFO:dynamic_partition_control_android.cc(163)] Succesfully mapped system_ext_a to device mapper (force_writable = 1); device path at /dev/block/dm-22
04-24 10:13:51.114 1251 1251 I update_engine: [0424/101351.114025:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.114 1251 1251 I update_engine: [0424/101351.114153:INFO:dynamic_partition_control_android.cc(697)] abl_b is not in super partition metadata.
04-24 10:13:51.114 1251 1251 I update_engine: [0424/101351.114881:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.116 1251 1251 I update_engine: [0424/101351.116663:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:13:51.116 1251 1251 I update_engine: [0424/101351.116756:INFO:dynamic_partition_control_android.cc(697)] abl_a is not in super partition metadata.
04-24 10:13:51.117 1251 1251 I update_engine: [0424/101351.117376:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.119 1251 1251 I update_engine: [0424/101351.119159:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.119 1251 1251 I update_engine: [0424/101351.119251:INFO:dynamic_partition_control_android.cc(697)] aop_b is not in super partition metadata.
04-24 10:13:51.119 1251 1251 I update_engine: [0424/101351.119898:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.121 1251 1251 I update_engine: [0424/101351.121388:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:13:51.121 1251 1251 I update_engine: [0424/101351.121496:INFO:dynamic_partition_control_android.cc(697)] aop_a is not in super partition metadata.
04-24 10:13:51.122 1251 1251 I update_engine: [0424/101351.122118:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.125 1251 1251 I update_engine: [0424/101351.125014:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.125 1251 1251 I update_engine: [0424/101351.125117:INFO:dynamic_partition_control_android.cc(697)] cmnlib_b is not in super partition metadata.
04-24 10:13:51.125 1251 1251 I update_engine: [0424/101351.125702:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.127 1251 1251 I update_engine: [0424/101351.126982:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:13:51.127 1251 1251 I update_engine: [0424/101351.127060:INFO:dynamic_partition_control_android.cc(697)] cmnlib_a is not in super partition metadata.
04-24 10:13:51.127 1251 1251 I update_engine: [0424/101351.127665:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.129 1251 1251 I update_engine: [0424/101351.129180:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.129 1251 1251 I update_engine: [0424/101351.129250:INFO:dynamic_partition_control_android.cc(697)] cmnlib64_b is not in super partition metadata.
04-24 10:13:51.129 1251 1251 I update_engine: [0424/101351.129820:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.131 1251 1251 I update_engine: [0424/101351.131387:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:13:51.131 1251 1251 I update_engine: [0424/101351.131468:INFO:dynamic_partition_control_android.cc(697)] cmnlib64_a is not in super partition metadata.
04-24 10:13:51.132 1251 1251 I update_engine: [0424/101351.132378:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.133 1251 1251 I update_engine: [0424/101351.133941:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.134 1251 1251 I update_engine: [0424/101351.134024:INFO:dynamic_partition_control_android.cc(697)] devcfg_b is not in super partition metadata.
04-24 10:13:51.134 1251 1251 I update_engine: [0424/101351.134695:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.136 1251 1251 I update_engine: [0424/101351.136209:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:13:51.136 1251 1251 I update_engine: [0424/101351.136289:INFO:dynamic_partition_control_android.cc(697)] devcfg_a is not in super partition metadata.
04-24 10:13:51.136 1251 1251 I update_engine: [0424/101351.136957:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.138 1251 1251 I update_engine: [0424/101351.138306:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.138 1251 1251 I update_engine: [0424/101351.138573:INFO:dynamic_partition_control_android.cc(697)] hyp_b is not in super partition metadata.
04-24 10:13:51.139 1251 1251 I update_engine: [0424/101351.139379:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.141 1251 1251 I update_engine: [0424/101351.141047:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:13:51.141 1251 1251 I update_engine: [0424/101351.141142:INFO:dynamic_partition_control_android.cc(697)] hyp_a is not in super partition metadata.
04-24 10:13:51.141 1251 1251 I update_engine: [0424/101351.141733:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.143 1251 1251 I update_engine: [0424/101351.143169:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.143 1251 1251 I update_engine: [0424/101351.143718:INFO:dynamic_partition_control_android.cc(697)] keymaster_b is not in super partition metadata.
04-24 10:13:51.144 1251 1251 I update_engine: [0424/101351.144338:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.145 1251 1251 I update_engine: [0424/101351.145783:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:13:51.145 1251 1251 I update_engine: [0424/101351.145863:INFO:dynamic_partition_control_android.cc(697)] keymaster_a is not in super partition metadata.
04-24 10:13:51.146 1251 1251 I update_engine: [0424/101351.146387:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.147 1251 1251 I update_engine: [0424/101351.147529:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.147 1251 1251 I update_engine: [0424/101351.147614:INFO:dynamic_partition_control_android.cc(697)] qupfw_b is not in super partition metadata.
04-24 10:13:51.148 1251 1251 I update_engine: [0424/101351.148124:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.149 1251 1251 I update_engine: [0424/101351.149492:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:13:51.149 1251 1251 I update_engine: [0424/101351.149570:INFO:dynamic_partition_control_android.cc(697)] qupfw_a is not in super partition metadata.
04-24 10:13:51.150 1251 1251 I update_engine: [0424/101351.150109:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.151 1251 1251 I update_engine: [0424/101351.151209:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.151 1251 1251 I update_engine: [0424/101351.151286:INFO:dynamic_partition_control_android.cc(697)] tz_b is not in super partition metadata.
04-24 10:13:51.151 1251 1251 I update_engine: [0424/101351.151774:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.152 1251 1251 I update_engine: [0424/101351.152942:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:13:51.153 1251 1251 I update_engine: [0424/101351.153017:INFO:dynamic_partition_control_android.cc(697)] tz_a is not in super partition metadata.
04-24 10:13:51.153 1251 1251 I update_engine: [0424/101351.153508:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.154 1251 1251 I update_engine: [0424/101351.154593:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.154 1251 1251 I update_engine: [0424/101351.154664:INFO:dynamic_partition_control_android.cc(697)] xbl_b is not in super partition metadata.
04-24 10:13:51.155 1251 1251 I update_engine: [0424/101351.155146:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.156 1251 1251 I update_engine: [0424/101351.156427:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:13:51.156 1251 1251 I update_engine: [0424/101351.156501:INFO:dynamic_partition_control_android.cc(697)] xbl_a is not in super partition metadata.
04-24 10:13:51.157 1251 1251 I update_engine: [0424/101351.157001:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.158 1251 1251 I update_engine: [0424/101351.158525:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.158 1251 1251 I update_engine: [0424/101351.158610:INFO:dynamic_partition_control_android.cc(697)] xbl_config_b is not in super partition metadata.
04-24 10:13:51.159 1251 1251 I update_engine: [0424/101351.159174:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.160 1251 1251 I update_engine: [0424/101351.160295:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:13:51.160 1251 1251 I update_engine: [0424/101351.160363:INFO:dynamic_partition_control_android.cc(697)] xbl_config_a is not in super partition metadata.
04-24 10:13:51.160 1251 1251 I update_engine: [0424/101351.160877:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.162 1251 1251 I update_engine: [0424/101351.162068:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.162 1251 1251 I update_engine: [0424/101351.162133:INFO:dynamic_partition_control_android.cc(697)] modem_b is not in super partition metadata.
04-24 10:13:51.162 1251 1251 I update_engine: [0424/101351.162737:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.164 1251 1251 I update_engine: [0424/101351.164155:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:13:51.164 1251 1251 I update_engine: [0424/101351.164222:INFO:dynamic_partition_control_android.cc(697)] modem_a is not in super partition metadata.
04-24 10:13:51.164 1251 1251 I update_engine: [0424/101351.164688:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:13:51.164 1251 1251 I update_engine: [0424/101351.164778:INFO:delta_performer.cc(451)] PartitionInfo old vendor sha256: 7tCtJFtMbISWexh5VgL9zuUHiKClzPn1WTR7Qq59wWQ= size: 461029376
04-24 10:13:51.164 1251 1251 I update_engine: [0424/101351.164828:INFO:delta_performer.cc(451)] PartitionInfo new vendor sha256: B9PneI0Ti3ZPy0uhseQUdeceubjjYQNmCQubsuxhlao= size: 463802368
04-24 10:13:51.164 1251 1251 I update_engine: [0424/101351.164867:INFO:delta_performer.cc(451)] PartitionInfo old boot sha256: P1lgJFQC7XwF6QUFhfp3bob8AIgNDcVbGTKUvupWkYw= size: 67108864
04-24 10:13:51.164 1251 1251 I update_engine: [0424/101351.164910:INFO:delta_performer.cc(451)] PartitionInfo new boot sha256: L9/wwcxfMAEF9Yf7NK96Sf/T+yIQOyI74TRoiIdCAa8= size: 67108864
04-24 10:13:51.164 1251 1251 I update_engine: [0424/101351.164952:INFO:delta_performer.cc(451)] PartitionInfo old system sha256: wJSGb3Lk3FalwrjLxIt05ylYQHwc3ZiSJYIWMU1NAj8= size: 820457472
04-24 10:13:51.165 1251 1251 I update_engine: [0424/101351.164992:INFO:delta_performer.cc(451)] PartitionInfo new system sha256: X1fs3Rk64cgdSXJ6cxrXCtwrTUPtuRiYkS0vHea4dxo= size: 833884160
04-24 10:13:51.165 1251 1251 I update_engine: [0424/101351.165033:INFO:delta_performer.cc(451)] PartitionInfo old vbmeta sha256: NZA30noTDwOxDdA0Pn3echbcMoLl45QyORs2jH5B/fo= size: 8192
04-24 10:13:51.165 1251 1251 I update_engine: [0424/101351.165072:INFO:delta_performer.cc(451)] PartitionInfo new vbmeta sha256: hslCQhrNGTXHKgMVs/Vr+xYzAhr59TgDkB2CSZNjrDI= size: 8192
04-24 10:13:51.165 1251 1251 I update_engine: [0424/101351.165112:INFO:delta_performer.cc(451)] PartitionInfo old dtbo sha256: epm94N0O9DNu7GZ5eZ5pOjFSezFgPRILbW1IDNIriOM= size: 8388608
04-24 10:13:51.165 1251 1251 I update_engine: [0424/101351.165151:INFO:delta_performer.cc(451)] PartitionInfo new dtbo sha256: Z+PrdGI9HsQS8bX3NZpu4Gf1zDN03R4/fk9B1Ty50bw= size: 8388608
04-24 10:13:51.165 1251 1251 I update_engine: [0424/101351.165193:INFO:delta_performer.cc(451)] PartitionInfo old product sha256: +RfEmpDVC9ex/vPJynvCcuaWEFkXDC0ad2MQ7u27bN0= size: 1940889600
04-24 10:13:51.165 1251 1251 I update_engine: [0424/101351.165232:INFO:delta_performer.cc(451)] PartitionInfo new product sha256: S+lNq+Hyyy9QpQnjxtvz1HYbcrFfd9RGGurXw4Z1oX4= size: 1914433536
04-24 10:13:51.165 1251 1251 I update_engine: [0424/101351.165272:INFO:delta_performer.cc(451)] PartitionInfo old system_ext sha256: DTesApHya0kNme5itTSC1MEp+Hsg543MWA4Vq0ykcBs= size: 181174272
04-24 10:13:51.165 1251 1251 I update_engine: [0424/101351.165355:INFO:delta_performer.cc(451)] PartitionInfo new system_ext sha256: NIqTbVPG4T6Tem/dfVa7U7HmMtX546dz1O/MtLYNseQ= size: 184561664
04-24 10:13:51.165 1251 1251 I update_engine: [0424/101351.165397:INFO:delta_performer.cc(451)] PartitionInfo old abl sha256: LVgMdz2xnvkLkVcJ+oqJg0TkcKLJvJhRPNHKRUkdJ2c= size: 1048576
04-24 10:13:51.165 1251 1251 I update_engine: [0424/101351.165434:INFO:delta_performer.cc(451)] PartitionInfo new abl sha256: LVgMdz2xnvkLkVcJ+oqJg0TkcKLJvJhRPNHKRUkdJ2c= size: 1048576
04-24 10:13:51.165 1251 1251 I update_engine: [0424/101351.165472:INFO:delta_performer.cc(451)] PartitionInfo old aop sha256: lwMLGjNpF5XfyBdAMy8aeFjdp7InRDD6nz5zKeP4I6k= size: 188416
04-24 10:13:51.165 1251 1251 I update_engine: [0424/101351.165510:INFO:delta_performer.cc(451)] PartitionInfo new aop sha256: lwMLGjNpF5XfyBdAMy8aeFjdp7InRDD6nz5zKeP4I6k= size: 188416
04-24 10:13:51.165 1251 1251 I update_engine: [0424/101351.165547:INFO:delta_performer.cc(451)] PartitionInfo old cmnlib sha256: m53rJ50FFnmZU/b5m31kPq0GNUX7/qag9oqKzrulYgQ= size: 380928
04-24 10:13:51.165 1251 1251 I update_engine: [0424/101351.165584:INFO:delta_performer.cc(451)] PartitionInfo new cmnlib sha256: m53rJ50FFnmZU/b5m31kPq0GNUX7/qag9oqKzrulYgQ= size: 380928
04-24 10:13:51.165 1251 1251 I update_engine: [0424/101351.165733:INFO:delta_performer.cc(451)] PartitionInfo old cmnlib64 sha256: 7cTk0BpXrCRydJgq7Q1XlIdnrr9Du3zF1brOZRNgzso= size: 499712
04-24 10:13:51.165 1251 1251 I update_engine: [0424/101351.165772:INFO:delta_performer.cc(451)] PartitionInfo new cmnlib64 sha256: 7cTk0BpXrCRydJgq7Q1XlIdnrr9Du3zF1brOZRNgzso= size: 499712
04-24 10:13:51.165 1251 1251 I update_engine: [0424/101351.165827:INFO:delta_performer.cc(451)] PartitionInfo old devcfg sha256: Oiiho60b3LwSrDHj6FBrcIuq+xysUSslPrwekIKFaWI= size: 40960
04-24 10:13:51.165 1251 1251 I update_engine: [0424/101351.165865:INFO:delta_performer.cc(451)] PartitionInfo new devcfg sha256: Oiiho60b3LwSrDHj6FBrcIuq+xysUSslPrwekIKFaWI= size: 40960
04-24 10:13:51.165 1251 1251 I update_engine: [0424/101351.165952:INFO:delta_performer.cc(451)] PartitionInfo old hyp sha256: oeV8en/VZcLP5KMcF6lNpQOlCKk6tJ3fRQLOELr05qY= size: 393216
04-24 10:13:51.166 1251 1251 I update_engine: [0424/101351.165989:INFO:delta_performer.cc(451)] PartitionInfo new hyp sha256: oeV8en/VZcLP5KMcF6lNpQOlCKk6tJ3fRQLOELr05qY= size: 393216
04-24 10:13:51.166 1251 1251 I update_engine: [0424/101351.166025:INFO:delta_performer.cc(451)] PartitionInfo old keymaster sha256: HWG8G+i3TudNjXfsOf2YTGjaDFNugZCbFuOZcmpdOSA= size: 221184
04-24 10:13:51.166 1251 1251 I update_engine: [0424/101351.166079:INFO:delta_performer.cc(451)] PartitionInfo new keymaster sha256: HWG8G+i3TudNjXfsOf2YTGjaDFNugZCbFuOZcmpdOSA= size: 221184
04-24 10:13:51.166 1251 1251 I update_engine: [0424/101351.166118:INFO:delta_performer.cc(451)] PartitionInfo old qupfw sha256: dbGYgOeXcVu2vYzKLLWOQL73bqyqqE8NmsI+weCoIbM= size: 65536
04-24 10:13:51.166 1251 1251 I update_engine: [0424/101351.166153:INFO:delta_performer.cc(451)] PartitionInfo new qupfw sha256: dbGYgOeXcVu2vYzKLLWOQL73bqyqqE8NmsI+weCoIbM= size: 65536
04-24 10:13:51.166 1251 1251 I update_engine: [0424/101351.166189:INFO:delta_performer.cc(451)] PartitionInfo old tz sha256: 6bJna8eHGZLR0FnICEb1txhlsl6Lr6Eh5+aDyXQeFnQ= size: 2056192
04-24 10:13:51.166 1251 1251 I update_engine: [0424/101351.166225:INFO:delta_performer.cc(451)] PartitionInfo new tz sha256: 6bJna8eHGZLR0FnICEb1txhlsl6Lr6Eh5+aDyXQeFnQ= size: 2056192
04-24 10:13:51.166 1251 1251 I update_engine: [0424/101351.166296:INFO:delta_performer.cc(451)] PartitionInfo old xbl sha256: dyTD92W0a1LmpoDQ45K24y6TGFvvmTfpZSYx7+xjPVI= size: 3670016
04-24 10:13:51.166 1251 1251 I update_engine: [0424/101351.166334:INFO:delta_performer.cc(451)] PartitionInfo new xbl sha256: dyTD92W0a1LmpoDQ45K24y6TGFvvmTfpZSYx7+xjPVI= size: 3670016
04-24 10:13:51.166 1251 1251 I update_engine: [0424/101351.166370:INFO:delta_performer.cc(451)] PartitionInfo old xbl_config sha256: FiHFX0+WXgnpSJlw5pQLczrmOPZjw7wUbYHj7V2MqS8= size: 98304
04-24 10:13:51.166 1251 1251 I update_engine: [0424/101351.166405:INFO:delta_performer.cc(451)] PartitionInfo new xbl_config sha256: FiHFX0+WXgnpSJlw5pQLczrmOPZjw7wUbYHj7V2MqS8= size: 98304
04-24 10:13:51.166 1251 1251 I update_engine: [0424/101351.166441:INFO:delta_performer.cc(451)] PartitionInfo old modem sha256: Bma4ByN9EbgVcXp0hYo3c200C+j6JEO6Wg6nKLgb9ZQ= size: 73150464
04-24 10:13:51.166 1251 1251 I update_engine: [0424/101351.166476:INFO:delta_performer.cc(451)] PartitionInfo new modem sha256: W9aol30QOcS2QId5FY6JojfXyaV7rhhCaq9TBsn3A+k= size: 73150464
04-24 10:13:51.166 1251 1251 I update_engine: [0424/101351.166917:INFO:delta_performer.cc(385)] Opening /dev/block/dm-19 partition without O_DSYNC
04-24 10:13:51.168 1251 1251 I update_engine: [0424/101351.168025:INFO:delta_performer.cc(128)] Caching writes.
04-24 10:13:51.168 1251 1251 I update_engine: [0424/101351.168092:INFO:delta_performer.cc(397)] Applying 2298 operations to partition "vendor"
04-24 10:13:51.168 1251 1251 I update_engine: [0424/101351.168139:INFO:delta_performer.cc(657)] Starting to apply update payload operations
04-24 10:13:54.776 2778 6285 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.010).
04-24 10:13:54.833 8915 8915 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.010097.
04-24 10:13:54.865 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:13:56.451 2778 6285 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.020).
04-24 10:13:56.471 8915 8915 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.020135.
04-24 10:13:56.500 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:13:57.883 2778 6285 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.030).
04-24 10:13:57.902 8915 8915 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.030173.
04-24 10:13:57.929 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:13:59.246 2778 6285 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.040).
04-24 10:13:59.266 8915 8915 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.040212.
04-24 10:13:59.294 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:14:01.383 1251 1251 I update_engine: [0424/101401.382895:INFO:delta_performer.cc(209)] Completed 1390/8682 operations (16%), 12662367/264404200 bytes downloaded (4%), overall progress 10%
04-24 10:14:02.363 2778 6285 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.050).
04-24 10:14:02.383 8915 8915 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.050250.
04-24 10:14:02.412 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:14:03.508 2778 6285 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.060).
04-24 10:14:03.526 8915 8915 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.060289.
04-24 10:14:03.553 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:14:06.929 1251 1251 I update_engine: [0424/101406.929706:INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/boot_a partition without O_DSYNC
04-24 10:14:06.931 1251 1251 I update_engine: [0424/101406.931193:INFO:delta_performer.cc(128)] Caching writes.
04-24 10:14:06.931 1251 1251 I update_engine: [0424/101406.931363:INFO:delta_performer.cc(397)] Applying 21 operations to partition "boot"
04-24 10:14:06.952 2778 6285 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.070).
04-24 10:14:06.971 8915 8915 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.070327.
04-24 10:14:07.001 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:14:07.063 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:14:08.333 2778 6285 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.100).
04-24 10:14:08.375 8915 8915 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.100380.
04-24 10:14:08.404 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:14:08.405 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:14:20.066 1251 1251 I update_engine: [0424/101420.065900:INFO:delta_performer.cc(385)] Opening /dev/block/dm-20 partition without O_DSYNC
04-24 10:14:20.067 1251 1251 I update_engine: [0424/101420.067514:INFO:delta_performer.cc(128)] Caching writes.
04-24 10:14:20.067 1251 1251 I update_engine: [0424/101420.067688:INFO:delta_performer.cc(397)] Applying 3452 operations to partition "system"
04-24 10:14:20.082 2778 2834 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.119).
04-24 10:14:20.102 8915 8915 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.118660.
04-24 10:14:20.129 2778 2834 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:14:20.440 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:14:20.489 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:14:20.492 1251 1251 I update_engine: [0424/101420.492512:INFO:delta_performer.cc(209)] Completed 2358/8682 operations (27%), 37025200/264404200 bytes downloaded (14%), overall progress 20%
04-24 10:14:20.697 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:14:25.577 2778 2834 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.159).
04-24 10:14:25.600 8915 8915 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.158817.
04-24 10:14:25.626 2778 2834 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:14:26.170 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:14:26.224 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:14:29.291 2778 10304 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
04-24 10:14:30.151 2778 6285 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.189).
04-24 10:14:30.190 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:14:33.680 1251 1251 I update_engine: [0424/101433.680811:INFO:delta_performer.cc(209)] Completed 3647/8682 operations (42%), 52492555/264404200 bytes downloaded (19%), overall progress 30%
04-24 10:14:33.808 2778 6285 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.199).
04-24 10:14:33.882 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:14:34.856 2778 3215 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
04-24 10:14:34.870 2778 10304 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
04-24 10:14:36.603 2778 6285 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.209).
04-24 10:14:36.648 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:14:36.886 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:14:38.102 2778 6285 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.239).
04-24 10:14:38.144 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:14:38.148 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:14:41.347 2778 6285 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.259).
04-24 10:14:41.396 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:14:42.597 2778 6285 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.269).
04-24 10:14:42.664 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:14:42.879 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:14:42.914 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:14:44.181 1251 1251 I update_engine: [0424/101444.181514:INFO:delta_performer.cc(209)] Completed 4515/8682 operations (52%), 79021304/264404200 bytes downloaded (29%), overall progress 40%
04-24 10:14:44.214 2778 6285 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.299).
04-24 10:14:44.261 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:14:46.056 2778 6285 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.309).
04-24 10:14:46.094 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:14:47.472 2778 2834 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.319).
04-24 10:14:47.513 2778 2834 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:14:49.254 2778 2834 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.329).
04-24 10:14:49.308 2778 2834 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:14:51.235 2778 2834 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.339).
04-24 10:14:51.278 2778 2834 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:14:52.528 2778 2834 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.349).
04-24 10:14:52.578 2778 2834 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:14:54.348 2778 2834 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.360).
04-24 10:14:54.403 2778 2834 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:14:54.446 1251 1251 I update_engine: [0424/101454.446752:INFO:delta_performer.cc(209)] Completed 5691/8682 operations (65%), 95187958/264404200 bytes downloaded (36%), overall progress 50%
04-24 10:14:55.869 1251 1251 I update_engine: [0424/101455.869310:INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/vbmeta_a partition without O_DSYNC
04-24 10:14:55.870 1251 1251 I update_engine: [0424/101455.870708:INFO:delta_performer.cc(128)] Caching writes.
04-24 10:14:55.870 1251 1251 I update_engine: [0424/101455.870855:INFO:delta_performer.cc(397)] Applying 2 operations to partition "vbmeta"
04-24 10:14:55.899 1251 1251 I update_engine: [0424/101455.899026:INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/dtbo_a partition without O_DSYNC
04-24 10:14:55.900 1251 1251 I update_engine: [0424/101455.900258:INFO:delta_performer.cc(128)] Caching writes.
04-24 10:14:55.900 1251 1251 I update_engine: [0424/101455.900381:INFO:delta_performer.cc(397)] Applying 6 operations to partition "dtbo"
04-24 10:14:55.950 1251 1251 I update_engine: [0424/101455.950582:INFO:delta_performer.cc(385)] Opening /dev/block/dm-21 partition without O_DSYNC
04-24 10:14:55.952 1251 1251 I update_engine: [0424/101455.952143:INFO:delta_performer.cc(128)] Caching writes.
04-24 10:14:55.952 1251 1251 I update_engine: [0424/101455.952300:INFO:delta_performer.cc(397)] Applying 1709 operations to partition "product"
04-24 10:14:56.289 2778 2834 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.370).
04-24 10:14:56.337 2778 2834 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:14:56.399 2778 2834 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:15:04.923 2778 2834 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.400).
04-24 10:15:04.989 2778 2834 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:15:05.204 2778 2834 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:15:11.090 2778 2834 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.440).
04-24 10:15:11.149 2778 2834 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:15:11.152 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:15:11.211 1251 1251 I update_engine: [0424/101511.211177:INFO:delta_performer.cc(209)] Completed 6494/8682 operations (74%), 121631536/264404200 bytes downloaded (46%), overall progress 60%
04-24 10:15:11.212 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:15:11.957 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:15:12.565 2778 6285 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.500).
04-24 10:15:12.648 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:15:13.168 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:15:32.121 2778 3215 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
04-24 10:15:32.150 2778 10318 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
04-24 10:15:34.849 2778 3239 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
04-24 10:15:34.872 2778 10318 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
04-24 10:16:34.888 2778 3239 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
04-24 10:16:34.902 2778 10462 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
04-24 10:16:37.734 2778 3239 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
04-24 10:16:37.747 2778 10462 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
04-24 10:16:41.515 2778 10462 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
04-24 10:16:41.559 8915 8915 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x111, isSetupWizard=false.
04-24 10:16:47.317 2778 10495 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
04-24 10:16:49.947 1251 1251 I update_engine: [0424/101649.946970:INFO:delta_performer.cc(209)] Completed 6495/8682 operations (74%), 137015982/264404200 bytes downloaded (51%), overall progress 62%
04-24 10:16:51.665 2778 2824 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.518).
04-24 10:16:51.723 2778 2824 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:16:51.727 2778 2834 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:16:51.778 2778 2834 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:16:51.890 2778 2834 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:16:52.715 2778 2834 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.558).
04-24 10:16:52.778 2778 2834 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:16:52.946 2778 2834 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:16:53.332 2778 2834 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:16:53.815 2778 2834 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.589).
04-24 10:16:53.883 2778 2834 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:16:54.526 2778 2834 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:17:34.891 2778 3239 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
04-24 10:17:34.906 2778 10517 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
04-24 10:17:47.787 2778 3239 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
04-24 10:17:47.802 2778 10518 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
04-24 10:17:47.899 2778 3239 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
04-24 10:17:47.908 2778 10518 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
04-24 10:17:52.699 2778 3239 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
04-24 10:17:52.710 2778 10518 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
04-24 10:17:52.818 2778 3239 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
04-24 10:17:52.831 2778 10518 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
04-24 10:17:56.378 2778 3239 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
04-24 10:17:56.386 2778 10518 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
04-24 10:18:34.854 2778 3239 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
04-24 10:18:34.885 2778 10523 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
04-24 10:18:36.639 1251 1251 I update_engine: [0424/101836.639042:INFO:delta_performer.cc(209)] Completed 6610/8682 operations (76%), 160494085/264404200 bytes downloaded (60%), overall progress 68%
04-24 10:18:36.674 2778 2824 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.607).
04-24 10:18:36.737 2778 2824 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:18:39.632 2778 6285 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.617).
04-24 10:18:39.642 1251 1251 I update_engine: [0424/101839.642863:INFO:delta_performer.cc(209)] Completed 6933/8682 operations (79%), 163934693/264404200 bytes downloaded (62%), overall progress 70%
04-24 10:18:39.686 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:18:39.689 2778 2824 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:18:40.234 2778 2824 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:18:42.864 2778 2824 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.657).
04-24 10:18:42.928 2778 2824 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:18:44.164 2778 2824 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.667).
04-24 10:18:44.221 2778 2824 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:18:45.823 2778 2824 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.677).
04-24 10:18:45.883 2778 2824 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:18:46.459 2778 2824 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:18:47.816 2778 2824 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.697).
04-24 10:18:47.855 2778 2824 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:18:47.865 2778 2824 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:18:49.418 2778 2824 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.717).
04-24 10:18:49.475 2778 2824 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:18:50.755 2778 2824 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.727).
04-24 10:18:50.865 2778 2824 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:18:50.869 2778 2824 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:18:53.476 2778 2824 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.758).
04-24 10:18:53.527 2778 2824 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:18:53.529 2778 2824 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:18:53.615 1251 1251 I update_engine: [0424/101853.615747:INFO:delta_performer.cc(209)] Completed 7145/8682 operations (82%), 206237859/264404200 bytes downloaded (78%), overall progress 80%
04-24 10:18:53.620 2778 2824 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:18:54.290 2778 2824 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:18:54.673 2778 2824 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.808).
04-24 10:18:54.724 2778 2824 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:19:01.424 2778 2824 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.818).
04-24 10:19:01.489 2778 2824 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:19:02.460 2778 2824 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.828).
04-24 10:19:02.505 2778 2824 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:19:05.226 1251 1251 I update_engine: [0424/101905.226056:INFO:delta_performer.cc(385)] Opening /dev/block/dm-22 partition without O_DSYNC
04-24 10:19:05.231 1251 1251 I update_engine: [0424/101905.231280:INFO:delta_performer.cc(128)] Caching writes.
04-24 10:19:05.231 1251 1251 I update_engine: [0424/101905.231433:INFO:delta_performer.cc(397)] Applying 401 operations to partition "system_ext"
04-24 10:19:06.646 2778 2824 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.838).
04-24 10:19:06.699 2778 2824 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:19:07.279 2778 2824 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:19:07.662 2778 2824 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.858).
04-24 10:19:07.715 2778 2824 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:19:07.718 2778 2824 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:19:09.516 2778 2824 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.878).
04-24 10:19:09.588 2778 2824 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:19:10.365 2778 2824 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:19:10.827 2778 2824 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.898).
04-24 10:19:10.833 1251 1251 I update_engine: [0424/101910.833121:INFO:delta_performer.cc(209)] Completed 7876/8682 operations (90%), 237973427/264404200 bytes downloaded (90%), overall progress 90%
04-24 10:19:10.937 2778 2824 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:19:11.484 1251 1251 I update_engine: [0424/101911.484346:INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/abl_a partition without O_DSYNC
04-24 10:19:11.485 1251 1251 I update_engine: [0424/101911.485702:INFO:delta_performer.cc(128)] Caching writes.
04-24 10:19:11.485 1251 1251 I update_engine: [0424/101911.485831:INFO:delta_performer.cc(397)] Applying 1 operations to partition "abl"
04-24 10:19:11.506 1251 1251 I update_engine: [0424/101911.505937:INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/aop_a partition without O_DSYNC
04-24 10:19:11.507 1251 1251 I update_engine: [0424/101911.507232:INFO:delta_performer.cc(128)] Caching writes.
04-24 10:19:11.507 1251 1251 I update_engine: [0424/101911.507342:INFO:delta_performer.cc(397)] Applying 3 operations to partition "aop"
04-24 10:19:11.525 1251 1251 I update_engine: [0424/101911.525121:INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/cmnlib_a partition without O_DSYNC
04-24 10:19:11.526 1251 1251 I update_engine: [0424/101911.526419:INFO:delta_performer.cc(128)] Caching writes.
04-24 10:19:11.526 1251 1251 I update_engine: [0424/101911.526551:INFO:delta_performer.cc(397)] Applying 1 operations to partition "cmnlib"
04-24 10:19:11.541 1251 1251 I update_engine: [0424/101911.541859:INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/cmnlib64_a partition without O_DSYNC
04-24 10:19:11.543 1251 1251 I update_engine: [0424/101911.543103:INFO:delta_performer.cc(128)] Caching writes.
04-24 10:19:11.543 1251 1251 I update_engine: [0424/101911.543242:INFO:delta_performer.cc(397)] Applying 1 operations to partition "cmnlib64"
04-24 10:19:11.560 1251 1251 I update_engine: [0424/101911.559981:INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/devcfg_a partition without O_DSYNC
04-24 10:19:11.561 1251 1251 I update_engine: [0424/101911.561113:INFO:delta_performer.cc(128)] Caching writes.
04-24 10:19:11.561 1251 1251 I update_engine: [0424/101911.561203:INFO:delta_performer.cc(397)] Applying 1 operations to partition "devcfg"
04-24 10:19:11.574 1251 1251 I update_engine: [0424/101911.573984:INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/hyp_a partition without O_DSYNC
04-24 10:19:11.575 1251 1251 I update_engine: [0424/101911.575334:INFO:delta_performer.cc(128)] Caching writes.
04-24 10:19:11.575 1251 1251 I update_engine: [0424/101911.575444:INFO:delta_performer.cc(397)] Applying 2 operations to partition "hyp"
04-24 10:19:11.593 1251 1251 I update_engine: [0424/101911.593135:INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/keymaster_a partition without O_DSYNC
04-24 10:19:11.594 1251 1251 I update_engine: [0424/101911.594313:INFO:delta_performer.cc(128)] Caching writes.
04-24 10:19:11.594 1251 1251 I update_engine: [0424/101911.594419:INFO:delta_performer.cc(397)] Applying 3 operations to partition "keymaster"
04-24 10:19:11.613 1251 1251 I update_engine: [0424/101911.613678:INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/qupfw_a partition without O_DSYNC
04-24 10:19:11.614 1251 1251 I update_engine: [0424/101911.614931:INFO:delta_performer.cc(128)] Caching writes.
04-24 10:19:11.615 1251 1251 I update_engine: [0424/101911.615049:INFO:delta_performer.cc(397)] Applying 1 operations to partition "qupfw"
04-24 10:19:11.620 1251 1251 I update_engine: [0424/101911.620639:INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/tz_a partition without O_DSYNC
04-24 10:19:11.621 1251 1251 I update_engine: [0424/101911.621750:INFO:delta_performer.cc(128)] Caching writes.
04-24 10:19:11.621 1251 1251 I update_engine: [0424/101911.621827:INFO:delta_performer.cc(397)] Applying 23 operations to partition "tz"
04-24 10:19:11.697 1251 1251 I update_engine: [0424/101911.697761:INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/xbl_a partition without O_DSYNC
04-24 10:19:11.699 1251 1251 I update_engine: [0424/101911.699205:INFO:delta_performer.cc(128)] Caching writes.
04-24 10:19:11.699 1251 1251 I update_engine: [0424/101911.699320:INFO:delta_performer.cc(397)] Applying 7 operations to partition "xbl"
04-24 10:19:11.778 1251 1251 I update_engine: [0424/101911.778268:INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/xbl_config_a partition without O_DSYNC
04-24 10:19:11.779 1251 1251 I update_engine: [0424/101911.779888:INFO:delta_performer.cc(128)] Caching writes.
04-24 10:19:11.780 1251 1251 I update_engine: [0424/101911.780055:INFO:delta_performer.cc(397)] Applying 1 operations to partition "xbl_config"
04-24 10:19:11.795 1251 1251 I update_engine: [0424/101911.795465:INFO:delta_performer.cc(385)] Opening /dev/block/bootdevice/by-name/modem_a partition without O_DSYNC
04-24 10:19:11.797 1251 1251 I update_engine: [0424/101911.797254:INFO:delta_performer.cc(128)] Caching writes.
04-24 10:19:11.797 1251 1251 I update_engine: [0424/101911.797444:INFO:delta_performer.cc(397)] Applying 749 operations to partition "modem"
04-24 10:19:11.850 2778 2824 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.908).
04-24 10:19:11.911 2778 2824 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:19:11.912 2778 2824 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:19:12.911 2778 2824 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.928).
04-24 10:19:12.987 2778 2824 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:19:13.582 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:19:14.123 2778 6285 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.948).
04-24 10:19:14.177 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:19:15.155 2778 6285 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.958).
04-24 10:19:15.239 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:19:15.737 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:19:16.260 2778 6285 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.978).
04-24 10:19:16.315 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:19:16.691 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:19:16.921 2778 6285 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003.
04-24 10:19:19.484 1251 1251 I update_engine: [0424/101919.483899:INFO:delta_performer.cc(209)] Completed 8682/8682 operations (100%), 264404200/264404200 bytes downloaded (100%), overall progress 100%
04-24 10:19:19.486 1251 1251 I update_engine: [0424/101919.486339:INFO:delta_performer.cc(1649)] Extracted signature data of size 267 at 263764395
04-24 10:19:19.486 1251 1251 I update_engine: [0424/101919.486915:INFO:multi_range_http_fetcher.cc(115)] Terminating transfer.
04-24 10:19:19.487 1251 1251 I update_engine: [0424/101919.486982:INFO:libcurl_http_fetcher.cc(548)] Requesting libcurl to terminate transfer.
04-24 10:19:19.506 1251 1251 I update_engine: [0424/101919.506866:INFO:multi_range_http_fetcher.cc(177)] Received transfer terminated.
04-24 10:19:19.507 1251 1251 I update_engine: [0424/101919.507099:INFO:multi_range_http_fetcher.cc(129)] TransferEnded w/ code 206
04-24 10:19:19.507 1251 1251 I update_engine: [0424/101919.507145:INFO:multi_range_http_fetcher.cc(163)] Done w/ all transfers
04-24 10:19:19.561 1251 1251 I update_engine: [0424/101919.561384:INFO:delta_performer.cc(1677)] Verifying using certificates: /system/etc/security/otacerts.zip
04-24 10:19:19.566 1251 1251 I update_engine: [0424/101919.566834:INFO:payload_verifier.cc(102)] signature blob size = 267
04-24 10:19:19.567 1251 1251 I update_engine: [0424/101919.567033:INFO:payload_verifier.cc(118)] Truncating the signature to its unpadded size: 256.
04-24 10:19:19.574 1251 1251 I update_engine: [0424/101919.574693:INFO:payload_verifier.cc(129)] Verified correct signature 1 out of 1 signatures.
04-24 10:19:19.574 1251 1251 I update_engine: [0424/101919.574803:INFO:delta_performer.cc(1899)] Payload hash matches value in payload.
04-24 10:19:19.581 1251 1251 I update_engine: [0424/101919.581418:INFO:download_action.cc(400)] Collections of histograms for UpdateEngine.DownloadAction.
04-24 10:19:19.581 1251 1251 I update_engine: Histogram: UpdateEngine.DownloadAction.InstallOperation::PUFFDIFF.Duration recorded 118 samples, mean = 2097.8
04-24 10:19:19.581 1251 1251 I update_engine: 0 ------------------------------------------------------------------------O (18 = 15.3%)
04-24 10:19:19.581 1251 1251 I update_engine: 10 --------------------------------------------------------------------O (17 = 14.4%) {15.3%}
04-24 10:19:19.581 1251 1251 I update_engine: 18 --------------------------------------------O (11 = 9.3%) {29.7%}
04-24 10:19:19.581 1251 1251 I update_engine: 32 --------------------------------------------------------------------O (17 = 14.4%) {39.0%}
04-24 10:19:19.581 1251 1251 I update_engine: 57 ------------------------------------O (9 = 7.6%) {53.4%}
04-24 10:19:19.581 1251 1251 I update_engine: 101 ------------------------------------------------O (12 = 10.2%) {61.0%}
04-24 10:19:19.581 1251 1251 I update_engine: 179 ------------------------------------O (9 = 7.6%) {71.2%}
04-24 10:19:19.581 1251 1251 I update_engine: 317 ----------------------------O (7 = 5.9%) {78.8%}
04-24 10:19:19.581 1251 1251 I update_engine: 561 ------------O (3 = 2.5%) {84.7%}
04-24 10:19:19.581 1251 1251 I update_engine: 993 ------------------------O (6 = 5.1%) {87.3%}
04-24 10:19:19.581 1251 1251 I update_engine: 1758 ----------------O (4 = 3.4%) {92.4%}
04-24 10:19:19.581 1251 1251 I update_engine: 3112 --------O (2 = 1.7%) {95.8%}
04-24 10:19:19.581 1251 1251 I update_engine: 5509 O (0 = 0.0%) {97.5%}
04-24 10:19:19.581 1251 1251 I update_engine: 9752 ----O (1 = 0.8%) {97.5%}
04-24 10:19:19.581 1251 1251 I update_engine: 17262 ...
04-24 10:19:19.581 1251 1251 I update_engine: 95743 --------O (2 = 1.7%) {98.3%}
04-24 10:19:19.581 1251 1251 I update_engine: 169478 ...
04-24 10:19:19.581 1251 1251 I update_engine:
04-24 10:19:19.581 1251 1251 I update_engine: Histogram: UpdateEngine.DownloadAction.InstallOperation::REPLACE.Duration recorded 470 samples, mean = 1.9
04-24 10:19:19.581 1251 1251 I update_engine: 0 ------------------------------------------------------------------------O (456 = 97.0%)
04-24 10:19:19.581 1251 1251 I update_engine: 10 O (3 = 0.6%) {97.0%}
04-24 10:19:19.581 1251 1251 I update_engine: 18 -O (5 = 1.1%) {97.7%}
04-24 10:19:19.581 1251 1251 I update_engine: 32 O (2 = 0.4%) {98.7%}
04-24 10:19:19.581 1251 1251 I update_engine: 57 O (2 = 0.4%) {99.1%}
04-24 10:19:19.581 1251 1251 I update_engine: 101 O (1 = 0.2%) {99.6%}
04-24 10:19:19.581 1251 1251 I update_engine: 179 O (1 = 0.2%) {99.8%}
04-24 10:19:19.581 1251 1251 I update_engine: 317 ...
04-24 10:19:19.581 1251 1251 I update_engine:
04-24 10:19:19.581 1251 1251 I update_engine: Histogram: UpdateEngine.DownloadAction.InstallOperation::SOURCE_BSDIFF.Duration recorded 2302 samples, mean = 12.3
04-24 10:19:19.581 1251 1251 I update_engine: 0 ------------------------------------------------------------------------O (2002 = 87.0%)
04-24 10:19:19.581 1251 1251 I update_engine: 10 -------O (184 = 8.0%) {87.0%}
04-24 10:19:19.581 1251 1251 I update_engine: 18 --O (54 = 2.3%) {95.0%}
04-24 10:19:19.581 1251 1251 I update_engine: 32 -O (26 = 1.1%) {97.3%}
04-24 10:19:19.581 1251 1251 I update_engine: 57 O (11 = 0.5%) {98.4%}
04-24 10:19:19.581 1251 1251 I update_engine: 101 O (10 = 0.4%) {98.9%}
04-24 10:19:19.581 1251 1251 I update_engine: 179 O (4 = 0.2%) {99.3%}
04-24 10:19:19.581 1251 1251 I update_engine: 317 O (6 = 0.3%) {99.5%}
04-24 10:19:19.581 1251 1251 I update_engine: 561 O (3 = 0.1%) {99.8%}
04-24 10:19:19.581 1251 1251 I update_engine: 993 O (2 = 0.1%) {99.9%}
04-24 10:19:19.581 1251 1251 I update_engine: 1758 ...
04-24 10:19:19.581 1251 1251 I update_engine:
04-24 10:19:19.581 1251 1251 I update_engine: Histogram: UpdateEngine.DownloadAction.InstallOperation::SOURCE_COPY.Duration recorded 5148 samples, mean = 5.1
04-24 10:19:19.581 1251 1251 I update_engine: 0 ------------------------------------------------------------------------O (4336 = 84.2%)
04-24 10:19:19.581 1251 1251 I update_engine: 10 ------------O (712 = 13.8%) {84.2%}
04-24 10:19:19.581 1251 1251 I update_engine: 18 -O (81 = 1.6%) {
04-24 10:19:19.586 2778 2824 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.000).
04-24 10:19:19.652 2778 2824 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:19:19.661 1251 1251 I update_engine: [0424/101919.660910:INFO:action_processor.cc(116)] ActionProcessor: finished DownloadAction with code ErrorCode::kSuccess
04-24 10:19:19.661 1251 1251 I update_engine: [0424/101919.661157:INFO:action_processor.cc(143)] ActionProcessor: starting FilesystemVerifierAction
04-24 10:19:19.661 1251 1251 I update_engine: [0424/101919.661269:INFO:filesystem_verifier_action.cc(117)] Hashing partition 0 (vendor) on device /dev/block/dm-19
04-24 10:19:21.823 1251 1251 I update_engine: [0424/101921.823004:INFO:verity_writer_android.cc(93)] Writing verity hash tree to /dev/block/dm-19
04-24 10:19:21.845 1251 1251 I update_engine: [0424/101921.845243:INFO:verity_writer_android.cc(105)] Writing verity FEC to /dev/block/dm-19
04-24 10:19:34.894 2778 3239 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
04-24 10:19:34.910 2778 10527 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
04-24 10:19:47.104 1251 1251 I update_engine: [0424/101947.104290:INFO:filesystem_verifier_action.cc(237)] Hash of vendor: B9PneI0Ti3ZPy0uhseQUdeceubjjYQNmCQubsuxhlao=
04-24 10:19:47.357 1251 1251 I update_engine: [0424/101947.356916:INFO:filesystem_verifier_action.cc(117)] Hashing partition 1 (boot) on device /dev/block/bootdevice/by-name/boot_a
04-24 10:19:47.586 1251 1251 I update_engine: [0424/101947.586134:INFO:filesystem_verifier_action.cc(237)] Hash of boot: L9/wwcxfMAEF9Yf7NK96Sf/T+yIQOyI74TRoiIdCAa8=
04-24 10:19:47.616 1251 1251 I update_engine: [0424/101947.615964:INFO:filesystem_verifier_action.cc(117)] Hashing partition 2 (system) on device /dev/block/dm-20
04-24 10:19:51.476 1251 1251 I update_engine: [0424/101951.476770:INFO:verity_writer_android.cc(93)] Writing verity hash tree to /dev/block/dm-20
04-24 10:19:51.514 1251 1251 I update_engine: [0424/101951.514286:INFO:verity_writer_android.cc(105)] Writing verity FEC to /dev/block/dm-20
04-24 10:20:30.348 2778 10617 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
04-24 10:20:30.384 8915 8915 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x211, isSetupWizard=false.
04-24 10:20:34.847 2778 3239 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
04-24 10:20:34.856 2778 10617 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
04-24 10:20:35.575 2778 10617 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
04-24 10:20:38.248 1251 1251 I update_engine: [0424/102038.244374:INFO:filesystem_verifier_action.cc(237)] Hash of system: X1fs3Rk64cgdSXJ6cxrXCtwrTUPtuRiYkS0vHea4dxo=
04-24 10:20:38.616 1251 1251 I update_engine: [0424/102038.616396:INFO:filesystem_verifier_action.cc(117)] Hashing partition 3 (vbmeta) on device /dev/block/bootdevice/by-name/vbmeta_a
04-24 10:20:38.635 1251 1251 I update_engine: [0424/102038.635199:INFO:filesystem_verifier_action.cc(237)] Hash of vbmeta: hslCQhrNGTXHKgMVs/Vr+xYzAhr59TgDkB2CSZNjrDI=
04-24 10:20:38.635 1251 1251 I update_engine: [0424/102038.635498:INFO:filesystem_verifier_action.cc(117)] Hashing partition 4 (dtbo) on device /dev/block/bootdevice/by-name/dtbo_a
04-24 10:20:38.672 1251 1251 I update_engine: [0424/102038.672365:INFO:filesystem_verifier_action.cc(237)] Hash of dtbo: Z+PrdGI9HsQS8bX3NZpu4Gf1zDN03R4/fk9B1Ty50bw=
04-24 10:20:38.677 1251 1251 I update_engine: [0424/102038.677123:INFO:filesystem_verifier_action.cc(117)] Hashing partition 5 (product) on device /dev/block/dm-21
04-24 10:20:47.521 1251 1251 I update_engine: [0424/102047.520941:INFO:verity_writer_android.cc(93)] Writing verity hash tree to /dev/block/dm-21
04-24 10:20:47.606 1251 1251 I update_engine: [0424/102047.606223:INFO:verity_writer_android.cc(105)] Writing verity FEC to /dev/block/dm-21
04-24 10:21:34.851 2778 3239 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
04-24 10:21:34.866 2778 10816 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
04-24 10:22:31.762 2778 3239 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
04-24 10:22:31.794 2778 10840 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
04-24 10:22:34.247 1251 1251 I update_engine: [0424/102234.247388:INFO:filesystem_verifier_action.cc(237)] Hash of product: S+lNq+Hyyy9QpQnjxtvz1HYbcrFfd9RGGurXw4Z1oX4=
04-24 10:22:34.727 1251 1251 I update_engine: [0424/102234.727647:INFO:filesystem_verifier_action.cc(117)] Hashing partition 6 (system_ext) on device /dev/block/dm-22
04-24 10:22:34.853 2778 3239 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
04-24 10:22:34.863 2778 10840 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
04-24 10:22:35.652 1251 1251 I update_engine: [0424/102235.652070:INFO:verity_writer_android.cc(93)] Writing verity hash tree to /dev/block/dm-22
04-24 10:22:35.660 1251 1251 I update_engine: [0424/102235.660297:INFO:verity_writer_android.cc(105)] Writing verity FEC to /dev/block/dm-22
04-24 10:22:45.725 1251 1251 I update_engine: [0424/102245.725737:INFO:filesystem_verifier_action.cc(237)] Hash of system_ext: NIqTbVPG4T6Tem/dfVa7U7HmMtX546dz1O/MtLYNseQ=
04-24 10:22:45.810 1251 1251 I update_engine: [0424/102245.809931:INFO:filesystem_verifier_action.cc(117)] Hashing partition 7 (abl) on device /dev/block/bootdevice/by-name/abl_a
04-24 10:22:45.816 1251 1251 I update_engine: [0424/102245.816690:INFO:filesystem_verifier_action.cc(237)] Hash of abl: LVgMdz2xnvkLkVcJ+oqJg0TkcKLJvJhRPNHKRUkdJ2c=
04-24 10:22:45.817 1251 1251 I update_engine: [0424/102245.817375:INFO:filesystem_verifier_action.cc(117)] Hashing partition 8 (aop) on device /dev/block/bootdevice/by-name/aop_a
04-24 10:22:45.819 1251 1251 I update_engine: [0424/102245.819568:INFO:filesystem_verifier_action.cc(237)] Hash of aop: lwMLGjNpF5XfyBdAMy8aeFjdp7InRDD6nz5zKeP4I6k=
04-24 10:22:45.819 1251 1251 I update_engine: [0424/102245.819730:INFO:filesystem_verifier_action.cc(117)] Hashing partition 9 (cmnlib) on device /dev/block/bootdevice/by-name/cmnlib_a
04-24 10:22:45.821 1251 1251 I update_engine: [0424/102245.821662:INFO:filesystem_verifier_action.cc(237)] Hash of cmnlib: m53rJ50FFnmZU/b5m31kPq0GNUX7/qag9oqKzrulYgQ=
04-24 10:22:45.821 1251 1251 I update_engine: [0424/102245.821956:INFO:filesystem_verifier_action.cc(117)] Hashing partition 10 (cmnlib64) on device /dev/block/bootdevice/by-name/cmnlib64_a
04-24 10:22:45.824 1251 1251 I update_engine: [0424/102245.824606:INFO:filesystem_verifier_action.cc(237)] Hash of cmnlib64: 7cTk0BpXrCRydJgq7Q1XlIdnrr9Du3zF1brOZRNgzso=
04-24 10:22:45.824 1251 1251 I update_engine: [0424/102245.824823:INFO:filesystem_verifier_action.cc(117)] Hashing partition 11 (devcfg) on device /dev/block/bootdevice/by-name/devcfg_a
04-24 10:22:45.826 1251 1251 I update_engine: [0424/102245.826457:INFO:filesystem_verifier_action.cc(237)] Hash of devcfg: Oiiho60b3LwSrDHj6FBrcIuq+xysUSslPrwekIKFaWI=
04-24 10:22:45.826 1251 1251 I update_engine: [0424/102245.826566:INFO:filesystem_verifier_action.cc(117)] Hashing partition 12 (hyp) on device /dev/block/bootdevice/by-name/hyp_a
04-24 10:22:45.828 1251 1251 I update_engine: [0424/102245.828639:INFO:filesystem_verifier_action.cc(237)] Hash of hyp: oeV8en/VZcLP5KMcF6lNpQOlCKk6tJ3fRQLOELr05qY=
04-24 10:22:45.828 1251 1251 I update_engine: [0424/102245.828852:INFO:filesystem_verifier_action.cc(117)] Hashing partition 13 (keymaster) on device /dev/block/bootdevice/by-name/keymaster_a
04-24 10:22:45.830 1251 1251 I update_engine: [0424/102245.830588:INFO:filesystem_verifier_action.cc(237)] Hash of keymaster: HWG8G+i3TudNjXfsOf2YTGjaDFNugZCbFuOZcmpdOSA=
04-24 10:22:45.830 1251 1251 I update_engine: [0424/102245.830745:INFO:filesystem_verifier_action.cc(117)] Hashing partition 14 (qupfw) on device /dev/block/bootdevice/by-name/qupfw_a
04-24 10:22:45.831 1251 1251 I update_engine: [0424/102245.831702:INFO:filesystem_verifier_action.cc(237)] Hash of qupfw: dbGYgOeXcVu2vYzKLLWOQL73bqyqqE8NmsI+weCoIbM=
04-24 10:22:45.831 1251 1251 I update_engine: [0424/102245.831794:INFO:filesystem_verifier_action.cc(117)] Hashing partition 15 (tz) on device /dev/block/bootdevice/by-name/tz_a
04-24 10:22:45.840 1251 1251 I update_engine: [0424/102245.840073:INFO:filesystem_verifier_action.cc(237)] Hash of tz: 6bJna8eHGZLR0FnICEb1txhlsl6Lr6Eh5+aDyXQeFnQ=
04-24 10:22:45.841 1251 1251 I update_engine: [0424/102245.841214:INFO:filesystem_verifier_action.cc(117)] Hashing partition 16 (xbl) on device /dev/block/bootdevice/by-name/xbl_a
04-24 10:22:45.854 1251 1251 I update_engine: [0424/102245.854096:INFO:filesystem_verifier_action.cc(237)] Hash of xbl: dyTD92W0a1LmpoDQ45K24y6TGFvvmTfpZSYx7+xjPVI=
04-24 10:22:45.855 1251 1251 I update_engine: [0424/102245.855930:INFO:filesystem_verifier_action.cc(117)] Hashing partition 17 (xbl_config) on device /dev/block/bootdevice/by-name/xbl_config_a
04-24 10:22:45.857 1251 1251 I update_engine: [0424/102245.857818:INFO:filesystem_verifier_action.cc(237)] Hash of xbl_config: FiHFX0+WXgnpSJlw5pQLczrmOPZjw7wUbYHj7V2MqS8=
04-24 10:22:45.857 1251 1251 I update_engine: [0424/102245.857935:INFO:filesystem_verifier_action.cc(117)] Hashing partition 18 (modem) on device /dev/block/bootdevice/by-name/modem_a
04-24 10:22:46.082 1251 1251 I update_engine: [0424/102246.082278:INFO:filesystem_verifier_action.cc(237)] Hash of modem: W9aol30QOcS2QId5FY6JojfXyaV7rhhCaq9TBsn3A+k=
04-24 10:22:46.120 1251 1251 I update_engine: [0424/102246.117842:INFO:action_processor.cc(116)] ActionProcessor: finished FilesystemVerifierAction with code ErrorCode::kSuccess
04-24 10:22:46.120 1251 1251 I update_engine: [0424/102246.120309:INFO:action_processor.cc(143)] ActionProcessor: starting PostinstallRunnerAction
04-24 10:22:46.123 2778 6357 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.000).
04-24 10:22:46.132 1251 1251 I update_engine: [0424/102246.132411:INFO:postinstall_runner_action.cc(174)] Performing postinst (bin/checkpoint_gc at /postinstall/bin/checkpoint_gc) installed on device /dev/block/dm-19 and mountable device /dev/block/dm-19
04-24 10:22:46.133 1251 1251 I update_engine: [0424/102246.132668:INFO:postinstall_runner_action.cc(181)] Format file for new bin/checkpoint_gc is: data
04-24 10:22:46.211 2778 6357 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:22:56.482 2778 6385 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.016).
04-24 10:22:56.580 2778 6385 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:23:01.581 2778 6385 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.135).
04-24 10:23:01.704 2778 6385 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:23:06.671 2778 6385 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.333).
04-24 10:23:06.679 1251 1251 I update_engine: [0424/102306.679251:INFO:postinstall_runner_action.cc(174)] Performing postinst (system/bin/otapreopt_script at /postinstall/system/bin/otapreopt_script) installed on device /dev/block/dm-20 and mountable device /dev/block/dm-20
04-24 10:23:06.683 1251 1251 I update_engine: [0424/102306.679896:INFO:postinstall_runner_action.cc(181)] Format file for new system/bin/otapreopt_script is: data
04-24 10:23:06.727 2778 6385 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:23:17.305 2778 6385 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.340).
04-24 10:23:17.350 2778 6385 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:23:28.191 2778 6357 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.347).
04-24 10:23:28.236 2778 6357 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:23:34.854 2778 3239 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
04-24 10:23:34.871 2778 11286 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
04-24 10:23:39.365 2778 6357 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.353).
04-24 10:23:39.414 2778 6357 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:23:50.075 2778 11533 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
04-24 10:23:50.144 8915 8915 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x211, isSetupWizard=false.
04-24 10:23:50.460 2778 2822 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.360).
04-24 10:23:50.478 8915 8915 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.360000.
04-24 10:23:50.491 2778 2822 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:23:55.583 2778 11637 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
04-24 10:24:01.487 2778 11732 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
04-24 10:24:01.523 8915 8915 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x211, isSetupWizard=false.
04-24 10:24:01.938 2778 4637 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.367).
04-24 10:24:01.947 8915 8915 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.366667.
04-24 10:24:01.960 2778 4637 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:24:10.483 2778 11896 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
04-24 10:24:12.656 2778 2822 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.373).
04-24 10:24:12.688 2778 2822 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:24:24.279 2778 2822 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.380).
04-24 10:24:24.335 2778 2822 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:24:34.856 2778 3239 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
04-24 10:24:34.874 2778 12288 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
04-24 10:24:35.626 2778 3874 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.387).
04-24 10:24:35.677 2778 3874 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:24:46.847 2778 3874 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.393).
04-24 10:24:46.900 2778 3874 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:24:57.793 2778 7340 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.400).
04-24 10:24:57.840 2778 7340 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:25:08.858 2778 7340 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.407).
04-24 10:25:08.910 2778 7340 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:25:19.910 2778 3874 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.413).
04-24 10:25:19.960 2778 3874 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:25:31.050 2778 3874 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.420).
04-24 10:25:31.092 2778 3874 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:25:34.847 2778 3239 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
04-24 10:25:34.863 2778 13170 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
04-24 10:25:42.194 2778 7340 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.427).
04-24 10:25:42.245 2778 7340 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:25:53.513 2778 3874 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.433).
04-24 10:25:53.567 2778 3874 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:26:04.745 2778 3874 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.440).
04-24 10:26:04.796 2778 3874 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:26:17.083 2778 3874 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.447).
04-24 10:26:17.152 2778 3874 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:26:27.904 2778 3874 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.453).
04-24 10:26:27.956 2778 3874 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:26:34.871 2778 3239 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
04-24 10:26:34.889 2778 14175 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
04-24 10:26:39.032 2778 2822 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.460).
04-24 10:26:39.080 2778 2822 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:26:50.023 2778 2822 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.467).
04-24 10:26:50.066 2778 2822 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:27:00.931 2778 2822 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.473).
04-24 10:27:00.976 2778 2822 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:27:12.013 2778 2822 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.480).
04-24 10:27:12.061 2778 2822 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:27:22.887 2778 2822 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.487).
04-24 10:27:22.938 2778 2822 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:27:33.941 2778 2822 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.493).
04-24 10:27:33.988 2778 2822 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:27:34.884 2778 3239 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
04-24 10:27:34.895 2778 15121 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
04-24 10:27:44.904 2778 2822 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.500).
04-24 10:27:44.959 2778 2822 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:27:55.927 2778 7340 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.507).
04-24 10:27:55.971 2778 7340 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:28:06.844 2778 7340 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.513).
04-24 10:28:06.890 2778 7340 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:28:09.167 2778 3239 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
04-24 10:28:09.209 2778 15640 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
04-24 10:28:18.187 2778 7340 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.520).
04-24 10:28:18.257 2778 7340 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:28:29.272 2778 7340 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.527).
04-24 10:28:29.320 2778 7340 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:28:34.866 2778 3239 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
04-24 10:28:34.883 2778 16062 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
04-24 10:28:40.305 2778 7340 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.533).
04-24 10:28:40.354 2778 7340 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:28:51.367 2778 7340 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.540).
04-24 10:28:51.416 2778 7340 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:29:02.586 2778 7340 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.547).
04-24 10:29:02.629 2778 7340 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:29:13.662 2778 7340 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.553).
04-24 10:29:13.705 2778 7340 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:29:24.649 2778 2822 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.560).
04-24 10:29:24.694 2778 2822 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:29:34.854 2778 3239 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
04-24 10:29:34.870 2778 17002 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
04-24 10:29:35.690 2778 2822 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.567).
04-24 10:29:35.741 2778 2822 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:29:46.742 2778 2822 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.573).
04-24 10:29:46.782 2778 2822 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:29:58.384 2778 3874 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.580).
04-24 10:29:58.431 2778 3874 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:30:09.765 2778 3874 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.587).
04-24 10:30:09.805 2778 3874 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:30:21.145 2778 2822 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.593).
04-24 10:30:21.194 2778 2822 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:30:32.007 2778 2822 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.600).
04-24 10:30:32.055 2778 2822 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:30:34.884 2778 3239 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
04-24 10:30:34.902 2778 17816 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
04-24 10:30:43.065 2778 2822 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.607).
04-24 10:30:43.112 2778 2822 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:30:54.174 2778 2822 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.613).
04-24 10:30:54.217 2778 2822 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:31:05.288 2778 2822 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.620).
04-24 10:31:05.349 2778 2822 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:31:16.387 2778 2822 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.627).
04-24 10:31:16.440 2778 2822 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:31:27.628 2778 2822 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.633).
04-24 10:31:27.678 2778 2822 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:31:34.844 2778 3239 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }.
04-24 10:31:34.870 2778 18863 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4.
04-24 10:31:38.652 2778 2822 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.640).
04-24 10:31:38.694 2778 2822 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:31:49.669 2778 3874 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.647).
04-24 10:31:49.719 2778 3874 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:32:00.690 2778 3874 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.653).
04-24 10:32:00.735 2778 3874 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:32:11.711 2778 3874 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 0.660).
04-24 10:32:11.752 2778 3874 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:32:20.754 1251 1251 I update_engine: [0424/103220.754204:INFO:subprocess.cc(157)] Subprocess output:
04-24 10:32:20.754 1251 1251 I update_engine: Complete or error.
04-24 10:32:20.754 1251 1251 I update_engine:
04-24 10:32:20.765 1251 1251 I update_engine: [0424/103220.765827:INFO:postinstall_runner_action.cc(174)] Performing postinst (bin/check_dynamic_partitions at /postinstall/bin/check_dynamic_partitions) installed on device /dev/block/dm-21 and mountable device /dev/block/dm-21
04-24 10:32:20.767 1251 1251 I update_engine: [0424/103220.766039:INFO:postinstall_runner_action.cc(181)] Format file for new bin/check_dynamic_partitions is: data
04-24 10:32:20.833 1251 1251 I update_engine: [0424/103220.833363:INFO:postinstall_runner_action.cc(370)] All post-install commands succeeded
04-24 10:32:20.834 1251 1251 I update_engine: [0424/103220.834674:INFO:action_processor.cc(116)] ActionProcessor: finished last action PostinstallRunnerAction with code ErrorCode::kUpdatedButNotActive
04-24 10:32:20.834 1251 1251 I update_engine: [0424/103220.834776:INFO:update_attempter_android.cc(503)] Processing Done.
04-24 10:32:20.834 1251 1251 I update_engine: [0424/103220.834853:INFO:dynamic_partition_control_android.cc(250)] Destroying [product_a, system_a, system_ext_a, vendor_a] from device mapper
04-24 10:32:20.841 2778 6357 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x211, 1.000).
04-24 10:32:20.852 1251 1251 I update_engine: [libfs_mgr]Unmapped logical partition product_a
04-24 10:32:20.852 1251 1251 I update_engine: [0424/103220.852735:INFO:dynamic_partition_control_android.cc(236)] Successfully unmapped product_a from device mapper.
04-24 10:32:20.876 1251 1251 I update_engine: [libfs_mgr]Unmapped logical partition system_a
04-24 10:32:20.876 1251 1251 I update_engine: [0424/103220.876652:INFO:dynamic_partition_control_android.cc(236)] Successfully unmapped system_a from device mapper.
04-24 10:32:20.895 2778 6357 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x005.
04-24 10:32:20.916 1251 1251 I update_engine: [libfs_mgr]Unmapped logical partition system_ext_a
04-24 10:32:20.916 1251 1251 I update_engine: [0424/103220.916188:INFO:dynamic_partition_control_android.cc(236)] Successfully unmapped system_ext_a from device mapper.
04-24 10:32:20.929 1251 1251 I update_engine: [libfs_mgr]Unmapped logical partition vendor_a
04-24 10:32:20.929 1251 1251 I update_engine: [0424/103220.929437:INFO:dynamic_partition_control_android.cc(236)] Successfully unmapped vendor_a from device mapper.
04-24 10:32:20.936 2778 6357 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.000).
04-24 10:32:20.938 1251 1251 I update_engine: [0424/103220.938778:INFO:metrics_reporter_android.cc(80)] Current update attempt downloads 252 bytes data
04-24 10:32:21.027 2778 6357 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x000.
04-24 10:32:21.060 2778 6357 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x000.
04-24 10:32:21.090 2778 10269 I SystemUpdate: [Control,DeviceControl] Prepare resume on reboot.
04-24 10:32:21.124 2778 10269 I SystemUpdate: [Execution,SynchronizedUpdateEngine] stop()
04-24 10:32:21.124 2778 10269 I SystemUpdate: [Execution,ExecutionManager] Action streaming-apply executed for 1112.00 seconds.
04-24 10:32:21.145 2778 10269 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x110, -1.000).
04-24 10:32:21.293 2778 10269 I SystemUpdate: [Execution,ExecutionManager] Action ab-reboot executed for 0.16 seconds.
04-24 10:33:40.883 2778 19638 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
04-24 10:33:40.887 2778 19639 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 }.
04-24 10:33:40.897 2778 19640 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 }.
04-24 10:33:40.914 2778 19638 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 12.
04-24 10:33:40.954 2778 19639 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x110, -1.000).
04-24 10:33:40.969 8915 8915 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x110, isSetupWizard=false.
04-24 10:33:40.984 2778 19640 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
04-24 10:33:41.102 2778 19639 I SystemUpdate: [Execution,ExecutionManager] Action ab-reboot executed for 0.21 seconds.
04-24 10:33:41.105 2778 19639 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 }.
04-24 10:33:41.127 2778 19639 I SystemUpdate: [Execution,ExecutionManager] Action ab-reboot executed for 0.02 seconds.
04-24 10:33:41.231 2778 19639 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
04-24 10:33:41.238 2778 19640 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 }.
04-24 10:33:41.274 8915 8915 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x110, isSetupWizard=false.
04-24 10:33:41.279 2778 19640 I SystemUpdate: [Execution,ExecutionManager] Action ab-reboot executed for 0.04 seconds.
04-24 10:34:22.210 2778 19692 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
04-24 10:34:22.213 2778 19693 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 }.
04-24 10:34:22.229 2778 19693 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x110, -1.000).
04-24 10:34:22.278 2778 19693 I SystemUpdate: [Execution,ExecutionManager] Action ab-reboot executed for 0.06 seconds.
04-24 10:40:48.895 2778 20016 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
04-24 10:40:48.898 2778 20016 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 }.
04-24 10:40:48.912 2778 20016 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x110, -1.000).
04-24 10:40:48.913 8915 8915 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x110, isSetupWizard=false.
04-24 10:40:48.965 2778 20016 I SystemUpdate: [Execution,ExecutionManager] Action ab-reboot executed for 0.07 seconds.
04-24 10:40:54.369 2778 20016 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 105.
04-24 10:40:54.371 2778 20019 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 }.
04-24 10:40:54.386 2778 20019 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x310, -1.000).
04-24 10:40:54.395 8915 8915 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x310, isSetupWizard=false.
04-24 10:40:54.427 2778 20019 I SystemUpdate: [Execution,SynchronizedUpdateEngine] start(aweq{url=file:///data/ota_package/payload_metadata.bin, payload_binary_file.offset=0, payload_binary_file.length=264404200, properties=[FILE_HASH=RGZPFVSzneJzeO5fDCztYjzZHknYK0grsHdaBUkE5JU=, FILE_SIZE=264404200, METADATA_HASH=Usv6XeEjLVrUMqD0ATtWG706zqJwulW8sux55FSVIQU=, METADATA_SIZE=639271]}, additionalProperties.size=3)
04-24 10:40:54.427 2778 20019 I SystemUpdate: [Execution,UpdateEngineDelegate] applyPayload()
04-24 10:40:54.447 1251 1251 I update_engine: [0424/104054.447427:INFO:update_attempter_android.cc(273)] Using this install plan:
04-24 10:40:54.447 1251 1251 I update_engine: [0424/104054.447914:INFO:install_plan.cc(91)] InstallPlan: resume, version: , source_slot: B, target_slot: A, url: file:///data/ota_package/payload_metadata.bin, payload: (size: 264404200, metadata_size: 639271, metadata signature: , hash: 44664F1554B39DE27378EE5F0C2CED623CD91E49D82B482BB0775A054904E495, 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
04-24 10:40:54.448 1251 1251 I update_engine: [0424/104054.448936:INFO:metrics_utils.cc(371)] Payload Attempt Number = 2
04-24 10:40:54.449 1251 1251 I update_engine: [0424/104054.449290:INFO:metrics_utils.cc(388)] Update Monotonic Timestamp Start = 1/1/1970 0:36:37 GMT
04-24 10:40:54.449 1251 1251 I update_engine: [0424/104054.449573:INFO:metrics_utils.cc(397)] Update Boot Timestamp Start = 1/1/1970 0:36:37 GMT
04-24 10:40:54.449 1251 1251 I update_engine: [0424/104054.449629:INFO:update_attempter_android.cc(615)] Scheduling an action processor start.
04-24 10:40:54.449 1251 1251 I update_engine: [0424/104054.449878:INFO:action_processor.cc(51)] ActionProcessor: starting UpdateBootFlagsAction
04-24 10:40:54.449 1251 1251 I update_engine: [0424/104054.449950:INFO:update_boot_flags_action.cc(36)] Already updated boot flags. Skipping.
04-24 10:40:54.450 1251 1251 I update_engine: [0424/104054.450043:INFO:action_processor.cc(116)] ActionProcessor: finished UpdateBootFlagsAction with code ErrorCode::kSuccess
04-24 10:40:54.450 1251 1251 I update_engine: [0424/104054.450091:INFO:action_processor.cc(143)] ActionProcessor: starting InstallPlanAction
04-24 10:40:54.450 1251 1251 I update_engine: [0424/104054.450135:INFO:action_processor.cc(116)] ActionProcessor: finished InstallPlanAction with code ErrorCode::kSuccess
04-24 10:40:54.450 1251 1251 I update_engine: [0424/104054.450170:INFO:action_processor.cc(143)] ActionProcessor: starting DownloadAction
04-24 10:40:54.450 1251 1251 I update_engine: [0424/104054.450255:INFO:install_plan.cc(91)] InstallPlan: resume, version: , source_slot: B, target_slot: A, url: file:///data/ota_package/payload_metadata.bin, payload: (size: 264404200, metadata_size: 639271, metadata signature: , hash: 44664F1554B39DE27378EE5F0C2CED623CD91E49D82B482BB0775A054904E495, 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
04-24 10:40:54.450 1251 1251 I update_engine: [0424/104054.450354:INFO:prefs.cc(122)] update-state-payload-index not present in /data/misc/update_engine/prefs
04-24 10:40:54.450 1251 1251 I update_engine: [0424/104054.450399:INFO:download_action.cc(199)] Marking new slot as unbootable
04-24 10:40:54.506 1251 1251 I update_engine: [0424/104054.506246:INFO:multi_range_http_fetcher.cc(45)] starting first transfer
04-24 10:40:54.506 1251 1251 I update_engine: [0424/104054.506623:INFO:multi_range_http_fetcher.cc(74)] starting transfer of range 0+639538
04-24 10:40:54.511 1251 1251 I update_engine: [0424/104054.511242:INFO:delta_performer.cc(209)] Completed 0/? operations, 16384/264404200 bytes downloaded (0%), overall progress 0%
04-24 10:40:54.528 1251 1251 I update_engine: [0424/104054.528063:INFO:delta_performer.cc(520)] Manifest size in payload matches expected value from Omaha
04-24 10:40:54.528 1251 1251 I update_engine: [0424/104054.528600:INFO:delta_performer.cc(1677)] Verifying using certificates: /system/etc/security/otacerts.zip
04-24 10:40:54.532 1251 1251 I update_engine: [0424/104054.532481:INFO:payload_verifier.cc(102)] signature blob size = 267
04-24 10:40:54.533 1251 1251 I update_engine: [0424/104054.533915:INFO:payload_verifier.cc(118)] Truncating the signature to its unpadded size: 256.
04-24 10:40:54.534 1251 1251 I update_engine: [0424/104054.534394:INFO:payload_verifier.cc(129)] Verified correct signature 1 out of 1 signatures.
04-24 10:40:54.534 1251 1251 I update_engine: [0424/104054.534495:INFO:payload_metadata.cc(224)] Metadata hash signature matches value in Omaha response.
04-24 10:40:54.584 1251 1251 I update_engine: [0424/104054.584034:INFO:delta_performer.cc(1712)] Detected a 'delta' payload.
04-24 10:40:54.654 1251 1251 I update_engine: [0424/104054.653995:INFO:delta_performer.cc(982)] Using previously prepared partitions for update. hash = RGZPFVSzneJzeO5fDCztYjzZHknYK0grsHdaBUkE5JU=Usv6XeEjLVrUMqD0ATtWG706zqJwulW8sux55FSVIQU=
04-24 10:40:54.655 1251 1251 I update_engine: [0424/104054.655311:INFO:delta_performer.cc(1002)] PreparePartitionsForUpdate done.
04-24 10:40:54.686 1251 1251 W update_engine: type=1400 audit(0.0:959): avc: denied { search } for name="/" dev="sda20" ino=2 scontext=u:r:update_engine:s0 tcontext=u:object_r:metadata_file:s0 tclass=dir permissive=0
04-24 10:40:54.694 1251 1251 I update_engine: [0424/104054.693915:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.694 1251 1251 I update_engine: [0424/104054.694235:INFO:dynamic_partition_control_android.cc(716)] vendor_b is mapped on device mapper: /dev/block/dm-1
04-24 10:40:54.689 1251 1251 W update_engine: type=1400 audit(0.0:960): avc: denied { search } for name="/" dev="sda20" ino=2 scontext=u:r:update_engine:s0 tcontext=u:object_r:metadata_file:s0 tclass=dir permissive=0
04-24 10:40:54.696 1251 1251 I update_engine: [0424/104054.696931:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:40:54.724 1251 1251 I update_engine: [libfs_mgr]Created logical partition vendor_a on device /dev/block/dm-19
04-24 10:40:54.724 1251 1251 I update_engine: [0424/104054.724470:INFO:dynamic_partition_control_android.cc(163)] Succesfully mapped vendor_a to device mapper (force_writable = 1); device path at /dev/block/dm-19
04-24 10:40:54.722 1251 1251 W update_engine: type=1400 audit(0.0:961): avc: denied { search } for name="/" dev="sda20" ino=2 scontext=u:r:update_engine:s0 tcontext=u:object_r:metadata_file:s0 tclass=dir permissive=0
04-24 10:40:54.727 1251 1251 I update_engine: [0424/104054.726966:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.727 1251 1251 I update_engine: [0424/104054.727062:INFO:dynamic_partition_control_android.cc(697)] boot_b is not in super partition metadata.
04-24 10:40:54.727 1251 1251 I update_engine: [0424/104054.727589:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.722 1251 1251 W update_engine: type=1400 audit(0.0:962): avc: denied { search } for name="/" dev="sda20" ino=2 scontext=u:r:update_engine:s0 tcontext=u:object_r:metadata_file:s0 tclass=dir permissive=0
04-24 10:40:54.730 1251 1251 I update_engine: [0424/104054.730176:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:40:54.730 1251 1251 I update_engine: [0424/104054.730245:INFO:dynamic_partition_control_android.cc(697)] boot_a is not in super partition metadata.
04-24 10:40:54.730 1251 1251 I update_engine: [0424/104054.730721:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.726 1251 1251 W update_engine: type=1400 audit(0.0:963): avc: denied { search } for name="/" dev="sda20" ino=2 scontext=u:r:update_engine:s0 tcontext=u:object_r:metadata_file:s0 tclass=dir permissive=0
04-24 10:40:54.731 1251 1251 I update_engine: [0424/104054.731819:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.731 1251 1251 I update_engine: [0424/104054.731921:INFO:dynamic_partition_control_android.cc(716)] system_b is mapped on device mapper: /dev/block/dm-0
04-24 10:40:54.729 1251 1251 W update_engine: type=1400 audit(0.0:964): avc: denied { search } for name="/" dev="sda20" ino=2 scontext=u:r:update_engine:s0 tcontext=u:object_r:metadata_file:s0 tclass=dir permissive=0
04-24 10:40:54.733 1251 1251 I update_engine: [0424/104054.733000:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:40:54.758 1251 1251 I update_engine: [libfs_mgr]Created logical partition system_a on device /dev/block/dm-20
04-24 10:40:54.759 1251 1251 I update_engine: [0424/104054.759014:INFO:dynamic_partition_control_android.cc(163)] Succesfully mapped system_a to device mapper (force_writable = 1); device path at /dev/block/dm-20
04-24 10:40:54.761 1251 1251 I update_engine: [0424/104054.761449:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.761 1251 1251 I update_engine: [0424/104054.761554:INFO:dynamic_partition_control_android.cc(697)] vbmeta_b is not in super partition metadata.
04-24 10:40:54.762 1251 1251 I update_engine: [0424/104054.762070:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.763 1251 1251 I update_engine: [0424/104054.763367:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:40:54.763 1251 1251 I update_engine: [0424/104054.763451:INFO:dynamic_partition_control_android.cc(697)] vbmeta_a is not in super partition metadata.
04-24 10:40:54.763 1251 1251 I update_engine: [0424/104054.763953:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.765 1251 1251 I update_engine: [0424/104054.765093:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.765 1251 1251 I update_engine: [0424/104054.765164:INFO:dynamic_partition_control_android.cc(697)] dtbo_b is not in super partition metadata.
04-24 10:40:54.765 1251 1251 I update_engine: [0424/104054.765758:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.767 1251 1251 I update_engine: [0424/104054.767517:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:40:54.767 1251 1251 I update_engine: [0424/104054.767619:INFO:dynamic_partition_control_android.cc(697)] dtbo_a is not in super partition metadata.
04-24 10:40:54.768 1251 1251 I update_engine: [0424/104054.768333:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.770 1251 1251 I update_engine: [0424/104054.770145:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.770 1251 1251 I update_engine: [0424/104054.770326:INFO:dynamic_partition_control_android.cc(716)] product_b is mapped on device mapper: /dev/block/dm-2
04-24 10:40:54.772 1251 1251 I update_engine: [0424/104054.772273:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:40:54.808 1251 1251 I update_engine: [libfs_mgr]Created logical partition product_a on device /dev/block/dm-21
04-24 10:40:54.808 1251 1251 I update_engine: [0424/104054.808746:INFO:dynamic_partition_control_android.cc(163)] Succesfully mapped product_a to device mapper (force_writable = 1); device path at /dev/block/dm-21
04-24 10:40:54.812 1251 1251 I update_engine: [0424/104054.812091:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.812 1251 1251 I update_engine: [0424/104054.812313:INFO:dynamic_partition_control_android.cc(716)] system_ext_b is mapped on device mapper: /dev/block/dm-3
04-24 10:40:54.813 1251 1251 I update_engine: [0424/104054.813939:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:40:54.843 1251 1251 I update_engine: [libfs_mgr]Created logical partition system_ext_a on device /dev/block/dm-22
04-24 10:40:54.843 1251 1251 I update_engine: [0424/104054.843478:INFO:dynamic_partition_control_android.cc(163)] Succesfully mapped system_ext_a to device mapper (force_writable = 1); device path at /dev/block/dm-22
04-24 10:40:54.846 1251 1251 I update_engine: [0424/104054.846627:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.846 1251 1251 I update_engine: [0424/104054.846796:INFO:dynamic_partition_control_android.cc(697)] abl_b is not in super partition metadata.
04-24 10:40:54.847 1251 1251 I update_engine: [0424/104054.847624:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.849 1251 1251 I update_engine: [0424/104054.849821:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:40:54.850 1251 1251 I update_engine: [0424/104054.849991:INFO:dynamic_partition_control_android.cc(697)] abl_a is not in super partition metadata.
04-24 10:40:54.851 1251 1251 I update_engine: [0424/104054.851085:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.853 1251 1251 I update_engine: [0424/104054.853292:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.853 1251 1251 I update_engine: [0424/104054.853474:INFO:dynamic_partition_control_android.cc(697)] aop_b is not in super partition metadata.
04-24 10:40:54.854 1251 1251 I update_engine: [0424/104054.854300:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.856 1251 1251 I update_engine: [0424/104054.856495:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:40:54.856 1251 1251 I update_engine: [0424/104054.856634:INFO:dynamic_partition_control_android.cc(697)] aop_a is not in super partition metadata.
04-24 10:40:54.857 1251 1251 I update_engine: [0424/104054.857632:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.859 1251 1251 I update_engine: [0424/104054.859573:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.859 1251 1251 I update_engine: [0424/104054.859675:INFO:dynamic_partition_control_android.cc(697)] cmnlib_b is not in super partition metadata.
04-24 10:40:54.860 1251 1251 I update_engine: [0424/104054.860352:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.861 1251 1251 I update_engine: [0424/104054.861816:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:40:54.861 1251 1251 I update_engine: [0424/104054.861912:INFO:dynamic_partition_control_android.cc(697)] cmnlib_a is not in super partition metadata.
04-24 10:40:54.862 1251 1251 I update_engine: [0424/104054.862629:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.864 1251 1251 I update_engine: [0424/104054.864236:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.864 1251 1251 I update_engine: [0424/104054.864323:INFO:dynamic_partition_control_android.cc(697)] cmnlib64_b is not in super partition metadata.
04-24 10:40:54.865 1251 1251 I update_engine: [0424/104054.865005:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.866 1251 1251 I update_engine: [0424/104054.866470:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:40:54.866 1251 1251 I update_engine: [0424/104054.866548:INFO:dynamic_partition_control_android.cc(697)] cmnlib64_a is not in super partition metadata.
04-24 10:40:54.867 1251 1251 I update_engine: [0424/104054.867135:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.868 1251 1251 I update_engine: [0424/104054.868435:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.868 1251 1251 I update_engine: [0424/104054.868528:INFO:dynamic_partition_control_android.cc(697)] devcfg_b is not in super partition metadata.
04-24 10:40:54.869 1251 1251 I update_engine: [0424/104054.869400:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.870 1251 1251 I update_engine: [0424/104054.870846:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:40:54.870 1251 1251 I update_engine: [0424/104054.870924:INFO:dynamic_partition_control_android.cc(697)] devcfg_a is not in super partition metadata.
04-24 10:40:54.871 1251 1251 I update_engine: [0424/104054.871507:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.872 1251 1251 I update_engine: [0424/104054.872872:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.872 1251 1251 I update_engine: [0424/104054.872944:INFO:dynamic_partition_control_android.cc(697)] hyp_b is not in super partition metadata.
04-24 10:40:54.873 1251 1251 I update_engine: [0424/104054.873522:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.874 1251 1251 I update_engine: [0424/104054.874778:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:40:54.874 1251 1251 I update_engine: [0424/104054.874852:INFO:dynamic_partition_control_android.cc(697)] hyp_a is not in super partition metadata.
04-24 10:40:54.875 1251 1251 I update_engine: [0424/104054.875458:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.877 1251 1251 I update_engine: [0424/104054.877541:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.877 1251 1251 I update_engine: [0424/104054.877625:INFO:dynamic_partition_control_android.cc(697)] keymaster_b is not in super partition metadata.
04-24 10:40:54.878 1251 1251 I update_engine: [0424/104054.878318:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.879 1251 1251 I update_engine: [0424/104054.879864:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:40:54.879 1251 1251 I update_engine: [0424/104054.879945:INFO:dynamic_partition_control_android.cc(697)] keymaster_a is not in super partition metadata.
04-24 10:40:54.880 1251 1251 I update_engine: [0424/104054.880664:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.882 1251 1251 I update_engine: [0424/104054.882412:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.882 1251 1251 I update_engine: [0424/104054.882523:INFO:dynamic_partition_control_android.cc(697)] qupfw_b is not in super partition metadata.
04-24 10:40:54.883 1251 1251 I update_engine: [0424/104054.883194:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.884 1251 1251 I update_engine: [0424/104054.884457:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:40:54.884 1251 1251 I update_engine: [0424/104054.884547:INFO:dynamic_partition_control_android.cc(697)] qupfw_a is not in super partition metadata.
04-24 10:40:54.885 1251 1251 I update_engine: [0424/104054.885173:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.887 1251 1251 I update_engine: [0424/104054.887503:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.887 1251 1251 I update_engine: [0424/104054.887597:INFO:dynamic_partition_control_android.cc(697)] tz_b is not in super partition metadata.
04-24 10:40:54.888 1251 1251 I update_engine: [0424/104054.888130:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.889 1251 1251 I update_engine: [0424/104054.889595:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:40:54.889 1251 1251 I update_engine: [0424/104054.889679:INFO:dynamic_partition_control_android.cc(697)] tz_a is not in super partition metadata.
04-24 10:40:54.890 1251 1251 I update_engine: [0424/104054.890206:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.891 1251 1251 I update_engine: [0424/104054.891374:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.891 1251 1251 I update_engine: [0424/104054.891448:INFO:dynamic_partition_control_android.cc(697)] xbl_b is not in super partition metadata.
04-24 10:40:54.891 1251 1251 I update_engine: [0424/104054.891956:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.893 1251 1251 I update_engine: [0424/104054.893110:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:40:54.893 1251 1251 I update_engine: [0424/104054.893187:INFO:dynamic_partition_control_android.cc(697)] xbl_a is not in super partition metadata.
04-24 10:40:54.893 1251 1251 I update_engine: [0424/104054.893898:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.895 1251 1251 I update_engine: [0424/104054.895012:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.895 1251 1251 I update_engine: [0424/104054.895084:INFO:dynamic_partition_control_android.cc(697)] xbl_config_b is not in super partition metadata.
04-24 10:40:54.895 1251 1251 I update_engine: [0424/104054.895706:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.897 1251 1251 I update_engine: [0424/104054.897193:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:40:54.897 1251 1251 I update_engine: [0424/104054.897268:INFO:dynamic_partition_control_android.cc(697)] xbl_config_a is not in super partition metadata.
04-24 10:40:54.897 1251 1251 I update_engine: [0424/104054.897783:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.898 1251 1251 I update_engine: [0424/104054.898903:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.898 1251 1251 I update_engine: [0424/104054.898966:INFO:dynamic_partition_control_android.cc(697)] modem_b is not in super partition metadata.
04-24 10:40:54.899 1251 1251 I update_engine: [0424/104054.899634:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.901 1251 1251 I update_engine: [0424/104054.901020:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/system_a
04-24 10:40:54.901 1251 1251 I update_engine: [0424/104054.901121:INFO:dynamic_partition_control_android.cc(697)] modem_a is not in super partition metadata.
04-24 10:40:54.901 1251 1251 I update_engine: [0424/104054.901655:INFO:dynamic_partition_control_android.cc(306)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/system_b
04-24 10:40:54.901 1251 1251 I update_engine: [0424/104054.901777:INFO:delta_performer.cc(451)] PartitionInfo old vendor sha256: 7tCtJFtMbISWexh5VgL9zuUHiKClzPn1WTR7Qq59wWQ= size: 461029376
04-24 10:40:54.901 1251 1251 I update_engine: [0424/104054.901834:INFO:delta_performer.cc(451)] PartitionInfo new vendor sha256: B9PneI0Ti3ZPy0uhseQUdeceubjjYQNmCQubsuxhlao= size: 463802368
04-24 10:40:54.901 1251 1251 I update_engine: [0424/104054.901880:INFO:delta_performer.cc(451)] PartitionInfo old boot sha256: P1lgJFQC7XwF6QUFhfp3bob8AIgNDcVbGTKUvupWkYw= size: 67108864
04-24 10:40:54.901 1251 1251 I update_engine: [0424/104054.901922:INFO:delta_performer.cc(451)] PartitionInfo new boot sha256: L9/wwcxfMAEF9Yf7NK96Sf/T+yIQOyI74TRoiIdCAa8= size: 67108864
04-24 10:40:54.901 1251 1251 I update_engine: [0424/104054.901966:INFO:delta_performer.cc(451)] PartitionInfo old system sha256: wJSGb3Lk3FalwrjLxIt05ylYQHwc3ZiSJYIWMU1NAj8= size: 820457472
04-24 10:40:54.902 1251 1251 I update_engine: [0424/104054.902010:INFO:delta_performer.cc(451)] PartitionInfo new system sha256: X1fs3Rk64cgdSXJ6cxrXCtwrTUPtuRiYkS0vHea4dxo= size: 833884160
04-24 10:40:54.902 1251 1251 I update_engine: [0424/104054.902053:INFO:delta_performer.cc(451)] PartitionInfo old vbmeta sha256: NZA30noTDwOxDdA0Pn3echbcMoLl45QyORs2jH5B/fo= size: 8192
04-24 10:40:54.902 1251 1251 I update_engine: [0424/104054.902160:INFO:delta_performer.cc(451)] PartitionInfo new vbmeta sha256: hslCQhrNGTXHKgMVs/Vr+xYzAhr59TgDkB2CSZNjrDI= size: 8192
04-24 10:40:54.902 1251 1251 I update_engine: [0424/104054.902215:INFO:delta_performer.cc(451)] PartitionInfo old dtbo sha256: epm94N0O9DNu7GZ5eZ5pOjFSezFgPRILbW1IDNIriOM= size: 8388608
04-24 10:40:54.902 1251 1251 I update_engine: [0424/104054.902259:INFO:delta_performer.cc(451)] PartitionInfo new dtbo sha256: Z+PrdGI9HsQS8bX3NZpu4Gf1zDN03R4/fk9B1Ty50bw= size: 8388608
04-24 10:40:54.902 1251 1251 I update_engine: [0424/104054.902303:INFO:delta_performer.cc(451)] PartitionInfo old product sha256: +RfEmpDVC9ex/vPJynvCcuaWEFkXDC0ad2MQ7u27bN0= size: 1940889600
04-24 10:40:54.902 1251 1251 I update_engine: [0424/104054.902345:INFO:delta_performer.cc(451)] PartitionInfo new product sha256: S+lNq+Hyyy9QpQnjxtvz1HYbcrFfd9RGGurXw4Z1oX4= size: 1914433536
04-24 10:40:54.902 1251 1251 I update_engine: [0424/104054.902389:INFO:delta_performer.cc(451)] PartitionInfo old system_ext sha256: DTesApHya0kNme5itTSC1MEp+Hsg543MWA4Vq0ykcBs= size: 181174272
04-24 10:40:54.902 1251 1251 I update_engine: [0424/104054.902433:INFO:delta_performer.cc(451)] PartitionInfo new system_ext sha256: NIqTbVPG4T6Tem/dfVa7U7HmMtX546dz1O/MtLYNseQ= size: 184561664
04-24 10:40:54.902 1251 1251 I update_engine: [0424/104054.902476:INFO:delta_performer.cc(451)] PartitionInfo old abl sha256: LVgMdz2xnvkLkVcJ+oqJg0TkcKLJvJhRPNHKRUkdJ2c= size: 1048576
04-24 10:40:54.902 1251 1251 I update_engine: [0424/104054.902519:INFO:delta_performer.cc(451)] PartitionInfo new abl sha256: LVgMdz2xnvkLkVcJ+oqJg0TkcKLJvJhRPNHKRUkdJ2c= size: 1048576
04-24 10:40:54.902 1251 1251 I update_engine: [0424/104054.902563:INFO:delta_performer.cc(451)] PartitionInfo old aop sha256: lwMLGjNpF5XfyBdAMy8aeFjdp7InRDD6nz5zKeP4I6k= size: 188416
04-24 10:40:54.902 1251 1251 I update_engine: [0424/104054.902604:INFO:delta_performer.cc(451)] PartitionInfo new aop sha256: lwMLGjNpF5XfyBdAMy8aeFjdp7InRDD6nz5zKeP4I6k= size: 188416
04-24 10:40:54.902 1251 1251 I update_engine: [0424/104054.902648:INFO:delta_performer.cc(451)] PartitionInfo old cmnlib sha256: m53rJ50FFnmZU/b5m31kPq0GNUX7/qag9oqKzrulYgQ= size: 380928
04-24 10:40:54.902 1251 1251 I update_engine: [0424/104054.902691:INFO:delta_performer.cc(451)] PartitionInfo new cmnlib sha256: m53rJ50FFnmZU/b5m31kPq0GNUX7/qag9oqKzrulYgQ= size: 380928
04-24 10:40:54.902 1251 1251 I update_engine: [0424/104054.902776:INFO:delta_performer.cc(451)] PartitionInfo old cmnlib64 sha256: 7cTk0BpXrCRydJgq7Q1XlIdnrr9Du3zF1brOZRNgzso= size: 499712
04-24 10:40:54.902 1251 1251 I update_engine: [0424/104054.902821:INFO:delta_performer.cc(451)] PartitionInfo new cmnlib64 sha256: 7cTk0BpXrCRydJgq7Q1XlIdnrr9Du3zF1brOZRNgzso= size: 499712
04-24 10:40:54.902 1251 1251 I update_engine: [0424/104054.902864:INFO:delta_performer.cc(451)] PartitionInfo old devcfg sha256: Oiiho60b3LwSrDHj6FBrcIuq+xysUSslPrwekIKFaWI= size: 40960
04-24 10:40:54.902 1251 1251 I update_engine: [0424/104054.902905:INFO:delta_performer.cc(451)] PartitionInfo new devcfg sha256: Oiiho60b3LwSrDHj6FBrcIuq+xysUSslPrwekIKFaWI= size: 40960
04-24 10:40:54.902 1251 1251 I update_engine: [0424/104054.902948:INFO:delta_performer.cc(451)] PartitionInfo old hyp sha256: oeV8en/VZcLP5KMcF6lNpQOlCKk6tJ3fRQLOELr05qY= size: 393216
04-24 10:40:54.903 1251 1251 I update_engine: [0424/104054.902989:INFO:delta_performer.cc(451)] PartitionInfo new hyp sha256: oeV8en/VZcLP5KMcF6lNpQOlCKk6tJ3fRQLOELr05qY= size: 393216
04-24 10:40:54.903 1251 1251 I update_engine: [0424/104054.903031:INFO:delta_performer.cc(451)] PartitionInfo old keymaster sha256: HWG8G+i3TudNjXfsOf2YTGjaDFNugZCbFuOZcmpdOSA= size: 221184
04-24 10:40:54.903 1251 1251 I update_engine: [0424/104054.903076:INFO:delta_performer.cc(451)] PartitionInfo new keymaster sha256: HWG8G+i3TudNjXfsOf2YTGjaDFNugZCbFuOZcmpdOSA= size: 221184
04-24 10:40:54.903 1251 1251 I update_engine: [0424/104054.903119:INFO:delta_performer.cc(451)] PartitionInfo old qupfw sha256: dbGYgOeXcVu2vYzKLLWOQL73bqyqqE8NmsI+weCoIbM= size: 65536
04-24 10:40:54.903 1251 1251 I update_engine: [0424/104054.903162:INFO:delta_performer.cc(451)] PartitionInfo new qupfw sha256: dbGYgOeXcVu2vYzKLLWOQL73bqyqqE8NmsI+weCoIbM= size: 65536
04-24 10:40:54.903 1251 1251 I update_engine: [0424/104054.903204:INFO:delta_performer.cc(451)] PartitionInfo old tz sha256: 6bJna8eHGZLR0FnICEb1txhlsl6Lr6Eh5+aDyXQeFnQ= size: 2056192
04-24 10:40:54.903 1251 1251 I update_engine: [0424/104054.903250:INFO:delta_performer.cc(451)] PartitionInfo new tz sha256: 6bJna8eHGZLR0FnICEb1txhlsl6Lr6Eh5+aDyXQeFnQ= size: 2056192
04-24 10:40:54.903 1251 1251 I update_engine: [0424/104054.903294:INFO:delta_performer.cc(451)] PartitionInfo old xbl sha256: dyTD92W0a1LmpoDQ45K24y6TGFvvmTfpZSYx7+xjPVI= size: 3670016
04-24 10:40:54.903 1251 1251 I update_engine: [0424/104054.903337:INFO:delta_performer.cc(451)] PartitionInfo new xbl sha256: dyTD92W0a1LmpoDQ45K24y6TGFvvmTfpZSYx7+xjPVI= size: 3670016
04-24 10:40:54.903 1251 1251 I update_engine: [0424/104054.903381:INFO:delta_performer.cc(451)] PartitionInfo old xbl_config sha256: FiHFX0+WXgnpSJlw5pQLczrmOPZjw7wUbYHj7V2MqS8= size: 98304
04-24 10:40:54.903 1251 1251 I update_engine: [0424/104054.903425:INFO:delta_performer.cc(451)] PartitionInfo new xbl_config sha256: FiHFX0+WXgnpSJlw5pQLczrmOPZjw7wUbYHj7V2MqS8= size: 98304
04-24 10:40:54.903 1251 1251 I update_engine: [0424/104054.903471:INFO:delta_performer.cc(451)] PartitionInfo old modem sha256: Bma4ByN9EbgVcXp0hYo3c200C+j6JEO6Wg6nKLgb9ZQ= size: 73150464
04-24 10:40:54.903 1251 1251 I update_engine: [0424/104054.903564:INFO:delta_performer.cc(451)] PartitionInfo new modem sha256: W9aol30QOcS2QId5FY6JojfXyaV7rhhCaq9TBsn3A+k= size: 73150464
04-24 10:40:54.921 1251 1251 I update_engine: [0424/104054.921391:INFO:delta_performer.cc(209)] Resuming after 8682/8682 operations (100%), 264404200/264404200 bytes downloaded (100%), overall progress 100%
04-24 10:40:54.921 1251 1251 I update_engine: [0424/104054.921584:INFO:delta_performer.cc(657)] Starting to apply update payload operations
04-24 10:40:54.921 1251 1251 I update_engine: [0424/104054.921635:INFO:multi_range_http_fetcher.cc(115)] Terminating transfer.
04-24 10:40:54.921 1251 1251 I update_engine: [0424/104054.921706:INFO:multi_range_http_fetcher.cc(177)] Received transfer terminated.
04-24 10:40:54.921 1251 1251 I update_engine: [0424/104054.921750:INFO:multi_range_http_fetcher.cc(129)] TransferEnded w/ code 200
04-24 10:40:54.921 1251 1251 I update_engine: [0424/104054.921793:INFO:multi_range_http_fetcher.cc(163)] Done w/ all transfers
04-24 10:40:54.921 1251 1251 I update_engine: [0424/104054.921876:INFO:delta_performer.cc(1677)] Verifying using certificates: /system/etc/security/otacerts.zip
04-24 10:40:54.922 1251 1251 I update_engine: [0424/104054.922882:INFO:payload_verifier.cc(102)] signature blob size = 267
04-24 10:40:54.923 1251 1251 I update_engine: [0424/104054.923010:INFO:payload_verifier.cc(118)] Truncating the signature to its unpadded size: 256.
04-24 10:40:54.923 1251 1251 I update_engine: [0424/104054.923378:INFO:payload_verifier.cc(129)] Verified correct signature 1 out of 1 signatures.
04-24 10:40:54.923 1251 1251 I update_engine: [0424/104054.923434:INFO:delta_performer.cc(1899)] Payload hash matches value in payload.
04-24 10:40:54.927 1251 1251 I update_engine: [0424/104054.927133:INFO:download_action.cc(400)] Collections of histograms for UpdateEngine.DownloadAction.
04-24 10:40:54.927 1251 1251 I update_engine: Histogram: UpdateEngine.DownloadAction.InstallOperation::PUFFDIFF.Duration recorded 118 samples, mean = 2097.8
04-24 10:40:54.927 1251 1251 I update_engine: 0 ------------------------------------------------------------------------O (18 = 15.3%)
04-24 10:40:54.927 1251 1251 I update_engine: 10 --------------------------------------------------------------------O (17 = 14.4%) {15.3%}
04-24 10:40:54.927 1251 1251 I update_engine: 18 --------------------------------------------O (11 = 9.3%) {29.7%}
04-24 10:40:54.927 1251 1251 I update_engine: 32 --------------------------------------------------------------------O (17 = 14.4%) {39.0%}
04-24 10:40:54.927 1251 1251 I update_engine: 57 ------------------------------------O (9 = 7.6%) {53.4%}
04-24 10:40:54.927 1251 1251 I update_engine: 101 ------------------------------------------------O (12 = 10.2%) {61.0%}
04-24 10:40:54.927 1251 1251 I update_engine: 179 ------------------------------------O (9 = 7.6%) {71.2%}
04-24 10:40:54.927 1251 1251 I update_engine: 317 ----------------------------O (7 = 5.9%) {78.8%}
04-24 10:40:54.927 1251 1251 I update_engine: 561 ------------O (3 = 2.5%) {84.7%}
04-24 10:40:54.927 1251 1251 I update_engine: 993 ------------------------O (6 = 5.1%) {87.3%}
04-24 10:40:54.927 1251 1251 I update_engine: 1758 ----------------O (4 = 3.4%) {92.4%}
04-24 10:40:54.927 1251 1251 I update_engine: 3112 --------O (2 = 1.7%) {95.8%}
04-24 10:40:54.927 1251 1251 I update_engine: 5509 O (0 = 0.0%) {97.5%}
04-24 10:40:54.927 1251 1251 I update_engine: 9752 ----O (1 = 0.8%) {97.5%}
04-24 10:40:54.927 1251 1251 I update_engine: 17262 ...
04-24 10:40:54.927 1251 1251 I update_engine: 95743 --------O (2 = 1.7%) {98.3%}
04-24 10:40:54.927 1251 1251 I update_engine: 169478 ...
04-24 10:40:54.927 1251 1251 I update_engine:
04-24 10:40:54.927 1251 1251 I update_engine: Histogram: UpdateEngine.DownloadAction.InstallOperation::REPLACE.Duration recorded 470 samples, mean = 1.9
04-24 10:40:54.927 1251 1251 I update_engine: 0 ------------------------------------------------------------------------O (456 = 97.0%)
04-24 10:40:54.927 1251 1251 I update_engine: 10 O (3 = 0.6%) {97.0%}
04-24 10:40:54.927 1251 1251 I update_engine: 18 -O (5 = 1.1%) {97.7%}
04-24 10:40:54.927 1251 1251 I update_engine: 32 O (2 = 0.4%) {98.7%}
04-24 10:40:54.927 1251 1251 I update_engine: 57 O (2 = 0.4%) {99.1%}
04-24 10:40:54.927 1251 1251 I update_engine: 101 O (1 = 0.2%) {99.6%}
04-24 10:40:54.927 1251 1251 I update_engine: 179 O (1 = 0.2%) {99.8%}
04-24 10:40:54.927 1251 1251 I update_engine: 317 ...
04-24 10:40:54.927 1251 1251 I update_engine:
04-24 10:40:54.927 1251 1251 I update_engine: Histogram: UpdateEngine.DownloadAction.InstallOperation::SOURCE_BSDIFF.Duration recorded 2302 samples, mean = 12.3
04-24 10:40:54.927 1251 1251 I update_engine: 0 ------------------------------------------------------------------------O (2002 = 87.0%)
04-24 10:40:54.927 1251 1251 I update_engine: 10 -------O (184 = 8.0%) {87.0%}
04-24 10:40:54.927 1251 1251 I update_engine: 18 --O (54 = 2.3%) {95.0%}
04-24 10:40:54.927 1251 1251 I update_engine: 32 -O (26 = 1.1%) {97.3%}
04-24 10:40:54.927 1251 1251 I update_engine: 57 O (11 = 0.5%) {98.4%}
04-24 10:40:54.927 1251 1251 I update_engine: 101 O (10 = 0.4%) {98.9%}
04-24 10:40:54.927 1251 1251 I update_engine: 179 O (4 = 0.2%) {99.3%}
04-24 10:40:54.927 1251 1251 I update_engine: 317 O (6 = 0.3%) {99.5%}
04-24 10:40:54.927 1251 1251 I update_engine: 561 O (3 = 0.1%) {99.8%}
04-24 10:40:54.927 1251 1251 I update_engine: 993 O (2 = 0.1%) {99.9%}
04-24 10:40:54.927 1251 1251 I update_engine: 1758 ...
04-24 10:40:54.927 1251 1251 I update_engine:
04-24 10:40:54.927 1251 1251 I update_engine: Histogram: UpdateEngine.DownloadAction.InstallOperation::SOURCE_COPY.Duration recorded 5148 samples, mean = 5.1
04-24 10:40:54.927 1251 1251 I update_engine: 0 ------------------------------------------------------------------------O (4336 = 84.2%)
04-24 10:40:54.927 1251 1251 I update_engine: 10 ------------O (712 = 13.8%) {84.2%}
04-24 10:40:54.927 1251 1251 I update_engine: 18 -O (81 = 1.6%) {
04-24 10:40:55.024 1251 1251 I update_engine: [0424/104055.024321:INFO:action_processor.cc(116)] ActionProcessor: finished DownloadAction with code ErrorCode::kSuccess
04-24 10:40:55.024 1251 1251 I update_engine: [0424/104055.024646:INFO:action_processor.cc(143)] ActionProcessor: starting FilesystemVerifierAction
04-24 10:40:55.024 1251 1251 I update_engine: [0424/104055.024755:INFO:filesystem_verifier_action.cc(117)] Hashing partition 0 (vendor) on device /dev/block/dm-19
04-24 10:40:56.611 1251 1251 I update_engine: [0424/104056.611431:INFO:filesystem_verifier_action.cc(237)] Hash of vendor: B9PneI0Ti3ZPy0uhseQUdeceubjjYQNmCQubsuxhlao=
04-24 10:40:56.812 1251 1251 I update_engine: [0424/104056.812166:INFO:filesystem_verifier_action.cc(117)] Hashing partition 1 (boot) on device /dev/block/bootdevice/by-name/boot_a
04-24 10:40:57.026 1251 1251 I update_engine: [0424/104057.026334:INFO:filesystem_verifier_action.cc(237)] Hash of boot: L9/wwcxfMAEF9Yf7NK96Sf/T+yIQOyI74TRoiIdCAa8=
04-24 10:40:57.053 1251 1251 I update_engine: [0424/104057.052863:INFO:filesystem_verifier_action.cc(117)] Hashing partition 2 (system) on device /dev/block/dm-20
04-24 10:40:59.828 1251 1251 I update_engine: [0424/104059.828114:INFO:filesystem_verifier_action.cc(237)] Hash of system: X1fs3Rk64cgdSXJ6cxrXCtwrTUPtuRiYkS0vHea4dxo=
04-24 10:41:00.085 1251 1251 I update_engine: [0424/104100.085406:INFO:filesystem_verifier_action.cc(117)] Hashing partition 3 (vbmeta) on device /dev/block/bootdevice/by-name/vbmeta_a
04-24 10:41:00.087 1251 1251 I update_engine: [0424/104100.087679:INFO:filesystem_verifier_action.cc(237)] Hash of vbmeta: hslCQhrNGTXHKgMVs/Vr+xYzAhr59TgDkB2CSZNjrDI=
04-24 10:41:00.087 1251 1251 I update_engine: [0424/104100.087874:INFO:filesystem_verifier_action.cc(117)] Hashing partition 4 (dtbo) on device /dev/block/bootdevice/by-name/dtbo_a
04-24 10:41:00.117 1251 1251 I update_engine: [0424/104100.117193:INFO:filesystem_verifier_action.cc(237)] Hash of dtbo: Z+PrdGI9HsQS8bX3NZpu4Gf1zDN03R4/fk9B1Ty50bw=
04-24 10:41:00.121 1251 1251 I update_engine: [0424/104100.121643:INFO:filesystem_verifier_action.cc(117)] Hashing partition 5 (product) on device /dev/block/dm-21
04-24 10:41:06.402 1251 1251 I update_engine: [0424/104106.402000:INFO:filesystem_verifier_action.cc(237)] Hash of product: S+lNq+Hyyy9QpQnjxtvz1HYbcrFfd9RGGurXw4Z1oX4=
04-24 10:41:06.676 1251 1251 I update_engine: [0424/104106.676156:INFO:filesystem_verifier_action.cc(117)] Hashing partition 6 (system_ext) on device /dev/block/dm-22
04-24 10:41:07.276 1251 1251 I update_engine: [0424/104107.276189:INFO:filesystem_verifier_action.cc(237)] Hash of system_ext: NIqTbVPG4T6Tem/dfVa7U7HmMtX546dz1O/MtLYNseQ=
04-24 10:41:07.344 1251 1251 I update_engine: [0424/104107.344807:INFO:filesystem_verifier_action.cc(117)] Hashing partition 7 (abl) on device /dev/block/bootdevice/by-name/abl_a
04-24 10:41:07.365 1251 1251 I update_engine: [0424/104107.364940:INFO:filesystem_verifier_action.cc(237)] Hash of abl: LVgMdz2xnvkLkVcJ+oqJg0TkcKLJvJhRPNHKRUkdJ2c=
04-24 10:41:07.365 1251 1251 I update_engine: [0424/104107.365939:INFO:filesystem_verifier_action.cc(117)] Hashing partition 8 (aop) on device /dev/block/bootdevice/by-name/aop_a
04-24 10:41:07.368 1251 1251 I update_engine: [0424/104107.368199:INFO:filesystem_verifier_action.cc(237)] Hash of aop: lwMLGjNpF5XfyBdAMy8aeFjdp7InRDD6nz5zKeP4I6k=
04-24 10:41:07.368 1251 1251 I update_engine: [0424/104107.368409:INFO:filesystem_verifier_action.cc(117)] Hashing partition 9 (cmnlib) on device /dev/block/bootdevice/by-name/cmnlib_a
04-24 10:41:07.370 1251 1251 I update_engine: [0424/104107.370483:INFO:filesystem_verifier_action.cc(237)] Hash of cmnlib: m53rJ50FFnmZU/b5m31kPq0GNUX7/qag9oqKzrulYgQ=
04-24 10:41:07.370 1251 1251 I update_engine: [0424/104107.370721:INFO:filesystem_verifier_action.cc(117)] Hashing partition 10 (cmnlib64) on device /dev/block/bootdevice/by-name/cmnlib64_a
04-24 10:41:07.374 1251 1251 I update_engine: [0424/104107.374341:INFO:filesystem_verifier_action.cc(237)] Hash of cmnlib64: 7cTk0BpXrCRydJgq7Q1XlIdnrr9Du3zF1brOZRNgzso=
04-24 10:41:07.374 1251 1251 I update_engine: [0424/104107.374710:INFO:filesystem_verifier_action.cc(117)] Hashing partition 11 (devcfg) on device /dev/block/bootdevice/by-name/devcfg_a
04-24 10:41:07.376 1251 1251 I update_engine: [0424/104107.376419:INFO:filesystem_verifier_action.cc(237)] Hash of devcfg: Oiiho60b3LwSrDHj6FBrcIuq+xysUSslPrwekIKFaWI=
04-24 10:41:07.376 1251 1251 I update_engine: [0424/104107.376588:INFO:filesystem_verifier_action.cc(117)] Hashing partition 12 (hyp) on device /dev/block/bootdevice/by-name/hyp_a
04-24 10:41:07.378 1251 1251 I update_engine: [0424/104107.378892:INFO:filesystem_verifier_action.cc(237)] Hash of hyp: oeV8en/VZcLP5KMcF6lNpQOlCKk6tJ3fRQLOELr05qY=
04-24 10:41:07.379 1251 1251 I update_engine: [0424/104107.379158:INFO:filesystem_verifier_action.cc(117)] Hashing partition 13 (keymaster) on device /dev/block/bootdevice/by-name/keymaster_a
04-24 10:41:07.380 1251 1251 I update_engine: [0424/104107.380835:INFO:filesystem_verifier_action.cc(237)] Hash of keymaster: HWG8G+i3TudNjXfsOf2YTGjaDFNugZCbFuOZcmpdOSA=
04-24 10:41:07.381 1251 1251 I update_engine: [0424/104107.381058:INFO:filesystem_verifier_action.cc(117)] Hashing partition 14 (qupfw) on device /dev/block/bootdevice/by-name/qupfw_a
04-24 10:41:07.382 1251 1251 I update_engine: [0424/104107.382065:INFO:filesystem_verifier_action.cc(237)] Hash of qupfw: dbGYgOeXcVu2vYzKLLWOQL73bqyqqE8NmsI+weCoIbM=
04-24 10:41:07.382 1251 1251 I update_engine: [0424/104107.382193:INFO:filesystem_verifier_action.cc(117)] Hashing partition 15 (tz) on device /dev/block/bootdevice/by-name/tz_a
04-24 10:41:07.391 1251 1251 I update_engine: [0424/104107.391586:INFO:filesystem_verifier_action.cc(237)] Hash of tz: 6bJna8eHGZLR0FnICEb1txhlsl6Lr6Eh5+aDyXQeFnQ=
04-24 10:41:07.392 1251 1251 I update_engine: [0424/104107.392752:INFO:filesystem_verifier_action.cc(117)] Hashing partition 16 (xbl) on device /dev/block/bootdevice/by-name/xbl_a
04-24 10:41:07.407 1251 1251 I update_engine: [0424/104107.407819:INFO:filesystem_verifier_action.cc(237)] Hash of xbl: dyTD92W0a1LmpoDQ45K24y6TGFvvmTfpZSYx7+xjPVI=
04-24 10:41:07.409 1251 1251 I update_engine: [0424/104107.409459:INFO:filesystem_verifier_action.cc(117)] Hashing partition 17 (xbl_config) on device /dev/block/bootdevice/by-name/xbl_config_a
04-24 10:41:07.411 1251 1251 I update_engine: [0424/104107.411355:INFO:filesystem_verifier_action.cc(237)] Hash of xbl_config: FiHFX0+WXgnpSJlw5pQLczrmOPZjw7wUbYHj7V2MqS8=
04-24 10:41:07.411 1251 1251 I update_engine: [0424/104107.411502:INFO:filesystem_verifier_action.cc(117)] Hashing partition 18 (modem) on device /dev/block/bootdevice/by-name/modem_a
04-24 10:41:07.641 1251 1251 I update_engine: [0424/104107.641673:INFO:filesystem_verifier_action.cc(237)] Hash of modem: W9aol30QOcS2QId5FY6JojfXyaV7rhhCaq9TBsn3A+k=
04-24 10:41:07.670 1251 1251 I update_engine: [0424/104107.669950:INFO:action_processor.cc(116)] ActionProcessor: finished FilesystemVerifierAction with code ErrorCode::kSuccess
04-24 10:41:07.670 1251 1251 I update_engine: [0424/104107.670147:INFO:action_processor.cc(143)] ActionProcessor: starting PostinstallRunnerAction
04-24 10:41:07.670 1251 1251 I update_engine: [0424/104107.670220:INFO:postinstall_runner_action.cc(76)] Skipping optional post-install for partition vendor according to install plan.
04-24 10:41:07.670 1251 1251 I update_engine: [0424/104107.670257:INFO:postinstall_runner_action.cc(76)] Skipping optional post-install for partition system according to install plan.
04-24 10:41:07.674 1251 1251 I update_engine: [0424/104107.674175:INFO:postinstall_runner_action.cc(174)] Performing postinst (bin/check_dynamic_partitions at /postinstall/bin/check_dynamic_partitions) installed on device /dev/block/dm-21 and mountable device /dev/block/dm-21
04-24 10:41:07.676 1251 1251 I update_engine: [0424/104107.674302:INFO:postinstall_runner_action.cc(181)] Format file for new bin/check_dynamic_partitions is: data
04-24 10:41:07.795 1251 1251 I update_engine: [0424/104107.794994:INFO:postinstall_runner_action.cc(370)] All post-install commands succeeded
04-24 10:41:07.797 1251 1251 I update_engine: [0424/104107.796975:INFO:action_processor.cc(116)] ActionProcessor: finished last action PostinstallRunnerAction with code ErrorCode::kSuccess
04-24 10:41:07.797 1251 1251 I update_engine: [0424/104107.797079:INFO:update_attempter_android.cc(503)] Processing Done.
04-24 10:41:07.798 1251 1251 I update_engine: [0424/104107.798121:INFO:update_attempter_android.cc(511)] Update successfully applied, waiting to reboot.
04-24 10:41:07.798 1251 1251 I update_engine: [0424/104107.798258:INFO:dynamic_partition_control_android.cc(250)] Destroying [product_a, system_a, system_ext_a, vendor_a] from device mapper
04-24 10:41:07.826 1251 1251 I update_engine: [libfs_mgr]Unmapped logical partition product_a
04-24 10:41:07.826 1251 1251 I update_engine: [0424/104107.826147:INFO:dynamic_partition_control_android.cc(236)] Successfully unmapped product_a from device mapper.
04-24 10:41:07.852 1251 1251 I update_engine: [libfs_mgr]Unmapped logical partition system_a
04-24 10:41:07.853 1251 1251 I update_engine: [0424/104107.852885:INFO:dynamic_partition_control_android.cc(236)] Successfully unmapped system_a from device mapper.
04-24 10:41:07.879 1251 1251 I update_engine: [libfs_mgr]Unmapped logical partition system_ext_a
04-24 10:41:07.879 1251 1251 I update_engine: [0424/104107.879466:INFO:dynamic_partition_control_android.cc(236)] Successfully unmapped system_ext_a from device mapper.
04-24 10:41:07.909 1251 1251 I update_engine: [libfs_mgr]Unmapped logical partition vendor_a
04-24 10:41:07.909 1251 1251 I update_engine: [0424/104107.909462:INFO:dynamic_partition_control_android.cc(236)] Successfully unmapped vendor_a from device mapper.
04-24 10:41:07.941 1251 1251 I update_engine: [0424/104107.940980:INFO:metrics_reporter_android.cc(80)] Current update attempt downloads 0 bytes data
04-24 10:41:07.944 1251 1251 I update_engine: [0424/104107.944608:INFO:metrics_utils.cc(380)] Updated Marker = 1/1/1970 0:36:50 GMT
04-24 10:41:07.972 2778 20019 I SystemUpdate: [Execution,ExecutionManager] Action ab-reboot executed for 13.60 seconds.
04-24 10:41:07.978 2778 20019 I SystemUpdate: [Control,DeviceControl] Calling reboot with update token: 76.
04-24 10:41:09.710 2778 20047 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110.
04-24 10:41:10.671 1251 1251 I update_engine: [0424/104110.671811:INFO:main.cc(198)] A/B Update Engine terminating with exit code 0
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment