[0131/112114:INFO:main.cc(158)] Chrome OS Update Engine starting
[0131/112114:INFO:payload_state.cc(360)] Current Response Signature = 
NumURLs = 2
Url0 = http://dl.google.com/chromeos/samsung/3635.0.0/dev-channel/chromeos_3428.65.0-3635.0.0_x86-alex_dev-channel_delta_mp-v3.bin-3f9eaa9572be762aac1d75514017b6cb.signed
Url1 = https://dl.google.com/chromeos/samsung/3635.0.0/dev-channel/chromeos_3428.65.0-3635.0.0_x86-alex_dev-channel_delta_mp-v3.bin-3f9eaa9572be762aac1d75514017b6cb.signed
Payload Size = 69387506
Payload Sha256 Hash = qseQW5XeAhtxeD7ajgmORLL99LhmcXDmpGrzv6VC9TM=
Metadata Size = 388170
Metadata Signature = kbfFRN9CVoaUlNorPzBXyoMvJxD8/bFohAQVcrM5XmEzu2sR0lJaIVebK06PtQIDtj3nNNBLUOjTCbiloMxlQGQFfLqZXPGymg3HrtoMeSs0bk1vQ9ZMv7zApnUdZnrGy82xPNu5mVESE9V0E2wlY9zu4GnfE9I/2PLVb7+loi0YU6GEe+JQAyJ0tieJZyNh1dZlDfUETluShRC0yxTdHpukgDtHdiqO3m1EssCUHToxSrNPwd6Yv20haQ4y044vM/qjzWcw4WVorBqrKWb6uFRee0SA3or8SNQc3sEZEbHtwSStxEaY/mc41jxF2IB3aADC7gOn3CqFnAfhJw3ObQ==
Is Delta Payload = 1
Max Failure Count Per Url = 10
Disable Payload Backoff = 0

[0131/112114:INFO:payload_state.cc(381)] Payload Attempt Number = 0
[0131/112114:INFO:payload_state.cc(404)] Current URL Index = 0
[0131/112114:INFO:payload_state.cc(425)] Current URL (Url0)'s Failure Count = 0
[0131/112114:INFO:payload_state.cc(452)] Backoff Expiry Time = 4/22/2009 19:24:48 GMT
[0131/112114:INFO:update_check_scheduler.cc(84)] Next update check in 8m27s
[0131/112159:INFO:update_attempter.cc(778)] Updating boot flags...
[0131/112217:INFO:subprocess.cc(46)] Subprocess output:
Saving verbose log as /tmp/debug_vboot_QYGz3yGe1/noisy.log
Extracting BIOS components...
Pulling root and recovery keys from GBB...
Verify firmware A with root key: OK
  TPM=0x00010003, this=0x00010003
Verify firmware B with root key: OK
  TPM=0x00010003, this=0x00010003
Examining kernels...
Kernel /dev/sda2: OK
  Verify /dev/sda2 with kern_subkey_A.vbpubk: OK
    TPM=0x00030001 this=0x00030001
  Verify /dev/sda2 with kern_subkey_B.vbpubk: OK
    TPM=0x00030001 this=0x00030001
  Verify /dev/sda2 with recoverykey.vbpubk: FAILED
Kernel /dev/sda4: OK
  Verify /dev/sda4 with kern_subkey_A.vbpubk: OK
    TPM=0x00030001 this=0x00030001
  Verify /dev/sda4 with kern_subkey_B.vbpubk: OK
    TPM=0x00030001 this=0x00030001
  Verify /dev/sda4 with recoverykey.vbpubk: FAILED
Kernel /dev/sda6: FAILED
Exporting log file as /var/log/debug_vboot_noisy.log
Starting Alex firmware updater v2 (bootok)...
Detected Alex-R compatible EC firmware version (01VFA617).
 - Updater package: [Alex.03.61.0735.0056G3.0021 / 01VFA617]
 - Current system:  [RO:Alex.03.61.0735.0056G3.0021, ACT:Alex.03.61.0735.0056G3.0021 / 01VFA617]
 - Write protection: Hardware: ON, Software: Main=ON
 * invoke: flashrom -p internal:bus=spi -i RW_SECTION_A:_dup2_temp_from -i RW_SECTION_B:_dup2_temp_to -r _dup2_temp_image
Firmware update (bootok) completed.

