gistfile1.txt

Dec 11 03:53:01 localhost update_engine[480]: [1211/035301:INFO:dbus_service.cc(66)] Attempting interactive update
Dec 11 03:53:01 localhost update_engine[480]: [1211/035301:INFO:update_attempter.cc(433)] New update check requested
Dec 11 03:53:01 localhost update_engine[480]: [1211/035301:WARNING:libpolicy.cc(29)] Could not load the device policy file.
Dec 11 03:53:01 localhost update_engine[480]: [1211/035301:INFO:update_attempter.cc(195)] No device policies/settings present.
Dec 11 03:53:01 localhost update_engine[480]: [1211/035301:INFO:update_attempter.cc(239)] Scattering disabled since scatter factor is set to 0
Dec 11 03:53:01 localhost update_engine[480]: [1211/035301:INFO:omaha_request_params.cc(61)] Current group set to beta
Dec 11 03:53:01 localhost update_engine[480]: [1211/035301:INFO:update_attempter.cc(206)] update_disabled = false, target_version_prefix = , scatter_factor_in_seconds = 0s
Dec 11 03:53:01 localhost update_engine[480]: [1211/035301:INFO:update_attempter.cc(213)] Wall Clock Based Wait Enabled = 0, Update Check Count Wait Enabled = 0, Waiting Period = 0s
Dec 11 03:53:01 localhost update_engine[480]: [1211/035301:INFO:update_attempter.cc(664)] Already updated boot flags. Skipping.
Dec 11 03:53:01 localhost update_engine[480]: [1211/035301:INFO:update_attempter.cc(847)] Scheduling an action processor start.
Dec 11 03:53:01 localhost update_engine[480]: [1211/035301:INFO:action_processor.cc(36)] ActionProcessor::StartProcessing: OmahaRequestAction
Dec 11 03:53:01 localhost update_engine[480]: [1211/035301:INFO:omaha_request_action.cc(265)] Posting an Omaha request to https://public.update.core-os.net/v1/update/
Dec 11 03:53:01 localhost update_engine[480]: [1211/035301:INFO:omaha_request_action.cc(266)] Request: <?xml version="1.0" encoding="UTF-8"?>
Dec 11 03:53:01 localhost update_engine[480]: <request protocol="3.0" version="CoreOSUpdateEngine-0.1.0.0" updaterversion="CoreOSUpdateEngine-0.1.0.0" installsource="ondemandupdate" ismachine="1">
Dec 11 03:53:01 localhost update_engine[480]: <os version="Chateau" platform="CoreOS" sp="494.1.0+2014-11-25-2042_x86_64"></os>
Dec 11 03:53:01 localhost update_engine[480]: <app appid="{e96281a6-d1af-4bde-9a0a-97b76e56dc57}" version="494.1.0+2014-11-25-2042" track="beta" bootid="{a65a6bc9-f5d5-4875-9ef5-242a7dc443a3}" oem="niftycloud" oemversion="0.0.1" alephversion="494.1.0+2014-11-25-2042" machineid="3ff5317b97294bc883b4ee970a811099" lang="en-US" board="amd64-usr" hardware_class="" delta_okay="false" >
Dec 11 03:53:01 localhost update_engine[480]: <ping active="1"></ping>
Dec 11 03:53:01 localhost update_engine[480]: <updatecheck targetversionprefix=""></updatecheck>
Dec 11 03:53:01 localhost update_engine[480]: <event eventtype="3" eventresult="2" previousversion=""></event>
Dec 11 03:53:01 localhost update_engine[480]: </app>
Dec 11 03:53:01 localhost update_engine[480]: </request>
Dec 11 03:53:01 localhost update_engine[480]: [1211/035301:INFO:libcurl_http_fetcher.cc(62)] Starting/Resuming transfer
Dec 11 03:53:01 localhost update_engine[480]: [1211/035301:INFO:libcurl_http_fetcher.cc(51)] We are connected via Ethernet, Updates allowed: Yes
Dec 11 03:53:01 localhost update_engine[480]: [1211/035301:INFO:libcurl_http_fetcher.cc(185)] Setting up curl options for HTTPS
Dec 11 03:53:01 localhost update_engine[480]: [1211/035301:INFO:libcurl_http_fetcher.cc(448)] Setting up timeout source: 1 seconds.
Dec 11 03:53:02 localhost update_engine[480]: [1211/035302:INFO:libcurl_http_fetcher.cc(261)] HTTP response code: 200
Dec 11 03:53:02 localhost update_engine[480]: [1211/035302:INFO:libcurl_http_fetcher.cc(318)] Transfer completed (200), 798 bytes downloaded
Dec 11 03:53:02 localhost update_engine[480]: [1211/035302:INFO:omaha_request_action.cc(588)] Omaha request response: <?xml version="1.0" encoding="UTF-8"?>
Dec 11 03:53:02 localhost update_engine[480]: <response protocol="3.0" server="update.core-os.net">
Dec 11 03:53:02 localhost update_engine[480]: <daystart elapsed_seconds="0"></daystart>
Dec 11 03:53:02 localhost update_engine[480]: <app appid="e96281a6-d1af-4bde-9a0a-97b76e56dc57" status="ok">
Dec 11 03:53:02 localhost update_engine[480]: <updatecheck status="ok">
Dec 11 03:53:02 localhost update_engine[480]: <urls>
Dec 11 03:53:02 localhost update_engine[480]: <url codebase="https://commondatastorage.googleapis.com/update-storage.core-os.net/amd64-usr/494.4.0/"></url>
Dec 11 03:53:02 localhost update_engine[480]: </urls>
Dec 11 03:53:02 localhost update_engine[480]: <manifest version="494.4.0">
Dec 11 03:53:02 localhost update_engine[480]: <packages>
Dec 11 03:53:02 localhost update_engine[480]: <package hash="Gj7n536OF5Jboy7hSFWahZKN2yI=" name="update.gz" size="105900786" required="false"></package>
Dec 11 03:53:02 localhost update_engine[480]: </packages>
Dec 11 03:53:02 localhost update_engine[480]: <actions>
Dec 11 03:53:02 localhost update_engine[480]: <action event="postinstall" ChromeOSVersion="" sha256="X6RmmdPf7LUniwFZPQ3wdzSwaXfE8jlZ848DU641MyE=" needsadmin="false" IsDelta="false" DisablePayloadBackoff="true"></action>
Dec 11 03:53:02 localhost update_engine[480]: </actions>
Dec 11 03:53:02 localhost update_engine[480]: </manifest>
Dec 11 03:53:02 localhost update_engine[480]: </updatecheck>
Dec 11 03:53:02 localhost update_engine[480]: </app>
Dec 11 03:53:02 localhost update_engine[480]: </response>
Dec 11 03:53:02 localhost update_engine[480]: [1211/035302:INFO:omaha_request_action.cc(439)] Found 1 url(s)
Dec 11 03:53:02 localhost update_engine[480]: [1211/035302:INFO:omaha_request_action.cc(475)] Processing first of 1 package(s)
Dec 11 03:53:02 localhost update_engine[480]: [1211/035302:INFO:omaha_request_action.cc(482)] Omaha Response package name = update.gz
Dec 11 03:53:02 localhost update_engine[480]: [1211/035302:INFO:omaha_request_action.cc(494)] Url0: https://commondatastorage.googleapis.com/update-storage.core-os.net/amd64-usr/494.4.0/update.gz
Dec 11 03:53:02 localhost update_engine[480]: [1211/035302:INFO:omaha_request_action.cc(506)] Payload size = 105900786 bytes
Dec 11 03:53:02 localhost update_engine[480]: [1211/035302:INFO:omaha_request_action.cc(530)] Found 1 action(s). Processing the postinstall action.
Dec 11 03:53:02 localhost update_engine[480]: [1211/035302:INFO:payload_state.cc(199)] Payload backoff logic is disabled. Can proceed with the download
Dec 11 03:53:02 localhost update_engine[480]: [1211/035302:INFO:action_processor.cc(82)] ActionProcessor::ActionComplete: finished OmahaRequestAction, starting OmahaResponseHandlerAction
Dec 11 03:53:02 localhost update_engine[480]: [1211/035302:INFO:omaha_response_handler_action.cc(43)] Using Url0 as the download url this time
Dec 11 03:53:02 localhost update_engine[480]: [1211/035302:INFO:omaha_response_handler_action.cc(134)] Waiving payload hash checks since Omaha response only has HTTPS URL(s)
Dec 11 03:53:02 localhost update_engine[480]: [1211/035302:ERROR:delta_performer.cc(991)] prefs->GetInt64(kPrefsUpdateStateNextOperation, &next_operation) && next_operation != kUpdateStateOperationInvalid && next_operation > 0 failed.
Dec 11 03:53:02 localhost update_engine[480]: [1211/035302:INFO:omaha_response_handler_action.cc(71)] Using this install plan:
Dec 11 03:53:02 localhost update_engine[480]: [1211/035302:INFO:install_plan.cc(52)] InstallPlan: , new_update, url: https://commondatastorage.googleapis.com/update-storage.core-os.net/amd64-usr/494.4.0/update.gz, payload size: 105900786, payload hash: X6RmmdPf7LUniwFZPQ3wdzSwaXfE8jlZ848DU641MyE=, install_path: /dev/sda4, kernel_install_path: , hash_checks_mandatory: false
Dec 11 03:53:02 localhost update_engine[480]: [1211/035302:INFO:utils.cc(633)] Setting cgroup cpu shares to  2
Dec 11 03:53:02 localhost update_engine[480]: [1211/035302:ERROR:utils.cc(118)] 0 == writer.Open(path, O_WRONLY | O_CREAT | O_TRUNC, 0600) failed: No such file or directory
Dec 11 03:53:02 localhost update_engine[480]: [1211/035302:ERROR:utils.cc(638)] Failed to change cgroup cpu shares to 2 using /sys/fs/cgroup/cpu/update-engine/cpu.shares
Dec 11 03:53:02 localhost update_engine[480]: [1211/035302:INFO:action_processor.cc(82)] ActionProcessor::ActionComplete: finished OmahaResponseHandlerAction, starting FilesystemCopierAction
Dec 11 03:53:02 localhost update_engine[480]: [1211/035302:INFO:filesystem_copier_action.cc(323)] Filesystem size: 1073741824 bytes (262144x4096).
Dec 11 03:53:11 localhost update_engine[480]: [1211/035311:INFO:filesystem_copier_action.cc(283)] Hash: AxGvCGxW8bdaQ3Sgm9DQ00x9gwiILZczM7wFxsBN2g8=
Dec 11 03:53:11 localhost update_engine[480]: [1211/035311:INFO:action_processor.cc(82)] ActionProcessor::ActionComplete: finished FilesystemCopierAction, starting OmahaRequestAction
Dec 11 03:53:11 localhost update_engine[480]: [1211/035311:INFO:omaha_request_action.cc(265)] Posting an Omaha request to https://public.update.core-os.net/v1/update/
Dec 11 03:53:11 localhost update_engine[480]: [1211/035311:INFO:omaha_request_action.cc(266)] Request: <?xml version="1.0" encoding="UTF-8"?>
Dec 11 03:53:11 localhost update_engine[480]: <request protocol="3.0" version="CoreOSUpdateEngine-0.1.0.0" updaterversion="CoreOSUpdateEngine-0.1.0.0" installsource="ondemandupdate" ismachine="1">
Dec 11 03:53:11 localhost update_engine[480]: <os version="Chateau" platform="CoreOS" sp="494.1.0+2014-11-25-2042_x86_64"></os>
Dec 11 03:53:11 localhost update_engine[480]: <app appid="{e96281a6-d1af-4bde-9a0a-97b76e56dc57}" version="494.1.0+2014-11-25-2042" track="beta" bootid="{a65a6bc9-f5d5-4875-9ef5-242a7dc443a3}" oem="niftycloud" oemversion="0.0.1" alephversion="494.1.0+2014-11-25-2042" machineid="3ff5317b97294bc883b4ee970a811099" lang="en-US" board="amd64-usr" hardware_class="" delta_okay="false" >
Dec 11 03:53:11 localhost update_engine[480]: <event eventtype="13" eventresult="1"></event>
Dec 11 03:53:11 localhost update_engine[480]: </app>
Dec 11 03:53:11 localhost update_engine[480]: </request>
Dec 11 03:53:11 localhost update_engine[480]: [1211/035311:INFO:libcurl_http_fetcher.cc(62)] Starting/Resuming transfer
Dec 11 03:53:11 localhost update_engine[480]: [1211/035311:INFO:libcurl_http_fetcher.cc(51)] We are connected via Ethernet, Updates allowed: Yes
Dec 11 03:53:11 localhost update_engine[480]: [1211/035311:INFO:libcurl_http_fetcher.cc(185)] Setting up curl options for HTTPS
Dec 11 03:53:12 localhost update_engine[480]: [1211/035312:INFO:libcurl_http_fetcher.cc(448)] Setting up timeout source: 1 seconds.
Dec 11 03:53:12 localhost update_engine[480]: [1211/035312:INFO:libcurl_http_fetcher.cc(261)] HTTP response code: 200
Dec 11 03:53:12 localhost update_engine[480]: [1211/035312:INFO:libcurl_http_fetcher.cc(318)] Transfer completed (200), 798 bytes downloaded
Dec 11 03:53:12 localhost update_engine[480]: [1211/035312:INFO:omaha_request_action.cc(588)] Omaha request response: <?xml version="1.0" encoding="UTF-8"?>
Dec 11 03:53:12 localhost update_engine[480]: <response protocol="3.0" server="update.core-os.net">
Dec 11 03:53:12 localhost update_engine[480]: <daystart elapsed_seconds="0"></daystart>
Dec 11 03:53:12 localhost update_engine[480]: <app appid="e96281a6-d1af-4bde-9a0a-97b76e56dc57" status="ok">
Dec 11 03:53:12 localhost update_engine[480]: <updatecheck status="ok">
Dec 11 03:53:12 localhost update_engine[480]: <urls>
Dec 11 03:53:12 localhost update_engine[480]: <url codebase="https://commondatastorage.googleapis.com/update-storage.core-os.net/amd64-usr/494.4.0/"></url>
Dec 11 03:53:12 localhost update_engine[480]: </urls>
Dec 11 03:53:12 localhost update_engine[480]: <manifest version="494.4.0">
Dec 11 03:53:12 localhost update_engine[480]: <packages>
Dec 11 03:53:12 localhost update_engine[480]: <package hash="Gj7n536OF5Jboy7hSFWahZKN2yI=" name="update.gz" size="105900786" required="false"></package>
Dec 11 03:53:12 localhost update_engine[480]: </packages>
Dec 11 03:53:12 localhost update_engine[480]: <actions>
Dec 11 03:53:12 localhost update_engine[480]: <action event="postinstall" ChromeOSVersion="" sha256="X6RmmdPf7LUniwFZPQ3wdzSwaXfE8jlZ848DU641MyE=" needsadmin="false" IsDelta="false" DisablePayloadBackoff="true"></action>
Dec 11 03:53:12 localhost update_engine[480]: </actions>
Dec 11 03:53:12 localhost update_engine[480]: </manifest>
Dec 11 03:53:12 localhost update_engine[480]: </updatecheck>
Dec 11 03:53:12 localhost update_engine[480]: </app>
Dec 11 03:53:12 localhost update_engine[480]: </response>
Dec 11 03:53:12 localhost update_engine[480]: [1211/035312:INFO:action_processor.cc(82)] ActionProcessor::ActionComplete: finished OmahaRequestAction, starting DownloadAction
Dec 11 03:53:12 localhost update_engine[480]: [1211/035312:INFO:install_plan.cc(52)] InstallPlan: , new_update, url: https://commondatastorage.googleapis.com/update-storage.core-os.net/amd64-usr/494.4.0/update.gz, payload size: 105900786, payload hash: X6RmmdPf7LUniwFZPQ3wdzSwaXfE8jlZ848DU641MyE=, install_path: /dev/sda4, kernel_install_path: , hash_checks_mandatory: false
Dec 11 03:53:12 localhost update_engine[480]: [1211/035312:INFO:update_attempter.cc(597)] Download status: active
Dec 11 03:53:12 localhost update_engine[480]: [1211/035312:INFO:multi_range_http_fetcher.cc(29)] starting first transfer
Dec 11 03:53:12 localhost update_engine[480]: [1211/035312:INFO:multi_range_http_fetcher.cc(57)] starting transfer of range 0+?
Dec 11 03:53:12 localhost update_engine[480]: [1211/035312:INFO:libcurl_http_fetcher.cc(62)] Starting/Resuming transfer
Dec 11 03:53:12 localhost update_engine[480]: [1211/035312:INFO:libcurl_http_fetcher.cc(51)] We are connected via Ethernet, Updates allowed: Yes
Dec 11 03:53:12 localhost update_engine[480]: [1211/035312:INFO:libcurl_http_fetcher.cc(185)] Setting up curl options for HTTPS
Dec 11 03:53:13 localhost update_engine[480]: [1211/035313:INFO:libcurl_http_fetcher.cc(448)] Setting up timeout source: 1 seconds.
Dec 11 03:53:13 localhost update_engine[480]: [1211/035313:INFO:delta_performer.cc(153)] Completed 0/? operations, 676/105900786 bytes downloaded (0%), overall progress 0%
Dec 11 03:53:13 localhost update_engine[480]: [1211/035313:INFO:delta_performer.cc(277)] PartitionInfo new_rootfs_info sha256: ewxAuWS4+Hzlmc3mfPXbe8j/rVVSQsMLLGYWHvd88FY= size: 1073741824
Dec 11 03:53:13 localhost update_engine[480]: [1211/035313:INFO:delta_performer.cc(940)] Verifying source partitions.
Dec 11 03:53:13 localhost update_engine[480]: [1211/035313:INFO:delta_performer.cc(404)] Starting to apply update payload operations
Dec 11 03:53:14 localhost update_engine[480]: [1211/035314:INFO:delta_performer.cc(153)] Completed 25/1025 operations (2%), 19078311/105900786 bytes downloaded (18%), overall progress 10%
Dec 11 03:53:15 localhost update_engine[480]: [1211/035315:INFO:delta_performer.cc(153)] Completed 136/1025 operations (13%), 29662375/105900786 bytes downloaded (28%), overall progress 20%
Dec 11 03:53:16 localhost update_engine[480]: [1211/035316:INFO:delta_performer.cc(153)] Completed 269/1025 operations (26%), 36019367/105900786 bytes downloaded (34%), overall progress 30%
Dec 11 03:53:18 localhost update_engine[480]: [1211/035318:INFO:delta_performer.cc(153)] Completed 349/1025 operations (34%), 50044071/105900786 bytes downloaded (47%), overall progress 40%
Dec 11 03:53:19 localhost update_engine[480]: [1211/035319:INFO:delta_performer.cc(153)] Completed 492/1025 operations (48%), 56007847/105900786 bytes downloaded (52%), overall progress 50%
Dec 11 03:53:20 localhost update_engine[480]: [1211/035320:INFO:delta_performer.cc(153)] Completed 636/1025 operations (62%), 61676711/105900786 bytes downloaded (58%), overall progress 60%
Dec 11 03:53:22 localhost update_engine[480]: [1211/035322:INFO:delta_performer.cc(153)] Completed 759/1025 operations (74%), 70278311/105900786 bytes downloaded (66%), overall progress 70%
Dec 11 03:53:24 localhost update_engine[480]: [1211/035324:INFO:delta_performer.cc(153)] Completed 828/1025 operations (80%), 84728999/105900786 bytes downloaded (80%), overall progress 80%
Dec 11 03:53:25 localhost update_engine[480]: [1211/035325:INFO:delta_performer.cc(153)] Completed 932/1025 operations (90%), 95313063/105900786 bytes downloaded (90%), overall progress 90%
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:delta_performer.cc(767)] Skipping hash verification for signature operation 1025
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:delta_performer.cc(738)] Extracted signature data of size 528 at 105844204
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:delta_performer.cc(153)] Completed 1025/1025 operations (100%), 105900786/105900786 bytes downloaded (100%), overall progress 100%
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:libcurl_http_fetcher.cc(261)] HTTP response code: 200
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:libcurl_http_fetcher.cc(318)] Transfer completed (200), 105900786 bytes downloaded
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:multi_range_http_fetcher.cc(150)] Received transfer complete.
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:multi_range_http_fetcher.cc(107)] TransferEnded w/ code 200
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:multi_range_http_fetcher.cc(141)] Done w/ all transfers
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:update_attempter.cc(597)] Download status: inactive
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:delta_performer.cc(821)] Verifying delta payload using public key: /usr/share/update_engine/update-payload-key.pub.pem
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:payload_signer.cc(265)] signature size = 528
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:ERROR:delta_performer.cc(858)] Public key verification failed, thus update failed. Attached Signature:
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(251)] Logging array of length: 256
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(268)] 0x00000000 : 9e d2 21 81 5a 2d 13 63 29 8a 81 ef c8 46 59 42
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(268)] 0x00000010 : 6f f3 e5 3b 37 8c 60 c8 65 20 0e 48 55 32 27 7d
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(268)] 0x00000020 : c2 80 76 00 16 54 e3 80 0c 89 02 3c f8 16 24 a2
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(268)] 0x00000030 : d0 d6 79 d5 d7 2e 2d 4a d9 2b a4 41 25 e8 94 dc
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(268)] 0x00000040 : 28 43 a6 75 b7 9a f3 b9 bb 31 c9 b0 1e 75 56 78
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(268)] 0x00000050 : f1 23 6c 88 ae f1 91 a1 fd db 84 20 b6 6f 0b 89
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(268)] 0x00000060 : 8e 1d 69 42 45 4b 94 ba e9 9a 8b 4d 45 c8 fb a6
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(268)] 0x00000070 : 6f 91 f9 d9 3b 39 c7 96 0b 31 f4 82 1d 73 04 af
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(268)] 0x00000080 : 4e 5d 88 cb 9c 71 d2 04 e0 66 04 1f 55 9c 36 46
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(268)] 0x00000090 : 59 16 52 52 6c fc ab 05 1b ec c6 6c 52 11 55 59
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(268)] 0x000000a0 : 2d 4f aa bb 11 03 6e d0 cb 7a 13 13 9e c0 01 82
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(268)] 0x000000b0 : 60 63 87 64 96 00 5e e0 52 56 25 21 5a 7e f5 a4
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(268)] 0x000000c0 : e2 5f 46 18 54 be 83 ac cc 80 26 75 6f 90 52 45
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(268)] 0x000000d0 : b1 4f b9 aa 9b 7d 6a ff fd e4 4f 8f ea 38 95 15
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(268)] 0x000000e0 : 9e b3 06 a5 8e e2 c8 20 5d 79 64 f7 33 c8 c6 eb
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(268)] 0x000000f0 : 92 7c 8a 6a 77 13 a9 49 5c 15 59 fb aa 16 2e 37
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:ERROR:delta_performer.cc(861)] Computed Signature:
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(251)] Logging array of length: 256
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(268)] 0x00000000 : 00 01 ff ff ff ff ff ff ff ff ff ff ff ff ff ff
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(268)] 0x00000010 : ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(268)] 0x00000020 : ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(268)] 0x00000030 : ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(268)] 0x00000040 : ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(268)] 0x00000050 : ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(268)] 0x00000060 : ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(268)] 0x00000070 : ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(268)] 0x00000080 : ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(268)] 0x00000090 : ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(268)] 0x000000a0 : ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(268)] 0x000000b0 : ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff ff
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(268)] 0x000000c0 : ff ff ff ff ff ff ff ff ff ff ff ff 00 30 31 30
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(268)] 0x000000d0 : 0d 06 09 60 86 48 01 65 03 04 02 01 05 00 04 20
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(268)] 0x000000e0 : 8a 72 96 14 8d 49 ab 39 82 87 5b 59 0f 75 86 b7
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:utils.cc(268)] 0x000000f0 : 83 29 ab 4e f5 d0 6f c3 a4 d6 9d 57 56 c3 da fb
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:ERROR:download_action.cc(118)] Download of https://commondatastorage.googleapis.com/update-storage.core-os.net/amd64-usr/494.4.0/update.gz failed due to payload verification error.
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:action_processor.cc(68)] ActionProcessor::ActionComplete: DownloadAction action failed. Aborting processing.
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:action_processor.cc(73)] ActionProcessor::ActionComplete: finished last action of type DownloadAction
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:update_attempter.cc(460)] Processing Done.
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:ERROR:update_attempter.cc(787)] Update failed.
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:payload_state.cc(97)] Updating payload state for error code: 18 (kActionCodeDownloadPayloadPubKeyVerificationError)
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:payload_state.cc(257)] Resetting the current URL index (0) to 0 as we only have 1 URL(s)
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:payload_state.cc(400)] Current URL Index = 0
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:payload_state.cc(246)] Incrementing the payload attempt number
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:payload_state.cc(377)] Payload Attempt Number = 5
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:payload_state.cc(282)] Resetting backoff expiry time as payload backoff is disabled
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:payload_state.cc(448)] Backoff Expiry Time = 1/1/1601 0:00:00 GMT
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:payload_state.cc(421)] Current URL (Url0)'s Failure Count = 0
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:action_processor.cc(36)] ActionProcessor::StartProcessing: OmahaRequestAction
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:omaha_request_action.cc(265)] Posting an Omaha request to https://public.update.core-os.net/v1/update/
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:omaha_request_action.cc(266)] Request: <?xml version="1.0" encoding="UTF-8"?>
Dec 11 03:53:27 localhost update_engine[480]: <request protocol="3.0" version="CoreOSUpdateEngine-0.1.0.0" updaterversion="CoreOSUpdateEngine-0.1.0.0" installsource="ondemandupdate" ismachine="1">
Dec 11 03:53:27 localhost update_engine[480]: <os version="Chateau" platform="CoreOS" sp="494.1.0+2014-11-25-2042_x86_64"></os>
Dec 11 03:53:27 localhost update_engine[480]: <app appid="{e96281a6-d1af-4bde-9a0a-97b76e56dc57}" version="494.1.0+2014-11-25-2042" track="beta" bootid="{a65a6bc9-f5d5-4875-9ef5-242a7dc443a3}" oem="niftycloud" oemversion="0.0.1" alephversion="494.1.0+2014-11-25-2042" machineid="3ff5317b97294bc883b4ee970a811099" lang="en-US" board="amd64-usr" hardware_class="" delta_okay="false" >
Dec 11 03:53:27 localhost update_engine[480]: <event eventtype="3" eventresult="0" errorcode="18"></event>
Dec 11 03:53:27 localhost update_engine[480]: </app>
Dec 11 03:53:27 localhost update_engine[480]: </request>
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:libcurl_http_fetcher.cc(62)] Starting/Resuming transfer
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:libcurl_http_fetcher.cc(51)] We are connected via Ethernet, Updates allowed: Yes
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:libcurl_http_fetcher.cc(185)] Setting up curl options for HTTPS
Dec 11 03:53:27 localhost update_engine[480]: [1211/035327:INFO:libcurl_http_fetcher.cc(448)] Setting up timeout source: 1 seconds.
Dec 11 03:53:28 localhost update_engine[480]: [1211/035328:INFO:libcurl_http_fetcher.cc(261)] HTTP response code: 200
Dec 11 03:53:28 localhost update_engine[480]: [1211/035328:INFO:libcurl_http_fetcher.cc(318)] Transfer completed (200), 798 bytes downloaded
Dec 11 03:53:28 localhost update_engine[480]: [1211/035328:INFO:omaha_request_action.cc(588)] Omaha request response: <?xml version="1.0" encoding="UTF-8"?>
Dec 11 03:53:28 localhost update_engine[480]: <response protocol="3.0" server="update.core-os.net">
Dec 11 03:53:28 localhost update_engine[480]: <daystart elapsed_seconds="0"></daystart>
Dec 11 03:53:28 localhost update_engine[480]: <app appid="e96281a6-d1af-4bde-9a0a-97b76e56dc57" status="ok">
Dec 11 03:53:28 localhost update_engine[480]: <updatecheck status="ok">
Dec 11 03:53:28 localhost update_engine[480]: <urls>
Dec 11 03:53:28 localhost update_engine[480]: <url codebase="https://commondatastorage.googleapis.com/update-storage.core-os.net/amd64-usr/494.4.0/"></url>
Dec 11 03:53:28 localhost update_engine[480]: </urls>
Dec 11 03:53:28 localhost update_engine[480]: <manifest version="494.4.0">
Dec 11 03:53:28 localhost update_engine[480]: <packages>
Dec 11 03:53:28 localhost update_engine[480]: <package hash="Gj7n536OF5Jboy7hSFWahZKN2yI=" name="update.gz" size="105900786" required="false"></package>
Dec 11 03:53:28 localhost update_engine[480]: </packages>
Dec 11 03:53:28 localhost update_engine[480]: <actions>
Dec 11 03:53:28 localhost update_engine[480]: <action event="postinstall" ChromeOSVersion="" sha256="X6RmmdPf7LUniwFZPQ3wdzSwaXfE8jlZ848DU641MyE=" needsadmin="false" IsDelta="false" DisablePayloadBackoff="true"></action>
Dec 11 03:53:28 localhost update_engine[480]: </actions>
Dec 11 03:53:28 localhost update_engine[480]: </manifest>
Dec 11 03:53:28 localhost update_engine[480]: </updatecheck>
Dec 11 03:53:28 localhost update_engine[480]: </app>
Dec 11 03:53:28 localhost update_engine[480]: </response>
Dec 11 03:53:28 localhost update_engine[480]: [1211/035328:ERROR:omaha_request_action.cc(595)] HTTP reported success but Omaha reports an error.
Dec 11 03:53:28 localhost update_engine[480]: [1211/035328:INFO:action_processor.cc(65)] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction
Dec 11 03:53:28 localhost update_engine[480]: [1211/035328:INFO:action_processor.cc(73)] ActionProcessor::ActionComplete: finished last action of type OmahaRequestAction
Dec 11 03:53:28 localhost update_engine[480]: [1211/035328:INFO:update_attempter.cc(460)] Processing Done.
Dec 11 03:53:28 localhost update_engine[480]: [1211/035328:INFO:update_attempter.cc(467)] Error event sent.