[21:25:24.198] New invocation is queued and will start shortly
[21:25:25.360] Starting the invocation (attempt 1)
[21:25:25.395] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:25:25.396] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:25:25.396] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021169334250630848",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"40272a2897cdeb297be164a4df00e40107837995\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9021169334250630848",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/40272a2897cdeb297be164a4df00e40107837995",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/40272a2897cdeb297be164a4df00e40107837995",
"gitiles_ref:refs/heads/master"
]
}
[21:25:27.322] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612905925568399",
"id": "8855739272149658272",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"40272a2897cdeb297be164a4df00e40107837995\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612905926950468",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180432",
"builder:Linux Builder (dbg)",
"buildset:commit/git/40272a2897cdeb297be164a4df00e40107837995",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/40272a2897cdeb297be164a4df00e40107837995",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021169334250630848",
"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/8855739272149658272/+/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": "1612905926950671",
"url": "https://ci.chromium.org/b/8855739272149658272",
"utcnow_ts": "1612905927300659"
}
}
[21:25:27.322] Task URL: https://ci.chromium.org/b/8855739272149658272
[21:25:27.322] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:2:0) after 1m0s
[21:25:28.867] Received PubSub notification, asking Buildbucket for the build status
[21:25:29.940] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:27.488] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:2:0)
[21:26:27.488] Timer tick, asking Buildbucket for the build status
[21:26:27.582] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:27.582] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:4:0) after 1m0s
[21:27:27.670] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:4:0)
[21:27:27.670] Timer tick, asking Buildbucket for the build status
[21:27:27.840] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:27.840] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:5:0) after 1m0s
[21:28:27.846] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:5:0)
[21:28:27.846] Timer tick, asking Buildbucket for the build status
[21:28:28.004] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:28.004] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:6:0) after 1m0s
[21:29:28.066] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:6:0)
[21:29:28.066] Timer tick, asking Buildbucket for the build status
[21:29:28.209] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:28.209] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:7:0) after 1m0s
[21:30:28.885] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:7:0)
[21:30:28.885] Timer tick, asking Buildbucket for the build status
[21:30:29.157] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:29.157] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:8:0) after 1m0s
[21:31:29.337] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:8:0)
[21:31:29.337] Timer tick, asking Buildbucket for the build status
[21:31:29.480] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:29.480] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:9:0) after 1m0s
[21:32:29.539] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:9:0)
[21:32:29.539] Timer tick, asking Buildbucket for the build status
[21:32:29.682] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:29.682] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:10:0) after 1m0s
[21:33:29.964] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:10:0)
[21:33:29.964] Timer tick, asking Buildbucket for the build status
[21:33:30.090] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:30.090] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:11:0) after 1m0s
[21:34:30.211] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:11:0)
[21:34:30.211] Timer tick, asking Buildbucket for the build status
[21:34:30.275] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:30.275] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:12:0) after 1m0s
[21:35:30.381] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:12:0)
[21:35:30.381] Timer tick, asking Buildbucket for the build status
[21:35:31.491] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:31.491] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:13:0) after 1m0s
[21:36:31.549] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:13:0)
[21:36:31.549] Timer tick, asking Buildbucket for the build status
[21:36:31.632] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:31.632] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:14:0) after 1m0s
[21:37:31.675] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:14:0)
[21:37:31.675] Timer tick, asking Buildbucket for the build status
[21:37:37.747] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:37.747] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:15:0) after 1m0s
[21:38:37.927] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:15:0)
[21:38:37.927] Timer tick, asking Buildbucket for the build status
[21:38:38.090] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:38.090] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:16:0) after 1m0s
[21:39:38.167] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:16:0)
[21:39:38.167] Timer tick, asking Buildbucket for the build status
[21:39:38.265] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:38.265] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:17:0) after 1m0s
[21:40:39.005] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:17:0)
[21:40:39.005] Timer tick, asking Buildbucket for the build status
[21:40:39.192] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:39.192] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:18:0) after 1m0s
[21:41:39.731] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:18:0)
[21:41:39.731] Timer tick, asking Buildbucket for the build status
[21:41:39.804] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:39.804] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:19:0) after 1m0s
[21:42:39.909] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:19:0)
[21:42:39.909] Timer tick, asking Buildbucket for the build status
[21:42:39.985] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:39.985] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:20:0) after 1m0s
[21:43:40.010] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:20:0)
[21:43:40.010] Timer tick, asking Buildbucket for the build status
[21:43:40.223] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:40.223] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:21:0) after 1m0s
[21:44:40.227] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:21:0)
[21:44:40.227] Timer tick, asking Buildbucket for the build status
[21:44:40.282] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:40.282] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:22:0) after 1m0s
[21:45:40.554] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:22:0)
[21:45:40.554] Timer tick, asking Buildbucket for the build status
[21:45:41.403] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:41.403] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:23:0) after 1m0s
[21:46:41.537] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:23:0)
[21:46:41.537] Timer tick, asking Buildbucket for the build status
[21:46:41.642] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:41.642] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:24:0) after 1m0s
[21:47:41.790] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:24:0)
[21:47:41.790] Timer tick, asking Buildbucket for the build status
[21:47:42.020] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:42.020] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:25:0) after 1m0s
[21:48:42.049] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:25:0)
[21:48:42.049] Timer tick, asking Buildbucket for the build status
[21:48:42.220] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:42.220] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:26:0) after 1m0s
[21:49:42.276] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:26:0)
[21:49:42.276] Timer tick, asking Buildbucket for the build status
[21:49:42.347] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:42.347] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:27:0) after 1m0s
[21:50:42.390] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:27:0)
[21:50:42.390] Timer tick, asking Buildbucket for the build status
[21:50:42.932] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:42.932] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:28:0) after 1m0s
[21:51:43.015] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:28:0)
[21:51:43.015] Timer tick, asking Buildbucket for the build status
[21:51:43.347] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:43.347] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:29:0) after 1m0s
[21:52:43.389] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:29:0)
[21:52:43.389] Timer tick, asking Buildbucket for the build status
[21:52:43.526] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:43.526] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:30:0) after 1m0s
[21:53:43.634] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:30:0)
[21:53:43.634] Timer tick, asking Buildbucket for the build status
[21:53:44.583] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:44.583] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:31:0) after 1m0s
[21:54:44.604] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:31:0)
[21:54:44.604] Timer tick, asking Buildbucket for the build status
[21:54:45.352] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:45.352] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:32:0) after 1m0s
[21:55:45.411] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:32:0)
[21:55:45.411] Timer tick, asking Buildbucket for the build status
[21:55:45.568] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:45.568] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:33:0) after 1m0s
[21:56:45.815] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:33:0)
[21:56:45.815] Timer tick, asking Buildbucket for the build status
[21:56:47.681] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:47.681] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:34:0) after 1m0s
[21:57:47.716] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:34:0)
[21:57:47.716] Timer tick, asking Buildbucket for the build status
[21:57:47.821] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:47.821] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:35:0) after 1m0s
[21:58:47.826] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:35:0)
[21:58:47.826] Timer tick, asking Buildbucket for the build status
[21:58:47.888] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:47.888] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:36:0) after 1m0s
[21:59:47.919] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:36:0)
[21:59:47.919] Timer tick, asking Buildbucket for the build status
[21:59:48.021] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:48.021] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:37:0) after 1m0s
[22:00:48.219] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:37:0)
[22:00:48.219] Timer tick, asking Buildbucket for the build status
[22:00:48.394] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:48.394] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:38:0) after 1m0s
[22:01:48.765] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:38:0)
[22:01:48.765] Timer tick, asking Buildbucket for the build status
[22:01:50.092] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:50.092] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:39:0) after 1m0s
[22:02:50.521] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:39:0)
[22:02:50.521] Timer tick, asking Buildbucket for the build status
[22:02:50.650] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:50.650] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:40:0) after 1m0s
[22:03:50.742] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:40:0)
[22:03:50.742] Timer tick, asking Buildbucket for the build status
[22:03:53.467] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:53.467] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:41:0) after 1m0s
[22:04:53.470] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:41:0)
[22:04:53.470] Timer tick, asking Buildbucket for the build status
[22:04:53.577] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:53.577] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:42:0) after 1m0s
[22:05:53.650] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:42:0)
[22:05:53.650] Timer tick, asking Buildbucket for the build status
[22:05:54.105] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:54.105] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:43:0) after 1m0s
[22:06:54.644] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:43:0)
[22:06:54.644] Timer tick, asking Buildbucket for the build status
[22:06:54.929] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:54.929] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:44:0) after 1m0s
[22:07:55.040] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:44:0)
[22:07:55.040] Timer tick, asking Buildbucket for the build status
[22:07:55.319] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:55.319] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:45:0) after 1m0s
[22:08:55.366] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:45:0)
[22:08:55.366] Timer tick, asking Buildbucket for the build status
[22:08:55.472] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:55.472] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:46:0) after 1m0s
[22:09:55.752] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:46:0)
[22:09:55.752] Timer tick, asking Buildbucket for the build status
[22:09:56.002] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:56.002] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:47:0) after 1m0s
[22:10:56.163] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:47:0)
[22:10:56.163] Timer tick, asking Buildbucket for the build status
[22:10:56.361] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:56.361] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:48:0) after 1m0s
[22:11:56.931] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:48:0)
[22:11:56.931] Timer tick, asking Buildbucket for the build status
[22:11:57.139] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:57.142] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:49:0) after 1m0s
[22:12:57.307] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:49:0)
[22:12:57.307] Timer tick, asking Buildbucket for the build status
[22:12:57.447] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:57.447] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:50:0) after 1m0s
[22:13:57.666] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:50:0)
[22:13:57.666] Timer tick, asking Buildbucket for the build status
[22:13:57.752] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:57.752] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:51:0) after 1m0s
[22:14:58.059] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:51:0)
[22:14:58.059] Timer tick, asking Buildbucket for the build status
[22:15:00.190] Build 8855739272149658272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:00.190] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021169334250630848:52:0) after 1m0s
[22:15:55.827] Received PubSub notification, asking Buildbucket for the build status
[22:15:55.970] Build 8855739272149658272: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:15:55.970] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612908953999261",
"created_by": "project:chromium",
"created_ts": "1612905925568399",
"id": "8855739272149658272",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"40272a2897cdeb297be164a4df00e40107837995\"}}",
"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\": \"40272a2897cdeb297be164a4df00e40107837995\", \"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-68-2v8w\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180432, \"got_angle_revision\": \"b7d441e662a1839b941b1ddd6ca04f68aecfbabc\", \"got_dawn_revision\": \"2831f0584028114a8896059ce00e7bddaf3bba1f\", \"got_nacl_revision\": \"8db20f20316f13d8886a2732099f5bb880568663\", \"got_revision\": \"40272a2897cdeb297be164a4df00e40107837995\", \"got_revision_cp\": \"refs/heads/master@{#852351}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"aba242b50921817e2575589bc95206e2c3f4bd33\", \"got_v8_revision\": \"c369eee9f5827733bc6784843744c4ac8a9bea0b\", \"got_v8_revision_cp\": \"refs/heads/9.0.147@{#1}\", \"got_webrtc_revision\": \"54ea85c2cd3a2cb1b8f440a71aa9676a9b88135c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33190}\", \"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\": \"40272a2897cdeb297be164a4df00e40107837995\", \"swarm_hashes_refs/heads/master(at){#852351}_without_patch\": {\"absl_hardening_tests\": \"419fb7248b92dedcdd2a7407d54d6f51171183a1\", \"accessibility_unittests\": \"86008ac51f68381446ce46920918164e548e9c6e\", \"angle_unittests\": \"da36b3dc1c08a36cb959ee73e8343c27476a8e2e\", \"app_shell_unittests\": \"5aae5e19436a05d3459213fc00a980df6940737d\", \"aura_unittests\": \"70b27be66e3c203b5573872219354672bb9ebc01\", \"base_unittests\": \"5a86e81515db2b1ff650f3a97adce7c8aa7ab1e9\", \"base_util_unittests\": \"d82541e65848a6c37c0fb49d637c27ca3e3df3b7\", \"blink_common_unittests\": \"1717973437bac61ad74a1c0f960966c2dbd6841b\", \"blink_fuzzer_unittests\": \"28964557afb13be084906323c6ac53b27bfa0661\", \"blink_heap_unittests\": \"166d4190dd3ad183f8048ad20eef1bf90052a5c9\", \"blink_platform_unittests\": \"242271eca6941b6fb65147fea49303c7cba337d1\", \"blink_python_tests\": \"814042a93898eb94625b093ab73b7af40f0d59dc\", \"blink_unittests\": \"b259cf9e477a925ef1080f1a343cff4973bb4b42\", \"blink_web_tests\": \"f21d9ccc76de8fbb604090738f9e7cf0e1459957\", \"boringssl_crypto_tests\": \"0a59fb03094075f5d906b0983435121c025f51e4\", \"boringssl_ssl_tests\": \"0e74b981a0fe0542faca4f7fa4a4eddb700cb7e9\", \"browser_tests\": \"9d956a5ac29cd7b92feb2230c6e7dea8dcb618b1\", \"capture_unittests\": \"2488853749b2c1dd6c5f05b4634cbf77d6714428\", \"cast_unittests\": \"b4fc233a120b8f3df69f234ff16acab08a22951a\", \"cc_unittests\": \"edb9089c55c89d9d5a05fc0bb7be6628595ec26b\", \"chrome_app_unittests\": \"6b1c6d4ad1ec5c6bbf00a6269bdb258ae77717a8\", \"chromedriver_unittests\": \"3648faf47eda549e59068d1621a465957fa1318f\", \"components_browsertests\": \"81cf9934726115e65fe05e43b7dcc112f6c8b784\", \"components_unittests\": \"47228c7fb0dbc4726ed8ab96c603b28055d5d481\", \"compositor_unittests\": \"102179eea36ebd3cb9a9702e9b104a3402f48f8d\", \"content_browsertests\": \"a58b69d39a5480d4723c4169e439037b0e265106\", \"content_shell_crash_test\": \"f89961299e5d43adeed4017d4855357641b273a4\", \"content_unittests\": \"94aaf0621e473adbb4eec69d19ebb76d15fafd35\", \"crashpad_tests\": \"66b36876fd755c2ed05a9a50318de539e6eba9de\", \"cronet_tests\": \"01bba5585177690f9e5fefab5abbbd85275e3406\", \"cronet_unittests\": \"f4f39766bc7944b91687053e7e2b0c43c976ed26\", \"crypto_unittests\": \"21fad43adc38719a976accc9d23d80f66a9a8fcc\", \"dbus_unittests\": \"7a77f79f52283d65916b9143246b6d4d1281d77e\", \"device_unittests\": \"22101ab80b3e3b5ed11c72f56cfe21c9c7bc7930\", \"display_unittests\": \"d767ccc60a92d2dee5389186c4a2a97a225f86ad\", \"events_unittests\": \"556040fc20d7cfaeb0f582a3ff559c0131200114\", \"extensions_browsertests\": \"2c26a41359741b2fb08e36cde5450fb3f58d4b25\", \"extensions_unittests\": \"671b681059c5e71d3fd2e3c96f4f043bd60acfb3\", \"filesystem_service_unittests\": \"e6cbf97dffa867d7384eb255d2639b8dea4600a0\", \"flatbuffers_unittests\": \"58976a0c9ae5674987a52610b5f40e2c6cc5fd08\", \"gcm_unit_tests\": \"f0c254d3855f050f6d60f987e3564afdd0a79428\", \"gfx_unittests\": \"64cd29157e39cb9782cb52c055deeed8a728c6eb\", \"gin_unittests\": \"c2c6871f268c0ff14e12ed91c3789b8cca8f3995\", \"google_apis_unittests\": \"93b8f2f60848271fc5a34e81e391a5c4a8562f02\", \"gpu_unittests\": \"889e1370f54142f7de335692a0c5f193781e5e14\", \"grit_python_unittests\": \"09d11eaebf65aefde13fcafc2a12fe42d6476e6b\", \"gwp_asan_unittests\": \"3c5c47a9e99883464d51429e91a7af0ab4035727\", \"headless_browsertests\": \"e9b96fb7b1ddf234e094c08f90a7f7edbc9cf858\", \"headless_unittests\": \"2c4adb69157ac130f0c2b2f94d70ae847e74ff6b\", \"interactive_ui_tests\": \"2ce1970e3b7a331faef7bfc8b1e033b96e65528a\", \"ipc_tests\": \"3baedf8df641b1f69c882c5028dabbdf3a9ece4e\", \"jingle_unittests\": \"5a0e76d7191680eb3e771d54b7f122005cf31824\", \"latency_unittests\": \"e1d36f0392582d633c9cc103194814ea4824cab9\", \"libjingle_xmpp_unittests\": \"99102baae4d4ef96864db7442fe99c27f45c8818\", \"liburlpattern_unittests\": \"75e9101d0f66e522f3ad25d31a05ab500beb1e88\", \"media_blink_unittests\": \"5946aecbd7b45446a8391adb9af9fc20d478079f\", \"media_unittests\": \"602f2db0f29281c53419b27c11cd49b2e6c088ef\", \"message_center_unittests\": \"413aa0192c6edd2fa3aa800c64aa0060469ab312\", \"metrics_python_tests\": \"48ae93e9b63836d7e911142a0cd42aed26730313\", \"midi_unittests\": \"5d1ff07819238f1f50ef06fad24f01362baa41fa\", \"mojo_core_unittests\": \"0c889a50ee9310388473eab031961d3cf9587482\", \"mojo_unittests\": \"83a109dcac7dec362b176365a06301757b8966b0\", \"nacl_helper_nonsfi_unittests\": \"2a3c92573d5095ce2ea782d3b5e402ad3166dda3\", \"nacl_loader_unittests\": \"e757b0fedb0d621335104a078a9ef35eec0bba6f\", \"native_theme_unittests\": \"9f1e56901f90d31f7a34c1d5e617b4ce67a7996e\", \"net_unittests\": \"0327e6e175307fcc8f5576986f821377e1a8131a\", \"openscreen_unittests\": \"8b65ce3b6437da1814abc441281357981d7f2e17\", \"pdf_unittests\": \"40bf733bea284e6bba332dca04d7f0b6ce625cd4\", \"perfetto_unittests\": \"f3c94d5d020eaf103d87aa988dcfa5f4e2358dad\", \"ppapi_unittests\": \"778be4c1cf1796ff8a56484e66fff762e70ac6f2\", \"printing_unittests\": \"daa2d9dee564cb2933f8b06ac5c37af903fe800a\", \"remoting_unittests\": \"0e230c4565355b270b39704ca105018b663b8907\", \"sandbox_linux_unittests\": \"9b972873193f4a1e7aa223caaa98723d28cf19e2\", \"service_manager_unittests\": \"5b54ecc5e1e830b057def205cc29ead5017a1c46\", \"services_unittests\": \"3364aea1492068ba660e0cf1fe38ab95945446cb\", \"shell_dialogs_unittests\": \"3277f179b03ed02f08ff4959db8a7e8405bbe7fb\", \"skia_unittests\": \"18331a7e0dd48a46eae831bfb69cf72ad9f06184\", \"snapshot_unittests\": \"04c2cdc58e8f26ff38f364a64fef6aaddc41baf2\", \"sql_unittests\": \"b2b96227fc04cdfd07cc17dd8abcebce69cc6b48\", \"storage_unittests\": \"a0f71da5e229897583635710a2df3eef649fdad5\", \"sync_integration_tests\": \"b10f7f0334d09135c789f8c3641b06bf3e6cb892\", \"telemetry_gpu_unittests\": \"03cf3b845d2ffe34bb7e3a64ac027f7835041248\", \"telemetry_perf_unittests\": \"fa3586dd710a917dac49e59c303df3ed22c50f2f\", \"telemetry_unittests\": \"0f23cfcc8a7b40aaca80d7824d3c9ab5f7bd7311\", \"traffic_annotation_auditor_unittests\": \"1f9e0dd533c9cbaba952897eb000d022a4ba15b7\", \"ui_base_unittests\": \"021772c3d7d8f53f208f839fcc175f2aec742fca\", \"ui_touch_selection_unittests\": \"92619e2b4ffc8f1ca5ff0702da5018d3577db457\", \"unit_tests\": \"6db0c2aa63cf03fd77950b7d790deca5c47124b4\", \"url_unittests\": \"ee14f39dc0952d3a3458089c0410df75e18add50\", \"views_perftests\": \"9ca1a7620785e848509866738872d4b3d1820fbc\", \"views_unittests\": \"6ad04aec36b0e9015490034b5c0b22f83dec6cfe\", \"viz_unittests\": \"19c436e80e36617f436c5780c8be512d9c0bcf42\", \"vr_common_unittests\": \"cdf2a2808f7fb32f7f77d4b120fcd0dd2224dcea\", \"vr_pixeltests\": \"2d3a8e86386191bd21ee845b31d5cb8388ec8c21\", \"webdriver_wpt_tests\": \"cf65acceb0bad4dd59aa0fa57a88e8c819d2c682\", \"weblayer_browsertests\": \"f87912329cea37832f70642bcce6e1a540c2e436\", \"weblayer_unittests\": \"036cd753fbc6ffeec9a4e4502e2b95a6383a86dc\", \"wm_unittests\": \"62e047769afa789ceb73b468063b3f8f6e67600d\", \"wtf_unittests\": \"4b57a6d59b12f43f3add56005e994ea7ce592e32\", \"x11_unittests\": \"302801a72cab7e37c6590b1990abf3897216b6f8\", \"xr_browser_tests\": \"be34a36515f92bb866d27c4da50f7a914e1dd856\", \"zlib_unittests\": \"08231f3eb510bd122363dc4f460f89dd7a982f78\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1d6807bf68beb1f6e53b053acbc5bd9e728357249a14ae6e1a69ace8071ddc84_v2\", \"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_863d9d6073a39cfd51a17e8c0be606c54177e8c90f2c9a7c0e7333e92d562081_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_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-68-2v8w\"], \"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\": [\"5685-1877293\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612905928429267",
"status": "COMPLETED",
"status_changed_ts": "1612908954720416",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180432",
"builder:Linux Builder (dbg)",
"buildset:commit/git/40272a2897cdeb297be164a4df00e40107837995",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/40272a2897cdeb297be164a4df00e40107837995",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021169334250630848",
"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/8855739272149658272/+/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:51a180db4c3cd710",
"user_agent:luci-scheduler"
],
"updated_ts": "1612908954727305",
"url": "https://ci.chromium.org/b/8855739272149658272",
"utcnow_ts": "1612908955956832"
}
}
[22:15:55.970] Invocation finished in 50m31.788739546s with status SUCCEEDED