[20:58:20.331] New invocation is queued and will start shortly
[20:58:21.510] Starting the invocation (attempt 1)
[20:58:21.544] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:58:21.544] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:58:21.544] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9031589688133307888",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"66a8b2926f4fc16a85446095187432c44bc0772f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9031589688133307888",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/66a8b2926f4fc16a85446095187432c44bc0772f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/66a8b2926f4fc16a85446095187432c44bc0772f",
"gitiles_ref:refs/heads/master"
]
}
[20:58:22.217] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1602968301639614",
"id": "8866159626098325904",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"66a8b2926f4fc16a85446095187432c44bc0772f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1602968302101770",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/176766",
"builder:Linux Builder (dbg)",
"buildset:commit/git/66a8b2926f4fc16a85446095187432c44bc0772f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/66a8b2926f4fc16a85446095187432c44bc0772f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031589688133307888",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8866159626098325904/+/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": "1602968302101878",
"url": "https://ci.chromium.org/b/8866159626098325904",
"utcnow_ts": "1602968302208225"
}
}
[20:58:22.217] Task URL: https://ci.chromium.org/b/8866159626098325904
[20:58:22.217] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:2:0) after 1m0s
[20:59:22.334] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:2:0)
[20:59:22.334] Timer tick, asking Buildbucket for the build status
[20:59:22.429] Build 8866159626098325904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:59:22.429] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:3:0) after 1m0s
[21:00:22.428] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:3:0)
[21:00:22.428] Timer tick, asking Buildbucket for the build status
[21:00:22.617] Build 8866159626098325904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:00:22.618] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:4:0) after 1m0s
[21:01:22.637] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:4:0)
[21:01:22.637] Timer tick, asking Buildbucket for the build status
[21:01:22.733] Build 8866159626098325904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:01:22.733] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:5:0) after 1m0s
[21:02:22.736] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:5:0)
[21:02:22.736] Timer tick, asking Buildbucket for the build status
[21:02:22.820] Build 8866159626098325904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:02:22.820] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:6:0) after 1m0s
[21:03:22.888] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:6:0)
[21:03:22.888] Timer tick, asking Buildbucket for the build status
[21:03:22.980] Build 8866159626098325904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:03:22.980] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:7:0) after 1m0s
[21:04:23.085] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:7:0)
[21:04:23.085] Timer tick, asking Buildbucket for the build status
[21:04:23.182] Build 8866159626098325904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:04:23.182] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:8:0) after 1m0s
[21:05:23.304] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:8:0)
[21:05:23.304] Timer tick, asking Buildbucket for the build status
[21:05:23.387] Build 8866159626098325904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:05:23.387] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:9:0) after 1m0s
[21:06:23.443] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:9:0)
[21:06:23.443] Timer tick, asking Buildbucket for the build status
[21:06:23.784] Build 8866159626098325904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:06:23.784] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:10:0) after 1m0s
[21:07:23.855] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:10:0)
[21:07:23.855] Timer tick, asking Buildbucket for the build status
[21:07:24.022] Build 8866159626098325904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:07:24.022] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:11:0) after 1m0s
[21:08:24.043] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:11:0)
[21:08:24.043] Timer tick, asking Buildbucket for the build status
[21:08:24.111] Build 8866159626098325904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:08:24.111] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:12:0) after 1m0s
[21:09:24.264] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:12:0)
[21:09:24.264] Timer tick, asking Buildbucket for the build status
[21:09:24.392] Build 8866159626098325904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:09:24.392] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:13:0) after 1m0s
[21:10:24.468] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:13:0)
[21:10:24.468] Timer tick, asking Buildbucket for the build status
[21:10:24.784] Build 8866159626098325904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:10:24.784] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:14:0) after 1m0s
[21:11:24.795] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:14:0)
[21:11:24.795] Timer tick, asking Buildbucket for the build status
[21:11:24.866] Build 8866159626098325904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:11:24.866] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:15:0) after 1m0s
[21:12:24.941] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:15:0)
[21:12:24.941] Timer tick, asking Buildbucket for the build status
[21:12:25.139] Build 8866159626098325904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:12:25.139] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:16:0) after 1m0s
[21:13:25.389] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:16:0)
[21:13:25.389] Timer tick, asking Buildbucket for the build status
[21:13:25.613] Build 8866159626098325904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:13:25.613] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:17:0) after 1m0s
[21:14:25.631] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:17:0)
[21:14:25.631] Timer tick, asking Buildbucket for the build status
[21:14:25.813] Build 8866159626098325904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:14:25.813] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:18:0) after 1m0s
[21:15:25.859] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:18:0)
[21:15:25.859] Timer tick, asking Buildbucket for the build status
[21:15:25.950] Build 8866159626098325904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:15:25.950] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:19:0) after 1m0s
[21:16:25.923] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:19:0)
[21:16:25.923] Timer tick, asking Buildbucket for the build status
[21:16:25.990] Build 8866159626098325904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:16:25.990] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:20:0) after 1m0s
[21:17:26.016] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:20:0)
[21:17:26.016] Timer tick, asking Buildbucket for the build status
[21:17:26.141] Build 8866159626098325904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:17:26.141] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:21:0) after 1m0s
[21:18:26.166] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:21:0)
[21:18:26.166] Timer tick, asking Buildbucket for the build status
[21:18:26.371] Build 8866159626098325904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:18:26.371] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:22:0) after 1m0s
[21:19:26.442] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:22:0)
[21:19:26.442] Timer tick, asking Buildbucket for the build status
[21:19:26.532] Build 8866159626098325904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:19:26.532] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:23:0) after 1m0s
[21:20:26.509] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:23:0)
[21:20:26.509] Timer tick, asking Buildbucket for the build status
[21:20:27.205] Build 8866159626098325904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:20:27.205] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:24:0) after 1m0s
[21:21:27.274] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:24:0)
[21:21:27.274] Timer tick, asking Buildbucket for the build status
[21:21:27.613] Build 8866159626098325904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:21:27.613] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:25:0) after 1m0s
[21:22:27.589] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:25:0)
[21:22:27.589] Timer tick, asking Buildbucket for the build status
[21:22:27.661] Build 8866159626098325904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:22:27.661] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:26:0) after 1m0s
[21:23:27.682] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:26:0)
[21:23:27.682] Timer tick, asking Buildbucket for the build status
[21:23:28.092] Build 8866159626098325904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:23:28.092] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:27:0) after 1m0s
[21:24:28.122] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:27:0)
[21:24:28.122] Timer tick, asking Buildbucket for the build status
[21:24:28.206] Build 8866159626098325904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:24:28.206] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:28:0) after 1m0s
[21:25:28.252] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:28:0)
[21:25:28.252] Timer tick, asking Buildbucket for the build status
[21:25:28.565] Build 8866159626098325904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:25:28.565] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:29:0) after 1m0s
[21:26:28.610] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:29:0)
[21:26:28.610] Timer tick, asking Buildbucket for the build status
[21:26:28.689] Build 8866159626098325904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:26:28.689] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:30:0) after 1m0s
[21:27:28.744] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:30:0)
[21:27:28.744] Timer tick, asking Buildbucket for the build status
[21:27:28.821] Build 8866159626098325904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:27:28.821] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:31:0) after 1m0s
[21:28:29.719] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:31:0)
[21:28:29.719] Timer tick, asking Buildbucket for the build status
[21:28:29.822] Build 8866159626098325904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:28:29.822] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:32:0) after 1m0s
[21:29:12.403] Received PubSub notification, asking Buildbucket for the build status
[21:29:12.494] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:30.241] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:32:0)
[21:29:30.241] Timer tick, asking Buildbucket for the build status
[21:29:30.311] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:30.311] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:34:0) after 1m0s
[21:30:30.480] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:34:0)
[21:30:30.480] Timer tick, asking Buildbucket for the build status
[21:30:30.573] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:30.573] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:35:0) after 1m0s
[21:31:30.725] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:35:0)
[21:31:30.725] Timer tick, asking Buildbucket for the build status
[21:31:30.996] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:30.996] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:36:0) after 1m0s
[21:32:31.242] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:36:0)
[21:32:31.242] Timer tick, asking Buildbucket for the build status
[21:32:31.334] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:31.334] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:37:0) after 1m0s
[21:33:31.529] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:37:0)
[21:33:31.529] Timer tick, asking Buildbucket for the build status
[21:33:31.641] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:31.641] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:38:0) after 1m0s
[21:34:31.868] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:38:0)
[21:34:31.868] Timer tick, asking Buildbucket for the build status
[21:34:31.942] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:31.942] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:39:0) after 1m0s
[21:35:32.124] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:39:0)
[21:35:32.124] Timer tick, asking Buildbucket for the build status
[21:35:32.230] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:32.230] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:40:0) after 1m0s
[21:36:32.347] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:40:0)
[21:36:32.347] Timer tick, asking Buildbucket for the build status
[21:36:32.461] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:32.461] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:41:0) after 1m0s
[21:37:32.599] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:41:0)
[21:37:32.599] Timer tick, asking Buildbucket for the build status
[21:37:32.711] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:32.711] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:42:0) after 1m0s
[21:38:32.931] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:42:0)
[21:38:32.931] Timer tick, asking Buildbucket for the build status
[21:38:33.048] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:33.048] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:43:0) after 1m0s
[21:39:33.429] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:43:0)
[21:39:33.429] Timer tick, asking Buildbucket for the build status
[21:39:33.540] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:33.540] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:44:0) after 1m0s
[21:40:33.585] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:44:0)
[21:40:33.585] Timer tick, asking Buildbucket for the build status
[21:40:33.692] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:33.692] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:45:0) after 1m0s
[21:41:33.793] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:45:0)
[21:41:33.793] Timer tick, asking Buildbucket for the build status
[21:41:33.918] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:33.918] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:46:0) after 1m0s
[21:42:34.096] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:46:0)
[21:42:34.096] Timer tick, asking Buildbucket for the build status
[21:42:34.154] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:34.154] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:47:0) after 1m0s
[21:43:34.179] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:47:0)
[21:43:34.179] Timer tick, asking Buildbucket for the build status
[21:43:34.302] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:34.302] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:48:0) after 1m0s
[21:44:34.419] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:48:0)
[21:44:34.419] Timer tick, asking Buildbucket for the build status
[21:44:34.486] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:34.486] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:49:0) after 1m0s
[21:45:34.671] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:49:0)
[21:45:34.671] Timer tick, asking Buildbucket for the build status
[21:45:34.775] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:34.775] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:50:0) after 1m0s
[21:46:34.963] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:50:0)
[21:46:34.963] Timer tick, asking Buildbucket for the build status
[21:46:35.061] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:35.061] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:51:0) after 1m0s
[21:47:35.139] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:51:0)
[21:47:35.139] Timer tick, asking Buildbucket for the build status
[21:47:35.201] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:35.201] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:52:0) after 1m0s
[21:48:35.293] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:52:0)
[21:48:35.293] Timer tick, asking Buildbucket for the build status
[21:48:35.391] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:35.391] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:53:0) after 1m0s
[21:49:35.550] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:53:0)
[21:49:35.550] Timer tick, asking Buildbucket for the build status
[21:49:35.624] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:35.624] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:54:0) after 1m0s
[21:50:35.733] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:54:0)
[21:50:35.733] Timer tick, asking Buildbucket for the build status
[21:50:35.838] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:35.838] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:55:0) after 1m0s
[21:51:35.876] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:55:0)
[21:51:35.876] Timer tick, asking Buildbucket for the build status
[21:51:35.944] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:35.944] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:56:0) after 1m0s
[21:52:36.002] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:56:0)
[21:52:36.002] Timer tick, asking Buildbucket for the build status
[21:52:36.068] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:36.068] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:57:0) after 1m0s
[21:53:36.222] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:57:0)
[21:53:36.222] Timer tick, asking Buildbucket for the build status
[21:53:36.602] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:36.602] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:58:0) after 1m0s
[21:54:36.727] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:58:0)
[21:54:36.727] Timer tick, asking Buildbucket for the build status
[21:54:36.878] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:36.878] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:59:0) after 1m0s
[21:55:36.959] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:59:0)
[21:55:36.959] Timer tick, asking Buildbucket for the build status
[21:55:37.016] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:37.016] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:60:0) after 1m0s
[21:56:37.132] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:60:0)
[21:56:37.132] Timer tick, asking Buildbucket for the build status
[21:56:37.548] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:37.548] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:61:0) after 1m0s
[21:57:37.619] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:61:0)
[21:57:37.619] Timer tick, asking Buildbucket for the build status
[21:57:38.684] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:38.684] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:62:0) after 1m0s
[21:58:38.708] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:62:0)
[21:58:38.708] Timer tick, asking Buildbucket for the build status
[21:58:38.816] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:38.816] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:63:0) after 1m0s
[21:59:38.849] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:63:0)
[21:59:38.849] Timer tick, asking Buildbucket for the build status
[21:59:38.908] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:38.908] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:64:0) after 1m0s
[22:00:38.933] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:64:0)
[22:00:38.933] Timer tick, asking Buildbucket for the build status
[22:00:39.162] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:39.162] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:65:0) after 1m0s
[22:01:39.184] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:65:0)
[22:01:39.184] Timer tick, asking Buildbucket for the build status
[22:01:39.316] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:39.316] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:66:0) after 1m0s
[22:02:39.338] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:66:0)
[22:02:39.338] Timer tick, asking Buildbucket for the build status
[22:02:39.399] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:39.399] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:67:0) after 1m0s
[22:03:39.448] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:67:0)
[22:03:39.448] Timer tick, asking Buildbucket for the build status
[22:03:39.544] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:39.544] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:68:0) after 1m0s
[22:04:39.593] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:68:0)
[22:04:39.593] Timer tick, asking Buildbucket for the build status
[22:04:39.698] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:39.698] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:69:0) after 1m0s
[22:05:39.793] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:69:0)
[22:05:39.793] Timer tick, asking Buildbucket for the build status
[22:05:42.470] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:42.470] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:70:0) after 1m0s
[22:06:42.588] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:70:0)
[22:06:42.588] Timer tick, asking Buildbucket for the build status
[22:06:42.663] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:42.663] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:71:0) after 1m0s
[22:07:42.738] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:71:0)
[22:07:42.738] Timer tick, asking Buildbucket for the build status
[22:07:42.832] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:42.832] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:72:0) after 1m0s
[22:08:42.865] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:72:0)
[22:08:42.865] Timer tick, asking Buildbucket for the build status
[22:08:42.963] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:42.963] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:73:0) after 1m0s
[22:09:43.110] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:73:0)
[22:09:43.110] Timer tick, asking Buildbucket for the build status
[22:09:43.186] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:43.186] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:74:0) after 1m0s
[22:10:43.229] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:74:0)
[22:10:43.229] Timer tick, asking Buildbucket for the build status
[22:10:43.311] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:43.311] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:75:0) after 1m0s
[22:11:43.487] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:75:0)
[22:11:43.487] Timer tick, asking Buildbucket for the build status
[22:11:43.570] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:43.570] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:76:0) after 1m0s
[22:12:43.826] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:76:0)
[22:12:43.826] Timer tick, asking Buildbucket for the build status
[22:12:43.891] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:43.891] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:77:0) after 1m0s
[22:13:44.106] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:77:0)
[22:13:44.106] Timer tick, asking Buildbucket for the build status
[22:13:44.214] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:44.214] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:78:0) after 1m0s
[22:14:44.205] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:78:0)
[22:14:44.205] Timer tick, asking Buildbucket for the build status
[22:14:44.267] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:44.267] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:79:0) after 1m0s
[22:15:44.364] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:79:0)
[22:15:44.364] Timer tick, asking Buildbucket for the build status
[22:15:44.432] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:44.432] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:80:0) after 1m0s
[22:16:44.511] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:80:0)
[22:16:44.511] Timer tick, asking Buildbucket for the build status
[22:16:44.580] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:44.580] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:81:0) after 1m0s
[22:17:44.643] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:81:0)
[22:17:44.643] Timer tick, asking Buildbucket for the build status
[22:17:44.742] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:44.742] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:82:0) after 1m0s
[22:18:45.524] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:82:0)
[22:18:45.524] Timer tick, asking Buildbucket for the build status
[22:18:46.006] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:46.006] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:83:0) after 1m0s
[22:19:46.064] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:83:0)
[22:19:46.064] Timer tick, asking Buildbucket for the build status
[22:19:46.225] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:46.225] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:84:0) after 1m0s
[22:20:46.359] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:84:0)
[22:20:46.359] Timer tick, asking Buildbucket for the build status
[22:20:46.427] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:46.427] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:85:0) after 1m0s
[22:21:46.461] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:85:0)
[22:21:46.461] Timer tick, asking Buildbucket for the build status
[22:21:46.526] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:46.526] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:86:0) after 1m0s
[22:22:46.576] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:86:0)
[22:22:46.576] Timer tick, asking Buildbucket for the build status
[22:22:46.637] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:46.637] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:87:0) after 1m0s
[22:23:46.667] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:87:0)
[22:23:46.667] Timer tick, asking Buildbucket for the build status
[22:23:46.766] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:46.766] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:88:0) after 1m0s
[22:24:46.787] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:88:0)
[22:24:46.787] Timer tick, asking Buildbucket for the build status
[22:24:46.848] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:46.848] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:89:0) after 1m0s
[22:25:46.873] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:89:0)
[22:25:46.873] Timer tick, asking Buildbucket for the build status
[22:25:46.937] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:46.937] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:90:0) after 1m0s
[22:26:46.950] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:90:0)
[22:26:46.950] Timer tick, asking Buildbucket for the build status
[22:26:47.015] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:47.015] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:91:0) after 1m0s
[22:27:47.038] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:91:0)
[22:27:47.038] Timer tick, asking Buildbucket for the build status
[22:27:47.095] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:47.095] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:92:0) after 1m0s
[22:28:47.383] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:92:0)
[22:28:47.383] Timer tick, asking Buildbucket for the build status
[22:28:47.524] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:47.524] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:93:0) after 1m0s
[22:29:47.631] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:93:0)
[22:29:47.631] Timer tick, asking Buildbucket for the build status
[22:29:47.711] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:47.711] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:94:0) after 1m0s
[22:30:47.741] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:94:0)
[22:30:47.741] Timer tick, asking Buildbucket for the build status
[22:30:47.812] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:47.812] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:95:0) after 1m0s
[22:31:47.843] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:95:0)
[22:31:47.843] Timer tick, asking Buildbucket for the build status
[22:31:48.002] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:48.002] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:96:0) after 1m0s
[22:32:48.048] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:96:0)
[22:32:48.048] Timer tick, asking Buildbucket for the build status
[22:32:48.121] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:48.121] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:97:0) after 1m0s
[22:33:48.185] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:97:0)
[22:33:48.185] Timer tick, asking Buildbucket for the build status
[22:33:48.774] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:48.774] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:98:0) after 1m0s
[22:34:48.850] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:98:0)
[22:34:48.850] Timer tick, asking Buildbucket for the build status
[22:34:49.113] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:49.113] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:99:0) after 1m0s
[22:35:49.121] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:99:0)
[22:35:49.121] Timer tick, asking Buildbucket for the build status
[22:35:49.268] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:49.268] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:100:0) after 1m0s
[22:36:49.299] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:100:0)
[22:36:49.299] Timer tick, asking Buildbucket for the build status
[22:36:49.807] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:49.807] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:101:0) after 1m0s
[22:37:49.952] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:101:0)
[22:37:49.952] Timer tick, asking Buildbucket for the build status
[22:37:50.083] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:50.083] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:102:0) after 1m0s
[22:38:50.181] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:102:0)
[22:38:50.181] Timer tick, asking Buildbucket for the build status
[22:38:50.288] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:50.288] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:103:0) after 1m0s
[22:39:50.313] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:103:0)
[22:39:50.313] Timer tick, asking Buildbucket for the build status
[22:39:50.401] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:50.401] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:104:0) after 1m0s
[22:40:50.393] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:104:0)
[22:40:50.393] Timer tick, asking Buildbucket for the build status
[22:40:50.472] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:50.472] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:105:0) after 1m0s
[22:41:50.506] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:105:0)
[22:41:50.506] Timer tick, asking Buildbucket for the build status
[22:41:50.566] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:50.566] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:106:0) after 1m0s
[22:42:50.664] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:106:0)
[22:42:50.664] Timer tick, asking Buildbucket for the build status
[22:42:50.880] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:50.880] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:107:0) after 1m0s
[22:43:50.982] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:107:0)
[22:43:50.982] Timer tick, asking Buildbucket for the build status
[22:43:51.390] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:51.390] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:108:0) after 1m0s
[22:44:51.796] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:108:0)
[22:44:51.796] Timer tick, asking Buildbucket for the build status
[22:44:52.096] Build 8866159626098325904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:52.096] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031589688133307888:109:0) after 1m0s
[22:44:59.007] Received PubSub notification, asking Buildbucket for the build status
[22:44:59.078] Build 8866159626098325904: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:44:59.078] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1602974698201565",
"created_by": "project:chromium",
"created_ts": "1602968301639614",
"id": "8866159626098325904",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"66a8b2926f4fc16a85446095187432c44bc0772f\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"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\": \"66a8b2926f4fc16a85446095187432c44bc0772f\", \"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-66-rlk8\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 176766, \"got_angle_revision\": \"07ea804e620132517b6af0ef92fe85ea737d0c27\", \"got_dawn_revision\": \"875091308b04ba87e29c929ed707f27889c660ea\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"66a8b2926f4fc16a85446095187432c44bc0772f\", \"got_revision_cp\": \"refs/heads/master@{#818264}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"992b13db26c29db225f812aa1dfc637940e99cb8\", \"got_v8_revision_cp\": \"refs/heads/8.8.119@{#1}\", \"got_webrtc_revision\": \"1f3ac1f8e0688f8eff467b7dedbdb3f202604aeb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32428}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"66a8b2926f4fc16a85446095187432c44bc0772f\", \"swarm_hashes_refs/heads/master(at){#818264}_without_patch\": {\"absl_hardening_tests\": \"8c748dea6bbe07f26f69bbb0534ab2ca0802e235\", \"accessibility_unittests\": \"e5f090e268cc4135cdbf9bb1303286b9e64b2e78\", \"app_shell_unittests\": \"8d11b0e11dcfc2fe42982f0732c7f85bb3db33e7\", \"aura_unittests\": \"50ec3ff8e206a279bc96910bd58dbea18408c437\", \"base_unittests\": \"d286f8ee5372dc718462fb5ab858cd2230620cb4\", \"base_util_unittests\": \"7a21595d9622f0e680a8ede465046a765522f5d6\", \"blink_common_unittests\": \"00a6aa82b4cc4244d0d8da30f16a8d255aa8a430\", \"blink_fuzzer_unittests\": \"69f178238c90f8e3585d3075326d356406344a1b\", \"blink_heap_unittests\": \"5a97d9a2b20451f9f93838a0606d79710001e80c\", \"blink_platform_unittests\": \"374d12479c3f6d403db01e1143f4f6721b182f31\", \"blink_python_tests\": \"7b08d15d0de5c74590b1c67f4ccc39f585f13593\", \"blink_unittests\": \"4a16c8ea58d67e818df834c744963208644edaac\", \"blink_web_tests\": \"a8f1ab5b4ebe73996aa973bf4a63fa931db6bcd0\", \"boringssl_crypto_tests\": \"0fd6d501297f9b35122b8b1fc22d6ffa9f5716df\", \"boringssl_ssl_tests\": \"11c1c60612d4931d02bebffaeab56bc0f6db3bc2\", \"browser_tests\": \"fb6616e4595addb9dc26f0353f7387e4be2a83dc\", \"capture_unittests\": \"64b22239b9c42a20ee2fd75486b5e3793efb1498\", \"cast_unittests\": \"7853854974f94c23ec27b8ced27dfbead232546b\", \"cc_unittests\": \"a2d8b795ea89a63e9c97c3df1d060761425a7547\", \"chrome_app_unittests\": \"6a149d6e80cd630797dccfd7dc7faa99f8a6dff5\", \"chromedriver_unittests\": \"01564cb6f28665b381deeab53b8be7dbe2b4f2ee\", \"components_browsertests\": \"0ac27853a73a5693c951efb1150c91c8bd340c5d\", \"components_unittests\": \"959a3a8d7eec394252bba8baab75b89b74a467c7\", \"compositor_unittests\": \"b0ae71a1d74578f96db396a7fc57f082f7ac4991\", \"content_browsertests\": \"387f9a0773473b356d054dd1d574a45f817b0814\", \"content_shell_crash_test\": \"0e6fbf34ea08f8d458f2bf8f64bf6367b916302a\", \"content_unittests\": \"27507baf781d9c561c6033fdf8404ba8e19f14a4\", \"crashpad_tests\": \"752fe1003c6647f9d2b2a3f878e489670a723e89\", \"cronet_tests\": \"2b0a08f89499152c260dec477328aec060df22ba\", \"cronet_unittests\": \"71320ba520d7f6e47fe81a4ab939df6ab77b6bb2\", \"crypto_unittests\": \"4503d96fbab2194e8ca8fbdb89b40a52965b397e\", \"dbus_unittests\": \"000c300753f39e25b4409c08220bd113d6f5a916\", \"device_unittests\": \"ee07b33a395a2e4560517ab48dfa1b57e56f72eb\", \"display_unittests\": \"b14e32f30d3a1c6d9a465e5815d89ce8c8ec432c\", \"events_unittests\": \"933a86fef73fd436669d3d01262adca805c2daeb\", \"extension_docserver_python_unittests\": \"f63b04a390222006832c09a8c4a08547b12ede68\", \"extensions_browsertests\": \"62e3feca559bdab9235f4ae5835b733413c9d208\", \"extensions_unittests\": \"01c286402136ea4f667646d0920eacaa8c079aa5\", \"filesystem_service_unittests\": \"cdb665810f94162515143f730d2f6a3650e82745\", \"flatbuffers_unittests\": \"7c821f13730963d6e07deae074f4fffab315d766\", \"gcm_unit_tests\": \"53c7b6d693fa95e0a9069520a7cf629da51da290\", \"gfx_unittests\": \"3343c3889e3d56f7e60dd0f408cbe90ed9ce2c03\", \"gin_unittests\": \"a947b6a6885b3d403cd5d452a308f908f8441f94\", \"google_apis_unittests\": \"6a392d34c03f57479d9929783451f09e0add432f\", \"gpu_unittests\": \"e52580f07529f12953f237e54e2c7917830e767e\", \"grit_python_unittests\": \"8ff0b3de600ef80bc443ec65457d74cd6c46cf1a\", \"gwp_asan_unittests\": \"55205d0e6329790ce4aca4de94d08c4691355d45\", \"headless_browsertests\": \"5dde5b50b8f016701e092e2c2dcf63dfc440d81c\", \"headless_unittests\": \"0c6601db024feca67a42d8f0570a772c78b7d8d7\", \"interactive_ui_tests\": \"ea7e8f6b51bf266d5dbeddf833a9b182873c5b1c\", \"ipc_tests\": \"5b4fbdb06742d83721739a4cc838bfe8fb988483\", \"jingle_unittests\": \"93e2613b9a088c373b6869b6b6f4ebf8bf31c648\", \"latency_unittests\": \"b366f4a9b5b556da75b473190bcfd82968c121ca\", \"libjingle_xmpp_unittests\": \"1e3109545c3d9acd8875b41830072fe4046da029\", \"media_blink_unittests\": \"b6f1c03dacf7b5b0bafb74ee5d96e98e4a94dc7a\", \"media_unittests\": \"f5f5d0d0f3fcf86c3ab7556e668c9db7a7df5710\", \"message_center_unittests\": \"ebd04aeebf4a522fda65bb38436cf48dd4e3660e\", \"metrics_python_tests\": \"529514dacf9f4b326e8edd62e33ab2deca863d72\", \"midi_unittests\": \"10eb3293d010323375430ac5195c93d722f56167\", \"mojo_core_unittests\": \"4b58deaddd6850d5b17c3d8daa3c8972823313de\", \"mojo_unittests\": \"f07434dcaef08649f337a42e9eaf457394de0156\", \"nacl_helper_nonsfi_unittests\": \"d9859e85487baf3329eb88c32ef93b6374171718\", \"nacl_loader_unittests\": \"c5637175ac98584d5fc1dcc7a745bf2b43f404f8\", \"native_theme_unittests\": \"69d19b7ce963a2d11652f507f05015ce110819db\", \"net_unittests\": \"5ca7683ef02543e1fbf113407d750e9425f34f13\", \"openscreen_unittests\": \"60290712896a2f3cc9e64cd07f46103fdbf7b78b\", \"pdf_unittests\": \"af5ea34e984c509a9b86f46fbf09845ef7d5a1d0\", \"perfetto_unittests\": \"7b094148c0d45588f4c1cbba2227ad6f429d20ae\", \"ppapi_unittests\": \"ec354f6e581174348f48c9d5ecd58016fcd4c6b2\", \"printing_unittests\": \"309357078ea62b16231c4a126dac38f0a542f478\", \"remoting_unittests\": \"a19f7c4e4c63e9482b50bea382776e8ee504946b\", \"sandbox_linux_unittests\": \"c167d9018dd3a21484a873e0e6a21aad537ae731\", \"service_manager_unittests\": \"ace60da06e2d068009dd979802b337b2f7b96141\", \"services_unittests\": \"d5942307025bb08641be2cca4b53327b484e5c56\", \"shell_dialogs_unittests\": \"4df5d29b7302da8f9b3ee7260600da2af04a37a3\", \"skia_unittests\": \"b5f0d60de13038f6bff6934fab885c418017b892\", \"snapshot_unittests\": \"e9131b90db76561ec96064d69c6b30a44621a6cf\", \"sql_unittests\": \"f0d34b31f6a8c2963c049bf993045002b4f1b77a\", \"standalone_angle_unittests\": \"330d52cfa0f54b5cdbca24812e753de85773685c\", \"storage_unittests\": \"b8bb64769e5242677e43813048192084300260fd\", \"sync_integration_tests\": \"1a97be1bf88b90054b4a143aab1912031f8e8de1\", \"telemetry_gpu_unittests\": \"e8a60bda4fb9713b813af410cda9d8ae6ed713c2\", \"telemetry_perf_unittests\": \"b526c21b145f101f816923050aa5c0d76f6f4270\", \"telemetry_unittests\": \"df7b329ef60d84a06a817513b39a8d64ec729b1e\", \"traffic_annotation_auditor_unittests\": \"697ce2597f5f6f5fa0220f9e70f4f58962c4b524\", \"ui_base_unittests\": \"6759e8fa858de27b28d70076c45d3dd7ea6847ca\", \"ui_touch_selection_unittests\": \"04322b46d21366b2de63e0ce73c78dc2a035cfef\", \"unit_tests\": \"a2d0e74e89599afc985af75a842f4b834a48313a\", \"url_unittests\": \"e6b828cced0ea81fe2872a0353421972aa2bb4f5\", \"views_perftests\": \"eaacf881a861f3764cbceec7e454d60645c661c0\", \"views_unittests\": \"84b6175d18059a8faf462f00f4a25baa2ca30878\", \"viz_unittests\": \"be2cc84a5e37b1687279e1f2a5995204a3f338b0\", \"vr_common_unittests\": \"6379e1e769174be9638827bbb24dff7367221776\", \"vr_pixeltests\": \"c13965e703e2d35193dd4664e0aa3efe1c89f969\", \"webdriver_wpt_tests\": \"9093e4a57e35d5e73fcdf8d7e039136679bf4d2c\", \"weblayer_browsertests\": \"1e5dd2b6d1f00b7e9ea4ac3af7ce9ab10dc30885\", \"weblayer_unittests\": \"f781a211ec782f239fd3f75997775a2ebab199de\", \"wm_unittests\": \"fe02f56423f7e1d42ec1851c8575f3db8c6c5f2e\", \"wtf_unittests\": \"3478d694a6042f18986bd892795784ec43f91b27\", \"x11_unittests\": \"0c49b4c8d58209f384ecdcae7f1aced49d8067a1\", \"xr_browser_tests\": \"ef39882477cd746db9c128fdcc6277ba394f9815\", \"zlib_unittests\": \"229cca615d3d9ec6ca52b3ad1ecb580e66e5a383\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_28be8b4e850be8bd7a9db0671ff876681ccdf0c2c048860e172c20e0c8b9b79b_v2\", \"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_4ee5460861b9ef33d156aeaeac2391df3413ba8f3171f779b8382484348a79c5_v2\", \"builder_5315cf154f9c1ae6b2621094599bc107171a849e1c0f232ec66a504ee800a364_v2\", \"builder_94dc7d486ab1bafc5bfb11010ef18f0cf20e8e07ae86b58c09f57ba294c280ac_v2\", \"builder_e5bbff72983945f6847543519ce1052420cedd06fb8495f4080bfa2e6bcfd13f_v2\", \"builder_ee5c11e7a332f55fd7a24d7319a67a6829cd4b81b48e997032d91622b214e82b_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-66-rlk8\"], \"image\": [\"chrome-xenial-20101301-f14f52fdd71\"], \"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\": [\"5595-820ff29\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1602970151600151",
"status": "COMPLETED",
"status_changed_ts": "1602974698681917",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/176766",
"builder:Linux Builder (dbg)",
"buildset:commit/git/66a8b2926f4fc16a85446095187432c44bc0772f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/66a8b2926f4fc16a85446095187432c44bc0772f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031589688133307888",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8866159626098325904/+/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:4f512cbf9fbc1310",
"user_agent:luci-scheduler"
],
"updated_ts": "1602974698687699",
"url": "https://ci.chromium.org/b/8866159626098325904",
"utcnow_ts": "1602974699067108"
}
}
[22:44:59.078] Invocation finished in 1h46m38.762687814s with status SUCCEEDED