[19:23:44.510] New invocation is queued and will start shortly
[19:23:46.095] Starting the invocation (attempt 1)
[19:23:46.134] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:23:46.134] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:23:46.134] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9050258614745866288",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"a87e04800ee4df6437abe47e4092c7256b1e05a1\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9050258614745866288",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/a87e04800ee4df6437abe47e4092c7256b1e05a1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a87e04800ee4df6437abe47e4092c7256b1e05a1",
"gitiles_ref:refs/heads/master"
]
}
[19:23:47.057] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1585164226228570",
"id": "8884828552277295088",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a87e04800ee4df6437abe47e4092c7256b1e05a1\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1585164226686694",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/170180",
"builder:Linux Builder (dbg)",
"buildset:commit/git/a87e04800ee4df6437abe47e4092c7256b1e05a1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a87e04800ee4df6437abe47e4092c7256b1e05a1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9050258614745866288",
"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/8884828552277295088/+/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": "1585164226686807",
"url": "https://ci.chromium.org/b/8884828552277295088",
"utcnow_ts": "1585164227041329"
}
}
[19:23:47.057] Task URL: https://ci.chromium.org/b/8884828552277295088
[19:23:47.057] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:2:0) after 1m0s
[19:24:05.210] Received PubSub notification, asking Buildbucket for the build status
[19:24:05.313] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:47.093] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:2:0)
[19:24:47.093] Timer tick, asking Buildbucket for the build status
[19:24:47.727] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:47.727] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:4:0) after 1m0s
[19:25:47.801] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:4:0)
[19:25:47.801] Timer tick, asking Buildbucket for the build status
[19:25:48.013] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:48.013] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:5:0) after 1m0s
[19:26:48.034] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:5:0)
[19:26:48.034] Timer tick, asking Buildbucket for the build status
[19:26:48.184] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:48.184] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:6:0) after 1m0s
[19:27:48.211] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:6:0)
[19:27:48.211] Timer tick, asking Buildbucket for the build status
[19:27:48.580] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:48.580] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:7:0) after 1m0s
[19:28:48.565] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:7:0)
[19:28:48.565] Timer tick, asking Buildbucket for the build status
[19:28:48.692] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:48.692] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:8:0) after 1m0s
[19:29:48.780] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:8:0)
[19:29:48.780] Timer tick, asking Buildbucket for the build status
[19:29:48.922] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:48.922] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:9:0) after 1m0s
[19:30:48.946] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:9:0)
[19:30:48.946] Timer tick, asking Buildbucket for the build status
[19:30:49.105] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:49.105] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:10:0) after 1m0s
[19:31:49.124] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:10:0)
[19:31:49.124] Timer tick, asking Buildbucket for the build status
[19:31:49.208] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:49.208] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:11:0) after 1m0s
[19:32:49.245] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:11:0)
[19:32:49.245] Timer tick, asking Buildbucket for the build status
[19:32:49.349] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:49.349] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:12:0) after 1m0s
[19:33:49.772] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:12:0)
[19:33:49.772] Timer tick, asking Buildbucket for the build status
[19:33:50.356] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:50.356] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:13:0) after 1m0s
[19:34:50.439] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:13:0)
[19:34:50.439] Timer tick, asking Buildbucket for the build status
[19:34:50.510] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:50.510] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:14:0) after 1m0s
[19:35:51.136] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:14:0)
[19:35:51.136] Timer tick, asking Buildbucket for the build status
[19:35:51.416] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:51.417] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:15:0) after 1m0s
[19:36:51.640] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:15:0)
[19:36:51.640] Timer tick, asking Buildbucket for the build status
[19:36:51.820] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:51.821] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:16:0) after 1m0s
[19:37:51.805] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:16:0)
[19:37:51.805] Timer tick, asking Buildbucket for the build status
[19:37:51.922] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:51.922] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:17:0) after 1m0s
[19:38:52.167] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:17:0)
[19:38:52.167] Timer tick, asking Buildbucket for the build status
[19:38:52.270] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:52.270] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:18:0) after 1m0s
[19:39:52.328] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:18:0)
[19:39:52.328] Timer tick, asking Buildbucket for the build status
[19:39:52.459] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:52.459] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:19:0) after 1m0s
[19:40:52.565] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:19:0)
[19:40:52.565] Timer tick, asking Buildbucket for the build status
[19:40:52.707] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:52.708] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:20:0) after 1m0s
[19:41:52.781] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:20:0)
[19:41:52.781] Timer tick, asking Buildbucket for the build status
[19:41:52.954] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:52.954] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:21:0) after 1m0s
[19:42:52.976] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:21:0)
[19:42:52.976] Timer tick, asking Buildbucket for the build status
[19:42:53.316] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:53.316] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:22:0) after 1m0s
[19:43:53.507] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:22:0)
[19:43:53.507] Timer tick, asking Buildbucket for the build status
[19:43:53.704] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:53.704] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:23:0) after 1m0s
[19:44:53.876] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:23:0)
[19:44:53.876] Timer tick, asking Buildbucket for the build status
[19:44:54.032] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:54.032] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:24:0) after 1m0s
[19:45:54.169] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:24:0)
[19:45:54.169] Timer tick, asking Buildbucket for the build status
[19:45:54.342] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:54.342] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:25:0) after 1m0s
[19:46:54.452] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:25:0)
[19:46:54.452] Timer tick, asking Buildbucket for the build status
[19:46:54.559] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:54.559] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:26:0) after 1m0s
[19:47:54.743] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:26:0)
[19:47:54.743] Timer tick, asking Buildbucket for the build status
[19:47:54.906] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:54.906] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:27:0) after 1m0s
[19:48:55.300] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:27:0)
[19:48:55.300] Timer tick, asking Buildbucket for the build status
[19:48:55.997] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:55.997] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:28:0) after 1m0s
[19:49:56.221] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:28:0)
[19:49:56.221] Timer tick, asking Buildbucket for the build status
[19:49:56.380] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:56.380] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:29:0) after 1m0s
[19:50:56.588] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:29:0)
[19:50:56.588] Timer tick, asking Buildbucket for the build status
[19:50:56.765] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:56.765] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:30:0) after 1m0s
[19:51:56.788] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:30:0)
[19:51:56.788] Timer tick, asking Buildbucket for the build status
[19:51:57.085] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:57.085] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:31:0) after 1m0s
[19:52:57.127] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:31:0)
[19:52:57.127] Timer tick, asking Buildbucket for the build status
[19:52:57.281] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:57.281] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:32:0) after 1m0s
[19:53:57.390] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:32:0)
[19:53:57.390] Timer tick, asking Buildbucket for the build status
[19:53:57.522] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:57.522] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:33:0) after 1m0s
[19:54:57.599] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:33:0)
[19:54:57.599] Timer tick, asking Buildbucket for the build status
[19:54:58.606] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:58.606] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:34:0) after 1m0s
[19:55:58.664] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:34:0)
[19:55:58.665] Timer tick, asking Buildbucket for the build status
[19:55:58.740] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:58.740] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:35:0) after 1m0s
[19:56:58.836] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:35:0)
[19:56:58.836] Timer tick, asking Buildbucket for the build status
[19:56:59.049] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:59.049] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:36:0) after 1m0s
[19:57:59.135] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:36:0)
[19:57:59.135] Timer tick, asking Buildbucket for the build status
[19:57:59.317] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:59.317] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:37:0) after 1m0s
[19:58:59.399] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:37:0)
[19:58:59.399] Timer tick, asking Buildbucket for the build status
[19:58:59.546] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:59.546] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:38:0) after 1m0s
[19:59:59.663] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:38:0)
[19:59:59.663] Timer tick, asking Buildbucket for the build status
[19:59:59.810] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:59.810] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:39:0) after 1m0s
[20:00:59.812] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:39:0)
[20:00:59.812] Timer tick, asking Buildbucket for the build status
[20:00:59.932] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:59.933] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:40:0) after 1m0s
[20:01:59.994] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:40:0)
[20:01:59.994] Timer tick, asking Buildbucket for the build status
[20:02:00.148] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:00.148] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:41:0) after 1m0s
[20:03:00.257] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:41:0)
[20:03:00.257] Timer tick, asking Buildbucket for the build status
[20:03:00.383] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:00.383] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:42:0) after 1m0s
[20:04:00.454] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:42:0)
[20:04:00.454] Timer tick, asking Buildbucket for the build status
[20:04:00.663] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:00.663] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:43:0) after 1m0s
[20:05:00.900] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:43:0)
[20:05:00.900] Timer tick, asking Buildbucket for the build status
[20:05:01.033] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:01.033] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:44:0) after 1m0s
[20:06:01.254] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:44:0)
[20:06:01.254] Timer tick, asking Buildbucket for the build status
[20:06:01.353] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:01.353] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:45:0) after 1m0s
[20:07:01.649] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:45:0)
[20:07:01.649] Timer tick, asking Buildbucket for the build status
[20:07:01.817] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:01.817] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:46:0) after 1m0s
[20:08:01.934] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:46:0)
[20:08:01.934] Timer tick, asking Buildbucket for the build status
[20:08:02.124] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:02.124] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:47:0) after 1m0s
[20:09:02.268] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:47:0)
[20:09:02.268] Timer tick, asking Buildbucket for the build status
[20:09:02.522] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:02.522] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:48:0) after 1m0s
[20:10:02.624] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:48:0)
[20:10:02.624] Timer tick, asking Buildbucket for the build status
[20:10:02.722] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:02.722] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:49:0) after 1m0s
[20:11:02.935] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:49:0)
[20:11:02.935] Timer tick, asking Buildbucket for the build status
[20:11:03.058] Build 8884828552277295088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:03.058] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050258614745866288:50:0) after 1m0s
[20:11:43.436] Received PubSub notification, asking Buildbucket for the build status
[20:11:43.507] Build 8884828552277295088: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:11:43.507] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1585167102886916",
"created_by": "project:chromium",
"created_ts": "1585164226228570",
"id": "8884828552277295088",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a87e04800ee4df6437abe47e4092c7256b1e05a1\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/chromium_tests\": {\"bucketed_triggers\": true}, \"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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-93-cmnn\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 170180, \"got_angle_revision\": \"c77cb596a2c3bf94822d5d9528ad964fef9ac35f\", \"got_dawn_revision\": \"0eff2a2b463fa5bf03b080432d19526221ce6c65\", \"got_nacl_revision\": \"ffed96d1528df9f114a30b14d4eb06120c8fb022\", \"got_revision\": \"a87e04800ee4df6437abe47e4092c7256b1e05a1\", \"got_revision_cp\": \"refs/heads/master@{#753324}\", \"got_swarming_client_revision\": \"cc958279ffd6853e0a1b227a7e957ca334fe56af\", \"got_swiftshader_revision\": \"540bdf92531d0c325d7b5c770ec33e869b56059f\", \"got_v8_revision\": \"1aff54a5d8872718236985940b6b049de3fb44a5\", \"got_v8_revision_cp\": \"refs/heads/8.3.75@{#1}\", \"got_webrtc_revision\": \"d19513f3ffbb939fd56b5377b678bb31d3154e14\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30881}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a87e04800ee4df6437abe47e4092c7256b1e05a1\", \"swarm_hashes_refs/heads/master(at){#753324}_without_patch\": {\"accessibility_unittests\": \"7c453d5e90b3e770c57b34de7f6882eaec4995b8\", \"angle_unittests\": \"29a389f083225e88568948b3eb8b9431f1e6c653\", \"app_shell_unittests\": \"a9ad3e51376e9b61eeaf9080f08c90d9d1e16e7d\", \"aura_unittests\": \"e8edcb3309962a49d8aa7c80f76825dd4e4afb45\", \"base_unittests\": \"8cd9e86c7da62279cb270e88d5984d71a2d09636\", \"base_util_unittests\": \"0c355c75e04675be4d9dfda4ea9a9b9f09c9377b\", \"blink_common_unittests\": \"ae0f2ac67b7a1c2d0b580c2c5f37b1545184b0e5\", \"blink_fuzzer_unittests\": \"fd5bb562267b48ce3fc7d255e9c898fddfe96aba\", \"blink_heap_unittests\": \"9776934dfbc86fc4073b05145278151c5239a318\", \"blink_platform_unittests\": \"94969259e72292f323dbd5cfa3dcc8cc7b2d48c2\", \"blink_python_tests\": \"fc1270e115cf74fcae05b9d21b4f8727d63a2406\", \"blink_unittests\": \"441a36afd545d7ef3074c1f843e4438e5758b2e6\", \"blink_web_tests\": \"bced2b19672dd375607751e55fe36a4f13937131\", \"boringssl_crypto_tests\": \"efe22cb92a8b3e45e388c334ee769cfe168e7e65\", \"boringssl_ssl_tests\": \"4b1171bd375f28123d921f412a147423dd0b64b6\", \"browser_tests\": \"63bc82caa6d82af7a545fb335884f65e6994543c\", \"cacheinvalidation_unittests\": \"009ec736163166e9ff93c849168ccf9ca9ca126f\", \"capture_unittests\": \"5de94df76111050246025493df38af1f37519cb9\", \"cast_unittests\": \"c846bfc81b33531411a939d821d4eed62301ed77\", \"cc_unittests\": \"71acc941ea850bb2229d530b64151c288c05025c\", \"chrome_app_unittests\": \"8a3b18bf8165f3e5d9fc2e087306077ef648b440\", \"chromedriver_unittests\": \"45c7e098e5810ed161ef8cd6a618ad821f70f24d\", \"components_browsertests\": \"530ef26dd9f3648ebac970f5fc0eec84c20ca663\", \"components_unittests\": \"6652340777e687e226e2a31fedbacd5024717265\", \"compositor_unittests\": \"73ffb464be610ecc0c6835b89b4a332dcabbb46f\", \"content_browsertests\": \"ac020ac81a9c23e037c6b4d92b887be4e5abb80b\", \"content_shell_crash_test\": \"e2ccff70571a2ed02466d5c7dd5b455366de28e7\", \"content_unittests\": \"b27e585da2099a35977b58517f77fe007f2bf5ea\", \"crashpad_tests\": \"b8f43986304beb4bb3a94d623d6226dcfaf9ce09\", \"cronet_tests\": \"4a10466a84c9ea43f6bc6739736e42288cdcd49a\", \"cronet_unittests\": \"9ed4b3f56da3b30b5e5825acf166602bc59e72f6\", \"crypto_unittests\": \"8ffa97be29fcd0f388850517535efa53928278d4\", \"dbus_unittests\": \"2a9dfedcf022cf501c652f66499639a9e0e97743\", \"device_unittests\": \"064cf6ef340adcb16adce93573078e91eef502f5\", \"display_unittests\": \"9f4002bc292dbb25621410083171bc4c74c3e563\", \"events_unittests\": \"631cd95b69280885624920115696efe6ee1af150\", \"extensions_browsertests\": \"4132a7528e815a35c05ae2ceaa76b04cf6fea4be\", \"extensions_unittests\": \"804a81a771e9b72d4ec5878c648285365dbc32ee\", \"filesystem_service_unittests\": \"23b0dc35a9a16fb7090f3c891a1e6262fe7e9318\", \"flatbuffers_unittests\": \"d5a97f0e268c1e3e0a07477fbb5635ba77b25a21\", \"gcm_unit_tests\": \"85fb2b917e204ce86ab5c9ad712f5a9374bcc804\", \"gfx_unittests\": \"2be4ea82d06b95dffefc87e8f195bd3bc5779f4b\", \"gin_unittests\": \"095e2fc544443b6a9d4c5d5f14f621d001fc76e5\", \"google_apis_unittests\": \"7493341db3a05164726a92fccae78f66782c586d\", \"gpu_unittests\": \"28a4504e98d0962d9e65a8a76d8028dee2ba9e00\", \"grit_python_unittests\": \"920c6b3d7ae5f4f6a7545c1f01eb545d63387104\", \"gwp_asan_unittests\": \"d39c0abc999e57f546b03699e482e3a027caa88c\", \"headless_browsertests\": \"9efbc7eeb12f5d19595f16c9225e0262e826c1f0\", \"headless_unittests\": \"70e0123d15d6c928a22e96057fc06a43067cd988\", \"interactive_ui_tests\": \"581a981b7ec7d1915603c95e3ff3598e2efc3c3d\", \"ipc_tests\": \"172833607cde5c0d663faed5c8b033ead229252e\", \"jingle_unittests\": \"e91d9067252da7a2dd3e12b4c1ee50a54057c034\", \"latency_unittests\": \"cb511f286e8ef69cbd196b433ca2ab9ce63b746c\", \"libjingle_xmpp_unittests\": \"2cb3a737a5a63cbe30a813c383f7924c3abbf3be\", \"media_blink_unittests\": \"f124c6c9c6ec2995d6c7f732bc55cfd325a4d6fd\", \"media_service_unittests\": \"77babbcc84406e6bddeb75b0fde1fb05b985c0d2\", \"media_unittests\": \"5ed3884e885a755731693196e0ca12122207db32\", \"message_center_unittests\": \"d1c118776042e5c9ab5c708aedb8ad40c08ff404\", \"metrics_python_tests\": \"6499039d90525a56b9b54c9f48940638a925651d\", \"midi_unittests\": \"a886160e9894b4550346fcc1407f5049050ec948\", \"mojo_core_unittests\": \"8003ed6e93fd467b7e00ce89bb011b01c23e607d\", \"mojo_unittests\": \"1b7a79947cba090748736e87d730262c81170f4d\", \"nacl_helper_nonsfi_unittests\": \"f0e35f3d809e9228ed301a601a84283849568bec\", \"nacl_loader_unittests\": \"355d760781186d2e5b0d25bfc79674b41461f42d\", \"native_theme_unittests\": \"96101db8fbe1f1f0101d5e088f109db54660a951\", \"net_unittests\": \"a41d3a0e963968e75971c03cead2e6c1d3dc1f5f\", \"pdf_unittests\": \"6cd389b9e39754bc10624a912d302babc37228d1\", \"perfetto_unittests\": \"739d824d7c78f024524599566a4d7ee99e100e22\", \"ppapi_unittests\": \"9611c6b58e293eaf5c339cac6b0720e8d3e2f250\", \"printing_unittests\": \"2fd2534dcca7943b4d8cfaf67168dc98280a9658\", \"remoting_unittests\": \"db34b400f1af0c9b331d0f1a0c9bc857ecc837fe\", \"sandbox_linux_unittests\": \"2a1387acd920d88269fc779390648393bd6074cb\", \"service_manager_unittests\": \"00e0c11404a3994ad21dff485ab7efb53749a84e\", \"services_unittests\": \"08957b0e41cb0ce79df9cdc4f3c69464505b3c32\", \"shell_dialogs_unittests\": \"11ad82cf43b22dc57caa71c4f794365c0b53335c\", \"skia_unittests\": \"525303884c0b5c8f99baa753d8b7e5bc4cdcc9d4\", \"snapshot_unittests\": \"a98a6447598bb3a9b3a525bd8c07f96738c0b1e4\", \"sql_unittests\": \"b1a5f63d01c520289511140b1ce76c4d24ae8d4b\", \"storage_unittests\": \"01ad685509a388d334256f3e7ff9f901b95827ac\", \"sync_integration_tests\": \"e7bb3431ac4ba5b45e24000100194e6770b17f83\", \"telemetry_gpu_unittests\": \"09bd6572f14114618534a04bd44764c5ff862215\", \"telemetry_perf_unittests\": \"7b58a1cca15e72679825b3f33ca2898886ff31c2\", \"telemetry_unittests\": \"6917a30c59ba781736acedf3753e95cd709bb2bc\", \"traffic_annotation_auditor_unittests\": \"48a848d9ec81e0de28b1a74663a781a6c6cec335\", \"ui_base_unittests\": \"69f44f8ce4cf9dcfa6e9060b21501264c98aed7c\", \"ui_touch_selection_unittests\": \"3596d6c99603d5c1f08910d0f157e2bdd2d48d44\", \"unit_tests\": \"6e5f82db759cf0033888f1d8c82a60d1bca60467\", \"url_unittests\": \"807cc5e4876c88a8aff375b091082d1bd5c29cc0\", \"views_perftests\": \"f9bce4e53d7b396310ccd33e62b50f3e83b56160\", \"views_unittests\": \"b0b120a497dba36268709a339c7d5f7332b7b70d\", \"viz_unittests\": \"3a1b6b466eb49a0ff676cd1eba9d514deeca5c74\", \"vr_common_unittests\": \"e030095b77ce38dd490c1504e3fe3a1dff110bc2\", \"vr_pixeltests\": \"f854c253e12f3927a1332c47829062970e57e218\", \"webdriver_wpt_tests\": \"347f7cf2f0b1ab59af6e443e5d2933a45b8396ad\", \"weblayer_browsertests\": \"fa797c7ab34d59cc9ea3138ea93f5409373f6762\", \"wm_unittests\": \"0ced74218c4bf98451f33b8fea99dafd937cb3f2\", \"wtf_unittests\": \"742755600ec8c16f8270ce03e46ebcf46e3d254e\", \"xr_browser_tests\": \"c1eeaf7c785a72036594ee3d3e653c835de50153\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_c9091f6bc58db7983401393b6dacc93b3db8fae2c2ae9b40177b9e0904c8bc80_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-93-cmnn\"], \"image\": [\"chrome-xenial-20032200-f0f7a76907a\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4895-ce889b2\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1585164243768481",
"status": "COMPLETED",
"status_changed_ts": "1585167103177955",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/170180",
"builder:Linux Builder (dbg)",
"buildset:commit/git/a87e04800ee4df6437abe47e4092c7256b1e05a1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a87e04800ee4df6437abe47e4092c7256b1e05a1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9050258614745866288",
"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/8884828552277295088/+/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:4b2bf84e52b19110",
"user_agent:luci-scheduler"
],
"updated_ts": "1585167103183159",
"url": "https://ci.chromium.org/b/8884828552277295088",
"utcnow_ts": "1585167103498642"
}
}
[20:11:43.507] Invocation finished in 47m59.016633964s with status SUCCEEDED