[0131/112941:INFO:prefs.cc(55)] certificate-report-to-send-update not present in /var/lib/update_engine/prefs
[0131/112941:INFO:prefs.cc(55)] certificate-report-to-send-download not present in /var/lib/update_engine/prefs
[0131/112941:INFO:update_attempter.cc(224)] Networks over which updates are allowed per policy : all
[0131/112941:INFO:update_attempter.cc(298)] Scattering disabled since scatter factor is set to 0
[0131/112941:INFO:update_attempter.cc(248)] update_disabled = false, target_version_prefix = , scatter_factor_in_seconds = 0s
[0131/112941:INFO:update_attempter.cc(255)] Wall Clock Based Wait Enabled = 0, Update Check Count Wait Enabled = 0, Waiting Period = 0s
[0131/112941:INFO:update_attempter.cc(264)] forced to obey proxies
[0131/112941:INFO:update_attempter.cc(267)] proxy manual checks: 1
[0131/112941:INFO:update_attempter.cc(768)] Already updated boot flags. Skipping.
[0131/112941:INFO:update_attempter.cc(958)] Scheduling an action processor start.
[0131/112941:INFO:action_processor.cc(36)] ActionProcessor::StartProcessing: OmahaRequestAction
[0131/112941:INFO:omaha_request_action.cc(271)] Posting an Omaha request to https://tools.google.com/service/update2
[0131/112941:INFO:omaha_request_action.cc(272)] Request: <?xml version="1.0" encoding="UTF-8"?>
<request protocol="3.0" version="ChromeOSUpdateEngine-0.1.0.0" updaterversion="ChromeOSUpdateEngine-0.1.0.0" ismachine="1">
    <os version="Indy" platform="Chrome OS" sp="3635.0.0_i686"></os>
    <app appid="{C776D42E-287A-435E-8BA7-E770BD30B46D}" version="3635.0.0" lang="en-US" track="dev-channel" board="x86-alex-signed-mp-v3keys" hardware_class="SAMS ALEX BETA-US 8738" delta_okay="true">
        <updatecheck targetversionprefix="" userinitiated="false"></updatecheck>
    </app>
</request>

[0131/112941:INFO:chrome_browser_proxy_resolver.cc(167)] dbug_g_proxy_call succeeded!
[0131/112941:INFO:libcurl_http_fetcher.cc(63)] Starting/Resuming transfer
[0131/112941:INFO:libcurl_http_fetcher.cc(74)] Using proxy: no
[0131/112941:INFO:libcurl_http_fetcher.cc(52)] We are connected via wifi, Updates allowed: Yes
[0131/112941:INFO:libcurl_http_fetcher.cc(202)] Setting up curl options for HTTPS
[0131/112941:INFO:libcurl_http_fetcher.cc(485)] Setting up timeout source: 1 seconds.
[0131/112941:INFO:libcurl_http_fetcher.cc(286)] HTTP response code: 200
[0131/112941:INFO:libcurl_http_fetcher.cc(355)] Transfer completed (200), 225 bytes downloaded
[0131/112941:INFO:omaha_request_action.cc(625)] Omaha request response: <?xml version="1.0" encoding="UTF-8"?><response protocol="3.0" server="prod"><daystart elapsed_seconds="41385"/><app appid="{C776D42E-287A-435E-8BA7-E770BD30B46D}" status="ok"><updatecheck status="noupdate"/></app></response>
[0131/112941:INFO:omaha_request_action.cc(439)] No update.
[0131/112941:INFO:action_processor.cc(82)] ActionProcessor::ActionComplete: finished OmahaRequestAction, starting OmahaResponseHandlerAction
[0131/112941:INFO:omaha_response_handler_action.cc(36)] There are no updates. Aborting.
[0131/112941:INFO:action_processor.cc(68)] ActionProcessor::ActionComplete: OmahaResponseHandlerAction action failed. Aborting processing.
[0131/112941:INFO:action_processor.cc(73)] ActionProcessor::ActionComplete: finished last action of type OmahaResponseHandlerAction
[0131/112941:INFO:update_attempter.cc(548)] Processing Done.
[0131/112941:INFO:update_attempter.cc(612)] No update.
[0131/112941:INFO:update_check_scheduler.cc(84)] Next update check in 40m33s
[0131/113326:INFO:dbus_service.cc(94)] Attempt update: app_version="" omaha_url="" interactive=yes
[0131/113326:INFO:update_attempter.cc(511)] New update check requested
[0131/113326:INFO:gpio_handler.cc(587)] GPIOs not engaged, defaulting to normal mode
[0131/113326:INFO:update_attempter.cc(224)] Networks over which updates are allowed per policy : all
[0131/113326:INFO:update_attempter.cc(298)] Scattering disabled since scatter factor is set to 0
[0131/113326:INFO:update_attempter.cc(248)] update_disabled = false, target_version_prefix = , scatter_factor_in_seconds = 0s
[0131/113326:INFO:update_attempter.cc(255)] Wall Clock Based Wait Enabled = 0, Update Check Count Wait Enabled = 0, Waiting Period = 0s
[0131/113326:INFO:update_attempter.cc(264)] forced to obey proxies
[0131/113326:INFO:update_attempter.cc(267)] proxy manual checks: 2
[0131/113326:INFO:update_attempter.cc(768)] Already updated boot flags. Skipping.
[0131/113326:INFO:update_attempter.cc(958)] Scheduling an action processor start.
[0131/113326:INFO:action_processor.cc(36)] ActionProcessor::StartProcessing: OmahaRequestAction
[0131/113326:INFO:omaha_request_action.cc(271)] Posting an Omaha request to https://tools.google.com/service/update2
[0131/113326:INFO:omaha_request_action.cc(272)] Request: <?xml version="1.0" encoding="UTF-8"?>
<request protocol="3.0" version="ChromeOSUpdateEngine-0.1.0.0" updaterversion="ChromeOSUpdateEngine-0.1.0.0" ismachine="1">
    <os version="Indy" platform="Chrome OS" sp="3635.0.0_i686"></os>
    <app appid="{C776D42E-287A-435E-8BA7-E770BD30B46D}" version="3635.0.0" lang="en-US" track="dev-channel" board="x86-alex-signed-mp-v3keys" hardware_class="SAMS ALEX BETA-US 8738" delta_okay="true">
        <updatecheck targetversionprefix="" userinitiated="true"></updatecheck>
    </app>
