[14:32:32.745] New invocation is queued and will start shortly
[14:32:33.960] Starting the invocation (attempt 1)
[14:32:34.008] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:32:34.008] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:32:34.008] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027718290593160736",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"31b80a359186c53c6c0151d5427f9241e7d7a835\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9027718290593160736",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/31b80a359186c53c6c0151d5427f9241e7d7a835",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/31b80a359186c53c6c0151d5427f9241e7d7a835",
"gitiles_ref:refs/heads/master"
]
}
[14:32:35.278] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606660354173995",
"id": "8862288228420770304",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"31b80a359186c53c6c0151d5427f9241e7d7a835\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606660355018357",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178157",
"builder:Linux Builder (dbg)",
"buildset:commit/git/31b80a359186c53c6c0151d5427f9241e7d7a835",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/31b80a359186c53c6c0151d5427f9241e7d7a835",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027718290593160736",
"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/8862288228420770304/+/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": "1606660355018470",
"url": "https://ci.chromium.org/b/8862288228420770304",
"utcnow_ts": "1606660355262417"
}
}
[14:32:35.279] Task URL: https://ci.chromium.org/b/8862288228420770304
[14:32:35.279] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:2:0) after 1m0s
[14:33:35.269] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:2:0)
[14:33:35.269] Timer tick, asking Buildbucket for the build status
[14:33:35.371] Build 8862288228420770304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:33:35.371] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:3:0) after 1m0s
[14:34:35.448] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:3:0)
[14:34:35.448] Timer tick, asking Buildbucket for the build status
[14:34:35.521] Build 8862288228420770304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:34:35.521] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:4:0) after 1m0s
[14:35:35.662] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:4:0)
[14:35:35.662] Timer tick, asking Buildbucket for the build status
[14:35:35.879] Build 8862288228420770304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:35:35.879] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:5:0) after 1m0s
[14:36:36.039] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:5:0)
[14:36:36.039] Timer tick, asking Buildbucket for the build status
[14:36:36.210] Build 8862288228420770304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:36:36.210] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:6:0) after 1m0s
[14:37:36.275] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:6:0)
[14:37:36.275] Timer tick, asking Buildbucket for the build status
[14:37:36.411] Build 8862288228420770304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:37:36.411] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:7:0) after 1m0s
[14:38:36.575] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:7:0)
[14:38:36.575] Timer tick, asking Buildbucket for the build status
[14:38:36.657] Build 8862288228420770304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:38:36.657] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:8:0) after 1m0s
[14:39:36.727] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:8:0)
[14:39:36.727] Timer tick, asking Buildbucket for the build status
[14:39:36.834] Build 8862288228420770304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:39:36.834] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:9:0) after 1m0s
[14:40:36.974] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:9:0)
[14:40:36.974] Timer tick, asking Buildbucket for the build status
[14:40:37.053] Build 8862288228420770304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:40:37.053] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:10:0) after 1m0s
[14:41:37.095] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:10:0)
[14:41:37.095] Timer tick, asking Buildbucket for the build status
[14:41:37.172] Build 8862288228420770304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:41:37.172] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:11:0) after 1m0s
[14:42:37.313] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:11:0)
[14:42:37.313] Timer tick, asking Buildbucket for the build status
[14:42:37.523] Build 8862288228420770304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:42:37.523] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:12:0) after 1m0s
[14:43:37.619] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:12:0)
[14:43:37.619] Timer tick, asking Buildbucket for the build status
[14:43:37.821] Build 8862288228420770304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:43:37.821] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:13:0) after 1m0s
[14:44:37.892] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:13:0)
[14:44:37.892] Timer tick, asking Buildbucket for the build status
[14:44:38.056] Build 8862288228420770304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:44:38.056] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:14:0) after 1m0s
[14:45:38.127] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:14:0)
[14:45:38.127] Timer tick, asking Buildbucket for the build status
[14:45:38.276] Build 8862288228420770304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:45:38.276] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:15:0) after 1m0s
[14:46:38.306] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:15:0)
[14:46:38.306] Timer tick, asking Buildbucket for the build status
[14:46:38.415] Build 8862288228420770304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:46:38.415] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:16:0) after 1m0s
[14:47:38.450] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:16:0)
[14:47:38.450] Timer tick, asking Buildbucket for the build status
[14:47:38.534] Build 8862288228420770304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:47:38.534] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:17:0) after 1m0s
[14:48:38.606] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:17:0)
[14:48:38.606] Timer tick, asking Buildbucket for the build status
[14:48:38.911] Build 8862288228420770304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:48:38.911] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:18:0) after 1m0s
[14:49:38.886] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:18:0)
[14:49:38.886] Timer tick, asking Buildbucket for the build status
[14:49:38.959] Build 8862288228420770304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:49:38.959] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:19:0) after 1m0s
[14:50:39.014] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:19:0)
[14:50:39.014] Timer tick, asking Buildbucket for the build status
[14:50:39.553] Build 8862288228420770304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:50:39.553] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:20:0) after 1m0s
[14:51:39.549] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:20:0)
[14:51:39.549] Timer tick, asking Buildbucket for the build status
[14:51:40.089] Build 8862288228420770304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:51:40.089] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:21:0) after 1m0s
[14:52:40.164] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:21:0)
[14:52:40.164] Timer tick, asking Buildbucket for the build status
[14:52:40.296] Build 8862288228420770304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:52:40.296] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:22:0) after 1m0s
[14:53:40.372] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:22:0)
[14:53:40.372] Timer tick, asking Buildbucket for the build status
[14:53:40.505] Build 8862288228420770304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:53:40.505] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:23:0) after 1m0s
[14:54:40.523] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:23:0)
[14:54:40.523] Timer tick, asking Buildbucket for the build status
[14:54:40.676] Build 8862288228420770304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:54:40.676] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:24:0) after 1m0s
[14:55:40.721] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:24:0)
[14:55:40.721] Timer tick, asking Buildbucket for the build status
[14:55:40.789] Build 8862288228420770304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:55:40.789] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:25:0) after 1m0s
[14:56:40.808] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:25:0)
[14:56:40.808] Timer tick, asking Buildbucket for the build status
[14:56:41.007] Build 8862288228420770304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:56:41.007] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:26:0) after 1m0s
[14:57:41.043] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:26:0)
[14:57:41.043] Timer tick, asking Buildbucket for the build status
[14:57:41.430] Build 8862288228420770304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:57:41.430] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:27:0) after 1m0s
[14:58:41.496] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:27:0)
[14:58:41.496] Timer tick, asking Buildbucket for the build status
[14:58:41.574] Build 8862288228420770304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:58:41.574] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:28:0) after 1m0s
[14:59:41.595] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:28:0)
[14:59:41.595] Timer tick, asking Buildbucket for the build status
[14:59:41.669] Build 8862288228420770304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:59:41.669] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:29:0) after 1m0s
[15:00:41.690] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:29:0)
[15:00:41.690] Timer tick, asking Buildbucket for the build status
[15:00:41.825] Build 8862288228420770304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:00:41.825] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:30:0) after 1m0s
[15:01:41.842] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:30:0)
[15:01:41.842] Timer tick, asking Buildbucket for the build status
[15:01:41.929] Build 8862288228420770304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:01:41.929] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:31:0) after 1m0s
[15:02:41.950] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:31:0)
[15:02:41.950] Timer tick, asking Buildbucket for the build status
[15:02:42.068] Build 8862288228420770304: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:02:42.068] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:32:0) after 1m0s
[15:02:50.502] Received PubSub notification, asking Buildbucket for the build status
[15:02:50.578] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:42.086] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:32:0)
[15:03:42.086] Timer tick, asking Buildbucket for the build status
[15:03:42.412] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:42.412] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:34:0) after 1m0s
[15:04:42.434] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:34:0)
[15:04:42.434] Timer tick, asking Buildbucket for the build status
[15:04:42.512] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:42.512] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:35:0) after 1m0s
[15:05:42.532] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:35:0)
[15:05:42.532] Timer tick, asking Buildbucket for the build status
[15:05:42.685] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:42.685] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:36:0) after 1m0s
[15:06:42.710] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:36:0)
[15:06:42.710] Timer tick, asking Buildbucket for the build status
[15:06:42.869] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:42.869] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:37:0) after 1m0s
[15:07:42.889] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:37:0)
[15:07:42.889] Timer tick, asking Buildbucket for the build status
[15:07:43.165] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:43.165] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:38:0) after 1m0s
[15:08:43.237] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:38:0)
[15:08:43.237] Timer tick, asking Buildbucket for the build status
[15:08:43.338] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:43.339] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:39:0) after 1m0s
[15:09:43.359] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:39:0)
[15:09:43.359] Timer tick, asking Buildbucket for the build status
[15:09:43.543] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:43.543] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:40:0) after 1m0s
[15:10:43.561] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:40:0)
[15:10:43.561] Timer tick, asking Buildbucket for the build status
[15:10:43.765] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:43.765] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:41:0) after 1m0s
[15:11:43.839] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:41:0)
[15:11:43.839] Timer tick, asking Buildbucket for the build status
[15:11:44.181] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:44.181] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:42:0) after 1m0s
[15:12:44.220] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:42:0)
[15:12:44.220] Timer tick, asking Buildbucket for the build status
[15:12:44.309] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:44.309] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:43:0) after 1m0s
[15:13:44.341] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:43:0)
[15:13:44.341] Timer tick, asking Buildbucket for the build status
[15:13:44.460] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:44.460] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:44:0) after 1m0s
[15:14:44.481] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:44:0)
[15:14:44.481] Timer tick, asking Buildbucket for the build status
[15:14:44.577] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:44.577] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:45:0) after 1m0s
[15:15:44.596] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:45:0)
[15:15:44.596] Timer tick, asking Buildbucket for the build status
[15:15:44.801] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:44.801] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:46:0) after 1m0s
[15:16:44.887] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:46:0)
[15:16:44.887] Timer tick, asking Buildbucket for the build status
[15:16:44.957] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:44.957] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:47:0) after 1m0s
[15:17:44.996] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:47:0)
[15:17:44.996] Timer tick, asking Buildbucket for the build status
[15:17:45.314] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:45.314] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:48:0) after 1m0s
[15:18:45.337] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:48:0)
[15:18:45.338] Timer tick, asking Buildbucket for the build status
[15:18:45.516] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:45.516] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:49:0) after 1m0s
[15:19:45.536] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:49:0)
[15:19:45.536] Timer tick, asking Buildbucket for the build status
[15:19:45.683] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:45.683] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:50:0) after 1m0s
[15:20:45.706] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:50:0)
[15:20:45.706] Timer tick, asking Buildbucket for the build status
[15:20:45.894] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:45.894] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:51:0) after 1m0s
[15:21:45.952] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:51:0)
[15:21:45.952] Timer tick, asking Buildbucket for the build status
[15:21:46.425] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:46.425] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:52:0) after 1m0s
[15:22:46.536] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:52:0)
[15:22:46.536] Timer tick, asking Buildbucket for the build status
[15:22:46.599] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:46.599] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:53:0) after 1m0s
[15:23:46.624] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:53:0)
[15:23:46.624] Timer tick, asking Buildbucket for the build status
[15:23:46.721] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:46.721] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:54:0) after 1m0s
[15:24:46.746] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:54:0)
[15:24:46.746] Timer tick, asking Buildbucket for the build status
[15:24:46.816] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:46.816] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:55:0) after 1m0s
[15:25:46.858] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:55:0)
[15:25:46.858] Timer tick, asking Buildbucket for the build status
[15:25:46.933] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:46.933] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:56:0) after 1m0s
[15:26:47.038] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:56:0)
[15:26:47.038] Timer tick, asking Buildbucket for the build status
[15:26:47.297] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:47.297] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:57:0) after 1m0s
[15:27:47.409] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:57:0)
[15:27:47.409] Timer tick, asking Buildbucket for the build status
[15:27:47.570] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:47.570] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:58:0) after 1m0s
[15:28:47.570] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:58:0)
[15:28:47.570] Timer tick, asking Buildbucket for the build status
[15:28:47.701] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:47.701] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:59:0) after 1m0s
[15:29:47.852] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:59:0)
[15:29:47.852] Timer tick, asking Buildbucket for the build status
[15:29:48.032] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:48.032] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:60:0) after 1m0s
[15:30:48.071] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:60:0)
[15:30:48.071] Timer tick, asking Buildbucket for the build status
[15:30:48.431] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:48.431] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:61:0) after 1m0s
[15:31:48.471] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:61:0)
[15:31:48.471] Timer tick, asking Buildbucket for the build status
[15:31:48.542] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:48.543] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:62:0) after 1m0s
[15:32:48.584] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:62:0)
[15:32:48.584] Timer tick, asking Buildbucket for the build status
[15:32:48.849] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:48.849] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:63:0) after 1m0s
[15:33:48.844] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:63:0)
[15:33:48.844] Timer tick, asking Buildbucket for the build status
[15:33:49.169] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:49.169] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:64:0) after 1m0s
[15:34:49.189] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:64:0)
[15:34:49.189] Timer tick, asking Buildbucket for the build status
[15:34:49.312] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:49.312] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:65:0) after 1m0s
[15:35:49.362] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:65:0)
[15:35:49.362] Timer tick, asking Buildbucket for the build status
[15:35:49.427] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:49.427] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:66:0) after 1m0s
[15:36:49.446] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:66:0)
[15:36:49.446] Timer tick, asking Buildbucket for the build status
[15:36:49.551] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:49.551] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:67:0) after 1m0s
[15:37:49.574] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:67:0)
[15:37:49.574] Timer tick, asking Buildbucket for the build status
[15:37:49.652] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:49.652] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:68:0) after 1m0s
[15:38:49.675] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:68:0)
[15:38:49.675] Timer tick, asking Buildbucket for the build status
[15:38:49.830] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:49.830] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:69:0) after 1m0s
[15:39:49.852] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:69:0)
[15:39:49.852] Timer tick, asking Buildbucket for the build status
[15:39:50.279] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:50.279] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:70:0) after 1m0s
[15:40:50.302] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:70:0)
[15:40:50.302] Timer tick, asking Buildbucket for the build status
[15:40:51.266] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:51.266] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:71:0) after 1m0s
[15:41:51.297] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:71:0)
[15:41:51.297] Timer tick, asking Buildbucket for the build status
[15:41:51.375] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:51.375] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:72:0) after 1m0s
[15:42:51.395] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:72:0)
[15:42:51.395] Timer tick, asking Buildbucket for the build status
[15:42:51.781] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:51.782] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:73:0) after 1m0s
[15:43:51.807] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:73:0)
[15:43:51.807] Timer tick, asking Buildbucket for the build status
[15:43:51.939] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:51.939] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:74:0) after 1m0s
[15:44:51.959] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:74:0)
[15:44:51.959] Timer tick, asking Buildbucket for the build status
[15:44:52.411] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:52.411] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:75:0) after 1m0s
[15:45:52.464] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:75:0)
[15:45:52.464] Timer tick, asking Buildbucket for the build status
[15:45:53.057] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:53.057] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:76:0) after 1m0s
[15:46:53.077] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:76:0)
[15:46:53.077] Timer tick, asking Buildbucket for the build status
[15:46:53.171] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:53.171] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:77:0) after 1m0s
[15:47:53.246] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:77:0)
[15:47:53.246] Timer tick, asking Buildbucket for the build status
[15:47:53.323] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:53.323] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:78:0) after 1m0s
[15:48:53.388] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:78:0)
[15:48:53.388] Timer tick, asking Buildbucket for the build status
[15:48:53.580] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:53.580] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:79:0) after 1m0s
[15:49:53.615] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:79:0)
[15:49:53.615] Timer tick, asking Buildbucket for the build status
[15:49:54.038] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:54.038] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:80:0) after 1m0s
[15:50:54.083] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:80:0)
[15:50:54.083] Timer tick, asking Buildbucket for the build status
[15:50:54.176] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:54.176] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:81:0) after 1m0s
[15:51:54.198] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:81:0)
[15:51:54.198] Timer tick, asking Buildbucket for the build status
[15:51:54.261] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:54.261] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:82:0) after 1m0s
[15:52:54.281] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:82:0)
[15:52:54.281] Timer tick, asking Buildbucket for the build status
[15:52:54.436] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:54.436] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:83:0) after 1m0s
[15:53:54.456] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:83:0)
[15:53:54.456] Timer tick, asking Buildbucket for the build status
[15:53:54.761] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:54.761] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:84:0) after 1m0s
[15:54:54.787] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:84:0)
[15:54:54.787] Timer tick, asking Buildbucket for the build status
[15:54:54.866] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:54.866] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:85:0) after 1m0s
[15:55:54.889] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:85:0)
[15:55:54.889] Timer tick, asking Buildbucket for the build status
[15:55:55.243] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:55.243] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:86:0) after 1m0s
[15:56:55.276] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:86:0)
[15:56:55.276] Timer tick, asking Buildbucket for the build status
[15:56:55.368] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:55.368] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:87:0) after 1m0s
[15:57:55.387] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:87:0)
[15:57:55.387] Timer tick, asking Buildbucket for the build status
[15:57:55.549] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:55.549] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:88:0) after 1m0s
[15:58:55.571] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:88:0)
[15:58:55.571] Timer tick, asking Buildbucket for the build status
[15:58:55.818] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:55.818] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:89:0) after 1m0s
[15:59:55.839] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:89:0)
[15:59:55.839] Timer tick, asking Buildbucket for the build status
[15:59:56.619] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:56.619] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:90:0) after 1m0s
[16:00:56.637] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:90:0)
[16:00:56.637] Timer tick, asking Buildbucket for the build status
[16:00:56.775] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:56.775] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:91:0) after 1m0s
[16:01:56.852] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:91:0)
[16:01:56.852] Timer tick, asking Buildbucket for the build status
[16:01:56.954] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:56.954] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:92:0) after 1m0s
[16:02:56.978] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:92:0)
[16:02:56.978] Timer tick, asking Buildbucket for the build status
[16:02:57.307] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:57.307] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:93:0) after 1m0s
[16:04:01.126] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:93:0)
[16:04:01.126] Timer tick, asking Buildbucket for the build status
[16:04:01.509] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:01.509] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:94:0) after 1m0s
[16:05:01.589] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:94:0)
[16:05:01.589] Timer tick, asking Buildbucket for the build status
[16:05:01.659] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:01.659] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:95:0) after 1m0s
[16:06:02.396] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:95:0)
[16:06:02.396] Timer tick, asking Buildbucket for the build status
[16:06:02.584] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:02.584] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:96:0) after 1m0s
[16:07:02.806] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:96:0)
[16:07:02.806] Timer tick, asking Buildbucket for the build status
[16:07:02.959] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:02.959] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:97:0) after 1m0s
[16:08:03.135] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:97:0)
[16:08:03.135] Timer tick, asking Buildbucket for the build status
[16:08:03.652] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:03.652] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:98:0) after 1m0s
[16:09:03.751] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:98:0)
[16:09:03.751] Timer tick, asking Buildbucket for the build status
[16:09:03.868] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:03.868] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:99:0) after 1m0s
[16:10:04.042] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:99:0)
[16:10:04.042] Timer tick, asking Buildbucket for the build status
[16:10:04.290] Build 8862288228420770304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:04.290] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9027718290593160736:100:0) after 1m0s
[16:10:27.743] Received PubSub notification, asking Buildbucket for the build status
[16:10:27.814] Build 8862288228420770304: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:10:27.814] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606666227001095",
"created_by": "project:chromium",
"created_ts": "1606660354173995",
"id": "8862288228420770304",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"31b80a359186c53c6c0151d5427f9241e7d7a835\"}}",
"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\": \"31b80a359186c53c6c0151d5427f9241e7d7a835\", \"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-8-zakc\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 178157, \"got_angle_revision\": \"59aa1ef1975ae2d263da864f111eaaa7cdb4f9f2\", \"got_dawn_revision\": \"d8bb0bb7c735173219d7a8ffec18eee1813ff302\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"31b80a359186c53c6c0151d5427f9241e7d7a835\", \"got_revision_cp\": \"refs/heads/master@{#831724}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"9dff6a3bb5950edd890e5141f2d3d2f3b4ef351e\", \"got_v8_revision\": \"8d791670ba247239ef6ce9091183f11f8c5f0825\", \"got_v8_revision_cp\": \"refs/heads/8.9.65@{#1}\", \"got_webrtc_revision\": \"bcca3b08a90fccaa6dd8d86f6079f0ca0553ab4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32715}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux-clang-tidy-dbg\", \"tryserver.chromium.linux:linux_chromium_dbg_ng\", \"tryserver.chromium.linux:linux_chromium_compile_dbg_ng\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"31b80a359186c53c6c0151d5427f9241e7d7a835\", \"swarm_hashes_refs/heads/master(at){#831724}_without_patch\": {\"absl_hardening_tests\": \"740d8850953895d63e258f481d1a80067c88a338\", \"accessibility_unittests\": \"bff4e9ffa2ae6e1fbd0a8f2dd3ddd4c5b6483fa4\", \"angle_unittests\": \"3bdde81ea1fbe94515527e6b0ad88b51ebc9300f\", \"app_shell_unittests\": \"351e14e888a086d84c08d2d09d7b453cb3f7b7a1\", \"aura_unittests\": \"32d173edad8c8b14b3bfc75eb6fe36e193abb268\", \"base_unittests\": \"f5020a9f092ebdca5a8c4dc061baf40f781ea442\", \"base_util_unittests\": \"4f107560c67d610937aeb1f8b48e954c2cfad814\", \"blink_common_unittests\": \"a8e89a54412c8149a2ff6b4ffa8a59a5ed1bc4a8\", \"blink_fuzzer_unittests\": \"aafab970d0c279ff82245a1cacc4fdf5a6e33b83\", \"blink_heap_unittests\": \"bf36bb5b2fe997692d537850fa295e2a2f1960ca\", \"blink_platform_unittests\": \"e4da2e09cdb8a99560c0a728ebcbd84b5ca30aaf\", \"blink_python_tests\": \"915c6dc9ecb7ab37c7368b94b2d268d763bb557a\", \"blink_unittests\": \"bc89d882af4ff634877e9abf71985e0b0c42405d\", \"blink_web_tests\": \"ed67660490d52950c685490c94dfe9b4a6d53b18\", \"boringssl_crypto_tests\": \"4099ba6838262af758ebfc0ebe2e516b509f386c\", \"boringssl_ssl_tests\": \"deaf3cc9a6f6ac27871a4445c60000dc15d31e18\", \"browser_tests\": \"48bad51a824d5e912f96d1dc10fd3908c0e1df2e\", \"capture_unittests\": \"b62ebf2cc3b014d11820d8803e8808b3d1de3bb2\", \"cast_unittests\": \"cea35237b3cebe489ceea3dbd0b8a4e8b8dd5686\", \"cc_unittests\": \"ff74bcb2219444216a82d1d41b0d47763236cc60\", \"chrome_app_unittests\": \"3aa04ea03f1fb4bcb7ed0c259601891069d376b7\", \"chromedriver_unittests\": \"f7f9e9a30c06d6dbe505dd5ff57c8a7c4923cdf4\", \"components_browsertests\": \"070881830e93bca017263cc7a1a1f9451844754e\", \"components_unittests\": \"dfd2b28e00315418075a1b3f27060af172ff4580\", \"compositor_unittests\": \"0b164d715c4a71d31f9da3facf3e4a836d4bbf20\", \"content_browsertests\": \"0d02be6816fef805cf1a63ac8d70ed4386261f8b\", \"content_shell_crash_test\": \"3616a386d3cd155916c8ac06c442438e941ef3e8\", \"content_unittests\": \"268de09f92fcf3e6617075dffc4d457ffd0dc08c\", \"crashpad_tests\": \"ca617fd4ae0c2f652f7eb2e6ae052c9a8b969db5\", \"cronet_tests\": \"a19880932d6963097fd3bc649c6de4844ef98a8c\", \"cronet_unittests\": \"e23cad979c369d7dda820f9ca89f679cd5736d79\", \"crypto_unittests\": \"e8ad90f92859d6cd47719f86af32ae4f986a9da4\", \"dbus_unittests\": \"e458e10267933dcd1689a1f643c950da6b2e3afc\", \"device_unittests\": \"6b7f61afb95ff1e6d25dcb975cabd48735b629b2\", \"display_unittests\": \"f38bcdf6889cdc1120ed00949cf19bcce8b79ed2\", \"events_unittests\": \"c8d18e69a77fd03c7ddab922effe3d7cac1a78f8\", \"extension_docserver_python_unittests\": \"f91b28ffa748e6b7b25eaf739dbc2a96cdf764b2\", \"extensions_browsertests\": \"450831bb938223d9dc7942b7773107125ffaee92\", \"extensions_unittests\": \"d61103b869be818a391b07577f40139fde778839\", \"filesystem_service_unittests\": \"ff34e35f6b6c597d9f36c1af1847b95ddef35835\", \"flatbuffers_unittests\": \"4d7f6411689e0ca026ebaa10a0eb906a6c506cdd\", \"gcm_unit_tests\": \"ea31588cbedf172854ea0f1bacbb26cb358b4b39\", \"gfx_unittests\": \"8dbca76a5f38eb969fd85be5ce2359c6ae872355\", \"gin_unittests\": \"cf750b76c1d13d2c114d4f3471ff6ff158e68f27\", \"google_apis_unittests\": \"70bc1231f34dcc1e3dd60587b8457c7057f301eb\", \"gpu_unittests\": \"6c8c8221cd756dbbc1725d176d94dd6b5c2597cd\", \"grit_python_unittests\": \"86a90131d1d8072b550d0007cfbfe4a13c1eed69\", \"gwp_asan_unittests\": \"1576d70f898b8ab7d2fc6493702194fa980b3f6b\", \"headless_browsertests\": \"79aba906da092eae3e27022fa8f831f3d798558c\", \"headless_unittests\": \"838ed1faba64f1247435cf4d6fc9cf8af9f334a3\", \"interactive_ui_tests\": \"4b4857722c6491df329778b2c338d9e5eddd31ff\", \"ipc_tests\": \"77d4235840a12a335f3b131db42e87c39e7513f7\", \"jingle_unittests\": \"18db0f5d4aaf1c8132ded2a10d2a6e3cc4f32746\", \"latency_unittests\": \"aea28dca2e63a65fcc579bddda6b8ceea5924dcf\", \"libjingle_xmpp_unittests\": \"d9e102e7f1d16c12bb00946ee9d57b5fe68505bc\", \"liburlpattern_unittests\": \"7c5dd5e9055a63bfbe8073653b127c06165a1502\", \"media_blink_unittests\": \"89241a5ac132681e67becfc62845e2ce64a498bb\", \"media_unittests\": \"348ca5fdc1923cf3c7fbf20c731342139fdc3b86\", \"message_center_unittests\": \"de9d5418830ea73fa8c8e363414df7d217834ed5\", \"metrics_python_tests\": \"ea73669baa17447f281b6539bf716211ea4e10b2\", \"midi_unittests\": \"224506b4aa4dd56947273195b92a0533ce4db03c\", \"mojo_core_unittests\": \"025d39fe75d83f98716e7bd6ef37c27d0907b9de\", \"mojo_unittests\": \"1422871b1aa2f68e73f8d16875dab9125a4884c6\", \"nacl_helper_nonsfi_unittests\": \"eebd02e8cf7cb428b0142ae2220ad8a80e220d7d\", \"nacl_loader_unittests\": \"de6fba63105092948e268666cfc67c7ac21afbe9\", \"native_theme_unittests\": \"adcbd1fd8d763090a06ded32c039a81745b7a65f\", \"net_unittests\": \"2903dffdcc6d89e98249142d306ca5cad77731b0\", \"openscreen_unittests\": \"5075be094b794c9fc54943949cdf17cb25be9516\", \"pdf_unittests\": \"f42d3635d2a5a9a5a2470a34e187dfdb5df5d6cd\", \"perfetto_unittests\": \"ae6fa67913f409227fecbb1358e21d7e84f57372\", \"ppapi_unittests\": \"0c142622f1649e34178c5bc2b5750e9ae878c429\", \"printing_unittests\": \"bb66ef8889fcc113565b40e26f7029dd68114be7\", \"remoting_unittests\": \"8e3d0b62c8fb3f0fb497530679c0603ac63784d8\", \"sandbox_linux_unittests\": \"a029c4481645b95015364395487cb3e76ad4de66\", \"service_manager_unittests\": \"e3319f0adab4e88db2b5f7d13c7462e42c161f47\", \"services_unittests\": \"cff645a8b825118d105958b49b1a6c36fc49b12e\", \"shell_dialogs_unittests\": \"0700f0da23c706c4bb77fdae157ef564efe62c69\", \"skia_unittests\": \"b6de561c67401c10413325561974d31c8189f038\", \"snapshot_unittests\": \"36e2d0a61492181086b28594f13ddc1dff43a37d\", \"sql_unittests\": \"ed936195c0cc08e7acc7363d8040fd690efac1cb\", \"storage_unittests\": \"537817c5ce7c8c444468e61e8eadb3a8f5dd1031\", \"sync_integration_tests\": \"1a52269af3de33ab1adbe3eb6901b6a7ea5a59d4\", \"telemetry_gpu_unittests\": \"e120e49ba06d4289745b240e7b63d4ea8a70fc4b\", \"telemetry_perf_unittests\": \"d263abd020ddaf7a1f04814f3b4165038557705e\", \"telemetry_unittests\": \"3646bb078c4958a2f16b8fbead65556c9c7c9fdf\", \"traffic_annotation_auditor_unittests\": \"00a3cef4257b01487fe8f5d9060fd9b706a816a2\", \"ui_base_unittests\": \"b192a45b3e4fa0030e8cfd3a331e43d31a43fb90\", \"ui_touch_selection_unittests\": \"d833f8c0f1bd3a7eb677f83fa0e3f7224d1f9c79\", \"unit_tests\": \"f6935abd4d72c5b124a18c56e15859745817892b\", \"url_unittests\": \"c2427a1e2f34fcb3791210be76f52c0986920f20\", \"views_perftests\": \"471ec410fda79dc2bac4c9c1c91d2f91e72d7d64\", \"views_unittests\": \"52c2021c2b867c1bfde8d9d080716b86616a2461\", \"viz_unittests\": \"2a2ebc76dfe3c97bf1131ff3059c284a9f557a71\", \"vr_common_unittests\": \"4a48d8478e724380414478be845da6f1da6c50e2\", \"vr_pixeltests\": \"9b36d7d4cb481b948cb3c45dd73fb0fc0574f61d\", \"webdriver_wpt_tests\": \"abacd4abaa9c55431c874d6a218e6a6d15dec21c\", \"weblayer_browsertests\": \"5a4428578f238e3828b9743713dfa161aeacc0b4\", \"weblayer_unittests\": \"fa48de5cbb94050dc637ea8c8408c30dbd595e90\", \"wm_unittests\": \"29aac26d4ea34a4b858d167e8e8598b7814f6901\", \"wtf_unittests\": \"89c0ff6ba4ffb7414487182e381a870af5020514\", \"x11_unittests\": \"7a9c5848faa4f9bdec57b1f72084169176721e8f\", \"xr_browser_tests\": \"4f2f64890170bae42fc58c7e48a97aa8f7c642c6\", \"zlib_unittests\": \"e547c0dbc4d54702b3b4afac900373b0dc118011\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3e35691df8e10f0f9a2876627ba5bcbf70dc06793975d132d4535f10bccc6635_v2\", \"builder_3ebf4dd509a5805e98d79f047f39cac1c13d897e075c42798b95fb1279fe5d7c_v2\", \"builder_51829829c31fbaf3768e3309e640f1ed37e0867e138bde8c875431bcab07adc2_v2\", \"builder_5315cf154f9c1ae6b2621094599bc107171a849e1c0f232ec66a504ee800a364_v2\", \"builder_a3b3a06131dfa9924971b27d0acd4e18e80a2242b6d6ae41f94b770d7c996d6f_v2\", \"builder_abe2adbd32ad911c3e8d1f384e915329cf1f65e427edb6b91a9fbb61a55ed743_v2\", \"builder_c33cb68a27562f3c0030aeadb8872bc9395ca543fdfb70fdbe284a5ae715c202_v2\", \"builder_db66d224f5e060c065cb4a49cc418612a90bf947378d00f79622922b6c0b5060_v2\", \"builder_f5610824250c57fc28679fbc8606252c3dbaca731fb7f2a4bebf1e0fc7f48a3a_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-8-zakc\"], \"image\": [\"chrome-xenial-20112200-f7cdea8df03\"], \"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\": [\"5640-d0eb544\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1606662169370657",
"status": "COMPLETED",
"status_changed_ts": "1606666227368511",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178157",
"builder:Linux Builder (dbg)",
"buildset:commit/git/31b80a359186c53c6c0151d5427f9241e7d7a835",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/31b80a359186c53c6c0151d5427f9241e7d7a835",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027718290593160736",
"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/8862288228420770304/+/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:502d3cfd2b8d2810",
"user_agent:luci-scheduler"
],
"updated_ts": "1606666227374866",
"url": "https://ci.chromium.org/b/8862288228420770304",
"utcnow_ts": "1606666227805613"
}
}
[16:10:27.814] Invocation finished in 1h37m55.096135312s with status SUCCEEDED