Android虚拟AB升级流程简述及升级完整log
2024-06-01 18:22:08
本文对 Android update_engine 升级流程进行粗略的分析（详细流程，可以参考 log 对代码进行分析，主要梳理清楚主要类的关系即可搞懂升级流程，该 log 为本地通过update_engine_client 进行升级产生的）：
1、Java层
主要给应用提供bind()、applyPayload() 、onStatusUpdate()、onPayloadApplicationComplete()接口，用来bind 到 update_engine 服务、开始升级、获取升级进度、获取升级结果等。
frameworks/base/core/java/android/os/UpdateEngine.java/*** Creates a new instance.*/public UpdateEngine() {mUpdateEngine = IUpdateEngine.Stub.asInterface(ServiceManager.getService(UPDATE_ENGINE_SERVICE));}/*** Prepares this instance for use. The callback will be notified on any* status change, and when the update completes. A handler can be supplied* to control which thread runs the callback, or null.*/public boolean bind(final UpdateEngineCallback callback, final Handler handler) {synchronized (mUpdateEngineCallbackLock) {mUpdateEngineCallback = new IUpdateEngineCallback.Stub() {@Overridepublic void onStatusUpdate(final int status, final float percent) {if (handler != null) {handler.post(new Runnable() {@Overridepublic void run() {callback.onStatusUpdate(status, percent);}});} else {callback.onStatusUpdate(status, percent);}}@Overridepublic void onPayloadApplicationComplete(final int errorCode) {if (handler != null) {handler.post(new Runnable() {@Overridepublic void run() {callback.onPayloadApplicationComplete(errorCode);}});} else {callback.onPayloadApplicationComplete(errorCode);}}};try {return mUpdateEngine.bind(mUpdateEngineCallback);} catch (RemoteException e) {throw e.rethrowFromSystemServer();}}}/*** Equivalent to {@code bind(callback, null)}.*/public boolean bind(final UpdateEngineCallback callback) {return bind(callback, null);}public void applyPayload(String url, long offset, long size, String[] headerKeyValuePairs) {try {mUpdateEngine.applyPayload(url, offset, size, headerKeyValuePairs);} catch (RemoteException e) {throw e.rethrowFromSystemServer();}}frameworks/base/core/java/android/os/UpdateEngineCallback.java@SystemApi
public abstract class UpdateEngineCallback {/*** Invoked when anything changes. The value of {@code status} will* be one of the values from {@link UpdateEngine.UpdateStatusConstants},* and {@code percent} will be valid [TODO: in which cases?].*/public abstract void onStatusUpdate(int status, float percent);/*** Invoked when the payload has been applied, whether successfully or* unsuccessfully. The value of {@code errorCode} will be one of the* values from {@link UpdateEngine.ErrorCodeConstants}.*/public abstract void onPayloadApplicationComplete(@UpdateEngine.ErrorCode int errorCode);
}2、native 层
update_engine 初始化:
Main.cc(system\update_engine)// update_engine 服务入口，该服务由 init.rc中启动int main(int argc, char** argv) {chromeos_update_engine::Terminator::Init();brillo::FlagHelper::Init(argc, argv, "A/B Update Engine");LOG(INFO) << "A/B Update Engine starting";chromeos_update_engine::UpdateEngineDaemon update_engine_daemon;// 注意 UpdateEngineDaemon 继承于 brillo::Daemon (class UpdateEngineDaemon : public brillo::Daemon)，// 且 UpdateEngineDaemon 没有实现 Run()方法，则调用父类的Run()方法int exit_code = update_engine_daemon.Run();LOG(INFO) << "A/B Update Engine terminating with exit code " << exit_code;return exit_code;}Daemon.cc (external\libbrillo\brillo\daemons)int Daemon::Run() {// !!!重要, 这里OnInit()方法,调用Daemon类的还是UpdateEngineDaemon的? 实际从UpdateEngineDaemon// 调用的 Run()方法，而且 子类 进行了重写，所以这里实际调到 UpdateEngineDaemon中int exit_code = OnInit();message_loop_.PostTask(base::Bind(&Daemon::OnEventLoopStartedTask, base::Unretained(this)));message_loop_.Run();OnShutdown(&exit_code_);while (message_loop_.RunOnce(false /* may_block */)) {}return exit_code_;}int Daemon::OnInit() {async_signal_handler_.Init();for (int signal : {SIGTERM, SIGINT}) {async_signal_handler_.RegisterHandler(signal, base::Bind(&Daemon::Shutdown, base::Unretained(this)));}async_signal_handler_.RegisterHandler(SIGHUP, base::Bind(&Daemon::Restart, base::Unretained(this)));return EX_OK;}Daemon.h (external\libbrillo\brillo\daemons)class BRILLO_EXPORT Daemon : public AsynchronousSignalHandlerInterface {public:virtual int Run();}Daemon.h (system\update_engine)
// UpdateEngineDaemon继承于Daemon,但是该类本身没有实现Run()方法, 只能使用父类的方法,所以实际调用到
// Daemon::Run()中，而实际Daemon中Run方法先执行OnInit(),class UpdateEngineDaemon : public brillo::Daemon {protected:int OnInit() override;private:brillo::BinderWatcher binder_watcher_;android::sp<BinderUpdateEngineAndroidService> binder_service_;std::unique_ptr<DaemonStateInterface> daemon_state_;}Daemon.cc (system\update_engine)int UpdateEngineDaemon::OnInit() {int exit_code = Daemon::OnInit();DaemonStateAndroid* daemon_state_android = new DaemonStateAndroid();daemon_state_.reset(daemon_state_android);LOG_IF(ERROR, !daemon_state_android->Initialize()) << "Failed to initialize system state.";binder_service_ = new BinderUpdateEngineAndroidService{ daemon_state_android->service_delegate()};auto binder_wrapper = android::BinderWrapper::Get();// 注意 system/update_engine/binder_service_android.h : const char* ServiceName() // const { return "android.os.UpdateEngineService";} 所以RegisterService// 第一个参数为 "android.os.UpdateEngineService", 所以java层通过该service同update_engine进行通信,// 而不是update_engine_client所以简单来说通过update_engine.rc启动update_engine服务, 该服务里面注册了// "android.os.UpdateEngineService"服务,java层通过该Service名字通信if (!binder_wrapper->RegisterService(binder_service_->ServiceName(),binder_service_))daemon_state_->AddObserver(binder_service_.get());daemon_state_->StartUpdater();return EX_OK;}//UpdateEngineDaemon::OnInit() -> DaemonStateAndroid:Initialize()方法Daemon_state_android.cc (system\update_engine)// 创建boot_control_, 判断hardware信息, update_attempter_初始化等bool DaemonStateAndroid::Initialize() {boot_control_ = boot_control::CreateBootControl();hardware_ = hardware::CreateHardware();update_attempter_.reset(new UpdateAttempterAndroid(this, prefs_.get(), boot_control_.get(), hardware_.get()));return true;}bool DaemonStateAndroid::StartUpdater() {// The DaemonState in Android is a passive daemon. It will only start applying// an update when instructed to do so from the exposed binder API.update_attempter_->Init();return true;}void DaemonStateAndroid::AddObserver(ServiceObserverInterface* observer) {service_observers_.insert(observer);}ServiceDelegateAndroidInterface* DaemonStateAndroid::service_delegate() {return update_attempter_.get();}Applypayload流程:
system/update_engine/aosp/update_attempter_android.ccbool UpdateAttempterAndroid::ApplyPayload(const string& payload_url,int64_t payload_offset, int64_t payload_size,const vector<string>& key_value_pair_headers,brillo::ErrorPtr* error) {if (status_ == UpdateStatus::UPDATED_NEED_REBOOT) {return LogAndSetError(error, FROM_HERE, "An update already applied, waiting for reboot");}if (processor_->IsRunning()) {LogAndSetError(error, FROM_HERE, "Already processing an update, cancel it first.");}install_plan_ = InstallPlan();LOG(INFO) << "Using this install plan:";install_plan_.Dump();HttpFetcher* fetcher = nullptr;fetcher = new FileFetcher();BuildUpdateActions(fetcher);SetStatusAndNotify(UpdateStatus::UPDATE_AVAILABLE);UpdatePrefsOnUpdateStart(install_plan_.is_resume);ScheduleProcessingStart();}void UpdateAttempterAndroid::BuildUpdateActions(HttpFetcher* fetcher) {processor_->set_delegate(this);auto update_boot_flags_action = std::make_unique<UpdateBootFlagsAction>(boot_control_);auto cleanup_previous_update_action = boot_control_->GetDynamicPartitionControl()->GetCleanupPreviousUpdateAction(boot_control_, prefs_, this);auto install_plan_action = std::make_unique<InstallPlanAction>(install_plan_);auto download_action = std::make_unique<DownloadAction>(prefs_,boot_control_,hardware_,nullptr, // system_state, not used.fetcher, // passes ownershiptrue /* interactive */);download_action->set_delegate(this);download_action->set_base_offset(base_offset_);auto filesystem_verifier_action = std::make_unique<FilesystemVerifierAction>();auto postinstall_runner_action = std::make_unique<PostinstallRunnerAction>(boot_control_, hardware_);postinstall_runner_action->set_delegate(this);// Bond them together. We have to use the leaf-types when calling BondActions().BondActions(install_plan_action.get(), download_action.get());BondActions(download_action.get(), filesystem_verifier_action.get());BondActions(filesystem_verifier_action.get(),postinstall_runner_action.get());//将这6个Action放入processor中processor_->EnqueueAction(std::move(update_boot_flags_action));processor_->EnqueueAction(std::move(cleanup_previous_update_action));processor_->EnqueueAction(std::move(install_plan_action));processor_->EnqueueAction(std::move(download_action));processor_->EnqueueAction(std::move(filesystem_verifier_action));processor_->EnqueueAction(std::move(postinstall_runner_action));}// EnqueueAction() 实际把这 6 个 ActionProcessor push 到本地的 actions_(std::deque<std::unique_ptr<AbstractAction>> actions_)中，
// 在StartProcessing() 时从中读取数据
void ActionProcessor::EnqueueAction(unique_ptr<AbstractAction> action) {action->SetProcessor(this);actions_.push_back(std::move(action));
}void UpdateAttempterAndroid::ScheduleProcessingStart() {LOG(INFO) << "Scheduling an action processor start.";// 升级通过Action_Processor，到各个action中进行执行：如下action按顺序执行brillo::MessageLoop::current()->PostTask(FROM_HERE,Bind([](ActionProcessor* processor) { processor->StartProcessing(); },base::Unretained(processor_.get())));
}system/update_engine/common/action_processor.ccvoid ActionProcessor::StartProcessing() {if (!actions_.empty()) {// 从actions_中取出各个action,action对应的信息,如上log所示:current_action_ = std::move(actions_.front());actions_.pop_front();LOG(INFO) << "ActionProcessor: starting " << current_action_->Type();current_action_->PerformAction();}}// 截取的部分日志:
11-25 11:45:40.972 839 839 I update_engine: [INFO:action_processor.cc(51)] ActionProcessor: starting UpdateBootFlagsAction
11-25 11:45:41.004 839 839 I update_engine: [INFO:action_processor.cc(143)] ActionProcessor: starting CleanupPreviousUpdateAction
11-25 11:45:41.047 839 839 I update_engine: [INFO:action_processor.cc(143)] ActionProcessor: starting InstallPlanAction
11-25 11:45:41.055 839 839 I update_engine: [INFO:action_processor.cc(143)] ActionProcessor: starting DownloadAction
11-25 11:49:46.429 839 839 I update_engine: [INFO:action_processor.cc(143)] ActionProcessor: starting FilesystemVerifierAction
11-25 11:50:10.660 839 839 I update_engine: [INFO:action_processor.cc(143)] ActionProcessor: starting PostinstallRunnerAction
// 另外比较重要是各个delegate进行调用：
// delegate_变量关系分析:
// 关于delegate_变量定义, 多个文件中的方法中通过delegate_->func()调用,下面梳理下对应关系: 可以看到DownloadAction类中
// 定义了delegate_,且类型为DownloadActionDelegate* 同样HttpFetcher类定义了deleagte_, 且类型为HttpFetcherDelegate*Action_processor.h (system\update_engine\common): ActionProcessorDelegate* delegate_{nullptr};Cleanup_previous_update_action.h (system\update_engine): CleanupPreviousUpdateActionDelegateInterface* delegate_;Download_action.h (system\update_engine\payload_consumer): DownloadActionDelegate* delegate_;Http_fetcher.h (system\update_engine\common): HttpFetcherDelegate* delegate_;Postinstall_runner_action.h (system\update_engine\payload_consumer): DelegateInterface* delegate_{nullptr};// 这么多delegate_如何使用,有如何的联系,且看下面set_delegate()方法的地方:Download_action.cc (system\update_engine\payload_consumer): http_fetcher_->set_delegate(this);Multi_range_http_fetcher.cc (system\update_engine\common): base_fetcher_->set_delegate(this);Update_attempter_android.cc (system\update_engine): processor_->set_delegate(nullptr);Update_attempter_android.cc (system\update_engine): processor_->set_delegate(this);Update_attempter_android.cc (system\update_engine): download_action->set_delegate(this);Update_attempter_android.cc (system\update_engine): postinstall_runner_action->set_delegate(this);Update_attempter_android.cc (system\update_engine): processor_->set_delegate(this);// 而各个类中set_delegate()方法如下, 可以看出该方法A-set_delegate(B) 实际将A对象中的delegate_指针指向 B,
// 方便在后面A中执行delegate_->func()时, 从而执行到B中的方法. // 比如 DownloadAction对象中, http_fetcher_->set_delegate(this), 那么后续http_fetcher(实际为
// MultiRangeHttpFetcher)中执行delegate_->func()时, 会调用到DownloadAction
// 中的方法. 该处非常重要,理解了这里,那么几个对象之间的关系,就容易理清楚了.void set_delegate(ActionProcessorDelegate* delegate) { delegate_ = delegate; }
void set_delegate(DownloadActionDelegate* delegate) { delegate_ = delegate; }
void set_delegate(HttpFetcherDelegate* delegate) { delegate_ = delegate; }
void set_delegate(DelegateInterface* delegate) { delegate_ = delegate; }void DownloadAction::PerformAction(){//同样这里比较重要, 执行该方法后, http_fetcher_对象里面的delegate_ = DownloadAction(this);//那么http_fetcher_对象即MultiRangeHttpFetcher里面的delegate_->操作,都调用到 DownloadAction里面的方法;http_fetcher_->set_delegate(this);install_plan_.Dump();LOG(INFO) << "Marking new slot as unbootable";if (!boot_control_->MarkSlotUnbootable(install_plan_.target_slot)){LOG(WARNING) << "Unable to mark new slot "<< BootControlInterface::SlotName(install_plan_.target_slot)<< ". Proceeding with the update anyway.";}StartDownloading();
}Multi_range_http_fetcher.cc (system\update_engine\common)bool MultiRangeHttpFetcher::ReceivedBytes(HttpFetcher* fetcher,const void* bytes,size_t length) {//根据前面分析可知, 在DownloadAtion中通过http_fetcher_->set_delegate(this);设置//所以在MultiRangeHttpFetcher中,delegate_实际调用 DownloadAction中方法.if (delegate_ && !delegate_->ReceivedBytes(this, bytes, next_size))return false;//ReceivedBytes处理完, 才会走到这里.if (range.HasLength() && bytes_received_this_range_ >= range.length()) {LOG(INFO) << "Terminating transfer.";fetcher->TerminateTransfer();}}void MultiRangeHttpFetcher::TransferTerminated(HttpFetcher* fetcher) {LOG(INFO) << "Received transfer terminated.";TransferEnded(fetcher, false);}void MultiRangeHttpFetcher::TransferEnded(HttpFetcher* fetcher,bool successful) {http_response_code_ = fetcher->http_response_code();LOG(INFO) << "TransferEnded w/ code " << http_response_code_;LOG(INFO) << "Done w/ all transfers";if (delegate_)delegate_->TransferComplete(this, successful);//同样这里的delegate_-> 调用到 DownloadAction中的方法
}3、升级完整日志
11-25 11:45:40.929 839 839 I update_engine: [INFO:update_attempter_android.cc(280)] Using this install plan:
11-25 11:45:40.938 839 839 I update_engine: [INFO:install_plan.cc(91)] InstallPlan: new_update, version: , source_slot: A, target_slot: B, url: file:///data/ota_package/update.zip, payload: (size: 1408047432, metadata_size: 86042, metadata signature: , hash: 6AF24E671F9FF99FFE7C4A0B5A5FD9FABC22D3B40B712A6079C64DBAE76F5B44, payload type: unknown), hash_checks_mandatory: false, powerwash_required: false, switch_slot_on_reboot: true, run_post_install: true, is_rollback: false, write_verity: true
11-25 11:45:40.945 839 839 I update_engine: [INFO:metrics_utils.cc(363)] Number of Reboots during current update attempt = 0
11-25 11:45:40.951 839 839 I update_engine: [INFO:metrics_utils.cc(371)] Payload Attempt Number = 1
11-25 11:45:40.958 839 839 I update_engine: [INFO:metrics_utils.cc(388)] Update Monotonic Timestamp Start = 1/1/1970 0:11:13 GMT
11-25 11:45:40.963 839 839 I update_engine: [INFO:metrics_utils.cc(397)] Update Boot Timestamp Start = 1/1/1970 0:11:13 GMT
11-25 11:45:40.966 839 839 I update_engine: [INFO:update_attempter_android.cc(648)] Scheduling an action processor start.
11-25 11:45:40.971 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_IDLE (0), 0)11-25 11:45:40.972 839 839 I update_engine: [INFO:action_processor.cc(51)] ActionProcessor: starting UpdateBootFlagsAction
11-25 11:45:40.972 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_UPDATE_AVAILABLE (2), 0)
11-25 11:45:40.977 839 839 I update_engine: [INFO:update_boot_flags_action.cc(45)] Marking booted slot as good.
11-25 11:45:40.998 839 839 I update_engine: [INFO:action_processor.cc(116)] ActionProcessor: finished UpdateBootFlagsAction with code ErrorCode::kSuccess
11-25 11:45:40.998 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_CLEANUP_PREVIOUS_UPDATE (11), 0)
11-25 11:45:41.004 839 839 I update_engine: [INFO:action_processor.cc(143)] ActionProcessor: starting CleanupPreviousUpdateAction
11-25 11:45:41.008 839 839 I update_engine: [INFO:cleanup_previous_update_action.cc(82)] Starting/resuming CleanupPreviousUpdateAction
11-25 11:45:41.012 839 839 I update_engine: [INFO:cleanup_previous_update_action.cc(137)] Boot completed, waiting on markBootSuccessful()
11-25 11:45:41.016 839 839 I update_engine: EnsureMetadataMounted does nothing in Android mode.
11-25 11:45:41.020 839 839 I update_engine: Read merge statistics file failed: No such file or directory
11-25 11:45:41.027 839 839 I update_engine: [INFO:cleanup_previous_update_action.cc(206)] Waiting for any previous merge request to complete. This can take up to several minutes.
11-25 11:45:41.034 839 839 E update_engine: [ERROR:cleanup_previous_update_action.cc(240)] Previous update has not been completed, not cleaning up
11-25 11:45:41.039 839 839 I update_engine: [INFO:cleanup_previous_update_action.cc(397)] Not reporting merge stats because state is Initiated
11-25 11:45:41.043 839 839 I update_engine: [INFO:action_processor.cc(116)] ActionProcessor: finished CleanupPreviousUpdateAction with code ErrorCode::kSuccess
11-25 11:45:41.047 839 839 I update_engine: [INFO:action_processor.cc(143)] ActionProcessor: starting InstallPlanAction
11-25 11:45:41.051 839 839 I update_engine: [INFO:action_processor.cc(116)] ActionProcessor: finished InstallPlanAction with code ErrorCode::kSuccess
11-25 11:45:41.055 839 839 I update_engine: [INFO:action_processor.cc(143)] ActionProcessor: starting DownloadAction
11-25 11:45:41.059 839 839 I update_engine: [INFO:install_plan.cc(91)] InstallPlan: new_update, version: , source_slot: A, target_slot: B, url: file:///data/ota_package/update.zip, payload: (size: 1408047432, metadata_size: 86042, metadata signature: , hash: 6AF24E671F9FF99FFE7C4A0B5A5FD9FABC22D3B40B712A6079C64DBAE76F5B44, payload type: unknown), hash_checks_mandatory: false, powerwash_required: false, switch_slot_on_reboot: true, run_post_install: true, is_rollback: false, write_verity: true
11-25 11:45:41.062 839 839 I update_engine: [INFO:download_action.cc(199)] Marking new slot as unbootable
11-25 11:45:41.066 839 839 E update_engine: [ERROR:boot_control_android.cc(116)] Unable to mark slot B as unbootable: Operation failed
11-25 11:45:41.070 839 839 W update_engine: [WARNING:download_action.cc(201)] Unable to mark new slot B. Proceeding with the update anyway.
11-25 11:45:41.074 839 839 I update_engine: [INFO:multi_range_http_fetcher.cc(45)] starting first transfer
11-25 11:45:41.078 839 839 I update_engine: [INFO:multi_range_http_fetcher.cc(74)] starting transfer of range 2081+1408047432
11-25 11:45:41.085 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 1.31139e-05)
11-25 11:45:41.087 839 839 I update_engine: [INFO:delta_performer.cc(209)] Completed 0/? operations, 16384/1408047432 bytes downloaded (0%), overall progress 0%
11-25 11:45:41.096 839 839 I update_engine: [INFO:delta_performer.cc(520)] Manifest size in payload matches expected value from Omaha
11-25 11:45:41.101 839 839 I update_engine: [INFO:delta_performer.cc(1693)] Verifying using certificates: /system/etc/security/otacerts.zip
11-25 11:45:41.108 839 839 I update_engine: [INFO:payload_verifier.cc(102)] signature blob size = 267
11-25 11:45:41.112 839 839 I update_engine: [INFO:payload_verifier.cc(118)] Truncating the signature to its unpadded size: 256.
11-25 11:45:41.116 839 839 I update_engine: [INFO:payload_verifier.cc(129)] Verified correct signature 1 out of 1 signatures.
11-25 11:45:41.121 839 839 I update_engine: [INFO:payload_metadata.cc(224)] Metadata hash signature matches value in Omaha response.
11-25 11:45:41.133 839 839 I update_engine: [INFO:delta_performer.cc(1728)] Detected a 'full' payload.
11-25 11:45:41.145 839 839 I update_engine: [INFO:delta_performer.cc(985)] Preparing partitions for new update. last hash = , new hash = avJOZx+f+Z/+fEoLWl/Z+rwi07QLcSpgecZNuudvW0Q=eWsiz/DKLC/QScxAw8LIM9T1RR1+WobOfhO+zbhVgi8=
11-25 11:45:41.160 839 839 W update_engine: type=1400 audit(0.0:198): avc: denied { search } for name="/" dev="dm-6" ino=2 scontext=u:r:update_engine:s0 tcontext=u:object_r:unlabeled:s0 tclass=dir permissive=0
11-25 11:45:41.170 839 839 I chatty : uid=0(root) /system/bin/update_engine identical 5 lines
11-25 11:45:41.170 839 839 W update_engine: type=1400 audit(0.0:204): avc: denied { search } for name="/" dev="dm-6" ino=2 scontext=u:r:update_engine:s0 tcontext=u:object_r:unlabeled:s0 tclass=dir permissive=0
11-25 11:45:41.251 839 839 I update_engine: EnsureMetadataMounted does nothing in Android mode.
11-25 11:45:41.256 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(676)] Erasing AVB footer of system_other partition before update.
11-25 11:45:41.262 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(577)] AVB is not enabled on system_other. Skip erasing.
11-25 11:45:41.267 839 839 I update_engine: Update has been initiated, now canceling
11-25 11:45:41.270 839 839 I update_engine: Removing all update state.
11-25 11:45:41.274 839 839 W update_engine: Cannot read /metadata/ota/snapshot-boot: No such file or directory
11-25 11:45:41.276 839 839 W update_engine: Failed to get flashing status
11-25 11:45:41.279 839 839 W update_engine: Cannot read /metadata/ota/snapshot-boot: No such file or directory
11-25 11:45:42.349 839 839 I update_engine: Successfully unmapped snapshot system_b
11-25 11:45:42.356 839 839 I update_engine: Successfully unmapped snapshot hmd_custom_amx_b
11-25 11:45:42.361 839 839 I update_engine: Successfully unmapped snapshot vendor_b
11-25 11:45:42.366 839 839 I update_engine: Successfully unmapped snapshot product_b
11-25 11:45:42.400 839 839 W update_engine: type=1400 audit(0.0:205): avc: denied { search } for name="/" dev="dm-6" ino=2 scontext=u:r:update_engine:s0 tcontext=u:object_r:unlabeled:s0 tclass=dir permissive=0
11-25 11:45:42.410 839 839 I chatty : uid=0(root) /system/bin/update_engine identical 4 lines
11-25 11:45:42.420 839 839 W update_engine: type=1400 audit(0.0:210): avc: denied { search } for name="/" dev="dm-6" ino=2 scontext=u:r:update_engine:s0 tcontext=u:object_r:unlabeled:s0 tclass=dir permissive=0
11-25 11:45:42.510 839 839 I update_engine: [liblp]Partition vendor_b will resize from 274493440 bytes to 274477056 bytes
11-25 11:45:42.514 839 839 I update_engine: [liblp]Partition product_b will resize from 1283309568 bytes to 1281126400 bytes
11-25 11:45:42.517 839 839 I update_engine: [liblp]Partition system_b will resize from 1319051264 bytes to 1319157760 bytes
11-25 11:45:42.520 839 839 I update_engine: Remaining free space for COW: 6139273216 bytes
11-25 11:45:42.550 839 839 I update_engine: For partition hmd_custom_amx_b, device size = 109522944, snapshot size = 109522944, cow partition size = 109957120, cow file size = 0
11-25 11:45:42.556 839 839 I update_engine: [liblp]Partition hmd_custom_amx_b-cow will resize from 0 bytes to 109957120 bytes
11-25 11:45:42.559 839 839 I update_engine: Successfully created snapshot partition for hmd_custom_amx_b
11-25 11:45:42.561 839 839 I update_engine: Remaining free space for COW: 6029316096 bytes
11-25 11:45:42.629 839 839 I update_engine: For partition vendor_b, device size = 274477056, snapshot size = 274477056, cow partition size = 275554304, cow file size = 0
11-25 11:45:42.635 839 839 I update_engine: [liblp]Partition vendor_b-cow will resize from 0 bytes to 275554304 bytes
11-25 11:45:42.638 839 839 I update_engine: Successfully created snapshot partition for vendor_b
11-25 11:45:42.641 839 839 I update_engine: Remaining free space for COW: 5753761792 bytes
11-25 11:45:42.949 839 839 I update_engine: For partition product_b, device size = 1281126400, snapshot size = 1281126400, cow partition size = 1286135808, cow file size = 0
11-25 11:45:42.961 839 839 I update_engine: [liblp]Partition product_b-cow will resize from 0 bytes to 1286135808 bytes
11-25 11:45:42.964 839 839 I update_engine: Successfully created snapshot partition for product_b
11-25 11:45:42.967 839 839 I update_engine: Remaining free space for COW: 4467625984 bytes
11-25 11:45:43.282 839 839 I update_engine: For partition system_b, device size = 1319157760, snapshot size = 1319157760, cow partition size = 1324318720, cow file size = 0
11-25 11:45:43.293 839 839 I update_engine: [liblp]Partition system_b-cow will resize from 0 bytes to 1324318720 bytes
11-25 11:45:43.296 839 839 I update_engine: Successfully created snapshot partition for system_b
11-25 11:45:43.299 839 839 I update_engine: Allocating CoW images.
11-25 11:45:43.303 839 839 I update_engine: Successfully created snapshot for hmd_custom_amx_b
11-25 11:45:43.306 839 839 I update_engine: Successfully created snapshot for product_b
11-25 11:45:43.309 839 839 I update_engine: Successfully created snapshot for system_b
11-25 11:45:43.311 839 839 I update_engine: Successfully created snapshot for vendor_b
11-25 11:45:43.315 839 839 I update_engine: Successfully unmapped snapshot hmd_custom_amx_b
11-25 11:45:43.362 839 839 I update_engine: Mapped COW device for hmd_custom_amx_b at /dev/block/dm-4
11-25 11:45:43.369 839 839 I update_engine: Zero-filling COW device: /dev/block/dm-4
11-25 11:45:43.421 839 839 I update_engine: Successfully unmapped snapshot vendor_b
11-25 11:45:43.470 839 839 I update_engine: Mapped COW device for vendor_b at /dev/block/dm-4
11-25 11:45:43.475 839 839 I update_engine: Zero-filling COW device: /dev/block/dm-4
11-25 11:45:43.511 839 839 I update_engine: Successfully unmapped snapshot product_b
11-25 11:45:43.543 839 839 I update_engine: Mapped COW device for product_b at /dev/block/dm-4
11-25 11:45:43.549 839 839 I update_engine: Zero-filling COW device: /dev/block/dm-4
11-25 11:45:43.591 839 839 I update_engine: Successfully unmapped snapshot system_b
11-25 11:45:43.622 839 839 I update_engine: Mapped COW device for system_b at /dev/block/dm-4
11-25 11:45:43.628 839 839 I update_engine: Zero-filling COW device: /dev/block/dm-4
11-25 11:45:43.685 839 839 I update_engine: [liblp]Updated logical partition table at slot 1 on device super
11-25 11:45:43.690 839 839 I update_engine: Successfully created all snapshots for target slot _b
11-25 11:45:43.694 839 839 I update_engine: [INFO:delta_performer.cc(1002)] PreparePartitionsForUpdate done.
11-25 11:45:43.711 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/platform/bootdevice/by-name/super
11-25 11:45:43.716 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] boot_b is not in super partition metadata.
11-25 11:45:43.721 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/platform/bootdevice/by-name/super
11-25 11:45:43.727 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/platform/bootdevice/by-name/super
11-25 11:45:43.732 839 839 I update_engine: Successfully unmapped snapshot system_b
11-25 11:45:43.760 839 839 I update_engine: [libfs_mgr]Created logical partition system_b-base on device /dev/block/dm-4
11-25 11:45:43.793 839 839 I update_engine: Mapped COW device for system_b at /dev/block/dm-11
11-25 11:45:43.833 839 839 I update_engine: Mapped system_b as snapshot device at /dev/block/dm-12
11-25 11:45:43.839 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(173)] Succesfully mapped system_b to device mapper (force_writable = 1); device path at /dev/block/dm-12
11-25 11:45:43.846 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/platform/bootdevice/by-name/super
11-25 11:45:43.850 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] lk_b is not in super partition metadata.
11-25 11:45:43.854 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/platform/bootdevice/by-name/super
11-25 11:45:43.860 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/platform/bootdevice/by-name/super
11-25 11:45:43.865 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] preloader_b is not in super partition metadata.
11-25 11:45:43.869 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/platform/bootdevice/by-name/super
11-25 11:45:43.876 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/platform/bootdevice/by-name/super
11-25 11:45:43.879 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] logo_b is not in super partition metadata.
11-25 11:45:43.884 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/platform/bootdevice/by-name/super
11-25 11:45:43.890 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/platform/bootdevice/by-name/super
11-25 11:45:43.894 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] md1img_b is not in super partition metadata.
11-25 11:45:43.911 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/platform/bootdevice/by-name/super
11-25 11:45:43.917 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/platform/bootdevice/by-name/super
11-25 11:45:43.921 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] spmfw_b is not in super partition metadata.
11-25 11:45:43.926 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/platform/bootdevice/by-name/super
11-25 11:45:43.932 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/platform/bootdevice/by-name/super
11-25 11:45:43.937 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] scp_b is not in super partition metadata.
11-25 11:45:43.944 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/platform/bootdevice/by-name/super
11-25 11:45:43.951 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/platform/bootdevice/by-name/super
11-25 11:45:43.956 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] sspm_b is not in super partition metadata.
11-25 11:45:43.960 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/platform/bootdevice/by-name/super
11-25 11:45:43.967 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/platform/bootdevice/by-name/super
11-25 11:45:43.971 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] dtbo_b is not in super partition metadata.
11-25 11:45:43.975 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/platform/bootdevice/by-name/super
11-25 11:45:43.981 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/platform/bootdevice/by-name/super
11-25 11:45:43.987 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] tee_b is not in super partition metadata.
11-25 11:45:43.992 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/platform/bootdevice/by-name/super
11-25 11:45:44.001 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/platform/bootdevice/by-name/super
11-25 11:45:44.006 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] vbmeta_b is not in super partition metadata.
11-25 11:45:44.010 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/platform/bootdevice/by-name/super
11-25 11:45:44.017 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/platform/bootdevice/by-name/super
11-25 11:45:44.021 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] vbmeta_system_b is not in super partition metadata.
11-25 11:45:44.025 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/platform/bootdevice/by-name/super
11-25 11:45:44.031 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/platform/bootdevice/by-name/super
11-25 11:45:44.035 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] vbmeta_vendor_b is not in super partition metadata.
11-25 11:45:44.039 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/platform/bootdevice/by-name/super
11-25 11:45:44.047 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/platform/bootdevice/by-name/super
11-25 11:45:44.051 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(938)] wt_custom_b is not in super partition metadata.
11-25 11:45:44.055 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot A in /dev/block/platform/bootdevice/by-name/super
11-25 11:45:44.061 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/platform/bootdevice/by-name/super
11-25 11:45:44.068 839 839 I update_engine: Successfully unmapped snapshot hmd_custom_amx_b
11-25 11:45:44.100 839 839 I update_engine: [libfs_mgr]Created logical partition hmd_custom_amx_b-base on device /dev/block/dm-13
11-25 11:45:44.129 839 839 I update_engine: Mapped COW device for hmd_custom_amx_b at /dev/block/dm-14
11-25 11:45:44.167 839 839 I update_engine: Mapped hmd_custom_amx_b as snapshot device at /dev/block/dm-15
11-25 11:45:44.172 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(173)] Succesfully mapped hmd_custom_amx_b to device mapper (force_writable = 1); device path at /dev/block/dm-15
11-25 11:45:44.179 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/platform/bootdevice/by-name/super
11-25 11:45:44.183 839 839 I update_engine: Successfully unmapped snapshot vendor_b
11-25 11:45:44.214 839 839 I update_engine: [libfs_mgr]Created logical partition vendor_b-base on device /dev/block/dm-16
11-25 11:45:44.249 839 839 I update_engine: Mapped COW device for vendor_b at /dev/block/dm-17
11-25 11:45:44.288 839 839 I update_engine: Mapped vendor_b as snapshot device at /dev/block/dm-18
11-25 11:45:44.293 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(173)] Succesfully mapped vendor_b to device mapper (force_writable = 1); device path at /dev/block/dm-18
11-25 11:45:44.300 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(319)] Loaded metadata from slot B in /dev/block/platform/bootdevice/by-name/super
11-25 11:45:44.305 839 839 I update_engine: Successfully unmapped snapshot product_b
11-25 11:45:44.334 839 839 I update_engine: [libfs_mgr]Created logical partition product_b-base on device /dev/block/dm-19
11-25 11:45:44.366 839 839 I update_engine: Mapped COW device for product_b at /dev/block/dm-20
11-25 11:45:44.407 839 839 I update_engine: Mapped product_b as snapshot device at /dev/block/dm-21
11-25 11:45:44.412 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(173)] Succesfully mapped product_b to device mapper (force_writable = 1); device path at /dev/block/dm-21
11-25 11:45:44.416 839 839 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new boot sha256: uKMzlkL7zm6hLQTQfgnWH71BKA/aPAepZ/Q+tRUvrDw= size: 33554432
11-25 11:45:44.419 839 839 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new system sha256: 2jGxzfOd4HRwOMOZCHRwQIbYBtILXeFYMP4eOFhXnNI= size: 1319157760
11-25 11:45:44.423 839 839 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new lk sha256: ZQazTsS9tPE88Ro/NUjMixwz3FvN6vpEkCFYvL4hxy8= size: 1011712
11-25 11:45:44.431 839 839 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new preloader sha256: K4qmWI9F4I+xoOKgCxswPrryXuJ9EvrDJ1/cB+rpjCU= size: 245760
11-25 11:45:44.437 839 839 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new logo sha256: CJF41cTBIcrUmGpYhPXcUVZJsScSbL2Vyqu4b+62e1g= size: 1130496
11-25 11:45:44.441 839 839 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new md1img sha256: 7j/07qwGI+IeC5AAFVlec8Xcxl31h30Xi4ghGvPsKz0= size: 49893376
11-25 11:45:44.446 839 839 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new spmfw sha256: 39SWcIvL99BJODXZa9ezSeFiRVOcOn9aaWwAKXTO9wg= size: 65536
11-25 11:45:44.451 839 839 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new scp sha256: MlExa3WI2Qy7c2JYVnr01ssKYNLcXu6hrlKXQuQWN2c= size: 589824
11-25 11:45:44.455 839 839 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new sspm sha256: 7XgNblQoxAC4PuUBThxGdidpj43bEOWcUXY4+8lx0t8= size: 438272
11-25 11:45:44.458 839 839 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new dtbo sha256: utmiqgav12P+fshVY/qv/n0PUlb+IXAl0NEQnD4eDeo= size: 53248
11-25 11:45:44.462 839 839 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new tee sha256: h1l1hfA+zMrwZXVuc1SnhYza2Pmque4zQqtuZFfROe8= size: 1118208
11-25 11:45:44.465 839 839 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new vbmeta sha256: uXjrsDM39QIJWtKUoPJgDy2UUKtaq6yQ6lWwk9lh3ys= size: 4096
11-25 11:45:44.468 839 839 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new vbmeta_system sha256: 6F1qP6ugnOQQg0UD+y/8prD2wdjDNLcujb+a7Johi44= size: 4096
11-25 11:45:44.472 839 839 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new vbmeta_vendor sha256: /sd70SKGE0DBA371EN56iQu04+ShX/T44ldfbWNHhIk= size: 4096
11-25 11:45:44.475 839 839 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new wt_custom sha256: hCWhjiu+R3kCz+YhWg4XPExmJCwT+vczBEsMBtPaf9o= size: 52428800
11-25 11:45:44.478 839 839 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new hmd_custom_amx sha256: +RRonoHa66GIDgLkS3a19ayH7rotq++NMWGtuufUrLg= size: 109522944
11-25 11:45:44.481 839 839 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new vendor sha256: V5cQebp4DJVGxSOMwkK5c1jxpOVbaTt8ebgIMSRiyVU= size: 274477056
11-25 11:45:44.485 839 839 I update_engine: [INFO:delta_performer.cc(451)] PartitionInfo new product sha256: gRS187yzxWVwQ5HqTZBJJ2Z+0gIIOg2NNHP1LOymCHE= size: 1281126400
11-25 11:45:44.488 839 839 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/platform/bootdevice/by-name/boot_b partition without O_DSYNC
11-25 11:45:44.496 839 839 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
11-25 11:45:44.500 839 839 I update_engine: [INFO:delta_performer.cc(397)] Applying 16 operations to partition "boot"
11-25 11:45:44.504 839 839 I update_engine: [INFO:delta_performer.cc(657)] Starting to apply update payload operations
11-25 11:45:45.139 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.01002)
11-25 11:45:45.663 839 839 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/dm-12 partition without O_DSYNC
11-25 11:45:45.672 839 839 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
11-25 11:45:45.677 839 839 I update_engine: [INFO:delta_performer.cc(397)] Applying 630 operations to partition "system"
11-25 11:45:47.548 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.020027)
11-25 11:45:50.488 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.0300339)
11-25 11:45:53.786 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.0400409)
11-25 11:45:56.688 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.0500478)
11-25 11:45:59.392 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.0600547)
11-25 11:45:59.862 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.0700617)
11-25 11:46:00.321 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.0800686)
11-25 11:46:00.763 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.0900755)
11-25 11:46:02.621 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.100082)
11-25 11:46:05.236 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.110089)
11-25 11:46:05.551 839 839 I update_engine: [INFO:delta_performer.cc(209)] Completed 151/1501 operations (10%), 155156480/1408047432 bytes downloaded (11%), overall progress 10%
11-25 11:46:08.062 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.120096)
11-25 11:46:09.404 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.130103)
11-25 11:46:10.946 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.14011)
11-25 11:46:11.840 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.150117)
11-25 11:46:12.314 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.160124)
11-25 11:46:14.269 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.170131)
11-25 11:46:17.426 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.180138)
11-25 11:46:20.310 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.190145)
11-25 11:46:22.932 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.200152)
11-25 11:46:27.833 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.210159)
11-25 11:46:29.161 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.220166)
11-25 11:46:31.808 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.230173)
11-25 11:46:32.257 839 839 I update_engine: [INFO:delta_performer.cc(209)] Completed 271/1501 operations (18%), 326680576/1408047432 bytes downloaded (23%), overall progress 20%
11-25 11:46:34.429 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.24018)
11-25 11:46:37.095 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.250187)
11-25 11:46:39.852 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.260193)
11-25 11:46:42.909 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.2702)
11-25 11:46:45.035 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.280207)
11-25 11:46:46.581 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.290214)
11-25 11:46:49.263 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.300221)
11-25 11:46:51.950 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.310228)
11-25 11:46:55.046 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.320235)
11-25 11:46:58.101 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.330242)
11-25 11:46:58.989 839 839 I update_engine: [INFO:delta_performer.cc(209)] Completed 421/1501 operations (28%), 468877312/1408047432 bytes downloaded (33%), overall progress 30%
11-25 11:47:01.004 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.340249)
11-25 11:47:03.962 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.350256)
11-25 11:47:06.546 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.360263)
11-25 11:47:09.448 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.37027)
11-25 11:47:12.448 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.380277)
11-25 11:47:17.538 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.390284)
11-25 11:47:20.438 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.400291)
11-25 11:47:23.411 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.410297)
11-25 11:47:25.839 839 839 I update_engine: [INFO:delta_performer.cc(209)] Completed 580/1501 operations (38%), 591380480/1408047432 bytes downloaded (42%), overall progress 40%
11-25 11:47:25.864 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.420304)
11-25 11:47:30.218 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.430311)
11-25 11:47:32.109 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.440318)
11-25 11:47:32.923 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.450325)
11-25 11:47:33.973 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.460332)
11-25 11:47:34.564 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.470339)
11-25 11:47:34.892 839 839 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/platform/bootdevice/by-name/lk_b partition without O_DSYNC
11-25 11:47:34.901 839 839 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
11-25 11:47:34.906 839 839 I update_engine: [INFO:delta_performer.cc(397)] Applying 1 operations to partition "lk"
11-25 11:47:35.002 839 839 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/platform/bootdevice/by-name/preloader_b partition without O_DSYNC
11-25 11:47:35.009 839 839 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
11-25 11:47:35.012 839 839 I update_engine: [INFO:delta_performer.cc(397)] Applying 1 operations to partition "preloader"
11-25 11:47:35.044 839 839 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/platform/bootdevice/by-name/logo_b partition without O_DSYNC
11-25 11:47:35.052 839 839 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
11-25 11:47:35.055 839 839 I update_engine: [INFO:delta_performer.cc(397)] Applying 1 operations to partition "logo"
11-25 11:47:35.268 839 839 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/platform/bootdevice/by-name/md1img_b partition without O_DSYNC
11-25 11:47:35.276 839 839 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
11-25 11:47:35.279 839 839 I update_engine: [INFO:delta_performer.cc(397)] Applying 24 operations to partition "md1img"
11-25 11:47:36.980 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.480346)
11-25 11:47:37.989 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.490353)
11-25 11:47:38.356 839 839 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/platform/bootdevice/by-name/spmfw_b partition without O_DSYNC
11-25 11:47:38.365 839 839 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
11-25 11:47:38.368 839 839 I update_engine: [INFO:delta_performer.cc(397)] Applying 1 operations to partition "spmfw"
11-25 11:47:38.377 839 839 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/platform/bootdevice/by-name/scp_b partition without O_DSYNC
11-25 11:47:38.383 839 839 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
11-25 11:47:38.387 839 839 I update_engine: [INFO:delta_performer.cc(397)] Applying 1 operations to partition "scp"
11-25 11:47:38.433 839 839 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/platform/bootdevice/by-name/sspm_b partition without O_DSYNC
11-25 11:47:38.440 839 839 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
11-25 11:47:38.444 839 839 I update_engine: [INFO:delta_performer.cc(397)] Applying 1 operations to partition "sspm"
11-25 11:47:38.484 839 839 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/platform/bootdevice/by-name/dtbo_b partition without O_DSYNC
11-25 11:47:38.492 839 839 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
11-25 11:47:38.496 839 839 I update_engine: [INFO:delta_performer.cc(397)] Applying 1 operations to partition "dtbo"
11-25 11:47:38.507 839 839 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/platform/bootdevice/by-name/tee_b partition without O_DSYNC
11-25 11:47:38.513 839 839 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
11-25 11:47:38.517 839 839 I update_engine: [INFO:delta_performer.cc(397)] Applying 1 operations to partition "tee"
11-25 11:47:38.627 839 839 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/platform/bootdevice/by-name/vbmeta_b partition without O_DSYNC
11-25 11:47:38.635 839 839 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
11-25 11:47:38.638 839 839 I update_engine: [INFO:delta_performer.cc(397)] Applying 1 operations to partition "vbmeta"
11-25 11:47:38.645 839 839 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/platform/bootdevice/by-name/vbmeta_system_b partition without O_DSYNC
11-25 11:47:38.652 839 839 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
11-25 11:47:38.655 839 839 I update_engine: [INFO:delta_performer.cc(397)] Applying 1 operations to partition "vbmeta_system"
11-25 11:47:38.661 839 839 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/platform/bootdevice/by-name/vbmeta_vendor_b partition without O_DSYNC
11-25 11:47:38.668 839 839 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
11-25 11:47:38.671 839 839 I update_engine: [INFO:delta_performer.cc(397)] Applying 1 operations to partition "vbmeta_vendor"
11-25 11:47:38.678 839 839 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/platform/bootdevice/by-name/wt_custom_b partition without O_DSYNC
11-25 11:47:38.684 839 839 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
11-25 11:47:38.687 839 839 I update_engine: [INFO:delta_performer.cc(397)] Applying 25 operations to partition "wt_custom"
11-25 11:47:39.345 839 839 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/dm-15 partition without O_DSYNC
11-25 11:47:39.355 839 839 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
11-25 11:47:39.358 839 839 I update_engine: [INFO:delta_performer.cc(397)] Applying 53 operations to partition "hmd_custom_amx"
11-25 11:47:41.032 839 839 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/dm-18 partition without O_DSYNC
11-25 11:47:41.041 839 839 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
11-25 11:47:41.046 839 839 I update_engine: [INFO:delta_performer.cc(397)] Applying 131 operations to partition "vendor"
11-25 11:47:42.085 839 839 I update_engine: [INFO:delta_performer.cc(209)] Completed 766/1501 operations (51%), 704036864/1408047432 bytes downloaded (50%), overall progress 50%
11-25 11:47:42.110 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.50036)
11-25 11:47:45.718 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.510367)
11-25 11:47:48.463 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.520374)
11-25 11:47:51.779 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.530381)
11-25 11:47:54.958 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.540388)
11-25 11:47:58.030 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.550395)
11-25 11:48:00.254 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.560401)
11-25 11:48:02.377 839 839 I update_engine: [INFO:delta_performer.cc(385)] Opening /dev/block/dm-21 partition without O_DSYNC
11-25 11:48:02.386 839 839 I update_engine: [INFO:delta_performer.cc(128)] Caching writes.
11-25 11:48:02.389 839 839 I update_engine: [INFO:delta_performer.cc(397)] Applying 611 operations to partition "product"
11-25 11:48:02.395 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.570408)
11-25 11:48:04.390 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.580415)
11-25 11:48:06.712 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.590422)
11-25 11:48:09.391 839 839 I update_engine: [INFO:delta_performer.cc(209)] Completed 931/1501 operations (62%), 841482240/1408047432 bytes downloaded (59%), overall progress 60%
11-25 11:48:09.832 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.600429)
11-25 11:48:12.246 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.610436)
11-25 11:48:14.475 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.620443)
11-25 11:48:16.602 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.63045)
11-25 11:48:18.138 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.640457)
11-25 11:48:18.612 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.650464)
11-25 11:48:20.099 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.660471)
11-25 11:48:21.698 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.670478)
11-25 11:48:23.170 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.680485)
11-25 11:48:25.128 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.690492)
11-25 11:48:26.543 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.700499)
11-25 11:48:28.241 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.710506)
11-25 11:48:29.375 839 839 I update_engine: [INFO:delta_performer.cc(209)] Completed 1051/1501 operations (70%), 1007616000/1408047432 bytes downloaded (71%), overall progress 70%
11-25 11:48:30.291 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.720512)
11-25 11:48:32.988 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.730519)
11-25 11:48:34.373 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.740526)
11-25 11:48:35.415 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.750533)
11-25 11:48:38.458 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.76054)
11-25 11:48:41.235 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.770547)
11-25 11:48:42.977 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.780554)
11-25 11:48:45.307 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.790561)
11-25 11:48:47.214 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.800568)
11-25 11:48:52.002 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.810575)
11-25 11:48:54.677 839 839 I update_engine: [INFO:delta_performer.cc(209)] Completed 1199/1501 operations (79%), 1154613248/1408047432 bytes downloaded (82%), overall progress 80%
11-25 11:48:54.918 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.820582)
11-25 11:48:57.860 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.830589)
11-25 11:48:59.614 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.840596)
11-25 11:49:01.936 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.850603)
11-25 11:49:05.376 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.86061)
11-25 11:49:08.417 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.870616)
11-25 11:49:11.350 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.880623)
11-25 11:49:14.625 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.89063)
11-25 11:49:16.335 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.900637)
11-25 11:49:19.237 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.910644)
11-25 11:49:20.582 839 839 I update_engine: [INFO:delta_performer.cc(209)] Completed 1351/1501 operations (90%), 1288437760/1408047432 bytes downloaded (91%), overall progress 90%
11-25 11:49:21.897 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.920651)
11-25 11:49:24.824 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.930658)
11-25 11:49:27.603 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.940665)
11-25 11:49:34.020 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.950672)
11-25 11:49:37.344 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.960679)
11-25 11:49:40.287 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.970686)
11-25 11:49:43.173 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.980693)
11-25 11:49:45.747 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_DOWNLOADING (3), 0.9907)
11-25 11:49:46.226 839 839 I update_engine: [INFO:delta_performer.cc(209)] Completed 1501/1501 operations (100%), 1408047432/1408047432 bytes downloaded (100%), overall progress 100%
11-25 11:49:46.232 839 839 I update_engine: [INFO:delta_performer.cc(1665)] Extracted signature data of size 267 at 1407960856
11-25 11:49:46.235 839 839 I update_engine: [INFO:multi_range_http_fetcher.cc(115)] Terminating transfer.
11-25 11:49:46.238 839 839 I update_engine: [INFO:multi_range_http_fetcher.cc(177)] Received transfer terminated.
11-25 11:49:46.241 839 839 I update_engine: [INFO:multi_range_http_fetcher.cc(129)] TransferEnded w/ code 200
11-25 11:49:46.244 839 839 I update_engine: [INFO:multi_range_http_fetcher.cc(163)] Done w/ all transfers
11-25 11:49:46.390 839 839 I update_engine: [INFO:delta_performer.cc(1693)] Verifying using certificates: /system/etc/security/otacerts.zip
11-25 11:49:46.399 839 839 I update_engine: [INFO:payload_verifier.cc(102)] signature blob size = 267
11-25 11:49:46.404 839 839 I update_engine: [INFO:payload_verifier.cc(118)] Truncating the signature to its unpadded size: 256.
11-25 11:49:46.407 839 839 I update_engine: [INFO:payload_verifier.cc(129)] Verified correct signature 1 out of 1 signatures.
11-25 11:49:46.410 839 839 I update_engine: [INFO:delta_performer.cc(1915)] Payload hash matches value in payload.
11-25 11:49:46.413 839 839 I update_engine: [INFO:download_action.cc(400)] Collections of histograms for UpdateEngine.DownloadAction.
11-25 11:49:46.413 839 839 I update_engine: Histogram: UpdateEngine.DownloadAction.InstallOperation::REPLACE.Duration recorded 1501 samples, mean = 136.2
11-25 11:49:46.413 839 839 I update_engine: 0 -O (7 = 0.5%)
11-25 11:49:46.413 839 839 I update_engine: 10 --------------O (149 = 9.9%) {0.5%}
11-25 11:49:46.413 839 839 I update_engine: 18 ---O (34 = 2.3%) {10.4%}
11-25 11:49:46.413 839 839 I update_engine: 32 -----O (51 = 3.4%) {12.7%}
11-25 11:49:46.413 839 839 I update_engine: 57 ----------------------O (229 = 15.3%) {16.1%}
11-25 11:49:46.413 839 839 I update_engine: 101 ------------------------------------------------------------------------O (752 = 50.1%) {31.3%}
11-25 11:49:46.413 839 839 I update_engine: 179 -----------------------O (240 = 16.0%) {81.4%}
11-25 11:49:46.413 839 839 I update_engine: 317 --O (25 = 1.7%) {97.4%}
11-25 11:49:46.413 839 839 I update_engine: 561 -O (14 = 0.9%) {99.1%}
11-25 11:49:46.413 839 839 I update_engine: 993 ...
11-25 11:49:46.413 839 839 I update_engine:
11-25 11:49:46.417 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0)
11-25 11:49:46.424 839 839 I update_engine: [INFO:action_processor.cc(116)] ActionProcessor: finished DownloadAction with code ErrorCode::kSuccess
11-25 11:49:46.429 839 839 I update_engine: [INFO:action_processor.cc(143)] ActionProcessor: starting FilesystemVerifierAction
11-25 11:49:46.432 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 0 (boot) on device /dev/block/platform/bootdevice/by-name/boot_b
11-25 11:49:46.602 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of boot: uKMzlkL7zm6hLQTQfgnWH71BKA/aPAepZ/Q+tRUvrDw=
11-25 11:49:46.619 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 1 (system) on device /dev/block/dm-12
11-25 11:49:57.141 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of system: 2jGxzfOd4HRwOMOZCHRwQIbYBtILXeFYMP4eOFhXnNI=
11-25 11:49:57.235 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 2 (lk) on device /dev/block/platform/bootdevice/by-name/lk_b
11-25 11:49:57.248 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of lk: ZQazTsS9tPE88Ro/NUjMixwz3FvN6vpEkCFYvL4hxy8=
11-25 11:49:57.252 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 3 (preloader) on device /dev/block/platform/bootdevice/by-name/preloader_b
11-25 11:49:57.258 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of preloader: K4qmWI9F4I+xoOKgCxswPrryXuJ9EvrDJ1/cB+rpjCU=
11-25 11:49:57.261 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 4 (logo) on device /dev/block/platform/bootdevice/by-name/logo_b
11-25 11:49:57.275 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of logo: CJF41cTBIcrUmGpYhPXcUVZJsScSbL2Vyqu4b+62e1g=
11-25 11:49:57.281 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 5 (md1img) on device /dev/block/platform/bootdevice/by-name/md1img_b
11-25 11:49:57.529 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of md1img: 7j/07qwGI+IeC5AAFVlec8Xcxl31h30Xi4ghGvPsKz0=
11-25 11:49:57.549 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 6 (spmfw) on device /dev/block/platform/bootdevice/by-name/spmfw_b
11-25 11:49:57.556 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of spmfw: 39SWcIvL99BJODXZa9ezSeFiRVOcOn9aaWwAKXTO9wg=
11-25 11:49:57.560 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 7 (scp) on device /dev/block/platform/bootdevice/by-name/scp_b
11-25 11:49:57.570 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of scp: MlExa3WI2Qy7c2JYVnr01ssKYNLcXu6hrlKXQuQWN2c=
11-25 11:49:57.575 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 8 (sspm) on device /dev/block/platform/bootdevice/by-name/sspm_b
11-25 11:49:57.585 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of sspm: 7XgNblQoxAC4PuUBThxGdidpj43bEOWcUXY4+8lx0t8=
11-25 11:49:57.589 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 9 (dtbo) on device /dev/block/platform/bootdevice/by-name/dtbo_b
11-25 11:49:57.595 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of dtbo: utmiqgav12P+fshVY/qv/n0PUlb+IXAl0NEQnD4eDeo=
11-25 11:49:57.598 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 10 (tee) on device /dev/block/platform/bootdevice/by-name/tee_b
11-25 11:49:57.613 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of tee: h1l1hfA+zMrwZXVuc1SnhYza2Pmque4zQqtuZFfROe8=
11-25 11:49:57.618 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 11 (vbmeta) on device /dev/block/platform/bootdevice/by-name/vbmeta_b
11-25 11:49:57.623 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of vbmeta: uXjrsDM39QIJWtKUoPJgDy2UUKtaq6yQ6lWwk9lh3ys=
11-25 11:49:57.627 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 12 (vbmeta_system) on device /dev/block/platform/bootdevice/by-name/vbmeta_system_b
11-25 11:49:57.632 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of vbmeta_system: 6F1qP6ugnOQQg0UD+y/8prD2wdjDNLcujb+a7Johi44=
11-25 11:49:57.636 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 13 (vbmeta_vendor) on device /dev/block/platform/bootdevice/by-name/vbmeta_vendor_b
11-25 11:49:57.641 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of vbmeta_vendor: /sd70SKGE0DBA371EN56iQu04+ShX/T44ldfbWNHhIk=
11-25 11:49:57.646 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 14 (wt_custom) on device /dev/block/platform/bootdevice/by-name/wt_custom_b
11-25 11:49:57.898 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of wt_custom: hCWhjiu+R3kCz+YhWg4XPExmJCwT+vczBEsMBtPaf9o=
11-25 11:49:57.917 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 15 (hmd_custom_amx) on device /dev/block/dm-15
11-25 11:49:58.803 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of hmd_custom_amx: +RRonoHa66GIDgLkS3a19ayH7rotq++NMWGtuufUrLg=
11-25 11:49:58.838 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 16 (vendor) on device /dev/block/dm-18
11-25 11:50:00.939 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of vendor: V5cQebp4DJVGxSOMwkK5c1jxpOVbaTt8ebgIMSRiyVU=
11-25 11:50:00.990 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(117)] Hashing partition 17 (product) on device /dev/block/dm-21
11-25 11:50:10.562 839 839 I update_engine: [INFO:filesystem_verifier_action.cc(237)] Hash of product: gRS187yzxWVwQ5HqTZBJJ2Z+0gIIOg2NNHP1LOymCHE=
11-25 11:50:10.655 839 839 I update_engine: [INFO:action_processor.cc(116)] ActionProcessor: finished FilesystemVerifierAction with code ErrorCode::kSuccess
11-25 11:50:10.660 839 839 I update_engine: [INFO:action_processor.cc(143)] ActionProcessor: starting PostinstallRunnerAction
11-25 11:50:10.663 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0)
11-25 11:50:10.668 839 839 I update_engine: [INFO:postinstall_runner_action.cc(174)] Performing postinst (system/bin/otapreopt_script at /postinstall/system/bin/otapreopt_script) installed on device /dev/block/dm-12 and mountable device /dev/block/dm-12
11-25 11:50:10.677 839 839 I update_engine: [INFO:postinstall_runner_action.cc(181)] Format file for new system/bin/otapreopt_script is: data
11-25 11:50:15.970 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.01)
11-25 11:50:25.535 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.02)
11-25 11:50:35.553 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.03)
11-25 11:50:40.605 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.04)
11-25 11:50:50.133 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.05)
11-25 11:51:05.155 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.07)
11-25 11:51:20.074 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.08)
11-25 11:51:29.841 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.1)
11-25 11:51:44.371 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.12)
11-25 11:51:54.092 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.13)
11-25 11:52:04.115 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.14)
11-25 11:52:14.165 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.15)
11-25 11:52:19.316 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.16)
11-25 11:52:28.910 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.17)
11-25 11:52:43.667 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.19)
11-25 11:52:53.603 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.2)
11-25 11:53:08.187 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.22)
11-25 11:53:18.044 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.23)
11-25 11:53:32.751 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.25)
11-25 11:53:42.534 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.26)
11-25 11:53:47.307 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.27)
11-25 11:53:56.975 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.28)
11-25 11:54:11.706 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.3)
11-25 11:54:21.499 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.31)
11-25 11:54:26.414 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.32)
11-25 11:54:36.288 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.33)
11-25 11:54:45.996 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.34)
11-25 11:55:00.501 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.36)
11-25 11:55:10.144 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.37)
11-25 11:55:14.955 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.38)
11-25 11:55:24.646 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.39)
11-25 11:55:34.312 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.4)
11-25 11:55:48.533 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.42)
11-25 11:55:58.152 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.43)
11-25 11:56:02.974 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.44)
11-25 11:56:12.603 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.45)
11-25 11:56:22.008 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.46)
11-25 11:56:36.712 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.48)
11-25 11:56:46.414 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.49)
11-25 11:56:51.453 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.5)
11-25 11:57:01.182 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.51)
11-25 11:57:05.927 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.52)
11-25 11:57:15.612 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.53)
11-25 11:57:25.565 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.54)
11-25 11:57:30.483 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.55)
11-25 11:57:40.457 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.56)
11-25 11:57:55.343 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.58)
11-25 11:58:05.212 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.59)
11-25 11:58:15.203 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.6)
11-25 11:58:19.971 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.61)
11-25 11:58:29.931 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.62)
11-25 11:58:39.861 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.63)
11-25 11:58:44.681 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.64)
11-25 11:58:54.255 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.65)
11-25 11:59:04.240 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.66)
11-25 11:59:08.937 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.67)
11-25 11:59:18.863 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.68)
11-25 11:59:33.530 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.7)
11-25 11:59:43.406 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.71)
11-25 11:59:48.341 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.72)
11-25 11:59:57.975 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.73)
11-25 12:00:07.663 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.74)
11-25 12:00:12.473 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.75)
11-25 12:00:22.321 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.76)
11-25 12:00:32.203 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.77)
11-25 12:00:37.164 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.78)
11-25 12:00:47.006 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.79)
11-25 12:00:56.822 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.8)
11-25 12:01:01.670 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.81)
11-25 12:01:16.275 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.82)
11-25 12:01:21.234 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.83)
11-25 12:01:26.257 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.84)
11-25 12:01:35.946 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.85)
11-25 12:01:45.759 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.86)
11-25 12:01:50.440 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.87)
11-25 12:02:00.075 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.88)
11-25 12:02:09.601 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.89)
11-25 12:02:14.458 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.9)
11-25 12:02:23.956 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.91)
11-25 12:02:28.914 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.92)
11-25 12:02:38.767 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.93)
11-25 12:02:53.395 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.95)
11-25 12:03:03.225 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.96)
11-25 12:03:13.131 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.97)
11-25 12:03:18.003 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.98)
11-25 12:03:27.383 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 0.99)
11-25 12:03:36.839 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 1)
11-25 12:03:36.902 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 1)
11-25 12:03:36.940 839 839 I update_engine: [INFO:subprocess.cc(157)] Subprocess output:
11-25 12:03:36.940 839 839 I update_engine: Complete or error.
11-25 12:03:36.959 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_FINALIZING (5), 1)
11-25 12:03:36.961 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(863)] Snapshot writes are done.
11-25 12:03:36.967 839 839 I update_engine: Wipe is not scheduled. Deleting forward merge indicator.
11-25 12:03:36.992 839 839 I update_engine: [INFO:postinstall_runner_action.cc(371)] All post-install commands succeeded
11-25 12:03:36.998 839 839 I update_engine: [INFO:action_processor.cc(116)] ActionProcessor: finished last action PostinstallRunnerAction with code ErrorCode::kSuccess
11-25 12:03:37.001 839 839 I update_engine: [INFO:update_attempter_android.cc(522)] Processing Done.
11-25 12:03:37.006 839 839 I update_engine: [INFO:update_attempter_android.cc(535)] Update successfully applied, waiting to reboot.
11-25 12:03:37.010 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(263)] Destroying [hmd_custom_amx_b, product_b, system_b, vendor_b] from device mapper
11-25 12:03:37.050 839 839 I update_engine: [libfs_mgr]Unmapped logical partition hmd_custom_amx_b
11-25 12:03:37.140 839 839 I update_engine: Successfully unmapped snapshot hmd_custom_amx_b
11-25 12:03:37.145 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(249)] Successfully unmapped hmd_custom_amx_b from device mapper.
11-25 12:03:37.180 839 839 I update_engine: [libfs_mgr]Unmapped logical partition product_b
11-25 12:03:37.330 839 839 I update_engine: Successfully unmapped snapshot product_b
11-25 12:03:37.347 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(249)] Successfully unmapped product_b from device mapper.
11-25 12:03:37.410 839 839 I update_engine: [libfs_mgr]Unmapped logical partition system_b
11-25 12:03:37.520 839 839 I update_engine: Successfully unmapped snapshot system_b
11-25 12:03:37.525 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(249)] Successfully unmapped system_b from device mapper.
11-25 12:03:37.604 839 839 I update_engine: [libfs_mgr]Unmapped logical partition vendor_b
11-25 12:03:37.700 839 839 I update_engine: Successfully unmapped snapshot vendor_b
11-25 12:03:37.710 839 839 I update_engine: [INFO:dynamic_partition_control_android.cc(249)] Successfully unmapped vendor_b from device mapper.
11-25 12:03:37.715 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(92)] onStatusUpdate(UPDATE_STATUS_UPDATED_NEED_REBOOT (6), 0)
11-25 12:03:37.717 7013 7013 I update_engine_client: [INFO:update_engine_client_android.cc(100)] onPayloadApplicationComplete(ErrorCode::kSuccess (0))
11-25 12:03:37.722 839 839 I update_engine: [INFO:metrics_reporter_android.cc(131)] Current update attempt downloads 1342 bytes data
11-25 12:03:37.732 839 839 I update_engine: [INFO:metrics_utils.cc(380)] Updated Marker = 1/1/1970 0:29:10 GMTAndroid虚拟AB升级流程简述及升级完整log相关推荐
- Android View的绘制流程简述 Android自定义View(一)
1 Android的UI管理系统层级关系 如上图所示,这就是Android的UI管理系统的层级关系. 1.1 当一个应用启动的时候,会启动一个主Activity,然后Activity会创建出一个窗口系 ...
- android电视怎么升级失败,智能电视升级失败，原因都在这里！
很多朋友在给智能电视升级的时候,经常会遇到升级失败的难题. 那么升级失败后,常见的两种情况就是要么系统黑屏,要么是电视无法启动,这时我们应该怎样解决这样的问题? 比较简单的一个做法就是断电重启,重启后 ...
- 电视机android正在升级卡住,智能电视升级失败，原因都在这里！
很多朋友在给智能电视升级的时候,经常会遇到升级失败的难题. 那么升级失败后,常见的两种情况就是要么系统黑屏,要么是电视无法启动,这时我们应该怎样解决这样的问题? 比较简单的一个做法就是断电重启,重启后 ...
- Android 8.0 (35)----Android8.0.0-r4的OTA升级流程
Android8.0.0-r4的OTA升级流程 原网址:https://blog.csdn.net/dingfengnupt88/article/details/52875228 Android系统 ...
- Android FOTA 升级流程
Android设备的系统升级有两种方式:(1)下载更新包到手机后,手动安装,即所谓"卡刷包"的形式更新:(2) 通过 Over-the-air(OTA)的方式更新系统,简称为FOT ...
- android ota升级服务,android 标准OTA升级流程
标准的OTA升级流程包括一下几个步骤: 1.Android设备首先会与OTA服务器进行交互,如果有更新会推送给客户.推送的信息常常会包含OTA更新包的下载地址和一些版本信息. 2.Update程序会将 ...
- Android系统OTA升级流程
转自: https://www.2cto.com/kf/201610/558070.html Android系统进行升级的时候,有两种途径,一种是通过接口传递升级包路径自动升级,升级完之后系统自动重启 ...
- 【android系统】android系统升级流程分析（一）---recovery模式中进行update包升级流程分析
今天我们直接来看下android中具体的升级过程是如何的. 升级流程概述 升级的流程图: 升级流程分析 第一步:升级包获取 升级获取可以通过远程下载,也可直接拷贝到指定目录即可. 第二步:准备升级 然 ...
- android ota运动手环升级流程
(一)说明 一般市面上智能运动手环采用nRF51822 ble蓝牙芯片,该芯片是nordic出的一个低功耗的(BLE)芯片 手机需要支持蓝牙4.0及以上版本 蓝牙设备固有软件版本服务的UUID 服务的 ...
- QCC30DFU流程android说明,qcc512x qcc302x qcc303x earbud 软件GAIA OTA DFU 空中升级实现方法以及升级步骤...
QCC512x QCC302x QCC303x earbud 软件GAIA OTA DFU 空中升级实现方法以及升级步骤 概述 OTA只能升级部分,不是所有的都可以OTA.如PSKEY区,蓝牙地址,蓝 ...
最新文章
- 【视频】显示器固定参数struct fb_fix_screeninfo中char id[16]说明
- GO语言初识(为go开发android做准备)
- 由一个异常开始思考springmvc参数解析
- pair的常见用法详解
- CVPR 2020 | 序列化的三维形状生成网络PQ-NET
- vue data为什么是函数_由 Vue 中三个常见问题引发的深度思考
- python连接传感器_树莓派4B之光敏传感器模块（python3）
- SQLmap下载和安装教程（详细附图）
- 微信小程序位置定位php,【微信开发】微信小程序通过经纬度计算两地距离php代码实现...
- python爬虫之 网页正文提取方法
- html match函数,match函数 Match函数概述
- 使用PPT保存300dpi或者指定dpi的高质量图片
- while(i--)
- NB-IOT相关的术语 SGW、PGW、LTE、RRC、E-UTRAN、EPC
- BeanUtils.populate的用法
- 内存颗粒性能测试软件,内存性能测试及编辑总结
- dlclose隐藏的秘密！
- 用python做一个简单的猜拳游戏
- nginx配置文件总结
- PAT 1108 Finding Average