Created
October 22, 2020 16:28
-
-
Save nooriro/4854bddedfb1370a9a8e079dd24ac72d to your computer and use it in GitHub Desktop.
sunfish update log (FAILED LOG) / from QD4A.200805.003 to RP1A.201005.006 (using FULL OTA IMAGE) / Update URL (Full OTA Image): https://ota.googlezip.net/packages/ota-api/google_sunfish_sunfish/4e536e3e15bfab486e26dbed8170f2e0ad164456.zip
This file contains bidirectional Unicode text that may be interpreted or compiled differently than what appears below. To review, open the file in an editor that reveals hidden Unicode characters.
Learn more about bidirectional Unicode characters
| --------- beginning of system | |
| --------- beginning of main | |
| 10-23 00:35:02.411 1030 1030 I update_engine: [1023/003502.411599:INFO:multi_range_http_fetcher.cc(45)] starting first transfer | |
| 10-23 00:35:02.411 1030 1030 I update_engine: [1023/003502.411721:INFO:multi_range_http_fetcher.cc(74)] starting transfer of range 1260+105160 | |
| 10-23 00:35:02.411 1030 1030 I update_engine: [1023/003502.411834:INFO:libcurl_http_fetcher.cc(146)] Starting/Resuming transfer | |
| 10-23 00:35:02.418 1030 1030 I update_engine: [1023/003502.418058:INFO:libcurl_http_fetcher.cc(165)] Using proxy: no | |
| 10-23 00:35:02.418 1030 1030 I update_engine: [1023/003502.418305:INFO:libcurl_http_fetcher.cc(305)] Setting up curl options for HTTPS | |
| 10-23 00:35:03.572 1030 1030 I update_engine: [1023/003503.572456:INFO:certificate_checker.cc(185)] Certificate changed from 1237CBF5641AA75FE4D916B010F32BAF4E7BEA02EF175ADFD97BD10477E261AD to 7EF07575B8E8077EA41DF2C3C424C8D2F63AF534BEA01C46BA791F84B005BBE0. | |
| 10-23 00:35:04.494 1030 1030 I update_engine: [1023/003504.494277:INFO:certificate_checker.cc(185)] Certificate changed from 7EF07575B8E8077EA41DF2C3C424C8D2F63AF534BEA01C46BA791F84B005BBE0 to 1237CBF5641AA75FE4D916B010F32BAF4E7BEA02EF175ADFD97BD10477E261AD. | |
| 10-23 00:35:05.469 1030 1030 I update_engine: [1023/003505.469262:INFO:delta_performer.cc(208)] Completed 0/? operations, 16384/1576938951 bytes downloaded (0%), overall progress 0% | |
| 10-23 00:35:05.698 1030 1030 I update_engine: [1023/003505.698458:INFO:delta_performer.cc(519)] Manifest size in payload matches expected value from Omaha | |
| 10-23 00:35:05.701 1030 1030 I update_engine: [1023/003505.701326:INFO:delta_performer.cc(1612)] Verifying using public key: /etc/update_engine/update-payload-key.pub.pem | |
| 10-23 00:35:05.702 1030 1030 I update_engine: [1023/003505.702279:INFO:payload_verifier.cc(58)] signature blob size = 523 | |
| 10-23 00:35:05.703 1030 1030 I update_engine: [1023/003505.703252:INFO:payload_verifier.cc(78)] Verified correct signature 1 out of 1 signatures. | |
| 10-23 00:35:05.703 1030 1030 I update_engine: [1023/003505.703332:INFO:payload_metadata.cc(237)] Metadata hash signature matches value in Omaha response. | |
| 10-23 00:35:05.709 1030 1030 I update_engine: [1023/003505.709439:INFO:delta_performer.cc(1643)] Detected a 'full' payload. | |
| 10-23 00:35:05.733 1030 1030 I update_engine: [1023/003505.733528:INFO:delta_performer.cc(979)] InitPartitionMetadata done. | |
| 10-23 00:35:05.741 1030 1030 I update_engine: [1023/003505.741202:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:05.955 1030 1030 I update_engine: [1023/003505.955294:INFO:dynamic_partition_control_android.cc(140)] Successfully unmapped vendor_b from device mapper. | |
| 10-23 00:35:06.013 1030 1030 I update_engine: [1023/003506.013016:INFO:dynamic_partition_control_android.cc(77)] Succesfully mapped vendor_b to device mapper (force_writable = 1); device path at /dev/block/dm-3 | |
| 10-23 00:35:06.015 1030 1030 I update_engine: [1023/003506.015368:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.015 1030 1030 I update_engine: [1023/003506.015866:INFO:boot_control_android.cc(140)] boot_b is not in super partition metadata. | |
| 10-23 00:35:06.017 1030 1030 I update_engine: [1023/003506.017264:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.019 1030 1030 I update_engine: [1023/003506.018964:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.232 1030 1030 I update_engine: [1023/003506.231997:INFO:dynamic_partition_control_android.cc(140)] Successfully unmapped system_b from device mapper. | |
| 10-23 00:35:06.286 1030 1030 I update_engine: [1023/003506.286298:INFO:dynamic_partition_control_android.cc(77)] Succesfully mapped system_b to device mapper (force_writable = 1); device path at /dev/block/dm-1 | |
| 10-23 00:35:06.288 1030 1030 I update_engine: [1023/003506.288556:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.289 1030 1030 I update_engine: [1023/003506.289077:INFO:boot_control_android.cc(140)] vbmeta_b is not in super partition metadata. | |
| 10-23 00:35:06.289 1030 1030 I update_engine: [1023/003506.289580:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.291 1030 1030 I update_engine: [1023/003506.291345:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.291 1030 1030 I update_engine: [1023/003506.291866:INFO:boot_control_android.cc(140)] dtbo_b is not in super partition metadata. | |
| 10-23 00:35:06.292 1030 1030 I update_engine: [1023/003506.292434:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.294 1030 1030 I update_engine: [1023/003506.294298:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.552 1030 1030 I update_engine: [1023/003506.552718:INFO:dynamic_partition_control_android.cc(140)] Successfully unmapped product_b from device mapper. | |
| 10-23 00:35:06.607 1030 1030 I update_engine: [1023/003506.607371:INFO:dynamic_partition_control_android.cc(77)] Succesfully mapped product_b to device mapper (force_writable = 1); device path at /dev/block/dm-5 | |
| 10-23 00:35:06.609 1030 1030 I update_engine: [1023/003506.609553:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.610 1030 1030 I update_engine: [1023/003506.610747:INFO:boot_control_android.cc(140)] system_ext_b is not in super partition metadata. | |
| 10-23 00:35:06.611 1030 1030 I update_engine: [1023/003506.611330:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.611 1030 1030 E update_engine: [1023/003506.611432:ERROR:boot_control_android.cc(215)] Device file /dev/block/bootdevice/by-name/system_ext_b does not exist. | |
| 10-23 00:35:06.612 1030 1030 I update_engine: [1023/003506.612814:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.613 1030 1030 I update_engine: [1023/003506.613117:INFO:boot_control_android.cc(140)] vbmeta_system_b is not in super partition metadata. | |
| 10-23 00:35:06.613 1030 1030 I update_engine: [1023/003506.613590:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.615 1030 1030 I update_engine: [1023/003506.614972:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.615 1030 1030 I update_engine: [1023/003506.615397:INFO:boot_control_android.cc(140)] abl_b is not in super partition metadata. | |
| 10-23 00:35:06.615 1030 1030 I update_engine: [1023/003506.615847:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.617 1030 1030 I update_engine: [1023/003506.617231:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.617 1030 1030 I update_engine: [1023/003506.617586:INFO:boot_control_android.cc(140)] aop_b is not in super partition metadata. | |
| 10-23 00:35:06.618 1030 1030 I update_engine: [1023/003506.618043:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.619 1030 1030 I update_engine: [1023/003506.619446:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.619 1030 1030 I update_engine: [1023/003506.619778:INFO:boot_control_android.cc(140)] devcfg_b is not in super partition metadata. | |
| 10-23 00:35:06.620 1030 1030 I update_engine: [1023/003506.620174:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.621 1030 1030 I update_engine: [1023/003506.621399:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.621 1030 1030 I update_engine: [1023/003506.621679:INFO:boot_control_android.cc(140)] hyp_b is not in super partition metadata. | |
| 10-23 00:35:06.622 1030 1030 I update_engine: [1023/003506.622029:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.623 1030 1030 I update_engine: [1023/003506.623033:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.623 1030 1030 I update_engine: [1023/003506.623226:INFO:boot_control_android.cc(140)] keymaster_b is not in super partition metadata. | |
| 10-23 00:35:06.623 1030 1030 I update_engine: [1023/003506.623562:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.624 1030 1030 I update_engine: [1023/003506.624564:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.624 1030 1030 I update_engine: [1023/003506.624800:INFO:boot_control_android.cc(140)] qupfw_b is not in super partition metadata. | |
| 10-23 00:35:06.625 1030 1030 I update_engine: [1023/003506.625252:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.626 1030 1030 I update_engine: [1023/003506.626534:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.626 1030 1030 I update_engine: [1023/003506.626830:INFO:boot_control_android.cc(140)] tz_b is not in super partition metadata. | |
| 10-23 00:35:06.627 1030 1030 I update_engine: [1023/003506.627219:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.628 1030 1030 I update_engine: [1023/003506.628399:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.628 1030 1030 I update_engine: [1023/003506.628620:INFO:boot_control_android.cc(140)] uefisecapp_b is not in super partition metadata. | |
| 10-23 00:35:06.628 1030 1030 I update_engine: [1023/003506.628962:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.630 1030 1030 I update_engine: [1023/003506.630023:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.630 1030 1030 I update_engine: [1023/003506.630225:INFO:boot_control_android.cc(140)] xbl_b is not in super partition metadata. | |
| 10-23 00:35:06.630 1030 1030 I update_engine: [1023/003506.630572:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.631 1030 1030 I update_engine: [1023/003506.631945:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.632 1030 1030 I update_engine: [1023/003506.632243:INFO:boot_control_android.cc(140)] xbl_config_b is not in super partition metadata. | |
| 10-23 00:35:06.632 1030 1030 I update_engine: [1023/003506.632678:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.633 1030 1030 I update_engine: [1023/003506.633787:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.634 1030 1030 I update_engine: [1023/003506.633996:INFO:boot_control_android.cc(140)] modem_b is not in super partition metadata. | |
| 10-23 00:35:06.634 1030 1030 I update_engine: [1023/003506.634420:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 00:35:06.634 1030 1030 E update_engine: [1023/003506.634498:ERROR:delta_performer.cc(933)] Unable to determine all the partition devices. | |
| 10-23 00:35:06.634 1030 1030 E update_engine: [1023/003506.634536:ERROR:download_action.cc(336)] Error ErrorCode::kInstallDeviceOpenError (7) in DeltaPerformer's Write method when processing the received payload -- Terminating processing | |
| 10-23 00:35:06.634 1030 1030 I update_engine: [1023/003506.634588:INFO:libcurl_http_fetcher.cc(548)] Requesting libcurl to terminate transfer. | |
| 10-23 00:35:06.641 1030 1030 I update_engine: [1023/003506.641562:INFO:multi_range_http_fetcher.cc(177)] Received transfer terminated. | |
| 10-23 00:35:06.641 1030 1030 I update_engine: [1023/003506.641762:INFO:multi_range_http_fetcher.cc(129)] TransferEnded w/ code 206 | |
| 10-23 00:35:06.641 1030 1030 I update_engine: [1023/003506.641798:INFO:multi_range_http_fetcher.cc(131)] Terminating. | |
| 10-23 00:35:06.650 1030 1030 I update_engine: [1023/003506.650248:INFO:action_processor.cc(116)] ActionProcessor: finished DownloadAction with code ErrorCode::kInstallDeviceOpenError | |
| 10-23 00:35:06.650 1030 1030 I update_engine: [1023/003506.650539:INFO:action_processor.cc(121)] ActionProcessor: Aborting processing due to failure. | |
| 10-23 00:35:06.650 1030 1030 I update_engine: [1023/003506.650589:INFO:update_attempter_android.cc(454)] Processing Done. | |
| 10-23 00:35:06.650 1030 1030 I update_engine: [1023/003506.650633:INFO:dynamic_partition_control_android.cc(151)] Destroying [product_b, system_b, vendor_b] from device mapper | |
| 10-23 00:35:06.866 1030 1030 I update_engine: [1023/003506.866245:INFO:dynamic_partition_control_android.cc(140)] Successfully unmapped product_b from device mapper. | |
| 10-23 00:35:07.294 1030 1030 I update_engine: [1023/003507.294241:INFO:dynamic_partition_control_android.cc(140)] Successfully unmapped system_b from device mapper. | |
| 10-23 00:35:07.726 1030 1030 I update_engine: [1023/003507.726345:INFO:dynamic_partition_control_android.cc(140)] Successfully unmapped vendor_b from device mapper. | |
| 10-23 00:35:07.733 1030 1030 I update_engine: [1023/003507.733044:INFO:metrics_reporter_android.cc(29)] uploading 3 to histogram for metric ota_update_engine_attempt_number | |
| 10-23 00:35:07.733 1030 1030 I update_engine: [1023/003507.733357:INFO:metrics_reporter_android.cc(29)] uploading 0 to histogram for metric ota_update_engine_attempt_payload_type | |
| 10-23 00:35:07.733 1030 1030 I update_engine: [1023/003507.733475:INFO:metrics_reporter_android.cc(29)] uploading 0 to histogram for metric ota_update_engine_attempt_fixed_duration_boottime_in_minutes | |
| 10-23 00:35:07.733 1030 1030 I update_engine: [1023/003507.733625:INFO:metrics_reporter_android.cc(29)] uploading 0 to histogram for metric ota_update_engine_attempt_duration_monotonic_in_minutes | |
| 10-23 00:35:07.733 1030 1030 I update_engine: [1023/003507.733763:INFO:metrics_reporter_android.cc(29)] uploading 1503 to histogram for metric ota_update_engine_attempt_payload_size_mib | |
| 10-23 00:35:07.733 1030 1030 I update_engine: [1023/003507.733901:INFO:metrics_reporter_android.cc(29)] uploading 5 to histogram for metric ota_update_engine_attempt_result | |
| 10-23 00:35:07.734 1030 1030 I update_engine: [1023/003507.734082:INFO:metrics_reporter_android.cc(29)] uploading 7 to histogram for metric ota_update_engine_attempt_error_code | |
| 10-23 00:35:07.734 1030 1030 I update_engine: [1023/003507.734428:INFO:metrics_reporter_android.cc(29)] uploading 1505 to histogram for metric ota_update_engine_attempt_fixed_current_bytes_downloaded_mib | |
| 10-23 00:35:07.735 3074 4585 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.000). | |
| 10-23 00:35:07.834 3074 4585 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x000. | |
| 10-23 00:35:07.875 3074 4765 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x000. | |
| 10-23 00:35:07.937 3074 15596 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x412, -1.000). | |
| 10-23 00:35:08.139 3074 15596 I SystemUpdate: [Execution,SynchronizedUpdateEngine] stop() | |
| 10-23 00:35:08.139 3074 15596 I SystemUpdate: [Execution,ExecutionManager] Action streaming-apply executed for 6.52 seconds. | |
| 10-23 00:35:08.152 3074 15596 I SystemUpdate: [Execution,ExecutionManager] Action exponential-backoff-delay-execution executed for 0.01 seconds. | |
| 10-23 00:51:34.684 3074 16420 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110. | |
| 10-23 00:51:34.695 3074 16421 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 }. | |
| 10-23 00:51:34.709 3074 16421 I SystemUpdate: [Execution,ExecutionManager] Action exponential-backoff-delay-execution executed for 0.01 seconds. | |
| 10-23 00:51:34.725 9899 9899 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x412, isSetupWizard=false. | |
| 10-23 00:52:07.753 3074 16449 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110. | |
| 10-23 00:52:07.760 3074 16450 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 }. | |
| 10-23 00:52:07.777 3074 16450 I SystemUpdate: [Execution,ExecutionManager] Action exponential-backoff-delay-execution executed for 0.02 seconds. | |
| 10-23 01:01:25.827 3074 16891 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110. | |
| 10-23 01:01:25.834 3074 16892 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 }. | |
| 10-23 01:01:25.853 3074 16892 I SystemUpdate: [Execution,ExecutionManager] Action exponential-backoff-delay-execution executed for 0.01 seconds. | |
| 10-23 01:01:25.867 9899 9899 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x412, isSetupWizard=false. | |
| 10-23 01:01:25.876 3074 16892 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110. | |
| 10-23 01:01:25.882 3074 16891 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 }. | |
| 10-23 01:01:25.898 3074 16891 I SystemUpdate: [Execution,ExecutionManager] Action exponential-backoff-delay-execution executed for 0.01 seconds. | |
| 10-23 01:01:26.044 3074 16891 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110. | |
| 10-23 01:01:26.057 3074 16892 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 }. | |
| 10-23 01:01:26.095 3074 16892 I SystemUpdate: [Execution,ExecutionManager] Action exponential-backoff-delay-execution executed for 0.01 seconds. | |
| 10-23 01:01:26.166 9899 9899 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x412, isSetupWizard=false. | |
| 10-23 01:01:58.654 9899 9899 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x000, isSetupWizard=false. | |
| 10-23 01:01:58.686 3074 16921 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 102. | |
| 10-23 01:01:58.689 3074 16921 I SystemUpdate: [Execution,ExecutionManager] Finishing the current execution. | |
| 10-23 01:01:58.700 3074 16921 I SystemUpdate: [Execution,SynchronizedUpdateEngine] reset() | |
| 10-23 01:01:58.713 3074 16924 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 }. | |
| 10-23 01:01:58.715 3074 5477 I SystemUpdate: [Control,ChimeraGcmTaskService] Scheduling task: AutomaticUpdateFlagChanged. | |
| 10-23 01:01:58.740 3074 16924 I SystemUpdate: [Execution,ExecutionManager] Action pending executed for 0.02 seconds. | |
| 10-23 01:01:58.764 3074 16924 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x017, -1.000). | |
| 10-23 01:01:58.794 9899 9899 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x017, isSetupWizard=false. | |
| 10-23 01:02:01.685 3074 16924 I SystemUpdate: [Execution,PackageFiles] Aggressive allocating space for file /data/ota_package/payload_header.bin with size 24. | |
| 10-23 01:02:03.891 3074 16924 I SystemUpdate: [Execution,PackageFiles] Aggressive allocating space for file /data/ota_package/payload_metadata.bin with size 105160. | |
| 10-23 01:02:04.010 3074 16924 I SystemUpdate: [Execution,UpdateEngineDelegate] verifyPayloadMetadata() | |
| 10-23 01:02:04.011 1030 1030 I update_engine: [1023/010204.011357:INFO:binder_service_android.cc(145)] Received a request of verifying payload metadata in /data/ota_package/payload_metadata.bin. | |
| 10-23 01:02:04.012 1030 1030 I update_engine: [1023/010204.012910:INFO:payload_verifier.cc(58)] signature blob size = 523 | |
| 10-23 01:02:04.015 1030 1030 I update_engine: [1023/010204.014958:INFO:payload_verifier.cc(78)] Verified correct signature 1 out of 1 signatures. | |
| 10-23 01:02:04.015 1030 1030 I update_engine: [1023/010204.015095:INFO:payload_metadata.cc(237)] Metadata hash signature matches value in Omaha response. | |
| 10-23 01:02:05.956 3074 16924 I SystemUpdate: [Execution,PackageFiles] Aggressive allocating space for file /data/ota_package/metadata with size 554. | |
| 10-23 01:02:06.018 3074 16924 I SystemUpdate: [Execution,ExecutionManager] Action pre-download-validate executed for 7.27 seconds. | |
| 10-23 01:02:06.067 3074 16924 I SystemUpdate: [Network,NetworkRequester] Requesting network with capabilities [11, 12]... | |
| 10-23 01:02:06.071 3074 4236 I SystemUpdate: [Network,NetworkRequester] Network acquired. | |
| 10-23 01:02:06.074 3074 4395 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }. | |
| 10-23 01:02:06.075 3074 4398 I SystemUpdate: [Control,NetworkControl] Received intent: Intent { act=android.net.wifi.supplicant.STATE_CHANGE flg=0x24000010 (has extras) }. | |
| 10-23 01:02:06.083 3074 16979 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4. | |
| 10-23 01:02:06.138 3074 16979 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 3. | |
| 10-23 01:02:06.188 3074 16924 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x002, -1.000). | |
| 10-23 01:02:06.227 9899 9899 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x002, isSetupWizard=false. | |
| 10-23 01:02:08.812 3074 16924 I SystemUpdate: [Execution,PackageFiles] Aggressive allocating space for file /data/ota_package/payload_properties.txt with size 156. | |
| 10-23 01:02:08.903 3074 16924 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x002, -1.000). | |
| 10-23 01:02:10.874 3074 16924 I SystemUpdate: [Execution,PackageFiles] Aggressive allocating space for file /data/ota_package/care_map.pb with size 561. | |
| 10-23 01:02:10.965 3074 16924 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x002, -1.000). | |
| 10-23 01:02:13.541 3074 16924 I SystemUpdate: [Execution,PackageFiles] Aggressive allocating space for file /data/ota_package/metadata with size 554. | |
| 10-23 01:02:13.554 3074 16924 I SystemUpdate: [Execution,ExecutionManager] Action streaming-download executed for 7.53 seconds. | |
| 10-23 01:02:13.563 3074 16924 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x003, -1.000). | |
| 10-23 01:02:13.607 9899 9899 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x003, isSetupWizard=false. | |
| 10-23 01:02:13.768 3074 16924 I SystemUpdate: [Execution,ExecutionManager] Action streaming-process-package executed for 0.21 seconds. | |
| 10-23 01:02:13.776 3074 16924 I SystemUpdate: [Execution,ExecutionManager] Action ab-update-prep executed for 0.01 seconds. | |
| 10-23 01:02:13.843 3074 16924 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, -1.000). | |
| 10-23 01:02:13.881 9899 9899 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x111, isSetupWizard=false. | |
| 10-23 01:02:14.010 3074 16924 I SystemUpdate: [Network,NetworkRequester] Requesting network with capabilities [11, 12]... | |
| 10-23 01:02:14.013 3074 4236 I SystemUpdate: [Network,NetworkRequester] Network acquired. | |
| 10-23 01:02:14.017 3074 4398 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }. | |
| 10-23 01:02:14.018 3074 4395 I SystemUpdate: [Control,NetworkControl] Received intent: Intent { act=android.net.wifi.supplicant.STATE_CHANGE flg=0x24000010 (has extras) }. | |
| 10-23 01:02:14.027 3074 16979 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4. | |
| 10-23 01:02:14.126 3074 16979 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 3. | |
| 10-23 01:02:14.199 3074 16924 I SystemUpdate: [Execution,SynchronizedUpdateEngine] start(ayce{url=https://ota.googlezip.net/packages/ota-api/google_sunfish_sunfish/4e536e3e15bfab486e26dbed8170f2e0ad164456.zip, payload_binary_file.offset=1260, payload_binary_file.length=1576938951, properties=[FILE_HASH=yNdMzP4nHXPaSqS1D97Atji7R6JYwNRdRCyYebkY9+s=, FILE_SIZE=1576938951, METADATA_HASH=s4Rs4XtVL4Bzt4PV1NVNJoZWvqwa63LQMnGYpc4WPi0=, METADATA_SIZE=104637]}, additionalProperties.size=4) | |
| 10-23 01:02:14.200 3074 16924 I SystemUpdate: [Execution,UpdateEngineDelegate] applyPayload() | |
| 10-23 01:02:14.203 1030 1030 I update_engine: [1023/010214.203728:INFO:update_attempter_android.cc(257)] Using this install plan: | |
| 10-23 01:02:14.204 1030 1030 I update_engine: [1023/010214.204087:INFO:install_plan.cc(83)] InstallPlan: resume, version: , source_slot: A, target_slot: B, url: https://ota.googlezip.net/packages/ota-api/google_sunfish_sunfish/4e536e3e15bfab486e26dbed8170f2e0ad164456.zip, payload: (size: 1576938951, metadata_size: 104637, metadata signature: , hash: C8D74CCCFE271D73DA4AA4B50FDEC0B638BB47A258C0D45D442C9879B918F7EB, payload type: unknown), hash_checks_mandatory: true, powerwash_required: false, switch_slot_on_reboot: false, run_post_install: true, is_rollback: false, write_verity: false | |
| 10-23 01:02:14.204 1030 1030 I update_engine: [1023/010214.204796:INFO:metrics_utils.cc(357)] Payload Attempt Number = 4 | |
| 10-23 01:02:14.205 1030 1030 I update_engine: [1023/010214.205857:INFO:metrics_utils.cc(374)] Update Monotonic Timestamp Start = 1/1/1970 0:53:37 GMT | |
| 10-23 01:02:14.206 1030 1030 I update_engine: [1023/010214.206169:INFO:metrics_utils.cc(383)] Update Boot Timestamp Start = 1/1/1970 1:30:48 GMT | |
| 10-23 01:02:14.206 1030 1030 I update_engine: [1023/010214.206253:INFO:update_attempter_android.cc(566)] Scheduling an action processor start. | |
| 10-23 01:02:14.206 1030 1030 I update_engine: [1023/010214.206536:INFO:action_processor.cc(51)] ActionProcessor: starting UpdateBootFlagsAction | |
| 10-23 01:02:14.206 1030 1030 I update_engine: [1023/010214.206601:INFO:update_boot_flags_action.cc(36)] Already updated boot flags. Skipping. | |
| 10-23 01:02:14.206 1030 1030 I update_engine: [1023/010214.206652:INFO:action_processor.cc(116)] ActionProcessor: finished UpdateBootFlagsAction with code ErrorCode::kSuccess | |
| 10-23 01:02:14.206 1030 1030 I update_engine: [1023/010214.206701:INFO:action_processor.cc(143)] ActionProcessor: starting InstallPlanAction | |
| 10-23 01:02:14.206 1030 1030 I update_engine: [1023/010214.206755:INFO:action_processor.cc(116)] ActionProcessor: finished InstallPlanAction with code ErrorCode::kSuccess | |
| 10-23 01:02:14.206 1030 1030 I update_engine: [1023/010214.206800:INFO:action_processor.cc(143)] ActionProcessor: starting DownloadAction | |
| 10-23 01:02:14.206 1030 1030 I update_engine: [1023/010214.206859:INFO:install_plan.cc(83)] InstallPlan: resume, version: , source_slot: A, target_slot: B, url: https://ota.googlezip.net/packages/ota-api/google_sunfish_sunfish/4e536e3e15bfab486e26dbed8170f2e0ad164456.zip, payload: (size: 1576938951, metadata_size: 104637, metadata signature: , hash: C8D74CCCFE271D73DA4AA4B50FDEC0B638BB47A258C0D45D442C9879B918F7EB, payload type: unknown), hash_checks_mandatory: true, powerwash_required: false, switch_slot_on_reboot: false, run_post_install: true, is_rollback: false, write_verity: false | |
| 10-23 01:02:14.207 1030 1030 I update_engine: [1023/010214.206977:INFO:prefs.cc(122)] update-state-payload-index not present in /data/misc/update_engine/prefs | |
| 10-23 01:02:14.207 1030 1030 I update_engine: [1023/010214.207030:INFO:download_action.cc(199)] Marking new slot as unbootable | |
| 10-23 01:02:14.209 3074 3152 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x002. | |
| 10-23 01:02:14.247 1030 1030 I update_engine: [1023/010214.247634:INFO:multi_range_http_fetcher.cc(45)] starting first transfer | |
| 10-23 01:02:14.247 1030 1030 I update_engine: [1023/010214.247820:INFO:multi_range_http_fetcher.cc(74)] starting transfer of range 1260+105160 | |
| 10-23 01:02:14.248 1030 1030 I update_engine: [1023/010214.248003:INFO:libcurl_http_fetcher.cc(146)] Starting/Resuming transfer | |
| 10-23 01:02:14.248 1030 1030 I update_engine: [1023/010214.248215:INFO:libcurl_http_fetcher.cc(165)] Using proxy: no | |
| 10-23 01:02:14.248 1030 1030 I update_engine: [1023/010214.248321:INFO:libcurl_http_fetcher.cc(305)] Setting up curl options for HTTPS | |
| 10-23 01:02:15.374 1030 1030 I update_engine: [1023/010215.373947:INFO:certificate_checker.cc(185)] Certificate changed from 1237CBF5641AA75FE4D916B010F32BAF4E7BEA02EF175ADFD97BD10477E261AD to 7EF07575B8E8077EA41DF2C3C424C8D2F63AF534BEA01C46BA791F84B005BBE0. | |
| 10-23 01:02:16.342 1030 1030 I update_engine: [1023/010216.342382:INFO:certificate_checker.cc(185)] Certificate changed from 7EF07575B8E8077EA41DF2C3C424C8D2F63AF534BEA01C46BA791F84B005BBE0 to 1237CBF5641AA75FE4D916B010F32BAF4E7BEA02EF175ADFD97BD10477E261AD. | |
| 10-23 01:02:17.663 1030 1030 I update_engine: [1023/010217.663457:INFO:delta_performer.cc(208)] Completed 0/? operations, 16384/1576938951 bytes downloaded (0%), overall progress 0% | |
| 10-23 01:02:17.667 3074 3152 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.000). | |
| 10-23 01:02:17.720 9899 9899 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.000011. | |
| 10-23 01:02:17.768 1030 1030 I update_engine: [1023/010217.768493:INFO:delta_performer.cc(519)] Manifest size in payload matches expected value from Omaha | |
| 10-23 01:02:17.769 1030 1030 I update_engine: [1023/010217.768962:INFO:delta_performer.cc(1612)] Verifying using public key: /etc/update_engine/update-payload-key.pub.pem | |
| 10-23 01:02:17.769 1030 1030 I update_engine: [1023/010217.769906:INFO:payload_verifier.cc(58)] signature blob size = 523 | |
| 10-23 01:02:17.772 1030 1030 I update_engine: [1023/010217.772004:INFO:payload_verifier.cc(78)] Verified correct signature 1 out of 1 signatures. | |
| 10-23 01:02:17.772 1030 1030 I update_engine: [1023/010217.772148:INFO:payload_metadata.cc(237)] Metadata hash signature matches value in Omaha response. | |
| 10-23 01:02:17.784 1030 1030 I update_engine: [1023/010217.784381:INFO:delta_performer.cc(1643)] Detected a 'full' payload. | |
| 10-23 01:02:17.830 1030 1030 I update_engine: [1023/010217.830109:INFO:delta_performer.cc(979)] InitPartitionMetadata done. | |
| 10-23 01:02:17.831 3074 3152 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003. | |
| 10-23 01:02:17.833 1030 1030 I update_engine: [1023/010217.833044:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:17.895 1030 1030 I update_engine: [1023/010217.895267:INFO:dynamic_partition_control_android.cc(77)] Succesfully mapped vendor_b to device mapper (force_writable = 1); device path at /dev/block/dm-1 | |
| 10-23 01:02:17.898 1030 1030 I update_engine: [1023/010217.898721:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:17.899 1030 1030 I update_engine: [1023/010217.899397:INFO:boot_control_android.cc(140)] boot_b is not in super partition metadata. | |
| 10-23 01:02:17.900 1030 1030 I update_engine: [1023/010217.900139:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:17.902 1030 1030 I update_engine: [1023/010217.902268:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:17.964 1030 1030 I update_engine: [1023/010217.963862:INFO:dynamic_partition_control_android.cc(77)] Succesfully mapped system_b to device mapper (force_writable = 1); device path at /dev/block/dm-3 | |
| 10-23 01:02:17.968 1030 1030 I update_engine: [1023/010217.968073:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:17.969 1030 1030 I update_engine: [1023/010217.969437:INFO:boot_control_android.cc(140)] vbmeta_b is not in super partition metadata. | |
| 10-23 01:02:17.970 1030 1030 I update_engine: [1023/010217.970355:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:17.973 1030 1030 I update_engine: [1023/010217.973036:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:17.973 1030 1030 I update_engine: [1023/010217.973723:INFO:boot_control_android.cc(140)] dtbo_b is not in super partition metadata. | |
| 10-23 01:02:17.974 1030 1030 I update_engine: [1023/010217.974695:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:17.977 1030 1030 I update_engine: [1023/010217.977492:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:18.041 1030 1030 I update_engine: [1023/010218.041644:INFO:dynamic_partition_control_android.cc(77)] Succesfully mapped product_b to device mapper (force_writable = 1); device path at /dev/block/dm-5 | |
| 10-23 01:02:18.047 1030 1030 I update_engine: [1023/010218.046932:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:18.047 1030 1030 I update_engine: [1023/010218.047931:INFO:boot_control_android.cc(140)] system_ext_b is not in super partition metadata. | |
| 10-23 01:02:18.049 1030 1030 I update_engine: [1023/010218.049195:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:18.049 1030 1030 E update_engine: [1023/010218.049451:ERROR:boot_control_android.cc(215)] Device file /dev/block/bootdevice/by-name/system_ext_b does not exist. | |
| 10-23 01:02:18.052 1030 1030 I update_engine: [1023/010218.052586:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:18.053 1030 1030 I update_engine: [1023/010218.053233:INFO:boot_control_android.cc(140)] vbmeta_system_b is not in super partition metadata. | |
| 10-23 01:02:18.054 1030 1030 I update_engine: [1023/010218.054372:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:18.057 1030 1030 I update_engine: [1023/010218.057804:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:18.058 1030 1030 I update_engine: [1023/010218.058706:INFO:boot_control_android.cc(140)] abl_b is not in super partition metadata. | |
| 10-23 01:02:18.059 1030 1030 I update_engine: [1023/010218.059858:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:18.063 1030 1030 I update_engine: [1023/010218.063621:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:18.064 1030 1030 I update_engine: [1023/010218.064438:INFO:boot_control_android.cc(140)] aop_b is not in super partition metadata. | |
| 10-23 01:02:18.065 1030 1030 I update_engine: [1023/010218.065766:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:18.069 1030 1030 I update_engine: [1023/010218.069370:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:18.070 1030 1030 I update_engine: [1023/010218.070330:INFO:boot_control_android.cc(140)] devcfg_b is not in super partition metadata. | |
| 10-23 01:02:18.072 1030 1030 I update_engine: [1023/010218.072281:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:18.075 1030 1030 I update_engine: [1023/010218.075773:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:18.076 1030 1030 I update_engine: [1023/010218.076574:INFO:boot_control_android.cc(140)] hyp_b is not in super partition metadata. | |
| 10-23 01:02:18.077 1030 1030 I update_engine: [1023/010218.077514:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:18.080 1030 1030 I update_engine: [1023/010218.080371:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:18.081 1030 1030 I update_engine: [1023/010218.081036:INFO:boot_control_android.cc(140)] keymaster_b is not in super partition metadata. | |
| 10-23 01:02:18.082 1030 1030 I update_engine: [1023/010218.082026:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:18.085 1030 1030 I update_engine: [1023/010218.085074:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:18.086 1030 1030 I update_engine: [1023/010218.085952:INFO:boot_control_android.cc(140)] qupfw_b is not in super partition metadata. | |
| 10-23 01:02:18.086 1030 1030 I update_engine: [1023/010218.086883:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:18.089 1030 1030 I update_engine: [1023/010218.089794:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:18.090 1030 1030 I update_engine: [1023/010218.090334:INFO:boot_control_android.cc(140)] tz_b is not in super partition metadata. | |
| 10-23 01:02:18.091 1030 1030 I update_engine: [1023/010218.091241:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:18.094 1030 1030 I update_engine: [1023/010218.094199:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:18.094 1030 1030 I update_engine: [1023/010218.094818:INFO:boot_control_android.cc(140)] uefisecapp_b is not in super partition metadata. | |
| 10-23 01:02:18.095 1030 1030 I update_engine: [1023/010218.095715:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:18.097 1030 1030 I update_engine: [1023/010218.097796:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:18.098 1030 1030 I update_engine: [1023/010218.098334:INFO:boot_control_android.cc(140)] xbl_b is not in super partition metadata. | |
| 10-23 01:02:18.099 1030 1030 I update_engine: [1023/010218.099079:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:18.101 1030 1030 I update_engine: [1023/010218.100968:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:18.101 1030 1030 I update_engine: [1023/010218.101386:INFO:boot_control_android.cc(140)] xbl_config_b is not in super partition metadata. | |
| 10-23 01:02:18.102 1030 1030 I update_engine: [1023/010218.102081:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:18.104 1030 1030 I update_engine: [1023/010218.104001:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:18.104 1030 1030 I update_engine: [1023/010218.104432:INFO:boot_control_android.cc(140)] modem_b is not in super partition metadata. | |
| 10-23 01:02:18.105 1030 1030 I update_engine: [1023/010218.105073:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 01:02:18.105 1030 1030 E update_engine: [1023/010218.105209:ERROR:delta_performer.cc(933)] Unable to determine all the partition devices. | |
| 10-23 01:02:18.105 1030 1030 E update_engine: [1023/010218.105355:ERROR:download_action.cc(336)] Error ErrorCode::kInstallDeviceOpenError (7) in DeltaPerformer's Write method when processing the received payload -- Terminating processing | |
| 10-23 01:02:18.105 1030 1030 I update_engine: [1023/010218.105468:INFO:libcurl_http_fetcher.cc(548)] Requesting libcurl to terminate transfer. | |
| 10-23 01:02:18.110 1030 1030 I update_engine: [1023/010218.110150:INFO:multi_range_http_fetcher.cc(177)] Received transfer terminated. | |
| 10-23 01:02:18.111 1030 1030 I update_engine: [1023/010218.111111:INFO:multi_range_http_fetcher.cc(129)] TransferEnded w/ code 206 | |
| 10-23 01:02:18.111 1030 1030 I update_engine: [1023/010218.111211:INFO:multi_range_http_fetcher.cc(131)] Terminating. | |
| 10-23 01:02:18.126 1030 1030 I update_engine: [1023/010218.126766:INFO:action_processor.cc(116)] ActionProcessor: finished DownloadAction with code ErrorCode::kInstallDeviceOpenError | |
| 10-23 01:02:18.127 1030 1030 I update_engine: [1023/010218.127170:INFO:action_processor.cc(121)] ActionProcessor: Aborting processing due to failure. | |
| 10-23 01:02:18.127 1030 1030 I update_engine: [1023/010218.127273:INFO:update_attempter_android.cc(454)] Processing Done. | |
| 10-23 01:02:18.127 1030 1030 I update_engine: [1023/010218.127345:INFO:dynamic_partition_control_android.cc(151)] Destroying [product_b, system_b, vendor_b] from device mapper | |
| 10-23 01:02:18.343 1030 1030 I update_engine: [1023/010218.343700:INFO:dynamic_partition_control_android.cc(140)] Successfully unmapped product_b from device mapper. | |
| 10-23 01:02:18.764 1030 1030 I update_engine: [1023/010218.763944:INFO:dynamic_partition_control_android.cc(140)] Successfully unmapped system_b from device mapper. | |
| 10-23 01:02:19.181 1030 1030 I update_engine: [1023/010219.181199:INFO:dynamic_partition_control_android.cc(140)] Successfully unmapped vendor_b from device mapper. | |
| 10-23 01:02:19.182 1030 1030 I update_engine: [1023/010219.182640:INFO:metrics_reporter_android.cc(29)] uploading 4 to histogram for metric ota_update_engine_attempt_number | |
| 10-23 01:02:19.182 1030 1030 I update_engine: [1023/010219.182795:INFO:metrics_reporter_android.cc(29)] uploading 0 to histogram for metric ota_update_engine_attempt_payload_type | |
| 10-23 01:02:19.182 1030 1030 I update_engine: [1023/010219.182912:INFO:metrics_reporter_android.cc(29)] uploading 0 to histogram for metric ota_update_engine_attempt_fixed_duration_boottime_in_minutes | |
| 10-23 01:02:19.183 1030 1030 I update_engine: [1023/010219.183057:INFO:metrics_reporter_android.cc(29)] uploading 0 to histogram for metric ota_update_engine_attempt_duration_monotonic_in_minutes | |
| 10-23 01:02:19.183 1030 1030 I update_engine: [1023/010219.183170:INFO:metrics_reporter_android.cc(29)] uploading 1503 to histogram for metric ota_update_engine_attempt_payload_size_mib | |
| 10-23 01:02:19.183 1030 1030 I update_engine: [1023/010219.183281:INFO:metrics_reporter_android.cc(29)] uploading 5 to histogram for metric ota_update_engine_attempt_result | |
| 10-23 01:02:19.183 1030 1030 I update_engine: [1023/010219.183392:INFO:metrics_reporter_android.cc(29)] uploading 7 to histogram for metric ota_update_engine_attempt_error_code | |
| 10-23 01:02:19.183 1030 1030 I update_engine: [1023/010219.183626:INFO:metrics_reporter_android.cc(29)] uploading 0 to histogram for metric ota_update_engine_attempt_fixed_current_bytes_downloaded_mib | |
| 10-23 01:02:19.190 3074 3152 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.000). | |
| 10-23 01:02:19.244 9899 9899 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.000000. | |
| 10-23 01:02:19.359 3074 3152 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x000. | |
| 10-23 01:02:19.409 3074 3152 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x000. | |
| 10-23 01:02:19.456 3074 16924 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x412, -1.000). | |
| 10-23 01:02:19.497 9899 9899 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x412, isSetupWizard=false. | |
| 10-23 01:02:19.654 3074 16924 I SystemUpdate: [Execution,SynchronizedUpdateEngine] stop() | |
| 10-23 01:02:19.654 3074 16924 I SystemUpdate: [Execution,ExecutionManager] Action streaming-apply executed for 5.87 seconds. | |
| 10-23 01:02:19.671 3074 16924 I SystemUpdate: [Execution,ExecutionManager] Action exponential-backoff-delay-execution executed for 0.01 seconds. | |
| 10-23 01:02:52.926 3074 17028 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110. | |
| 10-23 01:02:52.940 3074 17036 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 }. | |
| 10-23 01:02:52.972 3074 17036 I SystemUpdate: [Execution,ExecutionManager] Action exponential-backoff-delay-execution executed for 0.01 seconds. | |
| 10-23 01:07:57.992 3074 17285 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110. | |
| 10-23 01:07:58.002 3074 17284 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 }. | |
| 10-23 01:07:58.026 3074 17284 I SystemUpdate: [Execution,ExecutionManager] Action exponential-backoff-delay-execution executed for 0.02 seconds. | |
| 10-23 01:07:58.052 9899 9899 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x412, isSetupWizard=false. | |
| 10-23 01:08:14.947 3074 17297 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110. | |
| 10-23 01:08:14.958 3074 17298 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 }. | |
| 10-23 01:08:14.987 3074 17298 I SystemUpdate: [Execution,ExecutionManager] Action exponential-backoff-delay-execution executed for 0.02 seconds. | |
| 10-23 01:08:45.608 3074 17540 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110. | |
| 10-23 01:08:45.618 3074 17541 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 }. | |
| 10-23 01:08:45.632 3074 17541 I SystemUpdate: [Execution,ExecutionManager] Action exponential-backoff-delay-execution executed for 0.01 seconds. | |
| 10-23 01:08:45.649 9899 9899 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x412, isSetupWizard=false. | |
| 10-23 01:09:11.018 9899 9899 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x000, isSetupWizard=false. | |
| 10-23 01:09:11.047 3074 17555 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 102. | |
| 10-23 01:09:11.055 3074 17555 I SystemUpdate: [Execution,ExecutionManager] Finishing the current execution. | |
| 10-23 01:09:11.067 3074 3331 I SystemUpdate: [Control,ChimeraGcmTaskService] Scheduling task: AutomaticUpdateFlagChanged. | |
| 10-23 01:09:11.068 3074 17555 I SystemUpdate: [Execution,SynchronizedUpdateEngine] reset() | |
| 10-23 01:09:11.080 3074 17557 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 }. | |
| 10-23 01:09:11.101 3074 17557 I SystemUpdate: [Execution,ExecutionManager] Action pending executed for 0.01 seconds. | |
| 10-23 01:09:11.130 3074 17557 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x017, -1.000). | |
| 10-23 01:09:11.156 9899 9899 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x017, isSetupWizard=false. | |
| 10-23 01:09:13.022 3074 17557 I SystemUpdate: [Execution,PackageFiles] Aggressive allocating space for file /data/ota_package/payload_header.bin with size 24. | |
| 10-23 01:09:14.596 3074 17557 I SystemUpdate: [Execution,PackageFiles] Aggressive allocating space for file /data/ota_package/payload_metadata.bin with size 105160. | |
| 10-23 01:09:14.678 3074 17557 I SystemUpdate: [Execution,UpdateEngineDelegate] verifyPayloadMetadata() | |
| 10-23 01:09:14.680 1030 1030 I update_engine: [1023/010914.679979:INFO:binder_service_android.cc(145)] Received a request of verifying payload metadata in /data/ota_package/payload_metadata.bin. | |
| 10-23 01:09:14.681 1030 1030 I update_engine: [1023/010914.681104:INFO:payload_verifier.cc(58)] signature blob size = 523 | |
| 10-23 01:09:14.682 1030 1030 I update_engine: [1023/010914.682347:INFO:payload_verifier.cc(78)] Verified correct signature 1 out of 1 signatures. | |
| 10-23 01:09:14.682 1030 1030 I update_engine: [1023/010914.682500:INFO:payload_metadata.cc(237)] Metadata hash signature matches value in Omaha response. | |
| 10-23 01:09:17.067 3074 17557 I SystemUpdate: [Execution,PackageFiles] Aggressive allocating space for file /data/ota_package/metadata with size 554. | |
| 10-23 01:09:17.150 3074 17557 I SystemUpdate: [Execution,ExecutionManager] Action pre-download-validate executed for 6.05 seconds. | |
| 10-23 01:09:17.203 3074 17557 I SystemUpdate: [Network,NetworkRequester] Requesting network with capabilities [11, 12]... | |
| 10-23 01:09:17.208 3074 4236 I SystemUpdate: [Network,NetworkRequester] Network acquired. | |
| 10-23 01:09:17.210 3074 4395 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }. | |
| 10-23 01:09:17.212 3074 4398 I SystemUpdate: [Control,NetworkControl] Received intent: Intent { act=android.net.wifi.supplicant.STATE_CHANGE flg=0x24000010 (has extras) }. | |
| 10-23 01:09:17.218 3074 17558 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4. | |
| 10-23 01:09:17.294 3074 17558 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 3. | |
| 10-23 01:09:17.349 3074 17557 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x002, -1.000). | |
| 10-23 01:09:17.380 9899 9899 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x002, isSetupWizard=false. | |
| 10-23 01:09:19.941 3074 17557 I SystemUpdate: [Execution,PackageFiles] Aggressive allocating space for file /data/ota_package/payload_properties.txt with size 156. | |
| 10-23 01:09:20.023 3074 17557 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x002, -1.000). | |
| 10-23 01:09:22.092 3074 17557 I SystemUpdate: [Execution,PackageFiles] Aggressive allocating space for file /data/ota_package/care_map.pb with size 561. | |
| 10-23 01:09:22.185 3074 17557 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x002, -1.000). | |
| 10-23 01:09:24.118 3074 17557 I SystemUpdate: [Execution,PackageFiles] Aggressive allocating space for file /data/ota_package/metadata with size 554. | |
| 10-23 01:09:24.125 3074 17557 I SystemUpdate: [Execution,ExecutionManager] Action streaming-download executed for 6.97 seconds. | |
| 10-23 01:09:24.133 3074 17557 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x003, -1.000). | |
| 10-23 01:09:24.172 9899 9899 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x003, isSetupWizard=false. | |
| 10-23 01:09:24.330 3074 17557 I SystemUpdate: [Execution,ExecutionManager] Action streaming-process-package executed for 0.20 seconds. | |
| 10-23 01:09:24.334 3074 17557 I SystemUpdate: [Execution,ExecutionManager] Action ab-update-prep executed for 0.00 seconds. | |
| 10-23 01:09:24.395 3074 17557 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x413, -1.000). | |
| 10-23 01:09:24.435 9899 9899 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x413, isSetupWizard=false. | |
| 10-23 01:09:24.565 3074 17557 I SystemUpdate: [Control,ChimeraGcmTaskService] Scheduling task: DeviceIdle. | |
| 10-23 01:09:24.570 3074 17557 I SystemUpdate: [Execution,ExecutionManager] Action streaming-apply executed for 0.23 seconds. | |
| 10-23 01:09:24.584 3074 17557 I SystemUpdate: [Execution,ExecutionManager] Action fixed-delay-execution executed for 0.01 seconds. | |
| 10-23 01:09:56.736 3074 17604 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110. | |
| 10-23 01:09:56.743 3074 17605 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 }. | |
| 10-23 01:09:56.795 3074 17605 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x413, -1.000). | |
| 10-23 01:09:56.900 3074 17605 I SystemUpdate: [Control,ChimeraGcmTaskService] Scheduling task: DeviceIdle. | |
| 10-23 01:09:56.903 3074 17605 I SystemUpdate: [Execution,ExecutionManager] Action streaming-apply executed for 0.16 seconds. | |
| 10-23 01:09:56.918 3074 17605 I SystemUpdate: [Execution,ExecutionManager] Action fixed-delay-execution executed for 0.01 seconds. | |
| 10-23 01:09:57.884 3074 17605 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110. | |
| 10-23 01:09:57.891 3074 17604 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 }. | |
| 10-23 01:09:57.924 9899 9899 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x413, isSetupWizard=false. | |
| 10-23 01:09:57.992 3074 17604 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x413, -1.000). | |
| 10-23 01:09:58.115 3074 17604 I SystemUpdate: [Control,ChimeraGcmTaskService] Scheduling task: DeviceIdle. | |
| 10-23 01:09:58.117 3074 17604 I SystemUpdate: [Execution,ExecutionManager] Action streaming-apply executed for 0.22 seconds. | |
| 10-23 01:09:58.128 3074 17604 I SystemUpdate: [Execution,ExecutionManager] Action fixed-delay-execution executed for 0.01 seconds. | |
| 10-23 01:10:02.815 3074 17604 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 109. | |
| 10-23 01:10:02.821 3074 17605 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 }. | |
| 10-23 01:10:02.882 3074 17605 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, -1.000). | |
| 10-23 01:10:02.915 9899 9899 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x111, isSetupWizard=false. | |
| 10-23 01:10:03.034 3074 17605 I SystemUpdate: [Network,NetworkRequester] Requesting network with capabilities [11, 12]... | |
| 10-23 01:10:03.038 3074 4236 I SystemUpdate: [Network,NetworkRequester] Network acquired. | |
| 10-23 01:10:03.042 3074 4398 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }. | |
| 10-23 01:10:03.043 3074 4395 I SystemUpdate: [Control,NetworkControl] Received intent: Intent { act=android.net.wifi.supplicant.STATE_CHANGE flg=0x24000010 (has extras) }. | |
| 10-23 01:10:03.050 3074 17604 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4. | |
| 10-23 01:10:03.136 3074 17604 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 3. | |
| 10-23 01:10:03.211 3074 17605 I SystemUpdate: [Execution,SynchronizedUpdateEngine] start(ayce{url=https://ota.googlezip.net/packages/ota-api/google_sunfish_sunfish/4e536e3e15bfab486e26dbed8170f2e0ad164456.zip, payload_binary_file.offset=1260, payload_binary_file.length=1576938951, properties=[FILE_HASH=yNdMzP4nHXPaSqS1D97Atji7R6JYwNRdRCyYebkY9+s=, FILE_SIZE=1576938951, METADATA_HASH=s4Rs4XtVL4Bzt4PV1NVNJoZWvqwa63LQMnGYpc4WPi0=, METADATA_SIZE=104637]}, additionalProperties.size=4) | |
| 10-23 01:10:03.212 3074 17605 I SystemUpdate: [Execution,UpdateEngineDelegate] applyPayload() | |
| 10-23 01:10:03.215 1030 1030 I update_engine: [1023/011003.215288:INFO:update_attempter_android.cc(257)] Using this install plan: | |
| 10-23 01:10:03.215 1030 1030 I update_engine: [1023/011003.215623:INFO:install_plan.cc(83)] InstallPlan: resume, version: , source_slot: A, target_slot: B, url: https://ota.googlezip.net/packages/ota-api/google_sunfish_sunfish/4e536e3e15bfab486e26dbed8170f2e0ad164456.zip, payload: (size: 1576938951, metadata_size: 104637, metadata signature: , hash: C8D74CCCFE271D73DA4AA4B50FDEC0B638BB47A258C0D45D442C9879B918F7EB, payload type: unknown), hash_checks_mandatory: true, powerwash_required: false, switch_slot_on_reboot: false, run_post_install: true, is_rollback: false, write_verity: false | |
| 10-23 01:10:03.217 1030 1030 I update_engine: [1023/011003.217101:INFO:metrics_utils.cc(357)] Payload Attempt Number = 5 | |
| 10-23 01:10:03.218 1030 1030 I update_engine: [1023/011003.218090:INFO:metrics_utils.cc(374)] Update Monotonic Timestamp Start = 1/1/1970 1:01:26 GMT | |
| 10-23 01:10:03.218 1030 1030 I update_engine: [1023/011003.218361:INFO:metrics_utils.cc(383)] Update Boot Timestamp Start = 1/1/1970 1:38:37 GMT | |
| 10-23 01:10:03.218 1030 1030 I update_engine: [1023/011003.218430:INFO:update_attempter_android.cc(566)] Scheduling an action processor start. | |
| 10-23 01:10:03.218 1030 1030 I update_engine: [1023/011003.218770:INFO:action_processor.cc(51)] ActionProcessor: starting UpdateBootFlagsAction | |
| 10-23 01:10:03.218 1030 1030 I update_engine: [1023/011003.218837:INFO:update_boot_flags_action.cc(36)] Already updated boot flags. Skipping. | |
| 10-23 01:10:03.218 1030 1030 I update_engine: [1023/011003.218900:INFO:action_processor.cc(116)] ActionProcessor: finished UpdateBootFlagsAction with code ErrorCode::kSuccess | |
| 10-23 01:10:03.218 1030 1030 I update_engine: [1023/011003.218950:INFO:action_processor.cc(143)] ActionProcessor: starting InstallPlanAction | |
| 10-23 01:10:03.219 1030 1030 I update_engine: [1023/011003.219014:INFO:action_processor.cc(116)] ActionProcessor: finished InstallPlanAction with code ErrorCode::kSuccess | |
| 10-23 01:10:03.219 1030 1030 I update_engine: [1023/011003.219069:INFO:action_processor.cc(143)] ActionProcessor: starting DownloadAction | |
| 10-23 01:10:03.219 1030 1030 I update_engine: [1023/011003.219130:INFO:install_plan.cc(83)] InstallPlan: resume, version: , source_slot: A, target_slot: B, url: https://ota.googlezip.net/packages/ota-api/google_sunfish_sunfish/4e536e3e15bfab486e26dbed8170f2e0ad164456.zip, payload: (size: 1576938951, metadata_size: 104637, metadata signature: , hash: C8D74CCCFE271D73DA4AA4B50FDEC0B638BB47A258C0D45D442C9879B918F7EB, payload type: unknown), hash_checks_mandatory: true, powerwash_required: false, switch_slot_on_reboot: false, run_post_install: true, is_rollback: false, write_verity: false | |
| 10-23 01:10:03.219 1030 1030 I update_engine: [1023/011003.219229:INFO:prefs.cc(122)] update-state-payload-index not present in /data/misc/update_engine/prefs | |
| 10-23 01:10:03.219 1030 1030 I update_engine: [1023/011003.219279:INFO:download_action.cc(199)] Marking new slot as unbootable | |
| 10-23 01:10:03.221 3074 6749 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x002. | |
| 10-23 01:10:03.266 1030 1030 I update_engine: [1023/011003.266597:INFO:multi_range_http_fetcher.cc(45)] starting first transfer | |
| 10-23 01:10:03.266 1030 1030 I update_engine: [1023/011003.266778:INFO:multi_range_http_fetcher.cc(74)] starting transfer of range 1260+105160 | |
| 10-23 01:10:03.266 1030 1030 I update_engine: [1023/011003.266916:INFO:libcurl_http_fetcher.cc(146)] Starting/Resuming transfer | |
| 10-23 01:10:03.267 1030 1030 I update_engine: [1023/011003.267079:INFO:libcurl_http_fetcher.cc(165)] Using proxy: no | |
| 10-23 01:10:03.267 1030 1030 I update_engine: [1023/011003.267165:INFO:libcurl_http_fetcher.cc(305)] Setting up curl options for HTTPS | |
| 10-23 01:10:04.395 1030 1030 I update_engine: [1023/011004.395329:INFO:certificate_checker.cc(185)] Certificate changed from 1237CBF5641AA75FE4D916B010F32BAF4E7BEA02EF175ADFD97BD10477E261AD to 7EF07575B8E8077EA41DF2C3C424C8D2F63AF534BEA01C46BA791F84B005BBE0. | |
| 10-23 01:10:04.419 3074 4395 I SystemUpdate: [Control,BatteryControl] Received intent: Intent { act=android.intent.action.BATTERY_CHANGED flg=0x60000010 (has extras) }. | |
| 10-23 01:10:04.429 3074 17604 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 4. | |
| 10-23 01:10:05.374 1030 1030 I update_engine: [1023/011005.374414:INFO:certificate_checker.cc(185)] Certificate changed from 7EF07575B8E8077EA41DF2C3C424C8D2F63AF534BEA01C46BA791F84B005BBE0 to 1237CBF5641AA75FE4D916B010F32BAF4E7BEA02EF175ADFD97BD10477E261AD. | |
| 10-23 01:10:06.453 1030 1030 I update_engine: [1023/011006.453469:INFO:delta_performer.cc(208)] Completed 0/? operations, 16384/1576938951 bytes downloaded (0%), overall progress 0% | |
| 10-23 01:10:06.458 3074 6749 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.000). | |
| 10-23 01:10:06.508 9899 9899 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.000011. | |
| 10-23 01:10:06.581 1030 1030 I update_engine: [1023/011006.581791:INFO:delta_performer.cc(519)] Manifest size in payload matches expected value from Omaha | |
| 10-23 01:10:06.582 1030 1030 I update_engine: [1023/011006.582157:INFO:delta_performer.cc(1612)] Verifying using public key: /etc/update_engine/update-payload-key.pub.pem | |
| 10-23 01:10:06.582 1030 1030 I update_engine: [1023/011006.582486:INFO:payload_verifier.cc(58)] signature blob size = 523 | |
| 10-23 01:10:06.583 1030 1030 I update_engine: [1023/011006.583736:INFO:payload_verifier.cc(78)] Verified correct signature 1 out of 1 signatures. | |
| 10-23 01:10:06.583 1030 1030 I update_engine: [1023/011006.583836:INFO:payload_metadata.cc(237)] Metadata hash signature matches value in Omaha response. | |
| 10-23 01:10:06.591 1030 1030 I update_engine: [1023/011006.591203:INFO:delta_performer.cc(1643)] Detected a 'full' payload. | |
| 10-23 01:10:06.610 3074 6749 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x003. | |
| 10-23 01:10:06.623 1030 1030 I update_engine: [1023/011006.623358:INFO:delta_performer.cc(979)] InitPartitionMetadata done. | |
| 10-23 01:10:06.625 1030 1030 I update_engine: [1023/011006.625842:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.685 1030 1030 I update_engine: [1023/011006.685323:INFO:dynamic_partition_control_android.cc(77)] Succesfully mapped vendor_b to device mapper (force_writable = 1); device path at /dev/block/dm-1 | |
| 10-23 01:10:06.688 1030 1030 I update_engine: [1023/011006.688029:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.688 1030 1030 I update_engine: [1023/011006.688783:INFO:boot_control_android.cc(140)] boot_b is not in super partition metadata. | |
| 10-23 01:10:06.689 1030 1030 I update_engine: [1023/011006.689497:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.691 1030 1030 I update_engine: [1023/011006.691366:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.750 1030 1030 I update_engine: [1023/011006.750052:INFO:dynamic_partition_control_android.cc(77)] Succesfully mapped system_b to device mapper (force_writable = 1); device path at /dev/block/dm-3 | |
| 10-23 01:10:06.753 1030 1030 I update_engine: [1023/011006.753525:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.754 1030 1030 I update_engine: [1023/011006.754300:INFO:boot_control_android.cc(140)] vbmeta_b is not in super partition metadata. | |
| 10-23 01:10:06.755 1030 1030 I update_engine: [1023/011006.755180:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.757 1030 1030 I update_engine: [1023/011006.757773:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.758 1030 1030 I update_engine: [1023/011006.758400:INFO:boot_control_android.cc(140)] dtbo_b is not in super partition metadata. | |
| 10-23 01:10:06.759 1030 1030 I update_engine: [1023/011006.759490:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.761 1030 1030 I update_engine: [1023/011006.761829:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.821 1030 1030 I update_engine: [1023/011006.821334:INFO:dynamic_partition_control_android.cc(77)] Succesfully mapped product_b to device mapper (force_writable = 1); device path at /dev/block/dm-5 | |
| 10-23 01:10:06.826 1030 1030 I update_engine: [1023/011006.826503:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.827 1030 1030 I update_engine: [1023/011006.827279:INFO:boot_control_android.cc(140)] system_ext_b is not in super partition metadata. | |
| 10-23 01:10:06.828 1030 1030 I update_engine: [1023/011006.828307:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.828 1030 1030 E update_engine: [1023/011006.828657:ERROR:boot_control_android.cc(215)] Device file /dev/block/bootdevice/by-name/system_ext_b does not exist. | |
| 10-23 01:10:06.831 1030 1030 I update_engine: [1023/011006.831475:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.832 1030 1030 I update_engine: [1023/011006.832402:INFO:boot_control_android.cc(140)] vbmeta_system_b is not in super partition metadata. | |
| 10-23 01:10:06.833 1030 1030 I update_engine: [1023/011006.833437:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.836 1030 1030 I update_engine: [1023/011006.836288:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.836 1030 1030 I update_engine: [1023/011006.836924:INFO:boot_control_android.cc(140)] abl_b is not in super partition metadata. | |
| 10-23 01:10:06.837 1030 1030 I update_engine: [1023/011006.837899:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.841 1030 1030 I update_engine: [1023/011006.841006:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.841 1030 1030 I update_engine: [1023/011006.841619:INFO:boot_control_android.cc(140)] aop_b is not in super partition metadata. | |
| 10-23 01:10:06.842 1030 1030 I update_engine: [1023/011006.842631:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.845 1030 1030 I update_engine: [1023/011006.845204:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.846 1030 1030 I update_engine: [1023/011006.846056:INFO:boot_control_android.cc(140)] devcfg_b is not in super partition metadata. | |
| 10-23 01:10:06.847 1030 1030 I update_engine: [1023/011006.847005:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.849 1030 1030 I update_engine: [1023/011006.849863:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.850 1030 1030 I update_engine: [1023/011006.850738:INFO:boot_control_android.cc(140)] hyp_b is not in super partition metadata. | |
| 10-23 01:10:06.851 1030 1030 I update_engine: [1023/011006.851725:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.854 1030 1030 I update_engine: [1023/011006.854696:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.855 1030 1030 I update_engine: [1023/011006.855406:INFO:boot_control_android.cc(140)] keymaster_b is not in super partition metadata. | |
| 10-23 01:10:06.856 1030 1030 I update_engine: [1023/011006.856203:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.858 1030 1030 I update_engine: [1023/011006.858865:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.859 1030 1030 I update_engine: [1023/011006.859337:INFO:boot_control_android.cc(140)] qupfw_b is not in super partition metadata. | |
| 10-23 01:10:06.860 1030 1030 I update_engine: [1023/011006.860185:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.862 1030 1030 I update_engine: [1023/011006.862366:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.863 1030 1030 I update_engine: [1023/011006.863130:INFO:boot_control_android.cc(140)] tz_b is not in super partition metadata. | |
| 10-23 01:10:06.863 1030 1030 I update_engine: [1023/011006.863922:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.866 1030 1030 I update_engine: [1023/011006.866239:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.866 1030 1030 I update_engine: [1023/011006.866702:INFO:boot_control_android.cc(140)] uefisecapp_b is not in super partition metadata. | |
| 10-23 01:10:06.867 1030 1030 I update_engine: [1023/011006.867382:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.869 1030 1030 I update_engine: [1023/011006.869401:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.869 1030 1030 I update_engine: [1023/011006.869748:INFO:boot_control_android.cc(140)] xbl_b is not in super partition metadata. | |
| 10-23 01:10:06.870 1030 1030 I update_engine: [1023/011006.870399:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.872 1030 1030 I update_engine: [1023/011006.872158:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.872 1030 1030 I update_engine: [1023/011006.872544:INFO:boot_control_android.cc(140)] xbl_config_b is not in super partition metadata. | |
| 10-23 01:10:06.873 1030 1030 I update_engine: [1023/011006.873093:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.874 1030 1030 I update_engine: [1023/011006.874751:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot B in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.875 1030 1030 I update_engine: [1023/011006.875106:INFO:boot_control_android.cc(140)] modem_b is not in super partition metadata. | |
| 10-23 01:10:06.875 1030 1030 I update_engine: [1023/011006.875718:INFO:dynamic_partition_control_android.cc(197)] Loaded metadata from slot A in /dev/block/bootdevice/by-name/super | |
| 10-23 01:10:06.875 1030 1030 E update_engine: [1023/011006.875845:ERROR:delta_performer.cc(933)] Unable to determine all the partition devices. | |
| 10-23 01:10:06.875 1030 1030 E update_engine: [1023/011006.875911:ERROR:download_action.cc(336)] Error ErrorCode::kInstallDeviceOpenError (7) in DeltaPerformer's Write method when processing the received payload -- Terminating processing | |
| 10-23 01:10:06.876 1030 1030 I update_engine: [1023/011006.876001:INFO:libcurl_http_fetcher.cc(548)] Requesting libcurl to terminate transfer. | |
| 10-23 01:10:06.880 1030 1030 I update_engine: [1023/011006.880175:INFO:multi_range_http_fetcher.cc(177)] Received transfer terminated. | |
| 10-23 01:10:06.880 1030 1030 I update_engine: [1023/011006.880415:INFO:multi_range_http_fetcher.cc(129)] TransferEnded w/ code 206 | |
| 10-23 01:10:06.880 1030 1030 I update_engine: [1023/011006.880468:INFO:multi_range_http_fetcher.cc(131)] Terminating. | |
| 10-23 01:10:06.893 1030 1030 I update_engine: [1023/011006.893206:INFO:action_processor.cc(116)] ActionProcessor: finished DownloadAction with code ErrorCode::kInstallDeviceOpenError | |
| 10-23 01:10:06.893 1030 1030 I update_engine: [1023/011006.893591:INFO:action_processor.cc(121)] ActionProcessor: Aborting processing due to failure. | |
| 10-23 01:10:06.893 1030 1030 I update_engine: [1023/011006.893678:INFO:update_attempter_android.cc(454)] Processing Done. | |
| 10-23 01:10:06.893 1030 1030 I update_engine: [1023/011006.893748:INFO:dynamic_partition_control_android.cc(151)] Destroying [product_b, system_b, vendor_b] from device mapper | |
| 10-23 01:10:07.154 1030 1030 I update_engine: [1023/011007.154570:INFO:dynamic_partition_control_android.cc(140)] Successfully unmapped product_b from device mapper. | |
| 10-23 01:10:07.574 1030 1030 I update_engine: [1023/011007.573877:INFO:dynamic_partition_control_android.cc(140)] Successfully unmapped system_b from device mapper. | |
| 10-23 01:10:07.990 1030 1030 I update_engine: [1023/011007.990701:INFO:dynamic_partition_control_android.cc(140)] Successfully unmapped vendor_b from device mapper. | |
| 10-23 01:10:07.993 1030 1030 I update_engine: [1023/011007.993334:INFO:metrics_reporter_android.cc(29)] uploading 5 to histogram for metric ota_update_engine_attempt_number | |
| 10-23 01:10:07.993 1030 1030 I update_engine: [1023/011007.993900:INFO:metrics_reporter_android.cc(29)] uploading 0 to histogram for metric ota_update_engine_attempt_payload_type | |
| 10-23 01:10:07.994 1030 1030 I update_engine: [1023/011007.994320:INFO:metrics_reporter_android.cc(29)] uploading 0 to histogram for metric ota_update_engine_attempt_fixed_duration_boottime_in_minutes | |
| 10-23 01:10:07.994 1030 1030 I update_engine: [1023/011007.994738:INFO:metrics_reporter_android.cc(29)] uploading 0 to histogram for metric ota_update_engine_attempt_duration_monotonic_in_minutes | |
| 10-23 01:10:07.995 1030 1030 I update_engine: [1023/011007.995041:INFO:metrics_reporter_android.cc(29)] uploading 1503 to histogram for metric ota_update_engine_attempt_payload_size_mib | |
| 10-23 01:10:07.995 1030 1030 I update_engine: [1023/011007.995367:INFO:metrics_reporter_android.cc(29)] uploading 5 to histogram for metric ota_update_engine_attempt_result | |
| 10-23 01:10:07.995 1030 1030 I update_engine: [1023/011007.995603:INFO:metrics_reporter_android.cc(29)] uploading 7 to histogram for metric ota_update_engine_attempt_error_code | |
| 10-23 01:10:07.996 1030 1030 I update_engine: [1023/011007.996522:INFO:metrics_reporter_android.cc(29)] uploading 0 to histogram for metric ota_update_engine_attempt_fixed_current_bytes_downloaded_mib | |
| 10-23 01:10:08.000 3074 6749 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x111, 0.000). | |
| 10-23 01:10:08.055 9899 9899 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Progress update: progress=0.000000. | |
| 10-23 01:10:08.166 3074 6749 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x000. | |
| 10-23 01:10:08.213 3074 6749 I SystemUpdate: [Control,InstallationControl] Update engine status updated to 0x000. | |
| 10-23 01:10:08.262 3074 17605 I SystemUpdate: [Control,InstallationControl] Installation progress updated to (0x412, -1.000). | |
| 10-23 01:10:08.305 9899 9899 I SystemUpdate: [Phone,SystemUpdateChimeraActivity] Status change: status=0x412, isSetupWizard=false. | |
| 10-23 01:10:08.462 3074 17605 I SystemUpdate: [Execution,SynchronizedUpdateEngine] stop() | |
| 10-23 01:10:08.463 3074 17605 I SystemUpdate: [Execution,ExecutionManager] Action streaming-apply executed for 5.64 seconds. | |
| 10-23 01:10:08.488 3074 17605 I SystemUpdate: [Execution,ExecutionManager] Action exponential-backoff-delay-execution executed for 0.02 seconds. | |
| 10-23 01:12:29.192 3074 17835 I SystemUpdate: [Execution,InstallationEventIntentOperation] Handling event of type 110. | |
| 10-23 01:12:29.199 3074 17836 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 }. | |
| 10-23 01:12:29.208 3074 17836 I SystemUpdate: [Execution,ExecutionManager] Action exponential-backoff-delay-execution executed for 0.01 seconds. | |
| 10-23 01:17:35.528 1030 1030 I update_engine: [1023/011735.527954:INFO:main.cc(198)] A/B Update Engine terminating with exit code 0 | |
| 10-23 01:17:35.528 1030 1030 I update_engine: [1023/011735.528329:INFO:dynamic_partition_control_android.cc(151)] Destroying [] from device mapper |
Sign up for free
to join this conversation on GitHub.
Already have an account?
Sign in to comment