[21:49:31.476] New invocation is queued and will start shortly
[21:49:32.562] Starting the invocation (attempt 1)
[21:49:32.601] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:49:32.601] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:49:32.601] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022436174199319856",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d91fa1d86fd90c4104a4d99ce7aa64a068ec0273\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9022436174199319856",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/d91fa1d86fd90c4104a4d99ce7aa64a068ec0273",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d91fa1d86fd90c4104a4d99ce7aa64a068ec0273",
"gitiles_ref:refs/heads/master"
]
}
[21:49:34.286] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611697773235614",
"id": "8857006111690987040",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d91fa1d86fd90c4104a4d99ce7aa64a068ec0273\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611697774004785",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180008",
"builder:Linux Builder (dbg)",
"buildset:commit/git/d91fa1d86fd90c4104a4d99ce7aa64a068ec0273",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d91fa1d86fd90c4104a4d99ce7aa64a068ec0273",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022436174199319856",
"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/8857006111690987040/+/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": "1611697774004951",
"url": "https://ci.chromium.org/b/8857006111690987040",
"utcnow_ts": "1611697774270595"
}
}
[21:49:34.286] Task URL: https://ci.chromium.org/b/8857006111690987040
[21:49:34.286] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:2:0) after 1m0s
[21:49:38.074] Received PubSub notification, asking Buildbucket for the build status
[21:49:38.365] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:35.064] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:2:0)
[21:50:35.064] Timer tick, asking Buildbucket for the build status
[21:50:35.881] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:35.881] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:4:0) after 1m0s
[21:51:36.043] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:4:0)
[21:51:36.043] Timer tick, asking Buildbucket for the build status
[21:51:36.149] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:36.149] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:5:0) after 1m0s
[21:52:36.310] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:5:0)
[21:52:36.310] Timer tick, asking Buildbucket for the build status
[21:52:36.433] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:36.433] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:6:0) after 1m0s
[21:53:36.669] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:6:0)
[21:53:36.669] Timer tick, asking Buildbucket for the build status
[21:53:37.265] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:37.265] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:7:0) after 1m0s
[21:54:37.283] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:7:0)
[21:54:37.283] Timer tick, asking Buildbucket for the build status
[21:54:37.558] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:37.558] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:8:0) after 1m0s
[21:55:37.640] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:8:0)
[21:55:37.640] Timer tick, asking Buildbucket for the build status
[21:55:37.896] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:37.896] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:9:0) after 1m0s
[21:56:38.037] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:9:0)
[21:56:38.037] Timer tick, asking Buildbucket for the build status
[21:56:38.343] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:38.343] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:10:0) after 1m0s
[21:57:38.459] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:10:0)
[21:57:38.459] Timer tick, asking Buildbucket for the build status
[21:57:38.558] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:38.558] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:11:0) after 1m0s
[21:58:38.704] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:11:0)
[21:58:38.704] Timer tick, asking Buildbucket for the build status
[21:58:38.823] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:38.823] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:12:0) after 1m0s
[21:59:38.826] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:12:0)
[21:59:38.826] Timer tick, asking Buildbucket for the build status
[21:59:39.001] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:39.001] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:13:0) after 1m0s
[22:00:39.135] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:13:0)
[22:00:39.135] Timer tick, asking Buildbucket for the build status
[22:00:39.623] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:39.623] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:14:0) after 1m0s
[22:01:40.157] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:14:0)
[22:01:40.157] Timer tick, asking Buildbucket for the build status
[22:01:40.243] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:40.243] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:15:0) after 1m0s
[22:02:40.496] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:15:0)
[22:02:40.496] Timer tick, asking Buildbucket for the build status
[22:02:41.657] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:41.657] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:16:0) after 1m0s
[22:03:41.803] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:16:0)
[22:03:41.803] Timer tick, asking Buildbucket for the build status
[22:03:42.380] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:42.380] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:17:0) after 1m0s
[22:04:42.808] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:17:0)
[22:04:42.808] Timer tick, asking Buildbucket for the build status
[22:04:43.141] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:43.141] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:18:0) after 1m0s
[22:05:43.233] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:18:0)
[22:05:43.233] Timer tick, asking Buildbucket for the build status
[22:05:43.314] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:43.314] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:19:0) after 1m0s
[22:06:43.380] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:19:0)
[22:06:43.380] Timer tick, asking Buildbucket for the build status
[22:06:43.450] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:43.450] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:20:0) after 1m0s
[22:07:43.638] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:20:0)
[22:07:43.638] Timer tick, asking Buildbucket for the build status
[22:07:43.747] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:43.747] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:21:0) after 1m0s
[22:08:44.347] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:21:0)
[22:08:44.347] Timer tick, asking Buildbucket for the build status
[22:08:44.432] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:44.432] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:22:0) after 1m0s
[22:09:44.633] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:22:0)
[22:09:44.633] Timer tick, asking Buildbucket for the build status
[22:09:46.727] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:46.727] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:23:0) after 1m0s
[22:10:46.899] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:23:0)
[22:10:46.899] Timer tick, asking Buildbucket for the build status
[22:10:47.004] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:47.004] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:24:0) after 1m0s
[22:11:47.011] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:24:0)
[22:11:47.011] Timer tick, asking Buildbucket for the build status
[22:11:47.192] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:47.192] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:25:0) after 1m0s
[22:12:47.254] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:25:0)
[22:12:47.254] Timer tick, asking Buildbucket for the build status
[22:12:47.342] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:47.342] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:26:0) after 1m0s
[22:13:47.425] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:26:0)
[22:13:47.425] Timer tick, asking Buildbucket for the build status
[22:13:47.509] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:47.509] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:27:0) after 1m0s
[22:14:47.639] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:27:0)
[22:14:47.639] Timer tick, asking Buildbucket for the build status
[22:14:47.848] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:47.848] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:28:0) after 1m0s
[22:15:47.939] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:28:0)
[22:15:47.939] Timer tick, asking Buildbucket for the build status
[22:15:48.220] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:48.220] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:29:0) after 1m0s
[22:16:48.326] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:29:0)
[22:16:48.326] Timer tick, asking Buildbucket for the build status
[22:16:48.415] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:48.415] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:30:0) after 1m0s
[22:17:48.487] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:30:0)
[22:17:48.487] Timer tick, asking Buildbucket for the build status
[22:17:48.735] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:48.735] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:31:0) after 1m0s
[22:18:48.727] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:31:0)
[22:18:48.727] Timer tick, asking Buildbucket for the build status
[22:18:48.818] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:48.818] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:32:0) after 1m0s
[22:19:48.945] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:32:0)
[22:19:48.945] Timer tick, asking Buildbucket for the build status
[22:19:49.164] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:49.164] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:33:0) after 1m0s
[22:20:49.253] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:33:0)
[22:20:49.253] Timer tick, asking Buildbucket for the build status
[22:20:49.329] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:49.329] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:34:0) after 1m0s
[22:21:49.352] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:34:0)
[22:21:49.352] Timer tick, asking Buildbucket for the build status
[22:21:49.468] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:49.468] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:35:0) after 1m0s
[22:22:49.542] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:35:0)
[22:22:49.542] Timer tick, asking Buildbucket for the build status
[22:22:49.618] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:49.618] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:36:0) after 1m0s
[22:23:50.183] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:36:0)
[22:23:50.183] Timer tick, asking Buildbucket for the build status
[22:23:50.439] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:50.439] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:37:0) after 1m0s
[22:24:50.685] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:37:0)
[22:24:50.685] Timer tick, asking Buildbucket for the build status
[22:24:51.051] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:51.051] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:38:0) after 1m0s
[22:25:51.092] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:38:0)
[22:25:51.092] Timer tick, asking Buildbucket for the build status
[22:25:51.276] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:51.276] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:39:0) after 1m0s
[22:26:51.296] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:39:0)
[22:26:51.296] Timer tick, asking Buildbucket for the build status
[22:26:51.971] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:51.972] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:40:0) after 1m0s
[22:27:52.065] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:40:0)
[22:27:52.065] Timer tick, asking Buildbucket for the build status
[22:27:52.818] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:52.818] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:41:0) after 1m0s
[22:28:52.850] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:41:0)
[22:28:52.850] Timer tick, asking Buildbucket for the build status
[22:28:53.312] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:53.312] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:42:0) after 1m0s
[22:29:53.304] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:42:0)
[22:29:53.304] Timer tick, asking Buildbucket for the build status
[22:29:53.880] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:53.880] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:43:0) after 1m0s
[22:30:53.910] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:43:0)
[22:30:53.911] Timer tick, asking Buildbucket for the build status
[22:30:54.342] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:54.342] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:44:0) after 1m0s
[22:31:54.393] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:44:0)
[22:31:54.393] Timer tick, asking Buildbucket for the build status
[22:31:54.500] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:54.500] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:45:0) after 1m0s
[22:32:54.521] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:45:0)
[22:32:54.521] Timer tick, asking Buildbucket for the build status
[22:32:54.589] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:54.589] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:46:0) after 1m0s
[22:33:54.653] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:46:0)
[22:33:54.653] Timer tick, asking Buildbucket for the build status
[22:33:54.736] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:54.736] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:47:0) after 1m0s
[22:34:54.755] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:47:0)
[22:34:54.755] Timer tick, asking Buildbucket for the build status
[22:34:54.870] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:54.870] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:48:0) after 1m0s
[22:35:55.589] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:48:0)
[22:35:55.589] Timer tick, asking Buildbucket for the build status
[22:35:55.816] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:55.816] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:49:0) after 1m0s
[22:36:55.833] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:49:0)
[22:36:55.833] Timer tick, asking Buildbucket for the build status
[22:36:56.167] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:56.167] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:50:0) after 1m0s
[22:37:56.220] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:50:0)
[22:37:56.220] Timer tick, asking Buildbucket for the build status
[22:37:56.976] Build 8857006111690987040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:56.976] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9022436174199319856:51:0) after 1m0s
[22:38:19.476] Received PubSub notification, asking Buildbucket for the build status
[22:38:19.616] Build 8857006111690987040: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:38:19.617] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611700698576572",
"created_by": "project:chromium",
"created_ts": "1611697773235614",
"id": "8857006111690987040",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d91fa1d86fd90c4104a4d99ce7aa64a068ec0273\"}}",
"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\": \"d91fa1d86fd90c4104a4d99ce7aa64a068ec0273\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-72-9inl\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180008, \"got_angle_revision\": \"50f7d64610097f0a1eeef27e6e35612ad52b1023\", \"got_dawn_revision\": \"2fe8cab10aeb3956b619a6c0c062417e05aa95d3\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"d91fa1d86fd90c4104a4d99ce7aa64a068ec0273\", \"got_revision_cp\": \"refs/heads/master@{#847315}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"ea1f7d10db1f22f3327f4c0bc690695bc1a73aa0\", \"got_v8_revision\": \"c316f1301cc02dea5fe5722364062578c071f4af\", \"got_v8_revision_cp\": \"refs/heads/9.0.71@{#1}\", \"got_webrtc_revision\": \"c57089a97a3df454f4356d882cc8df173e8b3ead\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33072}\", \"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\": \"d91fa1d86fd90c4104a4d99ce7aa64a068ec0273\", \"swarm_hashes_refs/heads/master(at){#847315}_without_patch\": {\"absl_hardening_tests\": \"cbba0e73cb8e7f767b4e2bd835e28b69c302e62e\", \"accessibility_unittests\": \"b253ab30b0ea8677a315c40be9aa9c0004bb18dc\", \"angle_unittests\": \"f2e25a6684cfd43ee2b154a31d3013000b75caa8\", \"app_shell_unittests\": \"4837708bd5b2b3c2108834f08d6eade329e9f6eb\", \"aura_unittests\": \"a1cde455dc96e53c5786432d7a74c6a970d61cb6\", \"base_unittests\": \"5b6515cbce34779abf94a42b4896bceb1001b0c3\", \"base_util_unittests\": \"7d815d291acdb25535fd1a38bc1727ef1c89d2ab\", \"blink_common_unittests\": \"7b697106602e4b7f80dcb002a872a7ab03c50d36\", \"blink_fuzzer_unittests\": \"e8ae44006fb7e479e497460d1f31b39130444c12\", \"blink_heap_unittests\": \"1c2419bec4c88ae842c7c158e35b182e791f6082\", \"blink_platform_unittests\": \"196bba2e00b069fc816ba94851a5d4416a29cf5f\", \"blink_python_tests\": \"2215367e2f32248351095764aa8cebca63b88856\", \"blink_unittests\": \"590296b9c496daf787f07c7d857cba8711b9b58c\", \"blink_web_tests\": \"924855516c7f712ac9ed72c5f7b975c9298f43eb\", \"boringssl_crypto_tests\": \"1023ec981a708a9a640bec8c8219abe78d1f95fa\", \"boringssl_ssl_tests\": \"58b2a36a1e1da8fcc3a42dcc8e5a64afeb392fb1\", \"browser_tests\": \"45337d719474a9ecba2df16eb7ac042123034bdf\", \"capture_unittests\": \"cf90cc3e5fc52176d796453d996dd3bd2152893d\", \"cast_unittests\": \"6a187a17e27f5315ed0bcd45b53e017e8ca8d345\", \"cc_unittests\": \"f30c1a65227c16ad89b211df11cd5f32202be1d0\", \"chrome_app_unittests\": \"505e65db01a7f43339d070db44c1afd915f615f8\", \"chromedriver_unittests\": \"8eb28bafef2e985660020f7fb79ff6742a7707ea\", \"components_browsertests\": \"393e4d3f9f7fedc189e72f4876b12b99434f030c\", \"components_unittests\": \"23ac4dbbacffc7703c857fc8e53d46fd22046adb\", \"compositor_unittests\": \"540f8b537219ad18e1193489b6c4a8fea709e3c8\", \"content_browsertests\": \"cc5f0e80b04dda0bc09f9e9307d6f912ab9ffdf0\", \"content_shell_crash_test\": \"221bbf3f80a014f272cce64c28f2cce8b8429bdc\", \"content_unittests\": \"0730e6597f5118d04e89ab6336370bec5a326285\", \"crashpad_tests\": \"4adec17248b8ab93361d3dc1a917b04712fb97b3\", \"cronet_tests\": \"4a6a58d48dfbedd6ae71a886894d344a67ae9ffa\", \"cronet_unittests\": \"70cdc6f1031775c8fbd2ebde79b7f2812f40ae4f\", \"crypto_unittests\": \"16bb0e9f97852c144136eec078ee44a415ef97aa\", \"dbus_unittests\": \"42374dd85833c012328ea4cae1d74b5adf46012d\", \"device_unittests\": \"941b2f00bfd2205a1588e5e9e2acfd7da26f80d1\", \"display_unittests\": \"263c9ce826f9a8a9252435b5b075679531ea93ea\", \"events_unittests\": \"bc10f152fc1cae0e28af2cbf65ae010f5c16f82f\", \"extensions_browsertests\": \"e04e344c5610f67085fc663e62257315ceab0339\", \"extensions_unittests\": \"41ba4a40f36ec6689a6f198cd4fdff412b326c26\", \"filesystem_service_unittests\": \"840558038e2dcf2d3586037a426b86ecef6cfcea\", \"flatbuffers_unittests\": \"bc94b5892d7faa8d4260fa7d28e336b3c313737d\", \"gcm_unit_tests\": \"f7cb074e4b189041ec90243902bbac3ac0ef73d1\", \"gfx_unittests\": \"494607f356ed795f5742b357faa7b711469a0ff5\", \"gin_unittests\": \"d7e900b63340892d25299de1d4515e957118e4bf\", \"google_apis_unittests\": \"22e27393ea3719745945e63ffc6e06072da17c3d\", \"gpu_unittests\": \"fb5e3c0085cce4b74604f4f9adfcda16f6faf2c3\", \"grit_python_unittests\": \"b0890b035c0d25a1641db23ae376539c3f64cf64\", \"gwp_asan_unittests\": \"654e08d8abd32532b80149414f467750a33daf7e\", \"headless_browsertests\": \"5769e371b63bfa0790cba0d0279ec3bf8e52ae0b\", \"headless_unittests\": \"6a468efad55a49ad90f79f9dad9e30755fd665ba\", \"interactive_ui_tests\": \"bc0acd71735bb5e0b9e947af7ccd77e038df85b1\", \"ipc_tests\": \"79c9a54a4905049324016ebf3c313728c38094d4\", \"jingle_unittests\": \"962b996787202e7d0e0f576b2a0eee3941f4b453\", \"latency_unittests\": \"f803e2ee4bad44b0017016b6a967332ad4600d8c\", \"libjingle_xmpp_unittests\": \"7604210459777e818ed24bd266d21b4d87f4794c\", \"liburlpattern_unittests\": \"715a0196010da92c790feac61272467183345b76\", \"media_blink_unittests\": \"acb2a6800f76e159912ba6ae8b90a6f3459b58d9\", \"media_unittests\": \"82180818ee64f0012fcb2d6cd4f8f838db8852a7\", \"message_center_unittests\": \"3e15d8b27554cb0e9cdef514cdee2e9da59d7fb3\", \"metrics_python_tests\": \"c359276329181f284ef374d866e1dbaf40739fa0\", \"midi_unittests\": \"f6185392a17cf3052dde88d7dfcc45cda00044a0\", \"mojo_core_unittests\": \"29c59df42e1f6e2c5026ea685d9f5e243b3ed6a1\", \"mojo_unittests\": \"f236751b9d5ce37048e6bfbe5a3e7d4cbbe47ac9\", \"nacl_helper_nonsfi_unittests\": \"ab1b1864ed3866f88a8cc30c32defda7f89231bb\", \"nacl_loader_unittests\": \"2abb24882c18838d221f77f12ac2247d9fd2c1ba\", \"native_theme_unittests\": \"82905f1bdcbe39cffa36e3ee4ac5ab49ae9fc74c\", \"net_unittests\": \"c3deec80962301fb004a79408b76b2c0e571a1d3\", \"openscreen_unittests\": \"80dd9805e2190b62aafadbac1a189a175ad277c6\", \"pdf_unittests\": \"be9dad50628a989d5ed4232eeccc395085754bc5\", \"perfetto_unittests\": \"5d7d5172ab38bd3b4f88fc8d2767dc1782924abc\", \"ppapi_unittests\": \"31d8d2bbc392223f9d443435080fa62ff3a84d7a\", \"printing_unittests\": \"c90307131b8bd16bb45f530326c9e304dfee06ba\", \"remoting_unittests\": \"47b57dd31591e0c5f1a8391885b2d9d1572297fe\", \"sandbox_linux_unittests\": \"7646a921b54d7389f266bc803d56d29930c09096\", \"service_manager_unittests\": \"68f0b6124ee6e0f8a0b8351ebb70d92e3ffd0dd2\", \"services_unittests\": \"8ed18935641d80933f6cd00cd4d40a90a06dad8a\", \"shell_dialogs_unittests\": \"63c591702255d415db9cbe19a49961c27adb8aad\", \"skia_unittests\": \"4b094ba769ecd3029715c453a7e0bc1c005774f1\", \"snapshot_unittests\": \"a5012c68c520ac193f2a97c73657217809273c54\", \"sql_unittests\": \"dceb2aa40790088e813c9eb48776ad986769894e\", \"storage_unittests\": \"9584ab9a7614a86d809e93295b8386f6e608a7aa\", \"sync_integration_tests\": \"a2632593e1934496032586f5b626459c94f642dc\", \"telemetry_gpu_unittests\": \"3ce888092a14f563108b7a63d59e7d64faa77750\", \"telemetry_perf_unittests\": \"60a3f10bd0943428429b1f4888daf9b16738baa6\", \"telemetry_unittests\": \"d40ac7c28d7bfefd1d28c2186966c6079ec28416\", \"traffic_annotation_auditor_unittests\": \"2f323eb4fd694ab9b682cd2761f67afedee179e4\", \"ui_base_unittests\": \"87ced3e5d0b0e418113729b3f96e24a6ac1b64e9\", \"ui_touch_selection_unittests\": \"0aee3353f1d40e39e6c0aa0d5f55ad6da983d839\", \"unit_tests\": \"57fed9f10a7df2f9aae96e323d03801f304e508f\", \"url_unittests\": \"5c883f6ba8cc6f718d75af9aec0022e332962de4\", \"views_perftests\": \"2e63249c2faaca7967cf0eec9086ca8c961f0e5d\", \"views_unittests\": \"e40b84a5744c7a698f19f58e4f62c070e6d3db02\", \"viz_unittests\": \"623ebc2c883d277eeaed491175c87bfb370bd657\", \"vr_common_unittests\": \"22d4469e43ff96c1d3f3082513eb92510c032be6\", \"vr_pixeltests\": \"22b4f4f3c54a4e9f0b7c623f97989c64dfa2904d\", \"webdriver_wpt_tests\": \"e50ce0f3eb362f515ff79c42de95fe1faf9984c2\", \"weblayer_browsertests\": \"6a995d78f0145976843a70ae02363c870ead2a64\", \"weblayer_unittests\": \"0cb1b09da1b928c51a8099bf0169d0bd3788b791\", \"wm_unittests\": \"01b303c04ffde741ef3544e6ddcadcc5141c88c8\", \"wtf_unittests\": \"4f8e9a301de349128474d368166260cb0ff45f77\", \"x11_unittests\": \"6376db439628cdded5eec5ab2b37cf2f0cf4b127\", \"xr_browser_tests\": \"ed6d1bd93745ae2f512de2411c4faa67e7a83535\", \"zlib_unittests\": \"a70672d8e6bf797f3ed6f5706a35989f98c6209f\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_17616f83fd632132c65ea3dd60ce01b78f71f01fa76c3e3446f88a64858a3864_v2\", \"builder_d99b56d6fc6fd15316497c0509dbc8d437110174a09b554c19aeca35e1687cdb_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"builder_fa0031875b7f2f11c46443055ab400bfaeb07a1d2a142b58c631314016c04e0a_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-72-9inl\"], \"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\": [\"5672-4713de1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611697776682830",
"status": "COMPLETED",
"status_changed_ts": "1611700698934556",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180008",
"builder:Linux Builder (dbg)",
"buildset:commit/git/d91fa1d86fd90c4104a4d99ce7aa64a068ec0273",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d91fa1d86fd90c4104a4d99ce7aa64a068ec0273",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022436174199319856",
"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/8857006111690987040/+/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:51597de79a0cf310",
"user_agent:luci-scheduler"
],
"updated_ts": "1611700698946272",
"url": "https://ci.chromium.org/b/8857006111690987040",
"utcnow_ts": "1611700699594714"
}
}
[22:38:19.618] Invocation finished in 48m48.158182482s with status SUCCEEDED