</request>

[0131/113326:WARNING:chrome_browser_proxy_resolver.cc(177)] dbug_g_proxy_call failed with no error string, continuing with no proxy.
[0131/113326:WARNING:chrome_browser_proxy_resolver.cc(146)] attempting to reinitialize dbus proxy and retrying
[0131/113326:INFO:chrome_browser_proxy_resolver.cc(167)] dbug_g_proxy_call succeeded!
[0131/113326:INFO:libcurl_http_fetcher.cc(63)] Starting/Resuming transfer
[0131/113326:INFO:libcurl_http_fetcher.cc(74)] Using proxy: no
[0131/113326:INFO:libcurl_http_fetcher.cc(52)] We are connected via wifi, Updates allowed: Yes
[0131/113326:INFO:libcurl_http_fetcher.cc(202)] Setting up curl options for HTTPS
[0131/113326:INFO:libcurl_http_fetcher.cc(485)] Setting up timeout source: 1 seconds.
[0131/113326:INFO:libcurl_http_fetcher.cc(286)] HTTP response code: 200
[0131/113326:INFO:libcurl_http_fetcher.cc(355)] Transfer completed (200), 225 bytes downloaded
[0131/113326:INFO:omaha_request_action.cc(625)] Omaha request response: <?xml version="1.0" encoding="UTF-8"?><response protocol="3.0" server="prod"><daystart elapsed_seconds="41610"/><app appid="{C776D42E-287A-435E-8BA7-E770BD30B46D}" status="ok"><updatecheck status="noupdate"/></app></response>
[0131/113326:INFO:omaha_request_action.cc(439)] No update.
[0131/113326:INFO:action_processor.cc(82)] ActionProcessor::ActionComplete: finished OmahaRequestAction, starting OmahaResponseHandlerAction
[0131/113326:INFO:omaha_response_handler_action.cc(36)] There are no updates. Aborting.
[0131/113326:INFO:action_processor.cc(68)] ActionProcessor::ActionComplete: OmahaResponseHandlerAction action failed. Aborting processing.
[0131/113326:INFO:action_processor.cc(73)] ActionProcessor::ActionComplete: finished last action of type OmahaResponseHandlerAction
[0131/113326:INFO:update_attempter.cc(548)] Processing Done.
[0131/113326:INFO:update_attempter.cc(612)] No update.