[13:35:32.447] New invocation is queued and will start shortly
[13:35:33.643] Starting the invocation (attempt 1)
[13:35:33.701] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:35:33.701] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:35:33.701] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018028001617634160",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"16ecf96f8f7276bd38361895edd08b760b7a56d9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9018028001617634160",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/16ecf96f8f7276bd38361895edd08b760b7a56d9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/16ecf96f8f7276bd38361895edd08b760b7a56d9",
"gitiles_ref:refs/heads/master"
]
}
[13:35:35.028] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615901734465761",
"id": "8852597938839757760",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"16ecf96f8f7276bd38361895edd08b760b7a56d9\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615901734896948",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/23006",
"builder:linux-chromeos-dbg",
"buildset:commit/git/16ecf96f8f7276bd38361895edd08b760b7a56d9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/16ecf96f8f7276bd38361895edd08b760b7a56d9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018028001617634160",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8852597938839757760/+/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": "1615901734897061",
"url": "https://ci.chromium.org/b/8852597938839757760",
"utcnow_ts": "1615901735021227"
}
}
[13:35:35.028] Task URL: https://ci.chromium.org/b/8852597938839757760
[13:35:35.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:2:0) after 1m0s
[13:36:35.053] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:2:0)
[13:36:35.053] Timer tick, asking Buildbucket for the build status
[13:36:35.161] Build 8852597938839757760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:36:35.161] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:3:0) after 1m0s
[13:36:51.173] Received PubSub notification, asking Buildbucket for the build status
[13:36:51.236] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:35.302] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:3:0)
[13:37:35.302] Timer tick, asking Buildbucket for the build status
[13:37:35.508] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:35.508] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:5:0) after 1m0s
[13:38:35.665] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:5:0)
[13:38:35.665] Timer tick, asking Buildbucket for the build status
[13:38:35.772] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:35.772] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:6:0) after 1m0s
[13:39:35.839] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:6:0)
[13:39:35.839] Timer tick, asking Buildbucket for the build status
[13:39:35.925] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:35.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:7:0) after 1m0s
[13:40:35.972] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:7:0)
[13:40:35.972] Timer tick, asking Buildbucket for the build status
[13:40:36.367] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:36.367] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:8:0) after 1m0s
[13:41:36.414] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:8:0)
[13:41:36.414] Timer tick, asking Buildbucket for the build status
[13:41:36.504] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:36.504] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:9:0) after 1m0s
[13:42:36.583] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:9:0)
[13:42:36.583] Timer tick, asking Buildbucket for the build status
[13:42:36.823] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:36.823] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:10:0) after 1m0s
[13:43:36.928] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:10:0)
[13:43:36.928] Timer tick, asking Buildbucket for the build status
[13:43:37.008] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:37.009] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:11:0) after 1m0s
[13:45:10.704] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:11:0)
[13:45:10.704] Timer tick, asking Buildbucket for the build status
[13:45:10.919] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:10.919] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:12:0) after 1m0s
[13:46:12.332] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:12:0)
[13:46:12.332] Timer tick, asking Buildbucket for the build status
[13:46:12.418] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:12.418] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:13:0) after 1m0s
[13:47:12.640] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:13:0)
[13:47:12.640] Timer tick, asking Buildbucket for the build status
[13:47:12.823] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:12.823] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:14:0) after 1m0s
[13:48:12.906] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:14:0)
[13:48:12.906] Timer tick, asking Buildbucket for the build status
[13:48:12.987] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:12.988] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:15:0) after 1m0s
[13:49:13.085] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:15:0)
[13:49:13.085] Timer tick, asking Buildbucket for the build status
[13:49:13.162] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:13.162] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:16:0) after 1m0s
[13:50:13.157] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:16:0)
[13:50:13.157] Timer tick, asking Buildbucket for the build status
[13:50:13.229] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:13.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:17:0) after 1m0s
[13:51:13.244] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:17:0)
[13:51:13.244] Timer tick, asking Buildbucket for the build status
[13:51:13.328] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:13.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:18:0) after 1m0s
[13:52:13.449] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:18:0)
[13:52:13.449] Timer tick, asking Buildbucket for the build status
[13:52:13.523] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:13.523] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:19:0) after 1m0s
[13:53:13.545] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:19:0)
[13:53:13.545] Timer tick, asking Buildbucket for the build status
[13:53:13.899] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:13.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:20:0) after 1m0s
[13:54:13.984] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:20:0)
[13:54:13.984] Timer tick, asking Buildbucket for the build status
[13:54:14.074] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:14.074] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:21:0) after 1m0s
[13:55:14.176] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:21:0)
[13:55:14.176] Timer tick, asking Buildbucket for the build status
[13:55:14.252] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:14.252] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:22:0) after 1m0s
[13:56:14.360] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:22:0)
[13:56:14.360] Timer tick, asking Buildbucket for the build status
[13:56:14.449] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:14.449] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:23:0) after 1m0s
[13:57:14.744] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:23:0)
[13:57:14.744] Timer tick, asking Buildbucket for the build status
[13:57:14.814] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:14.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:24:0) after 1m0s
[13:58:15.037] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:24:0)
[13:58:15.037] Timer tick, asking Buildbucket for the build status
[13:58:15.154] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:15.154] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:25:0) after 1m0s
[13:59:15.155] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:25:0)
[13:59:15.155] Timer tick, asking Buildbucket for the build status
[13:59:15.232] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:15.232] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:26:0) after 1m0s
[14:00:15.447] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:26:0)
[14:00:15.447] Timer tick, asking Buildbucket for the build status
[14:00:15.563] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:15.563] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:27:0) after 1m0s
[14:01:15.718] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:27:0)
[14:01:15.718] Timer tick, asking Buildbucket for the build status
[14:01:16.253] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:16.253] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:28:0) after 1m0s
[14:02:16.292] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:28:0)
[14:02:16.292] Timer tick, asking Buildbucket for the build status
[14:02:16.369] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:16.369] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:29:0) after 1m0s
[14:03:16.389] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:29:0)
[14:03:16.389] Timer tick, asking Buildbucket for the build status
[14:03:16.465] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:16.465] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:30:0) after 1m0s
[14:04:16.466] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:30:0)
[14:04:16.466] Timer tick, asking Buildbucket for the build status
[14:04:16.698] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:16.698] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:31:0) after 1m0s
[14:05:16.721] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:31:0)
[14:05:16.721] Timer tick, asking Buildbucket for the build status
[14:05:16.806] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:16.806] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:32:0) after 1m0s
[14:06:16.827] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:32:0)
[14:06:16.827] Timer tick, asking Buildbucket for the build status
[14:06:17.006] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:17.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:33:0) after 1m0s
[14:07:17.071] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:33:0)
[14:07:17.071] Timer tick, asking Buildbucket for the build status
[14:07:17.146] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:17.146] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:34:0) after 1m0s
[14:08:17.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:34:0)
[14:08:17.216] Timer tick, asking Buildbucket for the build status
[14:08:17.310] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:17.310] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:35:0) after 1m0s
[14:09:17.345] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:35:0)
[14:09:17.345] Timer tick, asking Buildbucket for the build status
[14:09:17.849] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:17.849] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:36:0) after 1m0s
[14:10:17.892] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:36:0)
[14:10:17.893] Timer tick, asking Buildbucket for the build status
[14:10:17.956] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:17.956] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:37:0) after 1m0s
[14:11:17.999] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:37:0)
[14:11:17.999] Timer tick, asking Buildbucket for the build status
[14:11:18.127] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:18.127] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:38:0) after 1m0s
[14:12:18.147] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:38:0)
[14:12:18.147] Timer tick, asking Buildbucket for the build status
[14:12:18.625] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:18.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:39:0) after 1m0s
[14:13:18.654] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:39:0)
[14:13:18.654] Timer tick, asking Buildbucket for the build status
[14:13:18.715] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:18.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:40:0) after 1m0s
[14:14:18.765] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:40:0)
[14:14:18.765] Timer tick, asking Buildbucket for the build status
[14:14:18.832] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:18.832] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:41:0) after 1m0s
[14:15:18.851] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:41:0)
[14:15:18.851] Timer tick, asking Buildbucket for the build status
[14:15:18.925] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:18.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:42:0) after 1m0s
[14:16:18.957] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:42:0)
[14:16:18.957] Timer tick, asking Buildbucket for the build status
[14:16:19.077] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:19.077] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:43:0) after 1m0s
[14:17:19.098] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:43:0)
[14:17:19.098] Timer tick, asking Buildbucket for the build status
[14:17:19.165] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:19.165] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:44:0) after 1m0s
[14:18:19.247] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:44:0)
[14:18:19.247] Timer tick, asking Buildbucket for the build status
[14:18:19.340] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:19.340] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:45:0) after 1m0s
[14:19:19.411] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:45:0)
[14:19:19.411] Timer tick, asking Buildbucket for the build status
[14:19:19.477] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:19.477] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:46:0) after 1m0s
[14:20:19.549] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:46:0)
[14:20:19.549] Timer tick, asking Buildbucket for the build status
[14:20:20.164] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:20.164] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:47:0) after 1m0s
[14:21:20.168] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:47:0)
[14:21:20.168] Timer tick, asking Buildbucket for the build status
[14:21:20.306] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:20.306] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:48:0) after 1m0s
[14:22:20.381] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:48:0)
[14:22:20.381] Timer tick, asking Buildbucket for the build status
[14:22:20.478] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:20.478] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:49:0) after 1m0s
[14:23:20.489] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:49:0)
[14:23:20.489] Timer tick, asking Buildbucket for the build status
[14:23:20.568] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:20.568] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:50:0) after 1m0s
[14:24:20.620] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:50:0)
[14:24:20.620] Timer tick, asking Buildbucket for the build status
[14:24:20.710] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:20.710] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:51:0) after 1m0s
[14:25:20.782] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:51:0)
[14:25:20.782] Timer tick, asking Buildbucket for the build status
[14:25:20.949] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:20.949] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:52:0) after 1m0s
[14:26:21.018] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:52:0)
[14:26:21.018] Timer tick, asking Buildbucket for the build status
[14:26:21.189] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:21.189] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:53:0) after 1m0s
[14:27:21.202] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:53:0)
[14:27:21.202] Timer tick, asking Buildbucket for the build status
[14:27:21.328] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:21.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:54:0) after 1m0s
[14:28:21.440] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:54:0)
[14:28:21.440] Timer tick, asking Buildbucket for the build status
[14:28:21.537] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:21.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:55:0) after 1m0s
[14:29:21.555] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:55:0)
[14:29:21.555] Timer tick, asking Buildbucket for the build status
[14:29:21.649] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:21.649] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:56:0) after 1m0s
[14:30:21.801] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:56:0)
[14:30:21.801] Timer tick, asking Buildbucket for the build status
[14:30:21.908] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:21.908] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:57:0) after 1m0s
[14:31:21.998] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:57:0)
[14:31:21.998] Timer tick, asking Buildbucket for the build status
[14:31:22.095] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:22.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:58:0) after 1m0s
[14:32:22.233] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:58:0)
[14:32:22.233] Timer tick, asking Buildbucket for the build status
[14:32:22.310] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:22.310] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:59:0) after 1m0s
[14:33:22.340] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:59:0)
[14:33:22.340] Timer tick, asking Buildbucket for the build status
[14:33:22.551] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:22.551] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:60:0) after 1m0s
[14:34:22.600] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:60:0)
[14:34:22.600] Timer tick, asking Buildbucket for the build status
[14:34:22.825] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:22.825] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:61:0) after 1m0s
[14:35:22.871] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:61:0)
[14:35:22.871] Timer tick, asking Buildbucket for the build status
[14:35:22.967] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:22.967] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:62:0) after 1m0s
[14:36:22.988] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:62:0)
[14:36:22.988] Timer tick, asking Buildbucket for the build status
[14:36:23.141] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:23.141] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:63:0) after 1m0s
[14:37:23.159] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:63:0)
[14:37:23.159] Timer tick, asking Buildbucket for the build status
[14:37:23.280] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:23.280] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:64:0) after 1m0s
[14:38:23.379] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:64:0)
[14:38:23.379] Timer tick, asking Buildbucket for the build status
[14:38:23.735] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:23.735] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:65:0) after 1m0s
[14:39:23.754] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:65:0)
[14:39:23.754] Timer tick, asking Buildbucket for the build status
[14:39:23.866] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:23.866] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:66:0) after 1m0s
[14:40:23.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:66:0)
[14:40:23.882] Timer tick, asking Buildbucket for the build status
[14:40:23.971] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:23.971] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:67:0) after 1m0s
[14:41:23.987] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:67:0)
[14:41:23.987] Timer tick, asking Buildbucket for the build status
[14:41:24.086] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:24.086] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:68:0) after 1m0s
[14:42:24.109] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:68:0)
[14:42:24.109] Timer tick, asking Buildbucket for the build status
[14:42:24.195] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:24.195] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:69:0) after 1m0s
[14:43:24.245] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:69:0)
[14:43:24.245] Timer tick, asking Buildbucket for the build status
[14:43:24.328] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:24.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:70:0) after 1m0s
[14:44:24.384] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:70:0)
[14:44:24.384] Timer tick, asking Buildbucket for the build status
[14:44:24.470] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:24.470] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:71:0) after 1m0s
[14:45:24.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:71:0)
[14:45:24.508] Timer tick, asking Buildbucket for the build status
[14:45:24.583] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:24.583] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:72:0) after 1m0s
[14:46:24.640] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:72:0)
[14:46:24.640] Timer tick, asking Buildbucket for the build status
[14:46:24.931] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:24.931] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:73:0) after 1m0s
[14:47:24.952] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:73:0)
[14:47:24.952] Timer tick, asking Buildbucket for the build status
[14:47:25.050] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:25.050] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:74:0) after 1m0s
[14:48:25.136] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:74:0)
[14:48:25.136] Timer tick, asking Buildbucket for the build status
[14:48:25.212] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:25.212] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:75:0) after 1m0s
[14:49:25.204] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:75:0)
[14:49:25.204] Timer tick, asking Buildbucket for the build status
[14:49:25.326] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:25.326] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:76:0) after 1m0s
[14:50:25.410] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:76:0)
[14:50:25.410] Timer tick, asking Buildbucket for the build status
[14:50:25.492] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:25.492] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:77:0) after 1m0s
[14:51:25.645] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:77:0)
[14:51:25.645] Timer tick, asking Buildbucket for the build status
[14:51:25.741] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:25.741] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:78:0) after 1m0s
[14:52:25.808] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:78:0)
[14:52:25.808] Timer tick, asking Buildbucket for the build status
[14:52:25.888] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:25.888] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:79:0) after 1m0s
[14:53:26.547] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:79:0)
[14:53:26.547] Timer tick, asking Buildbucket for the build status
[14:53:26.624] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:26.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:80:0) after 1m0s
[14:54:26.606] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:80:0)
[14:54:26.606] Timer tick, asking Buildbucket for the build status
[14:54:26.701] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:26.701] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:81:0) after 1m0s
[14:55:26.766] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:81:0)
[14:55:26.766] Timer tick, asking Buildbucket for the build status
[14:55:27.130] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:27.130] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:82:0) after 1m0s
[14:56:27.148] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:82:0)
[14:56:27.148] Timer tick, asking Buildbucket for the build status
[14:56:27.244] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:27.244] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:83:0) after 1m0s
[14:57:27.264] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:83:0)
[14:57:27.264] Timer tick, asking Buildbucket for the build status
[14:57:27.392] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:27.392] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:84:0) after 1m0s
[14:58:27.412] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:84:0)
[14:58:27.412] Timer tick, asking Buildbucket for the build status
[14:58:27.495] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:27.495] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:85:0) after 1m0s
[14:59:27.550] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:85:0)
[14:59:27.550] Timer tick, asking Buildbucket for the build status
[14:59:27.626] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:27.626] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:86:0) after 1m0s
[15:00:27.700] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:86:0)
[15:00:27.700] Timer tick, asking Buildbucket for the build status
[15:00:27.899] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:27.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:87:0) after 1m0s
[15:01:28.009] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:87:0)
[15:01:28.009] Timer tick, asking Buildbucket for the build status
[15:01:28.111] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:28.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:88:0) after 1m0s
[15:02:28.255] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:88:0)
[15:02:28.255] Timer tick, asking Buildbucket for the build status
[15:02:28.645] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:28.645] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:89:0) after 1m0s
[15:03:28.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:89:0)
[15:03:28.762] Timer tick, asking Buildbucket for the build status
[15:03:28.850] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:28.850] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:90:0) after 1m0s
[15:04:28.958] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:90:0)
[15:04:28.958] Timer tick, asking Buildbucket for the build status
[15:04:29.092] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:29.092] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:91:0) after 1m0s
[15:05:29.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:91:0)
[15:05:29.205] Timer tick, asking Buildbucket for the build status
[15:05:29.336] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:29.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:92:0) after 1m0s
[15:06:29.606] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:92:0)
[15:06:29.606] Timer tick, asking Buildbucket for the build status
[15:06:29.710] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:29.710] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:93:0) after 1m0s
[15:07:29.863] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:93:0)
[15:07:29.864] Timer tick, asking Buildbucket for the build status
[15:07:29.954] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:29.954] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:94:0) after 1m0s
[15:08:30.066] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:94:0)
[15:08:30.066] Timer tick, asking Buildbucket for the build status
[15:08:30.136] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:30.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:95:0) after 1m0s
[15:09:30.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:95:0)
[15:09:30.265] Timer tick, asking Buildbucket for the build status
[15:09:30.344] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:30.344] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:96:0) after 1m0s
[15:10:30.825] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:96:0)
[15:10:30.825] Timer tick, asking Buildbucket for the build status
[15:10:30.905] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:30.905] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:97:0) after 1m0s
[15:11:31.014] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:97:0)
[15:11:31.014] Timer tick, asking Buildbucket for the build status
[15:11:31.097] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:31.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:98:0) after 1m0s
[15:12:31.158] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:98:0)
[15:12:31.158] Timer tick, asking Buildbucket for the build status
[15:12:31.234] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:31.234] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:99:0) after 1m0s
[15:13:31.391] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:99:0)
[15:13:31.391] Timer tick, asking Buildbucket for the build status
[15:13:31.512] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:31.512] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:100:0) after 1m0s
[15:14:31.583] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:100:0)
[15:14:31.583] Timer tick, asking Buildbucket for the build status
[15:14:31.742] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:31.742] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:101:0) after 1m0s
[15:15:31.819] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:101:0)
[15:15:31.819] Timer tick, asking Buildbucket for the build status
[15:15:31.885] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:31.885] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:102:0) after 1m0s
[15:16:32.082] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:102:0)
[15:16:32.082] Timer tick, asking Buildbucket for the build status
[15:16:32.183] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:32.183] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:103:0) after 1m0s
[15:17:32.317] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:103:0)
[15:17:32.317] Timer tick, asking Buildbucket for the build status
[15:17:32.402] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:32.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:104:0) after 1m0s
[15:18:32.775] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:104:0)
[15:18:32.775] Timer tick, asking Buildbucket for the build status
[15:18:32.868] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:32.868] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:105:0) after 1m0s
[15:19:33.212] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:105:0)
[15:19:33.212] Timer tick, asking Buildbucket for the build status
[15:19:33.731] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:33.731] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:106:0) after 1m0s
[15:20:33.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:106:0)
[15:20:33.784] Timer tick, asking Buildbucket for the build status
[15:20:33.852] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:33.852] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:107:0) after 1m0s
[15:21:33.911] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:107:0)
[15:21:33.911] Timer tick, asking Buildbucket for the build status
[15:21:34.004] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:34.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:108:0) after 1m0s
[15:22:34.068] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:108:0)
[15:22:34.069] Timer tick, asking Buildbucket for the build status
[15:22:34.265] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:34.265] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:109:0) after 1m0s
[15:23:34.295] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:109:0)
[15:23:34.295] Timer tick, asking Buildbucket for the build status
[15:23:34.707] Build 8852597938839757760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:34.707] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018028001617634160:110:0) after 1m0s
[15:24:12.102] Received PubSub notification, asking Buildbucket for the build status
[15:24:12.206] Build 8852597938839757760: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:24:12.206] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615908251456623",
"created_by": "project:chromium",
"created_ts": "1615901734465761",
"id": "8852597938839757760",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"16ecf96f8f7276bd38361895edd08b760b7a56d9\"}}",
"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\": \"16ecf96f8f7276bd38361895edd08b760b7a56d9\", \"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-central1-b-8-150-md9u\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 23006, \"got_angle_revision\": \"6936ee8064dda1221c2358c9eae42e671fac0023\", \"got_dawn_revision\": \"eeb3d52b9510254b1d6f1800ac83b5e7b94b9f96\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"16ecf96f8f7276bd38361895edd08b760b7a56d9\", \"got_revision_cp\": \"refs/heads/master@{#863249}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"69b79eec6533f113920a5dd863ee2dea7d0c64e7\", \"got_v8_revision\": \"622e7caf6b288ebf0a003f38070b03c35bd8f2bd\", \"got_v8_revision_cp\": \"refs/heads/9.1.131@{#1}\", \"got_webrtc_revision\": \"6097b0fac0946a29d59a9266ea656c39b3fd7336\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33456}\", \"is_cached\": true, \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-dbg\", \"tryserver.chromium.chromiumos:linux-chromeos-compile-dbg\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"16ecf96f8f7276bd38361895edd08b760b7a56d9\", \"swarm_hashes_refs/heads/master(at){#863249}_without_patch\": {\"absl_hardening_tests\": \"a8501f721bf5f270dc56e4ee258d414b9779a5d0\", \"accessibility_unittests\": \"25df9b53f70602ed7b03a1e4edff813725d48126\", \"angle_unittests\": \"15ee331d0fd3668a6ecd3ad2ac127d56353361f3\", \"app_list_unittests\": \"8514e4f88ebee44ff8d05613999e127d96b9cf4c\", \"app_shell_unittests\": \"d58269866a033a336adef8653d60d5bab60a2333\", \"ash_unittests\": \"b8ef9edfd0fffc6e0ad17094ed67cd7b6763c46e\", \"aura_unittests\": \"882e2bd430b2634c65ec00793599ec847afaa6e5\", \"base_unittests\": \"eadafcccaf260b603bc7814274e1cdd7f3b3547f\", \"base_util_unittests\": \"c3d757249b98b845621ae75eb3a51a90b786ae27\", \"blink_common_unittests\": \"e1f35fe9537c2686389e0ec1db9afc9c387b747e\", \"blink_fuzzer_unittests\": \"0dd67181a03534cd4292c09ace6d7e5ed582d0e7\", \"blink_heap_unittests\": \"b7b6579fe6a5a893fb08528b7824a040c98de86f\", \"blink_platform_unittests\": \"835544845399c1b7c86ec65b181b1c4e46ead668\", \"blink_unittests\": \"58e21a29838b367ef91132b0039bc6b8c68035da\", \"boringssl_crypto_tests\": \"7ab8aab1fad5e987ce44b688e2a5307707555f8e\", \"boringssl_ssl_tests\": \"30f32f916765600e8eb52c99cb798cb8900d6fed\", \"browser_tests\": \"1a1f8f70ea229f8cfca78ddeec08211a4b17aff1\", \"capture_unittests\": \"6db9a912c7ee630a2f3e1797ea3755db93a61041\", \"cast_unittests\": \"23439a5cb9fa469ef6a18f43bd03d9b23fc27cd2\", \"cc_unittests\": \"ad454e16b5931f8d07de37c51cafd674e7e02e90\", \"chrome_app_unittests\": \"544575d347fa960c9767b014f77daa92b378c26e\", \"chromedriver_unittests\": \"9dc45f34e8a37fc3d5a48bf9ce19520bcb98d287\", \"chromeos_components_unittests\": \"aaa71098648adbe0d575a166db7c0000e8134729\", \"chromeos_unittests\": \"152cc80d14b71c2484ea55688bbbb3095f50e013\", \"color_unittests\": \"fb7b8eaf9018db6db34e2f3b2e17de76245dde75\", \"components_browsertests\": \"ae91ad3bb4afa3b430da0d321b1178e6c1e0dbe6\", \"components_unittests\": \"1b287ca9ed38480def6958d56e39a28d7c36fb3d\", \"compositor_unittests\": \"5b1d03a4d23547a2418621a12b566d3b8840fe3a\", \"content_browsertests\": \"0844eb991f839f9dac541c96b63defc9bdcf0938\", \"content_unittests\": \"6d2161b9a7075d3cbdefa1f651f67949c5e0aced\", \"crashpad_tests\": \"efcc4f6ea9b95199272a8fef2c3543ecd580f614\", \"crypto_unittests\": \"a5cbaee9d6c6014c04b3d737c7ba62b8d2e36bf3\", \"dbus_unittests\": \"4610caefb3049a52c535da1180ad0080eb4e8466\", \"device_unittests\": \"2ee8362163d4ff5a88a54bfe9e95e3f6c7e550ac\", \"display_unittests\": \"d4c708a459106c0ac2389a9a3a5c556751380ef0\", \"events_unittests\": \"136a64d0986d46f2829dae20a9fa4258e514127f\", \"exo_unittests\": \"329d63cd0ca63c2bcdb946c3342c4db17ee42d06\", \"extensions_browsertests\": \"813ee918fd85b2dbf9127d217423f540296e979a\", \"extensions_unittests\": \"4e5c01aa5eee72e2f42012baf2ed10b8687eda0c\", \"filesystem_service_unittests\": \"1c8c500a2c95745048568131b2c3a10d85f67fd1\", \"gcm_unit_tests\": \"c2a45ad735af843ad03784168c2ba742591fa49c\", \"gfx_unittests\": \"2644074ae316394a8b6d2498860c5ee09e52adea\", \"gin_unittests\": \"080ead42669d44d8e0dc3893f22e56695836321d\", \"gl_unittests_ozone\": \"bad0e1e030402e7e894d640271964f4268973af6\", \"google_apis_unittests\": \"379d83b49ec5278744d40c824d05e4395ffbdb16\", \"gpu_unittests\": \"0fc50e8465bc9ff96f067f25fb7c822f8de01d67\", \"gwp_asan_unittests\": \"52eb663e0cbe35abf82bec3df8ba0c7ad367e009\", \"interactive_ui_tests\": \"b74781326cab7f4d16c99273394ca30d5eed1db8\", \"ipc_tests\": \"29989919e0a8ce532365b159ead6b3673c38ff68\", \"jingle_unittests\": \"ff20936fe18ac486c0c9d6ab620ef294f1be3fe7\", \"keyboard_unittests\": \"30e9985b96226e8f13d63feb41d835efd2eae85c\", \"latency_unittests\": \"799fbe74fa679b05350080b41752a5c44560a3b4\", \"libjingle_xmpp_unittests\": \"85a0afc72e73f612178f5ca45bc979da4c12ba19\", \"liburlpattern_unittests\": \"071b257a40ad1a460e02b881dabe77b7f6dbcc85\", \"media_blink_unittests\": \"4bddd6908f85347a2f672fbcc36e868e1c583fd0\", \"media_unittests\": \"0fd413c2468261bb4910d8d73c2909b1edbdfff7\", \"message_center_unittests\": \"7050abd3653f0841b592fd7b0511c51c52adfa70\", \"midi_unittests\": \"939770ac3096a0cb436d3131e9903f3eed10aaa4\", \"mojo_core_unittests\": \"0378fe880ae01a14adb3ab0c3c99ee2108ec5a4f\", \"mojo_unittests\": \"93504a84a4c83f555bfc18dae90117591a15340f\", \"nacl_helper_nonsfi_unittests\": \"edffa5aca599fc5cb28abde1a7f590d0a03f6e20\", \"nacl_loader_unittests\": \"273a68e3fa22bcc3b63a6ecfda3b244d2965765f\", \"native_theme_unittests\": \"baa5f64bfc7fd63e3f8854777f43b31702ed4798\", \"net_unittests\": \"f8d8daad8462e28e722d9bc8a4b7e4901671e458\", \"ozone_gl_unittests\": \"c98cfd434d827441422e63b25051681fb2d7041f\", \"ozone_unittests\": \"769e1faf00ea6f48da8a86e855d2d45cfdb42c0a\", \"ozone_x11_unittests\": \"7462751589c0236ed3533a245444ddf798d1d052\", \"pdf_unittests\": \"4f35a13c5e277490a73fc6cf09ba3e5c964804b2\", \"perfetto_unittests\": \"d8e5e1b3db8f4c124f0d0663f5d606ae43b5b645\", \"ppapi_unittests\": \"5df6c0b4dd5ee18f175cc00910716e9f2b42ad0c\", \"printing_unittests\": \"92512e6c59cc9ae9fbc82565199d63e975611dee\", \"remoting_unittests\": \"8e3b4e62f36085078d4ba3df9f09616dc411e90a\", \"sandbox_linux_unittests\": \"f1319d55982b80b871165297186832bdbf3d143e\", \"service_manager_unittests\": \"e0d58d2aa4ad0ce8e2182a9b0664597962376487\", \"services_unittests\": \"ee487e47b96889209c84d2936dec85ad960171ef\", \"shell_dialogs_unittests\": \"056117334e099d0b78fa95f1eaf2457a9a3fe812\", \"shell_encryption_unittests\": \"44f8e380769b4666d002114cc6265c0789c89612\", \"skia_unittests\": \"3d25a92695c0b4e40f305687137fc55df32c2d58\", \"snapshot_unittests\": \"11b73d6965f5a7647de652769f79faed22cc31d1\", \"sql_unittests\": \"8c74a537f049194ca3709ba16b8825325b6f73e8\", \"storage_unittests\": \"b380f3ff70fff894b1d3c697162d8de5061865e0\", \"sync_integration_tests\": \"c22ec9294998b7d1ff93d18bb5b22b158001599b\", \"traffic_annotation_auditor_unittests\": \"5803e8f807aee55b5944666c89162d4fc98fac94\", \"ui_base_unittests\": \"386a46f5008f94b23b2ad47345b0ecd1aeb8127d\", \"ui_chromeos_unittests\": \"bacad2999da47bfbc3439e931a5b9457fe5527b4\", \"ui_touch_selection_unittests\": \"4b6b3a2f50bf1c16522d34b24fd9f932b906c4ef\", \"unit_tests\": \"6ae092f202afa60773f48723b23257ff137488ec\", \"url_unittests\": \"9e230a2c3e1619f33c6cfb2e195322ce0c2c544c\", \"usage_time_limit_unittests\": \"f5fe51450b3551044230d398df4cfe33c2b83dc8\", \"views_unittests\": \"a19901578a9371e7795b037ec7794b91f19de2f0\", \"viz_unittests\": \"364b3df7e0cdf936eeed593254e6db0cb43b347d\", \"wayland_client_tests\": \"4eaf46ca605302213baeb93a79c3475f1fcd95b0\", \"wm_unittests\": \"fcc8c587476ba882810963b092b52da3824231b6\", \"wtf_unittests\": \"e9ec921a50d1555c73d1935f61a9720185511fdf\", \"zlib_unittests\": \"b0e62ebf400842ebb0c16c7af823b51d21379152\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0b12ebe7b5a85484d05a2e374fff062d76e5173f31df9c66ec374db61ba113e3_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_61d28ae4242dfdf39401ff089e29474922615b0ef755e75d038c04bc68e6c0fa_v2\", \"builder_99ff1ef652ee1a099e982d95872de1fdd74468ee6a8079168e46d4cfc0b2cfdf_v2\", \"builder_c9711ee8cb745437051a87b27c8715038746bd3b2c402df1c75730a9e112a9f8_v2\", \"builder_d2010e0a6a440fb89731b061caf7d596c92723d209ffefd62489cc037db4f7a7_v2\", \"builder_fac2959e29eeee13eb43de2791ff2fcb7aa7ab15952f0beca21f4615b55fa2a2_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-central1-b-8-150-md9u\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"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\": [\"5754-8c4f760\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615901810640454",
"status": "COMPLETED",
"status_changed_ts": "1615908251729804",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/23006",
"builder:linux-chromeos-dbg",
"buildset:commit/git/16ecf96f8f7276bd38361895edd08b760b7a56d9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/16ecf96f8f7276bd38361895edd08b760b7a56d9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018028001617634160",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8852597938839757760/+/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:525411aa9a254210",
"user_agent:luci-scheduler"
],
"updated_ts": "1615908251734155",
"url": "https://ci.chromium.org/b/8852597938839757760",
"utcnow_ts": "1615908252196279"
}
}
[15:24:12.206] Invocation finished in 1h48m39.77410702s with status SUCCEEDED