[01:42:58.595] New invocation is queued and will start shortly
[01:42:59.729] Starting the invocation (attempt 1)
[01:42:59.774] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:42:59.774] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:42:59.774] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029669243983825984",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3cbfc83376573e7cbab9122824d3be3e415cbc15\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9029669243983825984",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/3cbfc83376573e7cbab9122824d3be3e415cbc15",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3cbfc83376573e7cbab9122824d3be3e415cbc15",
"gitiles_ref:refs/heads/master"
]
}
[01:43:00.725] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604799779870568",
"id": "8864239181981634912",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3cbfc83376573e7cbab9122824d3be3e415cbc15\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604799780549446",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42678",
"builder:linux-chromeos-rel",
"buildset:commit/git/3cbfc83376573e7cbab9122824d3be3e415cbc15",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3cbfc83376573e7cbab9122824d3be3e415cbc15",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029669243983825984",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8864239181981634912/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1604799780549706",
"url": "https://ci.chromium.org/b/8864239181981634912",
"utcnow_ts": "1604799780717741"
}
}
[01:43:00.725] Task URL: https://ci.chromium.org/b/8864239181981634912
[01:43:00.725] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:2:0) after 1m0s
[01:44:01.064] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:2:0)
[01:44:01.064] Timer tick, asking Buildbucket for the build status
[01:44:01.244] Build 8864239181981634912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:44:01.244] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:3:0) after 1m0s
[01:45:01.268] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:3:0)
[01:45:01.268] Timer tick, asking Buildbucket for the build status
[01:45:01.353] Build 8864239181981634912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:45:01.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:4:0) after 1m0s
[01:46:01.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:4:0)
[01:46:01.454] Timer tick, asking Buildbucket for the build status
[01:46:01.590] Build 8864239181981634912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:46:01.590] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:5:0) after 1m0s
[01:47:01.741] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:5:0)
[01:47:01.741] Timer tick, asking Buildbucket for the build status
[01:47:03.700] Build 8864239181981634912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:47:03.700] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:6:0) after 1m0s
[01:48:03.823] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:6:0)
[01:48:03.823] Timer tick, asking Buildbucket for the build status
[01:48:03.926] Build 8864239181981634912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:48:03.926] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:7:0) after 1m0s
[01:49:04.019] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:7:0)
[01:49:04.019] Timer tick, asking Buildbucket for the build status
[01:49:04.200] Build 8864239181981634912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:49:04.200] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:8:0) after 1m0s
[01:50:04.267] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:8:0)
[01:50:04.267] Timer tick, asking Buildbucket for the build status
[01:50:04.375] Build 8864239181981634912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:50:04.375] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:9:0) after 1m0s
[01:51:04.395] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:9:0)
[01:51:04.395] Timer tick, asking Buildbucket for the build status
[01:51:04.475] Build 8864239181981634912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:51:04.475] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:10:0) after 1m0s
[01:52:04.589] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:10:0)
[01:52:04.589] Timer tick, asking Buildbucket for the build status
[01:52:04.754] Build 8864239181981634912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:52:04.755] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:11:0) after 1m0s
[01:53:04.793] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:11:0)
[01:53:04.793] Timer tick, asking Buildbucket for the build status
[01:53:04.942] Build 8864239181981634912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:53:04.942] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:12:0) after 1m0s
[01:54:04.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:12:0)
[01:54:04.975] Timer tick, asking Buildbucket for the build status
[01:54:05.080] Build 8864239181981634912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:54:05.080] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:13:0) after 1m0s
[01:55:05.105] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:13:0)
[01:55:05.105] Timer tick, asking Buildbucket for the build status
[01:55:05.184] Build 8864239181981634912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:55:05.184] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:14:0) after 1m0s
[01:56:05.284] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:14:0)
[01:56:05.284] Timer tick, asking Buildbucket for the build status
[01:56:05.369] Build 8864239181981634912: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:56:05.369] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:15:0) after 1m0s
[01:56:37.243] Received PubSub notification, asking Buildbucket for the build status
[01:56:37.442] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:05.390] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:15:0)
[01:57:05.390] Timer tick, asking Buildbucket for the build status
[01:57:09.891] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:09.891] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:17:0) after 1m0s
[01:58:10.047] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:17:0)
[01:58:10.047] Timer tick, asking Buildbucket for the build status
[01:58:10.160] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:10.160] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:18:0) after 1m0s
[01:59:10.333] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:18:0)
[01:59:10.333] Timer tick, asking Buildbucket for the build status
[01:59:10.448] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:10.448] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:19:0) after 1m0s
[02:00:10.539] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:19:0)
[02:00:10.539] Timer tick, asking Buildbucket for the build status
[02:00:10.675] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:10.675] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:20:0) after 1m0s
[02:01:10.749] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:20:0)
[02:01:10.749] Timer tick, asking Buildbucket for the build status
[02:01:10.857] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:10.857] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:21:0) after 1m0s
[02:02:11.004] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:21:0)
[02:02:11.004] Timer tick, asking Buildbucket for the build status
[02:02:11.074] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:11.074] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:22:0) after 1m0s
[02:03:11.199] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:22:0)
[02:03:11.199] Timer tick, asking Buildbucket for the build status
[02:03:11.302] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:11.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:23:0) after 1m0s
[02:04:11.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:23:0)
[02:04:11.363] Timer tick, asking Buildbucket for the build status
[02:04:11.449] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:11.449] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:24:0) after 1m0s
[02:05:11.481] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:24:0)
[02:05:11.481] Timer tick, asking Buildbucket for the build status
[02:05:11.542] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:11.542] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:25:0) after 1m0s
[02:06:11.591] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:25:0)
[02:06:11.591] Timer tick, asking Buildbucket for the build status
[02:06:11.705] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:11.705] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:26:0) after 1m0s
[02:07:11.821] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:26:0)
[02:07:11.821] Timer tick, asking Buildbucket for the build status
[02:07:11.906] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:11.906] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:27:0) after 1m0s
[02:08:12.019] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:27:0)
[02:08:12.019] Timer tick, asking Buildbucket for the build status
[02:08:12.987] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:12.987] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:28:0) after 1m0s
[02:09:13.013] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:28:0)
[02:09:13.013] Timer tick, asking Buildbucket for the build status
[02:09:13.082] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:13.082] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:29:0) after 1m0s
[02:10:13.163] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:29:0)
[02:10:13.163] Timer tick, asking Buildbucket for the build status
[02:10:13.312] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:13.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:30:0) after 1m0s
[02:11:13.323] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:30:0)
[02:11:13.323] Timer tick, asking Buildbucket for the build status
[02:11:13.410] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:13.410] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:31:0) after 1m0s
[02:12:13.480] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:31:0)
[02:12:13.480] Timer tick, asking Buildbucket for the build status
[02:12:13.584] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:13.584] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:32:0) after 1m0s
[02:13:13.657] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:32:0)
[02:13:13.657] Timer tick, asking Buildbucket for the build status
[02:13:13.770] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:13.770] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:33:0) after 1m0s
[02:14:13.790] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:33:0)
[02:14:13.790] Timer tick, asking Buildbucket for the build status
[02:14:13.914] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:13.914] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:34:0) after 1m0s
[02:15:13.893] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:34:0)
[02:15:13.893] Timer tick, asking Buildbucket for the build status
[02:15:13.957] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:13.957] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:35:0) after 1m0s
[02:16:13.986] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:35:0)
[02:16:13.986] Timer tick, asking Buildbucket for the build status
[02:16:14.051] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:14.051] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:36:0) after 1m0s
[02:17:14.110] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:36:0)
[02:17:14.110] Timer tick, asking Buildbucket for the build status
[02:17:15.933] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:15.933] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:37:0) after 1m0s
[02:18:16.085] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:37:0)
[02:18:16.085] Timer tick, asking Buildbucket for the build status
[02:18:16.201] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:16.201] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:38:0) after 1m0s
[02:19:16.344] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:38:0)
[02:19:16.344] Timer tick, asking Buildbucket for the build status
[02:19:16.442] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:16.442] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:39:0) after 1m0s
[02:20:16.472] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:39:0)
[02:20:16.472] Timer tick, asking Buildbucket for the build status
[02:20:16.564] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:16.564] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:40:0) after 1m0s
[02:21:16.614] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:40:0)
[02:21:16.614] Timer tick, asking Buildbucket for the build status
[02:21:16.731] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:16.731] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:41:0) after 1m0s
[02:22:16.764] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:41:0)
[02:22:16.764] Timer tick, asking Buildbucket for the build status
[02:22:16.873] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:16.873] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:42:0) after 1m0s
[02:23:16.935] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:42:0)
[02:23:16.935] Timer tick, asking Buildbucket for the build status
[02:23:17.062] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:17.062] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:43:0) after 1m0s
[02:24:17.097] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:43:0)
[02:24:17.097] Timer tick, asking Buildbucket for the build status
[02:24:17.161] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:17.161] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:44:0) after 1m0s
[02:25:17.235] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:44:0)
[02:25:17.235] Timer tick, asking Buildbucket for the build status
[02:25:17.294] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:17.294] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:45:0) after 1m0s
[02:26:17.312] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:45:0)
[02:26:17.312] Timer tick, asking Buildbucket for the build status
[02:26:17.472] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:17.473] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:46:0) after 1m0s
[02:27:17.494] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:46:0)
[02:27:17.494] Timer tick, asking Buildbucket for the build status
[02:27:18.020] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:18.020] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:47:0) after 1m0s
[02:28:18.093] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:47:0)
[02:28:18.093] Timer tick, asking Buildbucket for the build status
[02:28:18.266] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:18.266] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:48:0) after 1m0s
[02:29:18.420] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:48:0)
[02:29:18.420] Timer tick, asking Buildbucket for the build status
[02:29:18.502] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:18.502] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:49:0) after 1m0s
[02:30:18.569] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:49:0)
[02:30:18.569] Timer tick, asking Buildbucket for the build status
[02:30:18.633] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:18.633] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:50:0) after 1m0s
[02:31:18.655] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:50:0)
[02:31:18.655] Timer tick, asking Buildbucket for the build status
[02:31:18.913] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:18.914] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:51:0) after 1m0s
[02:32:18.967] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:51:0)
[02:32:18.967] Timer tick, asking Buildbucket for the build status
[02:32:19.047] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:19.047] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:52:0) after 1m0s
[02:33:19.071] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:52:0)
[02:33:19.071] Timer tick, asking Buildbucket for the build status
[02:33:19.216] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:19.216] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:53:0) after 1m0s
[02:34:19.275] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:53:0)
[02:34:19.276] Timer tick, asking Buildbucket for the build status
[02:34:19.354] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:19.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:54:0) after 1m0s
[02:35:19.425] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:54:0)
[02:35:19.425] Timer tick, asking Buildbucket for the build status
[02:35:19.485] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:19.485] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:55:0) after 1m0s
[02:36:19.525] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:55:0)
[02:36:19.525] Timer tick, asking Buildbucket for the build status
[02:36:19.599] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:19.599] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:56:0) after 1m0s
[02:37:19.626] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:56:0)
[02:37:19.626] Timer tick, asking Buildbucket for the build status
[02:37:20.517] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:20.518] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:57:0) after 1m0s
[02:38:20.504] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:57:0)
[02:38:20.504] Timer tick, asking Buildbucket for the build status
[02:38:20.603] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:20.603] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:58:0) after 1m0s
[02:39:20.631] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:58:0)
[02:39:20.631] Timer tick, asking Buildbucket for the build status
[02:39:20.937] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:20.937] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:59:0) after 1m0s
[02:40:21.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:59:0)
[02:40:21.007] Timer tick, asking Buildbucket for the build status
[02:40:21.092] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:21.092] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:60:0) after 1m0s
[02:41:21.077] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:60:0)
[02:41:21.077] Timer tick, asking Buildbucket for the build status
[02:41:21.175] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:21.175] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:61:0) after 1m0s
[02:42:21.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:61:0)
[02:42:21.198] Timer tick, asking Buildbucket for the build status
[02:42:21.268] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:21.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:62:0) after 1m0s
[02:43:21.720] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:62:0)
[02:43:21.720] Timer tick, asking Buildbucket for the build status
[02:43:22.111] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:22.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:63:0) after 1m0s
[02:44:22.416] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:63:0)
[02:44:22.416] Timer tick, asking Buildbucket for the build status
[02:44:22.479] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:22.479] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:64:0) after 1m0s
[02:45:22.619] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:64:0)
[02:45:22.619] Timer tick, asking Buildbucket for the build status
[02:45:22.681] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:22.681] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:65:0) after 1m0s
[02:46:22.966] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:65:0)
[02:46:22.966] Timer tick, asking Buildbucket for the build status
[02:46:23.033] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:23.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:66:0) after 1m0s
[02:47:23.521] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:66:0)
[02:47:23.521] Timer tick, asking Buildbucket for the build status
[02:47:23.629] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:23.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:67:0) after 1m0s
[02:48:27.994] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:67:0)
[02:48:27.994] Timer tick, asking Buildbucket for the build status
[02:48:28.093] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:28.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:68:0) after 1m0s
[02:49:28.115] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:68:0)
[02:49:28.115] Timer tick, asking Buildbucket for the build status
[02:49:28.418] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:28.418] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:69:0) after 1m0s
[02:50:28.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:69:0)
[02:50:28.467] Timer tick, asking Buildbucket for the build status
[02:50:28.617] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:28.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:70:0) after 1m0s
[02:51:28.628] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:70:0)
[02:51:28.628] Timer tick, asking Buildbucket for the build status
[02:51:28.945] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:28.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:71:0) after 1m0s
[02:52:28.971] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:71:0)
[02:52:28.971] Timer tick, asking Buildbucket for the build status
[02:52:29.147] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:29.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:72:0) after 1m0s
[02:53:29.169] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:72:0)
[02:53:29.169] Timer tick, asking Buildbucket for the build status
[02:53:29.266] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:29.266] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:73:0) after 1m0s
[02:54:29.288] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:73:0)
[02:54:29.288] Timer tick, asking Buildbucket for the build status
[02:54:29.354] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:29.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:74:0) after 1m0s
[02:55:29.380] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:74:0)
[02:55:29.380] Timer tick, asking Buildbucket for the build status
[02:55:29.437] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:29.437] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:75:0) after 1m0s
[02:56:29.483] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:75:0)
[02:56:29.483] Timer tick, asking Buildbucket for the build status
[02:56:29.653] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:29.654] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:76:0) after 1m0s
[02:57:29.676] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:76:0)
[02:57:29.676] Timer tick, asking Buildbucket for the build status
[02:57:29.874] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:29.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:77:0) after 1m0s
[02:58:29.943] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:77:0)
[02:58:29.943] Timer tick, asking Buildbucket for the build status
[02:58:30.065] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:30.065] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:78:0) after 1m0s
[02:59:30.100] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:78:0)
[02:59:30.100] Timer tick, asking Buildbucket for the build status
[02:59:30.290] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:30.290] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:79:0) after 1m0s
[03:00:30.373] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:79:0)
[03:00:30.373] Timer tick, asking Buildbucket for the build status
[03:00:30.541] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:30.541] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:80:0) after 1m0s
[03:01:30.563] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:80:0)
[03:01:30.563] Timer tick, asking Buildbucket for the build status
[03:01:31.760] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:31.760] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:81:0) after 1m0s
[03:02:31.785] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:81:0)
[03:02:31.785] Timer tick, asking Buildbucket for the build status
[03:02:31.854] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:31.854] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:82:0) after 1m0s
[03:03:31.881] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:82:0)
[03:03:31.881] Timer tick, asking Buildbucket for the build status
[03:03:32.108] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:32.108] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:83:0) after 1m0s
[03:04:32.137] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:83:0)
[03:04:32.137] Timer tick, asking Buildbucket for the build status
[03:04:32.206] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:32.206] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:84:0) after 1m0s
[03:05:32.243] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:84:0)
[03:05:32.243] Timer tick, asking Buildbucket for the build status
[03:05:32.615] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:32.615] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:85:0) after 1m0s
[03:06:32.662] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:85:0)
[03:06:32.662] Timer tick, asking Buildbucket for the build status
[03:06:32.749] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:32.749] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:86:0) after 1m0s
[03:07:32.774] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:86:0)
[03:07:32.774] Timer tick, asking Buildbucket for the build status
[03:07:32.889] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:32.889] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:87:0) after 1m0s
[03:08:32.915] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:87:0)
[03:08:32.915] Timer tick, asking Buildbucket for the build status
[03:08:33.457] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:33.457] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:88:0) after 1m0s
[03:09:33.481] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:88:0)
[03:09:33.481] Timer tick, asking Buildbucket for the build status
[03:09:33.582] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:33.582] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:89:0) after 1m0s
[03:10:33.621] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:89:0)
[03:10:33.621] Timer tick, asking Buildbucket for the build status
[03:10:33.776] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:33.776] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:90:0) after 1m0s
[03:11:33.852] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:90:0)
[03:11:33.852] Timer tick, asking Buildbucket for the build status
[03:11:35.535] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:35.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:91:0) after 1m0s
[03:12:35.666] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:91:0)
[03:12:35.666] Timer tick, asking Buildbucket for the build status
[03:12:35.851] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:35.851] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:92:0) after 1m0s
[03:13:35.926] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:92:0)
[03:13:35.926] Timer tick, asking Buildbucket for the build status
[03:13:36.095] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:36.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:93:0) after 1m0s
[03:14:36.219] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:93:0)
[03:14:36.219] Timer tick, asking Buildbucket for the build status
[03:14:36.501] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:36.501] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:94:0) after 1m0s
[03:15:36.500] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:94:0)
[03:15:36.500] Timer tick, asking Buildbucket for the build status
[03:15:36.649] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:36.649] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:95:0) after 1m0s
[03:16:36.705] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:95:0)
[03:16:36.705] Timer tick, asking Buildbucket for the build status
[03:16:36.998] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:36.998] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:96:0) after 1m0s
[03:17:37.030] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:96:0)
[03:17:37.030] Timer tick, asking Buildbucket for the build status
[03:17:37.216] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:37.216] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:97:0) after 1m0s
[03:18:37.306] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:97:0)
[03:18:37.306] Timer tick, asking Buildbucket for the build status
[03:18:37.466] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:37.466] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:98:0) after 1m0s
[03:19:37.462] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:98:0)
[03:19:37.462] Timer tick, asking Buildbucket for the build status
[03:19:37.919] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:37.919] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:99:0) after 1m0s
[03:20:37.956] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:99:0)
[03:20:37.956] Timer tick, asking Buildbucket for the build status
[03:20:38.319] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:38.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:100:0) after 1m0s
[03:21:38.398] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:100:0)
[03:21:38.398] Timer tick, asking Buildbucket for the build status
[03:21:38.573] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:38.573] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:101:0) after 1m0s
[03:22:38.636] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:101:0)
[03:22:38.636] Timer tick, asking Buildbucket for the build status
[03:22:38.776] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:38.776] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:102:0) after 1m0s
[03:23:38.862] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:102:0)
[03:23:38.862] Timer tick, asking Buildbucket for the build status
[03:23:38.974] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:38.974] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:103:0) after 1m0s
[03:24:39.036] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:103:0)
[03:24:39.036] Timer tick, asking Buildbucket for the build status
[03:24:39.167] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:39.167] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:104:0) after 1m0s
[03:25:39.188] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:104:0)
[03:25:39.188] Timer tick, asking Buildbucket for the build status
[03:25:39.309] Build 8864239181981634912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:39.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029669243983825984:105:0) after 1m0s
[03:26:24.375] Received PubSub notification, asking Buildbucket for the build status
[03:26:24.574] Build 8864239181981634912: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:26:24.574] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604805982431720",
"created_by": "project:chromium",
"created_ts": "1604799779870568",
"id": "8864239181981634912",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3cbfc83376573e7cbab9122824d3be3e415cbc15\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"3cbfc83376573e7cbab9122824d3be3e415cbc15\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-13-ig3h\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 42678, \"got_angle_revision\": \"aca3d408105d03683edd20b98b333c5064ac5254\", \"got_dawn_revision\": \"3e17e33724b4d0b4c4fc1985340882e1f543e3a0\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"3cbfc83376573e7cbab9122824d3be3e415cbc15\", \"got_revision_cp\": \"refs/heads/master@{#825207}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"4ed9d3498dcffa987acba1a8007ff8dec336f263\", \"got_v8_revision\": \"4075f123295bb39d50e472b7af1fc04d4f4fe228\", \"got_v8_revision_cp\": \"refs/heads/8.8.250@{#1}\", \"got_webrtc_revision\": \"9c99b7964fabb16a022293ffbd2804f9b46551f6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32565}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3cbfc83376573e7cbab9122824d3be3e415cbc15\", \"swarm_hashes_refs/heads/master(at){#825207}_without_patch\": {\"absl_hardening_tests\": \"2074605e114de0a4823920a419127328a0c26ca6\", \"accessibility_unittests\": \"137bd74285e586191891fde5cad16c8cd2b6d14a\", \"angle_unittests\": \"25e760f492ba919bbe5ab7e0dc89b675e471b124\", \"app_list_unittests\": \"3687061e5d5f7cace5a1415bdcae9a506d1351c7\", \"app_shell_unittests\": \"1a07911a21012e964b51bff0c40af3591017ef19\", \"ash_unittests\": \"ffe18a20ba6ba9200c4be4f3bf3a7e89662fb366\", \"aura_unittests\": \"8525aa7859dbf3d37c7142bacc15476fa805f287\", \"base_unittests\": \"10639a6487e06ca2c1f6547d7c783f57f490cf69\", \"base_util_unittests\": \"73d65303556e9b6c01558b4e971741f8d140ae7c\", \"blink_common_unittests\": \"b9ff7b5b4882be60e422511c8a50a3ce52de3ef5\", \"blink_fuzzer_unittests\": \"c91b6fc1abe510cdec2d9cada2c601e0d994cbaa\", \"blink_heap_unittests\": \"df4e0e2ae9b49fba9e33b1a337d8d613481c43f2\", \"blink_platform_unittests\": \"a1eb1630c8f4dcb6dcd0af3841f2741870c4d9d5\", \"blink_unittests\": \"12769f1a9e2287fe7e51f99647c0d1ba0e5dfc96\", \"boringssl_crypto_tests\": \"da82d9af28503304860b8a500a53365811dd260d\", \"boringssl_ssl_tests\": \"32f562e541f517b30e5b0cfe0333f863f54f0081\", \"browser_tests\": \"708fe826f463ae4feaff1455a2605776424ba316\", \"capture_unittests\": \"5219257a2aec0336a090fe1c1343f9097d802975\", \"cast_unittests\": \"380f12685d92c2fe70e93b8ea0fbabc6b1c92bba\", \"cc_unittests\": \"46093a03bb38bcf8bd7a313e1e2be05cf53850a8\", \"chrome_app_unittests\": \"334f420d091023beeffaa8651a9c9946d035db35\", \"chromedriver_unittests\": \"ff6bfc5aa10d15ce5d67ed2ff836a21aec891ba0\", \"chromeos_components_unittests\": \"d6ca8da406d8fb2557d03ad535795e1ccab71315\", \"chromeos_unittests\": \"45e96cb51a7d3c9eac9499cc0239875e243a586b\", \"components_browsertests\": \"9d2fa3a5bd1eb558a4fe23369afbe0bbd0de6097\", \"components_unittests\": \"176201cd6cd1227c4531740705d73e37e6e83d11\", \"compositor_unittests\": \"30085506b084911472514f3723404634de28b3c2\", \"content_browsertests\": \"a9459aecf1cfe9210331166f48b52a51b0fa77d1\", \"content_unittests\": \"5b29b6d699d0a333e993dd1ecea68bc1d8c04578\", \"crypto_unittests\": \"dfb948bc3e97559be157dd81292bd196ff6d4230\", \"dbus_unittests\": \"ac197c44adc942f054381fefde533ac8a5d7d58e\", \"device_unittests\": \"b417784bcecdeaa9e08f0b74993a96c6972f80e1\", \"display_unittests\": \"26793ced2ff172b3f8ba7dd2580031d47070dbab\", \"events_unittests\": \"b210188a66ac27fa8ef7d67f098336b68ca9e43b\", \"exo_unittests\": \"68325351d579738b5fcaa24c0238ab646ef89c16\", \"extensions_browsertests\": \"576acc121e0c4343e6d9ae2f078ed052afb6b32f\", \"extensions_unittests\": \"e03a27e59dc9b9143bf3598a5a9cc106ff610376\", \"filesystem_service_unittests\": \"b6c669dbc3be3065c6b830175a4d03f69bfb8473\", \"gcm_unit_tests\": \"a02751dfa499e13166ff0b04b4717d23bd5d912e\", \"gfx_unittests\": \"9806a3150c7bd5e9eb981fd277f7f3ad9cceb510\", \"gin_unittests\": \"e45e5cc1d5b8e72f5f295ae543f4215dfacc83a6\", \"gl_unittests_ozone\": \"4e21b30dc9eaf32193d31196076488aeed439cc6\", \"google_apis_unittests\": \"d7b4e8dd6b86ad2d7f911db4686687904ea612b1\", \"gpu_unittests\": \"7ebc533143fcd3d59b18330ccad5192393f523dd\", \"gwp_asan_unittests\": \"bf9a8956edff3016cdcf2525726d7f71302922e1\", \"interactive_ui_tests\": \"b903a0927c67444ce7d5364209d47d33726d9c0e\", \"ipc_tests\": \"d9fb0ffee6f023982b771abd2b43a03136c1a865\", \"jingle_unittests\": \"00ec9d092ee3994763fa123e2f8dacba99f838da\", \"keyboard_unittests\": \"2a4b971aea18dd7f36ee35caf589d3b7453fd67c\", \"latency_unittests\": \"28028e096b50f326126d726672d1e9c1e07225c7\", \"libjingle_xmpp_unittests\": \"4a68ee11e9b5ea0a6797bb70fd6c5bfb617d4472\", \"liburlpattern_unittests\": \"fbff824392411fd48b408490d1d505e39a13480d\", \"media_blink_unittests\": \"ac0d07e6efd1f7abb9145e0ef36284df57d49839\", \"media_unittests\": \"f3ab797a6c07d83aa718fc2900a7729902e4bad3\", \"message_center_unittests\": \"4bb8a0897c2702cc40bcae6ce7865b9edb4ea5ed\", \"midi_unittests\": \"65d6673a1cf1234a1382d0c4056f371cc024670f\", \"mojo_core_unittests\": \"2ab41669a0028776f60e80b8f8b2c776e5a9162d\", \"mojo_unittests\": \"93e6eba781fbaa4292f005a1d04864a929bd83af\", \"nacl_helper_nonsfi_unittests\": \"8b1e43df009732433958d8176ddde8cb5984d68c\", \"nacl_loader_unittests\": \"ba4df769befafac81faddfa0992935818d6e72f9\", \"native_theme_unittests\": \"659a1660d6d4ae43b9d8aa5eb51d9e03e66cdd70\", \"net_unittests\": \"db8fa5b3eb69d33908099715a3f29342316c6839\", \"ozone_gl_unittests\": \"6ca9744b6855f9f4e6c89324bec50468439038cb\", \"ozone_unittests\": \"aa1ca14ee88c93e03d304ef2472ecf3ac4da660d\", \"ozone_x11_unittests\": \"46356e9571b65e2f7943ccf23e5ae2621f5ff987\", \"pdf_unittests\": \"f9e880915ac3a9486286f58bb08577460d681a9f\", \"perfetto_unittests\": \"875cb367b40786af2622cd5bc4d37095ce1ead67\", \"ppapi_unittests\": \"56bc502644f2c4f88679509b82a99063fb8f69da\", \"printing_unittests\": \"3bf9c5d66d2e16c229443602b6bc81f3aa4594a6\", \"remoting_unittests\": \"389670cec2f6063076e46cc16df653ffd2e929a6\", \"sandbox_linux_unittests\": \"3e3576ee2fca52e1fe6482f55fe2ddfceeadf338\", \"service_manager_unittests\": \"af07ba32339ffc62710f63a8c143aa81ddcaa85b\", \"services_unittests\": \"e0533e9e02ef27c79314d767cf01387e0f14849b\", \"shell_dialogs_unittests\": \"64da33691c37e545f4236a619e9534dd073c4a80\", \"skia_unittests\": \"c0abad7f8d24260a90147684af2664acaff2e5e2\", \"snapshot_unittests\": \"bf694bf4ae3cdbe1f4c39debeca6052e8b38deaf\", \"sql_unittests\": \"7e51d3a66377aeb982c43a5083d7ab445897378a\", \"storage_unittests\": \"929fdc725bfb870809763e30e7f7409c7b620595\", \"sync_integration_tests\": \"64b8799092f7cf70264b7b854c1ca9552761083e\", \"traffic_annotation_auditor_unittests\": \"7c2dbbba643d815246740221b0b305fdbc8654d3\", \"ui_base_unittests\": \"a8174f945f79856832d95226b0698ac076da6f84\", \"ui_chromeos_unittests\": \"78f4bd9f5332a836c935948de34557e41458fe44\", \"ui_touch_selection_unittests\": \"93fe3529eea6f27ecca1702ea4f995d5c75f7cbf\", \"unit_tests\": \"4b17500ccd9cc15d846eda2b8b7ec284843d10b0\", \"url_unittests\": \"53becd604f45d2a831d2200d10890613e17a28c4\", \"usage_time_limit_unittests\": \"ccbef15ec6b7956958977e18a98804207b7d13f3\", \"views_unittests\": \"e90f11dbbad3b3aa172bed37f25a50f0942cc9e2\", \"viz_unittests\": \"90ecd0cd197e77e7df9a094f1535186d36efaa50\", \"wayland_client_perftests\": \"e1beadc078b40aadbc683f7029a83a09cc8b5c11\", \"wm_unittests\": \"93780fc67ca761665e1ca7965e9ad6193595fa60\", \"wtf_unittests\": \"625be7c59c2648e7e428d686f0a98fe897919624\", \"zlib_unittests\": \"15c10e5cf2428ad934a3659e9d12a002c36e50aa\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_387e931c7b633ee2f48b892df14288ffa2061feda74b30444810d565fa474120_v2\", \"builder_3d74f5cea4cbf91e4b26f92a522c5c74e61b738440ef29ba16f5c9a596a5b201_v2\", \"builder_439308a62373488b965450387292170d4ea9c14a8841f8eafa3bc91f493efcbf_v2\", \"builder_562e40d9a0016a631bf2d4b73416a93abb069b959f020aa1a03e04f54d5ec620_v2\", \"builder_61893a5c8ae9b884bb20ec7e5a61377525a63e6bcd3c290923a393e48475e916_v2\", \"builder_7701d7ffc8ab5fe38a709c77d4f18478e80f1a1d01dd8053f239f119334d81d1_v2\", \"builder_c959b8ee6e9c42f44f995b7890149287c7e5844ce0eb5ab3df3608c75104ea49_v2\", \"builder_e809b372bbf789f5ec41592a5138d8997f6a9674af50aff06b5283644fb4e85c_v2\", \"builder_f2d41554cc5e5ccdd409a1e3331deca1f73b654eb50c3540ea4abf5478e808d4_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-13-ig3h\"], \"image\": [\"chrome-xenial-20110100-7e97731f9b6\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604800596468653",
"status": "COMPLETED",
"status_changed_ts": "1604805982859423",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42678",
"builder:linux-chromeos-rel",
"buildset:commit/git/3cbfc83376573e7cbab9122824d3be3e415cbc15",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3cbfc83376573e7cbab9122824d3be3e415cbc15",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029669243983825984",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8864239181981634912/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4fbe56e10238c210",
"user_agent:luci-scheduler"
],
"updated_ts": "1604805982864983",
"url": "https://ci.chromium.org/b/8864239181981634912",
"utcnow_ts": "1604805984565390"
}
}
[03:26:24.574] Invocation finished in 1h43m25.997707961s with status SUCCEEDED