[15:36:38.635] New invocation is queued and will start shortly
[15:36:39.855] Starting the invocation (attempt 1)
[15:36:39.887] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:36:39.887] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:36:39.887] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020738291461797680",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ace45d2e6677437c98d2e2e5a5f027babcccc246\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9020738291461797680",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/ace45d2e6677437c98d2e2e5a5f027babcccc246",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ace45d2e6677437c98d2e2e5a5f027babcccc246",
"gitiles_ref:refs/heads/master"
]
}
[15:36:40.620] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613316999995806",
"id": "8855308229371832816",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ace45d2e6677437c98d2e2e5a5f027babcccc246\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613317000365268",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180569",
"builder:Linux Builder (dbg)",
"buildset:commit/git/ace45d2e6677437c98d2e2e5a5f027babcccc246",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ace45d2e6677437c98d2e2e5a5f027babcccc246",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020738291461797680",
"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/8855308229371832816/+/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": "1613317000365406",
"url": "https://ci.chromium.org/b/8855308229371832816",
"utcnow_ts": "1613317000590563"
}
}
[15:36:40.620] Task URL: https://ci.chromium.org/b/8855308229371832816
[15:36:40.620] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:2:0) after 1m0s
[15:37:40.633] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:2:0)
[15:37:40.633] Timer tick, asking Buildbucket for the build status
[15:37:40.805] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:37:40.805] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:3:0) after 1m0s
[15:38:40.790] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:3:0)
[15:38:40.790] Timer tick, asking Buildbucket for the build status
[15:38:40.922] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:38:40.922] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:4:0) after 1m0s
[15:39:41.018] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:4:0)
[15:39:41.018] Timer tick, asking Buildbucket for the build status
[15:39:41.077] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:39:41.077] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:5:0) after 1m0s
[15:40:41.099] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:5:0)
[15:40:41.099] Timer tick, asking Buildbucket for the build status
[15:40:41.190] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:40:41.190] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:6:0) after 1m0s
[15:41:41.238] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:6:0)
[15:41:41.238] Timer tick, asking Buildbucket for the build status
[15:41:41.352] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:41:41.352] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:7:0) after 1m0s
[15:42:41.396] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:7:0)
[15:42:41.396] Timer tick, asking Buildbucket for the build status
[15:42:41.483] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:42:41.483] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:8:0) after 1m0s
[15:43:41.498] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:8:0)
[15:43:41.498] Timer tick, asking Buildbucket for the build status
[15:43:41.580] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:43:41.580] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:9:0) after 1m0s
[15:44:41.608] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:9:0)
[15:44:41.608] Timer tick, asking Buildbucket for the build status
[15:44:41.804] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:44:41.804] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:10:0) after 1m0s
[15:45:41.821] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:10:0)
[15:45:41.821] Timer tick, asking Buildbucket for the build status
[15:45:41.901] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:45:41.901] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:11:0) after 1m0s
[15:46:41.954] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:11:0)
[15:46:41.955] Timer tick, asking Buildbucket for the build status
[15:46:42.035] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:46:42.035] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:12:0) after 1m0s
[15:47:42.051] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:12:0)
[15:47:42.051] Timer tick, asking Buildbucket for the build status
[15:47:42.149] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:47:42.149] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:13:0) after 1m0s
[15:48:42.171] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:13:0)
[15:48:42.171] Timer tick, asking Buildbucket for the build status
[15:48:42.340] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:48:42.340] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:14:0) after 1m0s
[15:49:42.362] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:14:0)
[15:49:42.362] Timer tick, asking Buildbucket for the build status
[15:49:42.437] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:49:42.437] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:15:0) after 1m0s
[15:50:42.523] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:15:0)
[15:50:42.523] Timer tick, asking Buildbucket for the build status
[15:50:42.806] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:50:42.806] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:16:0) after 1m0s
[15:51:42.873] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:16:0)
[15:51:42.873] Timer tick, asking Buildbucket for the build status
[15:51:43.205] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:51:43.205] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:17:0) after 1m0s
[15:52:43.272] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:17:0)
[15:52:43.272] Timer tick, asking Buildbucket for the build status
[15:52:43.358] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:52:43.358] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:18:0) after 1m0s
[15:53:43.444] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:18:0)
[15:53:43.444] Timer tick, asking Buildbucket for the build status
[15:53:43.641] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:53:43.641] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:19:0) after 1m0s
[15:54:43.750] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:19:0)
[15:54:43.750] Timer tick, asking Buildbucket for the build status
[15:54:43.880] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:54:43.880] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:20:0) after 1m0s
[15:55:43.921] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:20:0)
[15:55:43.921] Timer tick, asking Buildbucket for the build status
[15:55:43.995] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:55:43.995] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:21:0) after 1m0s
[15:56:43.980] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:21:0)
[15:56:43.980] Timer tick, asking Buildbucket for the build status
[15:56:44.088] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:56:44.088] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:22:0) after 1m0s
[15:57:44.111] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:22:0)
[15:57:44.111] Timer tick, asking Buildbucket for the build status
[15:57:44.283] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:57:44.283] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:23:0) after 1m0s
[15:58:44.384] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:23:0)
[15:58:44.384] Timer tick, asking Buildbucket for the build status
[15:58:44.453] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:58:44.453] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:24:0) after 1m0s
[15:59:44.569] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:24:0)
[15:59:44.569] Timer tick, asking Buildbucket for the build status
[15:59:44.649] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:59:44.649] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:25:0) after 1m0s
[16:00:44.679] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:25:0)
[16:00:44.679] Timer tick, asking Buildbucket for the build status
[16:00:44.831] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:00:44.831] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:26:0) after 1m0s
[16:01:44.924] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:26:0)
[16:01:44.924] Timer tick, asking Buildbucket for the build status
[16:01:45.013] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:01:45.013] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:27:0) after 1m0s
[16:02:45.138] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:27:0)
[16:02:45.138] Timer tick, asking Buildbucket for the build status
[16:02:45.206] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:02:45.206] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:28:0) after 1m0s
[16:03:45.293] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:28:0)
[16:03:45.293] Timer tick, asking Buildbucket for the build status
[16:03:45.437] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:03:45.437] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:29:0) after 1m0s
[16:04:45.433] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:29:0)
[16:04:45.433] Timer tick, asking Buildbucket for the build status
[16:04:45.503] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:04:45.503] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:30:0) after 1m0s
[16:05:45.572] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:30:0)
[16:05:45.572] Timer tick, asking Buildbucket for the build status
[16:05:45.819] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:05:45.819] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:31:0) after 1m0s
[16:06:45.863] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:31:0)
[16:06:45.863] Timer tick, asking Buildbucket for the build status
[16:06:45.953] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:06:45.953] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:32:0) after 1m0s
[16:07:45.983] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:32:0)
[16:07:45.983] Timer tick, asking Buildbucket for the build status
[16:07:46.050] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:07:46.050] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:33:0) after 1m0s
[16:08:46.073] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:33:0)
[16:08:46.073] Timer tick, asking Buildbucket for the build status
[16:08:46.151] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:08:46.151] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:34:0) after 1m0s
[16:09:46.309] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:34:0)
[16:09:46.309] Timer tick, asking Buildbucket for the build status
[16:09:46.383] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:09:46.383] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:35:0) after 1m0s
[16:10:46.446] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:35:0)
[16:10:46.446] Timer tick, asking Buildbucket for the build status
[16:10:46.586] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:10:46.586] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:36:0) after 1m0s
[16:11:46.607] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:36:0)
[16:11:46.607] Timer tick, asking Buildbucket for the build status
[16:11:46.879] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:11:46.879] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:37:0) after 1m0s
[16:12:46.863] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:37:0)
[16:12:46.863] Timer tick, asking Buildbucket for the build status
[16:12:46.938] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:12:46.938] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:38:0) after 1m0s
[16:13:46.979] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:38:0)
[16:13:46.979] Timer tick, asking Buildbucket for the build status
[16:13:47.055] Build 8855308229371832816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:13:47.055] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:39:0) after 1m0s
[16:13:59.939] Received PubSub notification, asking Buildbucket for the build status
[16:14:00.179] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:47.099] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:39:0)
[16:14:47.099] Timer tick, asking Buildbucket for the build status
[16:14:47.167] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:47.167] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:41:0) after 1m0s
[16:15:47.150] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:41:0)
[16:15:47.150] Timer tick, asking Buildbucket for the build status
[16:15:47.233] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:47.233] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:42:0) after 1m0s
[16:16:47.229] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:42:0)
[16:16:47.229] Timer tick, asking Buildbucket for the build status
[16:16:47.444] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:47.444] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:43:0) after 1m0s
[16:17:47.517] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:43:0)
[16:17:47.517] Timer tick, asking Buildbucket for the build status
[16:17:47.589] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:47.589] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:44:0) after 1m0s
[16:18:47.584] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:44:0)
[16:18:47.584] Timer tick, asking Buildbucket for the build status
[16:18:47.708] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:47.708] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:45:0) after 1m0s
[16:19:47.717] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:45:0)
[16:19:47.717] Timer tick, asking Buildbucket for the build status
[16:19:47.795] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:47.795] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:46:0) after 1m0s
[16:20:47.851] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:46:0)
[16:20:47.851] Timer tick, asking Buildbucket for the build status
[16:20:47.969] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:47.969] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:47:0) after 1m0s
[16:21:48.055] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:47:0)
[16:21:48.055] Timer tick, asking Buildbucket for the build status
[16:21:48.246] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:48.246] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:48:0) after 1m0s
[16:22:48.264] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:48:0)
[16:22:48.264] Timer tick, asking Buildbucket for the build status
[16:22:48.359] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:48.359] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:49:0) after 1m0s
[16:23:48.378] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:49:0)
[16:23:48.378] Timer tick, asking Buildbucket for the build status
[16:23:48.449] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:48.449] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:50:0) after 1m0s
[16:24:48.491] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:50:0)
[16:24:48.491] Timer tick, asking Buildbucket for the build status
[16:24:48.640] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:48.640] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:51:0) after 1m0s
[16:25:48.670] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:51:0)
[16:25:48.670] Timer tick, asking Buildbucket for the build status
[16:25:48.741] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:48.741] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:52:0) after 1m0s
[16:26:48.763] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:52:0)
[16:26:48.763] Timer tick, asking Buildbucket for the build status
[16:26:49.536] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:49.536] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:53:0) after 1m0s
[16:27:49.555] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:53:0)
[16:27:49.555] Timer tick, asking Buildbucket for the build status
[16:27:50.008] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:50.008] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:54:0) after 1m0s
[16:28:50.027] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:54:0)
[16:28:50.027] Timer tick, asking Buildbucket for the build status
[16:28:50.105] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:50.105] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:55:0) after 1m0s
[16:29:50.154] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:55:0)
[16:29:50.154] Timer tick, asking Buildbucket for the build status
[16:29:50.229] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:50.229] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:56:0) after 1m0s
[16:30:50.247] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:56:0)
[16:30:50.247] Timer tick, asking Buildbucket for the build status
[16:30:50.332] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:50.332] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:57:0) after 1m0s
[16:31:50.366] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:57:0)
[16:31:50.366] Timer tick, asking Buildbucket for the build status
[16:31:50.607] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:50.607] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:58:0) after 1m0s
[16:32:50.630] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:58:0)
[16:32:50.630] Timer tick, asking Buildbucket for the build status
[16:32:50.710] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:50.710] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:59:0) after 1m0s
[16:33:50.708] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:59:0)
[16:33:50.708] Timer tick, asking Buildbucket for the build status
[16:33:50.786] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:50.786] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:60:0) after 1m0s
[16:34:50.803] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:60:0)
[16:34:50.803] Timer tick, asking Buildbucket for the build status
[16:34:51.188] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:51.188] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:61:0) after 1m0s
[16:35:51.208] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:61:0)
[16:35:51.208] Timer tick, asking Buildbucket for the build status
[16:35:51.443] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:51.443] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:62:0) after 1m0s
[16:36:51.490] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:62:0)
[16:36:51.490] Timer tick, asking Buildbucket for the build status
[16:36:51.597] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:51.597] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:63:0) after 1m0s
[16:37:51.624] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:63:0)
[16:37:51.624] Timer tick, asking Buildbucket for the build status
[16:37:51.707] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:51.707] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:64:0) after 1m0s
[16:38:51.727] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:64:0)
[16:38:51.727] Timer tick, asking Buildbucket for the build status
[16:38:52.083] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:52.083] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:65:0) after 1m0s
[16:39:52.182] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:65:0)
[16:39:52.182] Timer tick, asking Buildbucket for the build status
[16:39:52.431] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:52.431] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:66:0) after 1m0s
[16:40:52.516] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:66:0)
[16:40:52.516] Timer tick, asking Buildbucket for the build status
[16:40:52.693] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:52.693] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:67:0) after 1m0s
[16:41:52.761] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:67:0)
[16:41:52.761] Timer tick, asking Buildbucket for the build status
[16:41:53.019] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:53.019] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:68:0) after 1m0s
[16:42:53.101] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:68:0)
[16:42:53.101] Timer tick, asking Buildbucket for the build status
[16:42:53.194] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:53.194] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:69:0) after 1m0s
[16:43:53.296] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:69:0)
[16:43:53.296] Timer tick, asking Buildbucket for the build status
[16:43:53.376] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:53.376] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:70:0) after 1m0s
[16:44:53.396] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:70:0)
[16:44:53.396] Timer tick, asking Buildbucket for the build status
[16:44:53.500] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:53.500] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:71:0) after 1m0s
[16:45:53.517] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:71:0)
[16:45:53.517] Timer tick, asking Buildbucket for the build status
[16:45:53.608] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:53.608] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:72:0) after 1m0s
[16:46:53.632] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:72:0)
[16:46:53.632] Timer tick, asking Buildbucket for the build status
[16:46:53.790] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:53.790] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:73:0) after 1m0s
[16:47:53.809] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:73:0)
[16:47:53.809] Timer tick, asking Buildbucket for the build status
[16:47:53.902] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:53.902] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:74:0) after 1m0s
[16:48:53.923] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:74:0)
[16:48:53.923] Timer tick, asking Buildbucket for the build status
[16:48:54.020] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:54.020] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:75:0) after 1m0s
[16:49:54.093] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:75:0)
[16:49:54.093] Timer tick, asking Buildbucket for the build status
[16:49:54.293] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:54.294] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:76:0) after 1m0s
[16:50:54.324] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:76:0)
[16:50:54.324] Timer tick, asking Buildbucket for the build status
[16:50:54.599] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:54.599] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:77:0) after 1m0s
[16:51:54.620] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:77:0)
[16:51:54.620] Timer tick, asking Buildbucket for the build status
[16:51:54.733] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:54.733] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:78:0) after 1m0s
[16:52:54.754] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:78:0)
[16:52:54.754] Timer tick, asking Buildbucket for the build status
[16:52:54.822] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:54.822] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:79:0) after 1m0s
[16:53:54.840] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:79:0)
[16:53:54.840] Timer tick, asking Buildbucket for the build status
[16:53:54.913] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:54.913] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:80:0) after 1m0s
[16:54:54.938] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:80:0)
[16:54:54.938] Timer tick, asking Buildbucket for the build status
[16:54:55.144] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:55.144] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:81:0) after 1m0s
[16:55:55.209] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:81:0)
[16:55:55.209] Timer tick, asking Buildbucket for the build status
[16:55:55.402] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:55.402] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:82:0) after 1m0s
[16:56:55.423] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:82:0)
[16:56:55.423] Timer tick, asking Buildbucket for the build status
[16:56:55.552] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:55.552] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:83:0) after 1m0s
[16:57:55.616] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:83:0)
[16:57:55.616] Timer tick, asking Buildbucket for the build status
[16:57:55.684] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:55.684] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:84:0) after 1m0s
[16:58:55.704] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:84:0)
[16:58:55.704] Timer tick, asking Buildbucket for the build status
[16:58:55.800] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:55.800] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:85:0) after 1m0s
[16:59:55.821] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:85:0)
[16:59:55.821] Timer tick, asking Buildbucket for the build status
[16:59:56.131] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:56.131] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:86:0) after 1m0s
[17:00:56.132] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:86:0)
[17:00:56.132] Timer tick, asking Buildbucket for the build status
[17:00:56.232] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:56.232] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:87:0) after 1m0s
[17:01:56.387] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:87:0)
[17:01:56.387] Timer tick, asking Buildbucket for the build status
[17:01:56.499] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:56.499] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:88:0) after 1m0s
[17:02:56.521] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:88:0)
[17:02:56.521] Timer tick, asking Buildbucket for the build status
[17:02:56.608] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:56.608] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:89:0) after 1m0s
[17:03:56.652] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:89:0)
[17:03:56.652] Timer tick, asking Buildbucket for the build status
[17:03:56.741] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:56.741] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:90:0) after 1m0s
[17:04:56.743] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:90:0)
[17:04:56.743] Timer tick, asking Buildbucket for the build status
[17:04:56.817] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:56.817] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:91:0) after 1m0s
[17:05:56.845] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:91:0)
[17:05:56.845] Timer tick, asking Buildbucket for the build status
[17:05:57.114] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:57.114] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:92:0) after 1m0s
[17:06:57.159] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:92:0)
[17:06:57.159] Timer tick, asking Buildbucket for the build status
[17:06:57.272] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:57.272] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:93:0) after 1m0s
[17:07:57.342] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:93:0)
[17:07:57.342] Timer tick, asking Buildbucket for the build status
[17:07:57.437] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:57.437] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:94:0) after 1m0s
[17:08:57.461] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:94:0)
[17:08:57.461] Timer tick, asking Buildbucket for the build status
[17:08:57.613] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:57.613] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:95:0) after 1m0s
[17:09:57.684] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:95:0)
[17:09:57.684] Timer tick, asking Buildbucket for the build status
[17:09:57.787] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:57.787] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:96:0) after 1m0s
[17:10:57.857] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:96:0)
[17:10:57.857] Timer tick, asking Buildbucket for the build status
[17:10:58.365] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:58.365] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:97:0) after 1m0s
[17:11:58.397] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:97:0)
[17:11:58.397] Timer tick, asking Buildbucket for the build status
[17:11:58.496] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:58.496] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:98:0) after 1m0s
[17:12:58.564] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:98:0)
[17:12:58.564] Timer tick, asking Buildbucket for the build status
[17:12:58.647] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:58.647] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:99:0) after 1m0s
[17:13:58.758] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:99:0)
[17:13:58.758] Timer tick, asking Buildbucket for the build status
[17:13:58.841] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:58.841] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:100:0) after 1m0s
[17:14:58.861] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:100:0)
[17:14:58.861] Timer tick, asking Buildbucket for the build status
[17:14:59.086] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:59.086] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:101:0) after 1m0s
[17:15:59.210] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:101:0)
[17:15:59.210] Timer tick, asking Buildbucket for the build status
[17:15:59.378] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:59.378] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:102:0) after 1m0s
[17:16:59.432] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:102:0)
[17:16:59.432] Timer tick, asking Buildbucket for the build status
[17:16:59.906] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:59.906] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:103:0) after 1m0s
[17:18:00.075] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:103:0)
[17:18:00.075] Timer tick, asking Buildbucket for the build status
[17:18:00.284] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:00.284] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:104:0) after 1m0s
[17:19:00.287] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:104:0)
[17:19:00.287] Timer tick, asking Buildbucket for the build status
[17:19:00.368] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:00.368] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:105:0) after 1m0s
[17:20:00.437] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:105:0)
[17:20:00.437] Timer tick, asking Buildbucket for the build status
[17:20:00.526] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:00.526] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:106:0) after 1m0s
[17:21:01.053] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:106:0)
[17:21:01.053] Timer tick, asking Buildbucket for the build status
[17:21:01.146] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:01.146] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:107:0) after 1m0s
[17:22:01.425] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:107:0)
[17:22:01.425] Timer tick, asking Buildbucket for the build status
[17:22:01.518] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:01.518] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:108:0) after 1m0s
[17:23:01.859] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:108:0)
[17:23:01.859] Timer tick, asking Buildbucket for the build status
[17:23:01.930] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:01.930] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:109:0) after 1m0s
[17:24:02.029] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:109:0)
[17:24:02.029] Timer tick, asking Buildbucket for the build status
[17:24:02.139] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:02.139] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:110:0) after 1m0s
[17:25:02.126] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:110:0)
[17:25:02.126] Timer tick, asking Buildbucket for the build status
[17:25:02.222] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:02.222] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:111:0) after 1m0s
[17:26:02.309] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:111:0)
[17:26:02.309] Timer tick, asking Buildbucket for the build status
[17:26:02.405] Build 8855308229371832816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:02.405] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020738291461797680:112:0) after 1m0s
[17:26:12.244] Received PubSub notification, asking Buildbucket for the build status
[17:26:12.495] Build 8855308229371832816: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:26:12.495] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613323571436168",
"created_by": "project:chromium",
"created_ts": "1613316999995806",
"id": "8855308229371832816",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ace45d2e6677437c98d2e2e5a5f027babcccc246\"}}",
"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\": \"ace45d2e6677437c98d2e2e5a5f027babcccc246\", \"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-52-jqp1\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180569, \"got_angle_revision\": \"a8a2a71b3ab5e535def6239997f6f24da918556b\", \"got_dawn_revision\": \"e61c9d86884145733d5763ab23c15bf09acf358c\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"ace45d2e6677437c98d2e2e5a5f027babcccc246\", \"got_revision_cp\": \"refs/heads/master@{#853911}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"539ef8e9426e10d7611d433ee60b94de0737344a\", \"got_v8_revision\": \"554b7ee535b3eca3f041dc45d00de5cbd490729c\", \"got_v8_revision_cp\": \"refs/heads/9.0.172@{#1}\", \"got_webrtc_revision\": \"f28d7e89b7a3c985d83f59d16b9f3c3f45ef7997\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33224}\", \"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\": \"ace45d2e6677437c98d2e2e5a5f027babcccc246\", \"swarm_hashes_refs/heads/master(at){#853911}_without_patch\": {\"absl_hardening_tests\": \"a93815522230df3e3aadff6e38cb3675b53c9d72\", \"accessibility_unittests\": \"d28e4f2748f307b41081c0ecc0de2df0fdee77e8\", \"angle_unittests\": \"ba7fde709c2afd74af4b19cc54124a335177dba7\", \"app_shell_unittests\": \"139b0d39e624820655efba90a85e4c1d59147869\", \"aura_unittests\": \"f09b42c3513e9b0e651123e13b8b996e51f41431\", \"base_unittests\": \"8ccf96159336d96488f4b5f4601bd0b6e10519ff\", \"base_util_unittests\": \"db19e68e8b4849a64b4d946c2bdaeeec147da396\", \"blink_common_unittests\": \"123f56675d1caba76ceaf5028cbb03a6ea26ebe0\", \"blink_fuzzer_unittests\": \"ae092317180508fa5f96bb6529a7f04fdda9e413\", \"blink_heap_unittests\": \"431763ab14e15eff2986f0dfccceb012b3c7e306\", \"blink_platform_unittests\": \"47f4767b7358bc67df5152432b38ad990cbf27e0\", \"blink_python_tests\": \"e8a57771c000a66e6a51f3244690605a36dc48ae\", \"blink_unittests\": \"d2e98c3d7bdcb99c6ad96800b8c41a990ce4259a\", \"blink_web_tests\": \"ccca103fe5cb3f985d003c73be9238dd6600634a\", \"boringssl_crypto_tests\": \"02a18bce2b2db418f99b5f451fcec2cc8817a088\", \"boringssl_ssl_tests\": \"e1daad13fb890707a3da7fd1e63ddb68ee75fc47\", \"browser_tests\": \"8b9f7480ecbbbaf0281b21bd70892cd6dda0e75d\", \"capture_unittests\": \"5cab14a4b67ba7667fc837c8a27be4d80b1e0a60\", \"cast_unittests\": \"b5fd808581c9749475d4827f34ee3fa85eed5021\", \"cc_unittests\": \"89ae00f6d2dc94684622880740a26ed8bff2b6c5\", \"chrome_app_unittests\": \"9c9a77654b68d125fb36c5847ae6769a9acddc4e\", \"chromedriver_unittests\": \"a5a35bca335bc4f2059bd743d13e098467ab0bd8\", \"components_browsertests\": \"f8223fe8f04a4acff80a513b6549c47c57818cac\", \"components_unittests\": \"89b5625a8b80211e24b906a9d10fb54ba810aa85\", \"compositor_unittests\": \"2ed2f47a5fc4390d95710b63f626cb8fe2356898\", \"content_browsertests\": \"7c3a89457f70c3b37b74be75569797554fdff569\", \"content_shell_crash_test\": \"e50ea4fa0724e32a8e774eaf6fc3ca9eb2a7693c\", \"content_unittests\": \"52a414bf677fd87fd12f86613ae37fd8f588d348\", \"crashpad_tests\": \"86db55d3966d4dd1aff66001182b53589eae9175\", \"cronet_tests\": \"ae06de9fc645e12d2475c3a78f0450746f161291\", \"cronet_unittests\": \"21439f4753893dccb72572e6876ce0000f2a66f2\", \"crypto_unittests\": \"c2adf199a6365231eef45556cc59fdca30d6cc8e\", \"dbus_unittests\": \"fbe2fad91133c09662abf290eab1eb62d2a4f5ee\", \"device_unittests\": \"2acb3e69c0e4307b57bc24819a9eb7a3f66f36aa\", \"display_unittests\": \"610a9b21ab5915b393c733618feb8a9155bdc0a8\", \"events_unittests\": \"6275ff1b25c5ff0add41ec5c259a8a7e0a417c5a\", \"extensions_browsertests\": \"090ef46a34d47dd438d9886360ed60a97c90f108\", \"extensions_unittests\": \"7a22058f83f14a77e5b632e591be4ba27fe1c76b\", \"filesystem_service_unittests\": \"9996fa2ef42db38d1dcbbc197101f98d7de942b3\", \"flatbuffers_unittests\": \"075150972de9869140291a211d23ae9aa4ff1469\", \"gcm_unit_tests\": \"a371488135e5a0156c6035247805f675decf7604\", \"gfx_unittests\": \"3b0b060f10ee387a6457f2addfee07b313f526e2\", \"gin_unittests\": \"9559cce6e2af107be3b038879a7eb9e28e499ebb\", \"google_apis_unittests\": \"89af62d3feb9d5903eb946d440e6160cc8a7a35f\", \"gpu_unittests\": \"6ebaa9671cd2bd835eb71b18ae47a0cbdc6959e7\", \"grit_python_unittests\": \"6eb7a1f1dc57239cce2e1f3e8d13a9b7cd73171c\", \"gwp_asan_unittests\": \"1d5241d6573f064c64153d0c652e87fe8acb33bb\", \"headless_browsertests\": \"aa4f17c56be57aca85ecbbbd8b1340dc573857e5\", \"headless_unittests\": \"1ed85c729754f4b41bb59e9eb324baabd8046a54\", \"interactive_ui_tests\": \"820545b3273803ebbfd68fd344682512d48f7b54\", \"ipc_tests\": \"182deb1e22a9d60ac9614ee86e59a3fc49e243df\", \"jingle_unittests\": \"2248a690464faa9d200439bb2c7b37d44d219592\", \"latency_unittests\": \"01f7898d45ea98ad95b8dc0f818028b5338bcc6a\", \"libjingle_xmpp_unittests\": \"11667e289dc5c6c27f26d77310302e19e4cc7392\", \"liburlpattern_unittests\": \"10cf42779a6b393951c37678902166bd407f65e6\", \"media_blink_unittests\": \"45cd926ffdc9c986b1461e9180051b5989d8a70e\", \"media_unittests\": \"268f4c4b58e63b75998dfe9594ef5312fcdafa2b\", \"message_center_unittests\": \"7c602bb26a34313eb3d301cf8da58e6d7a804180\", \"metrics_python_tests\": \"54610491f8b45d3bd91588a5b37ce264a660ae2f\", \"midi_unittests\": \"0397e2124cef8cf9a45e208f0c8416105c75fbbe\", \"mojo_core_unittests\": \"29dee78eb039d2ee7808c7853eac76758b2544b1\", \"mojo_unittests\": \"093bdb8c779b0cc6c769e6f6eecee8a57d79af54\", \"nacl_helper_nonsfi_unittests\": \"24fe6938e1fb6c3845183562c4e2cf7af09155bb\", \"nacl_loader_unittests\": \"1bdab2d1e48019f53d7d6ad434f8413c1f225d7e\", \"native_theme_unittests\": \"3ddc5bf5a38f90a37423a14f6a46f72b4ca91af5\", \"net_unittests\": \"01f0e5d99c182962759db92e8137f71934df0804\", \"openscreen_unittests\": \"9c951fab0d24ee88b91778a7261b7e37e1bb979a\", \"pdf_unittests\": \"9b7b31a7a629803e09b6e5513e0a9fbad76ac490\", \"perfetto_unittests\": \"212fd825bd766afcb0c270fc3fe34b9530742d57\", \"ppapi_unittests\": \"4a395c2c00e7256b10ebc008289af8cf7579339c\", \"printing_unittests\": \"04564d67c372d8ce39e6573624c9e297d9e5bf5e\", \"remoting_unittests\": \"579ed9eee89702dc73042d3590423b11997607f7\", \"sandbox_linux_unittests\": \"787d7667c4e363a8058b03a224f6446f86df2131\", \"service_manager_unittests\": \"a767db954888101b5c0535b5806c7c9800bc83ae\", \"services_unittests\": \"7109402649856df0851260502d58937c7ab759c0\", \"shell_dialogs_unittests\": \"1400b11f549d55e34880c5dfbc41ff2bfb82fab0\", \"skia_unittests\": \"ae4bdc2d1095ec3e1c3d331933a3db008bd30bb5\", \"snapshot_unittests\": \"3b834eaafe967188eda2fe1f61d785129ebba2d4\", \"sql_unittests\": \"823b62ed56b02dbb9f12ee207293a2fab31b2717\", \"storage_unittests\": \"d120e4bf588d2f2344536179c1ecf87e7e84d4c5\", \"sync_integration_tests\": \"a954716feead1a95c3581df1c47f76b99c08d15d\", \"telemetry_gpu_unittests\": \"1842f6d8fa7bc4877fce36ef14d07a0bae7be5e1\", \"telemetry_perf_unittests\": \"c4700eabbc49d432003fcaa726a4cfcfacd2891f\", \"telemetry_unittests\": \"72cf4f66cdca5d890e23d1da350326aa97927290\", \"traffic_annotation_auditor_unittests\": \"e41f28ec30fb9aedd4650ad91fa9073d4b6cf37f\", \"ui_base_unittests\": \"27171bd02dca9ea0dc2a27b5e88dc2594f303000\", \"ui_touch_selection_unittests\": \"ab449c0fb0c59f4f01ed88138dfb48b4a1df0b1a\", \"unit_tests\": \"4103e829ac0b0fdd1c6c966db97a44c2245248dd\", \"url_unittests\": \"aa03031674ddbde580bb3c1aa59a76772a5f4e6f\", \"views_perftests\": \"ec5a3a2df67c166ce4ff2d14ea1c88cc8821856e\", \"views_unittests\": \"9a4b8e582aa3a20459c89c05c58a715a9a614e1e\", \"viz_unittests\": \"591525f9123db63b4491937c659e6739d5f6f25e\", \"vr_common_unittests\": \"8e7e34141a749b3f24470b071b4fdecd8afd419f\", \"vr_pixeltests\": \"2aa2b08af20a925717f7b86abea0eb2d535abe9e\", \"webdriver_wpt_tests\": \"c2fe015c77bb6224453a62fa50ba45224cef0768\", \"weblayer_browsertests\": \"e0ec17b08d132b53e9c235102c296e01af1f55a3\", \"weblayer_unittests\": \"635502dbf72df6dcdbc2b5414bece92fafe7fc9a\", \"wm_unittests\": \"17799c92ab78630b2312757b47b9f205db4110dd\", \"wtf_unittests\": \"c0750297bd36c518560b59093734c1da29a041a3\", \"x11_unittests\": \"c5587c762b50b192ec5aa5660425be415f4739ca\", \"xr_browser_tests\": \"ad60688e7c407b3b5327b7e9eb696f8105c42a5c\", \"zlib_unittests\": \"c41f4f4ff796bbfe06463909468cbd1719c1bfa0\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2295bac873f7edd8c9763e89419d85b38a875955550d968c436d775d3f06377b_v2\", \"builder_65ed874bd033a5984c3cbb528261ef1b136b40627f077f473aaaca27b3fa3caf_v2\", \"builder_80caf7430a3f42346120b86a5d4a8c20619a8e115748218c5e2ff55c5518ef8d_v2\", \"builder_8f7e40299f74ff9d94767563834f98f87bf45cac7401cd036aab5fd865cb3b58_v2\", \"builder_a10052c67097968898fa29710cdaa0ada58a120001760a536a006ca29eefe964_v2\", \"builder_a15c792d02d243f2865d956ab51326d361a8fcfed3c44b30d209df7676d4718c_v2\", \"builder_ce22d0fc5c297d03141230de59f52ebaf9005395a667e8b14df59e499796620f_v2\", \"builder_d1ade7eeaf5d4bfec46cdcc4260ff7266c5ca5ac9f935f1643683e9e2b66e303_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-52-jqp1\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5690-40331dd\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613319238836355",
"status": "COMPLETED",
"status_changed_ts": "1613323571827743",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180569",
"builder:Linux Builder (dbg)",
"buildset:commit/git/ace45d2e6677437c98d2e2e5a5f027babcccc246",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ace45d2e6677437c98d2e2e5a5f027babcccc246",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020738291461797680",
"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/8855308229371832816/+/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:51ba015788eed610",
"user_agent:luci-scheduler"
],
"updated_ts": "1613323571847737",
"url": "https://ci.chromium.org/b/8855308229371832816",
"utcnow_ts": "1613323572483764"
}
}
[17:26:12.495] Invocation finished in 1h49m33.877447424s with status SUCCEEDED