[09:17:30.712] New invocation is queued and will start shortly
[09:17:31.869] Starting the invocation (attempt 1)
[09:17:31.950] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:17:31.950] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:17:31.950] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9056638543147959792",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"475c6e24bb912ee26fa03b0efef2ce569c5262bc\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9056638543147959792",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/475c6e24bb912ee26fa03b0efef2ce569c5262bc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/475c6e24bb912ee26fa03b0efef2ce569c5262bc",
"gitiles_ref:refs/heads/master"
]
}
[09:17:33.875] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1579079852615022",
"id": "8891208480422460272",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"475c6e24bb912ee26fa03b0efef2ce569c5262bc\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1579079853547938",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/167395",
"builder:Linux Builder (dbg)",
"buildset:commit/git/475c6e24bb912ee26fa03b0efef2ce569c5262bc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/475c6e24bb912ee26fa03b0efef2ce569c5262bc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9056638543147959792",
"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/8891208480422460272/+/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": "1579079853548066",
"url": "https://ci.chromium.org/b/8891208480422460272",
"utcnow_ts": "1579079853862004"
}
}
[09:17:33.875] Task URL: https://ci.chromium.org/b/8891208480422460272
[09:17:33.875] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:2:0) after 1m0s
[09:18:33.938] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:2:0)
[09:18:33.938] Timer tick, asking Buildbucket for the build status
[09:18:34.911] Build 8891208480422460272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:18:34.911] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:3:0) after 1m0s
[09:19:35.201] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:3:0)
[09:19:35.201] Timer tick, asking Buildbucket for the build status
[09:19:35.322] Build 8891208480422460272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:19:35.322] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:4:0) after 1m0s
[09:20:35.397] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:4:0)
[09:20:35.397] Timer tick, asking Buildbucket for the build status
[09:20:35.854] Build 8891208480422460272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:20:35.854] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:5:0) after 1m0s
[09:21:36.035] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:5:0)
[09:21:36.035] Timer tick, asking Buildbucket for the build status
[09:21:36.281] Build 8891208480422460272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:21:36.281] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:6:0) after 1m0s
[09:22:36.365] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:6:0)
[09:22:36.365] Timer tick, asking Buildbucket for the build status
[09:22:37.340] Build 8891208480422460272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:22:37.340] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:7:0) after 1m0s
[09:23:07.165] Received PubSub notification, asking Buildbucket for the build status
[09:23:07.278] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:37.454] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:7:0)
[09:23:37.454] Timer tick, asking Buildbucket for the build status
[09:23:37.834] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:37.834] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:9:0) after 1m0s
[09:24:37.836] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:9:0)
[09:24:37.836] Timer tick, asking Buildbucket for the build status
[09:24:38.246] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:38.246] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:10:0) after 1m0s
[09:25:38.338] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:10:0)
[09:25:38.338] Timer tick, asking Buildbucket for the build status
[09:25:38.516] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:38.516] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:11:0) after 1m0s
[09:26:38.632] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:11:0)
[09:26:38.632] Timer tick, asking Buildbucket for the build status
[09:26:38.882] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:38.882] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:12:0) after 1m0s
[09:27:38.966] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:12:0)
[09:27:38.966] Timer tick, asking Buildbucket for the build status
[09:27:39.428] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:39.428] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:13:0) after 1m0s
[09:28:39.451] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:13:0)
[09:28:39.451] Timer tick, asking Buildbucket for the build status
[09:28:40.605] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:40.605] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:14:0) after 1m0s
[09:29:40.651] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:14:0)
[09:29:40.651] Timer tick, asking Buildbucket for the build status
[09:29:41.656] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:41.656] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:15:0) after 1m0s
[09:30:41.702] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:15:0)
[09:30:41.702] Timer tick, asking Buildbucket for the build status
[09:30:41.844] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:41.844] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:16:0) after 1m0s
[09:31:42.002] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:16:0)
[09:31:42.002] Timer tick, asking Buildbucket for the build status
[09:31:42.355] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:42.355] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:17:0) after 1m0s
[09:32:42.470] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:17:0)
[09:32:42.470] Timer tick, asking Buildbucket for the build status
[09:32:42.654] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:42.654] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:18:0) after 1m0s
[09:33:42.784] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:18:0)
[09:33:42.784] Timer tick, asking Buildbucket for the build status
[09:33:43.731] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:43.731] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:19:0) after 1m0s
[09:34:43.824] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:19:0)
[09:34:43.824] Timer tick, asking Buildbucket for the build status
[09:34:44.379] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:44.379] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:20:0) after 1m0s
[09:35:44.472] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:20:0)
[09:35:44.472] Timer tick, asking Buildbucket for the build status
[09:35:45.083] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:45.083] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:21:0) after 1m0s
[09:36:45.231] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:21:0)
[09:36:45.231] Timer tick, asking Buildbucket for the build status
[09:36:45.393] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:45.393] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:22:0) after 1m0s
[09:37:45.522] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:22:0)
[09:37:45.522] Timer tick, asking Buildbucket for the build status
[09:37:45.729] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:45.729] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:23:0) after 1m0s
[09:38:45.723] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:23:0)
[09:38:45.723] Timer tick, asking Buildbucket for the build status
[09:38:46.302] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:46.302] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:24:0) after 1m0s
[09:39:46.350] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:24:0)
[09:39:46.350] Timer tick, asking Buildbucket for the build status
[09:39:46.970] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:46.970] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:25:0) after 1m0s
[09:40:46.990] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:25:0)
[09:40:46.990] Timer tick, asking Buildbucket for the build status
[09:40:47.182] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:47.182] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:26:0) after 1m0s
[09:41:47.281] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:26:0)
[09:41:47.281] Timer tick, asking Buildbucket for the build status
[09:41:47.747] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:47.747] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:27:0) after 1m0s
[09:42:47.875] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:27:0)
[09:42:47.875] Timer tick, asking Buildbucket for the build status
[09:42:48.300] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:48.300] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:28:0) after 1m0s
[09:43:48.389] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:28:0)
[09:43:48.389] Timer tick, asking Buildbucket for the build status
[09:43:48.926] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:48.926] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:29:0) after 1m0s
[09:44:49.069] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:29:0)
[09:44:49.069] Timer tick, asking Buildbucket for the build status
[09:44:49.311] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:49.311] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:30:0) after 1m0s
[09:45:49.396] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:30:0)
[09:45:49.396] Timer tick, asking Buildbucket for the build status
[09:45:50.086] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:50.086] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:31:0) after 1m0s
[09:46:50.275] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:31:0)
[09:46:50.275] Timer tick, asking Buildbucket for the build status
[09:46:50.783] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:50.783] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:32:0) after 1m0s
[09:47:50.965] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:32:0)
[09:47:50.965] Timer tick, asking Buildbucket for the build status
[09:47:51.342] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:51.342] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:33:0) after 1m0s
[09:48:51.364] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:33:0)
[09:48:51.364] Timer tick, asking Buildbucket for the build status
[09:48:51.581] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:51.581] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:34:0) after 1m0s
[09:49:51.656] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:34:0)
[09:49:51.656] Timer tick, asking Buildbucket for the build status
[09:49:52.495] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:52.495] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:35:0) after 1m0s
[09:50:52.545] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:35:0)
[09:50:52.545] Timer tick, asking Buildbucket for the build status
[09:50:54.457] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:54.457] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:36:0) after 1m0s
[09:51:54.583] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:36:0)
[09:51:54.583] Timer tick, asking Buildbucket for the build status
[09:51:54.872] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:54.872] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:37:0) after 1m0s
[09:52:54.960] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:37:0)
[09:52:54.960] Timer tick, asking Buildbucket for the build status
[09:52:55.157] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:55.157] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:38:0) after 1m0s
[09:53:55.177] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:38:0)
[09:53:55.177] Timer tick, asking Buildbucket for the build status
[09:53:56.089] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:56.089] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:39:0) after 1m0s
[09:54:56.275] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:39:0)
[09:54:56.275] Timer tick, asking Buildbucket for the build status
[09:54:56.555] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:56.555] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:40:0) after 1m0s
[09:55:56.622] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:40:0)
[09:55:56.622] Timer tick, asking Buildbucket for the build status
[09:55:56.966] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:56.966] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:41:0) after 1m0s
[09:56:57.173] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:41:0)
[09:56:57.173] Timer tick, asking Buildbucket for the build status
[09:56:57.327] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:57.327] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:42:0) after 1m0s
[09:57:57.539] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:42:0)
[09:57:57.539] Timer tick, asking Buildbucket for the build status
[09:57:57.655] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:57.655] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:43:0) after 1m0s
[09:58:57.912] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:43:0)
[09:58:57.912] Timer tick, asking Buildbucket for the build status
[09:58:58.056] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:58.056] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:44:0) after 1m0s
[09:59:58.372] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:44:0)
[09:59:58.372] Timer tick, asking Buildbucket for the build status
[09:59:58.619] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:58.619] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:45:0) after 1m0s
[10:00:58.821] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:45:0)
[10:00:58.822] Timer tick, asking Buildbucket for the build status
[10:00:59.453] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:59.453] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:46:0) after 1m0s
[10:01:59.503] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:46:0)
[10:01:59.503] Timer tick, asking Buildbucket for the build status
[10:01:59.777] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:59.777] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:47:0) after 1m0s
[10:02:59.943] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:47:0)
[10:02:59.943] Timer tick, asking Buildbucket for the build status
[10:03:00.431] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:00.431] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:48:0) after 1m0s
[10:04:00.503] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:48:0)
[10:04:00.503] Timer tick, asking Buildbucket for the build status
[10:04:00.714] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:00.714] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:49:0) after 1m0s
[10:05:00.783] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:49:0)
[10:05:00.783] Timer tick, asking Buildbucket for the build status
[10:05:01.336] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:01.336] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:50:0) after 1m0s
[10:06:01.481] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:50:0)
[10:06:01.481] Timer tick, asking Buildbucket for the build status
[10:06:01.902] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:01.902] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:51:0) after 1m0s
[10:07:01.913] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:51:0)
[10:07:01.913] Timer tick, asking Buildbucket for the build status
[10:07:02.537] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:02.537] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:52:0) after 1m0s
[10:08:02.589] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:52:0)
[10:08:02.589] Timer tick, asking Buildbucket for the build status
[10:08:03.864] Build 8891208480422460272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:03.864] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9056638543147959792:53:0) after 1m0s
[10:08:52.098] Received PubSub notification, asking Buildbucket for the build status
[10:08:52.242] Build 8891208480422460272: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:08:52.242] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1579082931483132",
"created_by": "project:chromium",
"created_ts": "1579079852615022",
"id": "8891208480422460272",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"475c6e24bb912ee26fa03b0efef2ce569c5262bc\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"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-48-uh1s\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 167395, \"got_angle_revision\": \"86f730971751eb18460f2e13e3be1b97a68abacc\", \"got_dawn_revision\": \"7f078e7ebe3f1046b57f4fb3cc21805b4348dbf9\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"475c6e24bb912ee26fa03b0efef2ce569c5262bc\", \"got_revision_cp\": \"refs/heads/master@{#731892}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"146e16f68fdc4678600031ab3256cccf7b32d5e2\", \"got_v8_revision\": \"fab248d2ccddc45eae7806b23a1992b304e1abb2\", \"got_v8_revision_cp\": \"refs/heads/8.1.185@{#1}\", \"got_webrtc_revision\": \"b42aeaa3fb21d78e59c47d2a9916acb380494496\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30212}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"475c6e24bb912ee26fa03b0efef2ce569c5262bc\", \"swarm_hashes_refs/heads/master(at){#731892}_without_patch\": {\"accessibility_unittests\": \"e201309a321253b5de37a2d88b7d36133d0a99b5\", \"angle_unittests\": \"4677daaf12ee4f1266ef6aadf7264b8a00c9e6da\", \"app_shell_unittests\": \"f89a36057311d8f7be355323f9b97f79a865c85a\", \"aura_unittests\": \"8ac2fb630b3a3d79e41e14a04d73a1b9ff0e798c\", \"base_unittests\": \"3f49085f2eea7fd6a512c7f7aead39a181df1a5b\", \"base_util_unittests\": \"ea81722d0875148c8445957335ce0054448a2c61\", \"blink_common_unittests\": \"faf255b0dc57c41aec614f6d014639270d0a3023\", \"blink_fuzzer_unittests\": \"ea221d1638266cd5b761d1110c1394bcf2dee333\", \"blink_heap_unittests\": \"a969f715b4cd3f6bbd33d661ae8229ea8c21c2bd\", \"blink_platform_unittests\": \"7e866d044b776ca66d6b212616e6c2c71bf79bd0\", \"blink_python_tests\": \"94843e9513012f9caeb74a409b34aaf1c0d63c7f\", \"blink_unittests\": \"11123044e7546afd51e1312d924a7393430b9372\", \"blink_web_tests\": \"a981f47519686edbc148dfece2ba43615a308a7c\", \"boringssl_crypto_tests\": \"c037cd18bf29691228b148bdfb0e6221ed41a124\", \"boringssl_ssl_tests\": \"68d909fc69d4b3c0977b575297e4f3ff020fc999\", \"browser_tests\": \"9307d713f2e9149f8c7e905c18a3131f87fc41d2\", \"cacheinvalidation_unittests\": \"e49a6759d7f456202925c83e5d20128d9c3c4599\", \"capture_unittests\": \"0ff6c215daff4889d451971ef55cfc9e1f2955f5\", \"cast_unittests\": \"64ac194d181b2d4cec11d83031fd802c9ab0d529\", \"cc_unittests\": \"3acf83fe74917fbdbac56dd680424cc045f1ba10\", \"chrome_app_unittests\": \"d676126348f71c0724bd468c90c7231cc578349c\", \"chromedriver_unittests\": \"bdcf7807bbff68b6b3c6225a3e329a841e02fc56\", \"components_browsertests\": \"495b0539f91f9ba318f274eced304b8b302fdd6e\", \"components_unittests\": \"40d3006288a6d4688dcc0f664802665af1150924\", \"compositor_unittests\": \"f82ddc027316278f2608e73b525bdf4bd3a095ca\", \"content_browsertests\": \"db0093f9aaf25fdb1b08382aadd182865ddcfff8\", \"content_shell_crash_test\": \"19b7306868a9efcd7369db60222e0d2ff9e32084\", \"content_unittests\": \"dccd091f3f97eac8bf89dc0182a60468eb94108b\", \"crashpad_tests\": \"25c703272c663e00e1ab7c7317a69a3d33518d89\", \"cronet_tests\": \"2c3f72c516191abddebffb141a34fef15ce6b478\", \"cronet_unittests\": \"b59430f6b259569a94f7955ceb5c252818ec9acb\", \"crypto_unittests\": \"f50d7e658b9a100c238d43b7986d9b07f7fb5a4d\", \"dbus_unittests\": \"c34bb9cc6ed940e1d3f02c3fff059b56c684061f\", \"device_unittests\": \"9d4121badede3c290d723382576a3964c373de79\", \"devtools_lint_check\": \"96946eeafba952dbd8a682d55f95863685f67791\", \"devtools_type_check\": \"4493a93cf09bb717fc60eada2c715b17298a5c9e\", \"display_unittests\": \"090b46bfdcb9f0043430c94cd12c8d76fe3ec753\", \"events_unittests\": \"6a9e74a4f089879be091a8a742a2af68977a2436\", \"extensions_browsertests\": \"183efeae2936a0d1ed522aa3ca4092f5f37e61db\", \"extensions_unittests\": \"69ddaa11da1501d34a3ba377bad0147ce9c43adf\", \"filesystem_service_unittests\": \"0f8c3f5cb9b5da00a70a79cf3990c69d8dc7cf6e\", \"flatbuffers_unittests\": \"034d1c63a8199a680c9bbf29b5866b1c851e28ee\", \"gcm_unit_tests\": \"5425fdb20cbb321210c5218fd02a68f4c7c3d724\", \"gfx_unittests\": \"34bfc961592ae1a440746a2ba543326baabc9a5f\", \"gin_unittests\": \"e4d525a52740a41fbab4e4f30cbedd31f349d316\", \"google_apis_unittests\": \"7b34ebe988427daf8bc3c3aac76edeeb0a5412be\", \"gpu_unittests\": \"f657b1e6bc50917e8d85fca994369c5f074d56e0\", \"grit_python_unittests\": \"5ba70f2d123ffe8977591ea0b82d6185e7fe166f\", \"gwp_asan_unittests\": \"41ea4cc60f9a0c7454a0653371021680b2646a01\", \"headless_browsertests\": \"dc5b91cc27689a79f49682357c172a63edbb7b7a\", \"headless_unittests\": \"41ac8b538bd7d30c6918c260eb3e64299644d7f6\", \"interactive_ui_tests\": \"b8759b6ed4024efbced27d050918790ae04515dc\", \"ipc_tests\": \"c316c7c4da2792066b96954b9fc0946cc9949d0b\", \"jingle_unittests\": \"555411673f2dda3dc29349c5385f1c14fbd58daa\", \"latency_unittests\": \"2a8e3e1242ec640ed3de0d40b98934f2083bd3d3\", \"libjingle_xmpp_unittests\": \"ca9acf032b1916c4386c961364f4e7bc57693ba8\", \"media_blink_unittests\": \"ba8499ad1362b50d2023b5fcfbd60bc7de542772\", \"media_service_unittests\": \"cd0e83ea8d1ed340aa283ef755bfd60d8524e97d\", \"media_unittests\": \"9e930b9e8414f75da08c21e438140264b8ba068b\", \"message_center_unittests\": \"e706b28c2b7f7d05452d9405cb0cc6d5e3ffb159\", \"metrics_python_tests\": \"18abffe4a8039d7a2f4eb032cdfd7d40d1d06110\", \"midi_unittests\": \"92d583f139e751b799ed8ded18fdcb6c49ffe8ae\", \"mojo_core_unittests\": \"c5f6ffe78761c4af9b3459a16251a9c86f1401dd\", \"mojo_unittests\": \"b2441ab49c6387b1889d75da971ba900fa2c5317\", \"nacl_helper_nonsfi_unittests\": \"e2b7f2b3f35e6f52844b7203b847865e84fec957\", \"nacl_loader_unittests\": \"9cf7d34e5e479751fbc9a00b8dc9e5307787f6e7\", \"native_theme_unittests\": \"f7857255bee8dc79077cd98dabfafcd298b1b143\", \"net_unittests\": \"f1e3449621c6d2563a86b4f4269724b39a73c251\", \"pdf_unittests\": \"27ee2a9f899dab3a17f0e5f48d781a3141c3da9f\", \"perfetto_unittests\": \"51e2a9f8cc037f34932b5b00d9808318be842601\", \"ppapi_unittests\": \"8046445805aa92a579f1c2023e0cdaddcca85c3e\", \"printing_unittests\": \"a2d8b9fcd0fd3c2d872da13d0b5142562db02bb4\", \"remoting_unittests\": \"cab13b89e78e8aa2e639b3772f11554395a59ed3\", \"sandbox_linux_unittests\": \"03e54aa7e028ae77443e6fcff2bf017e9a680cd1\", \"service_manager_unittests\": \"ed8e861a0b75c92fe978ac63cca595ac22365944\", \"services_unittests\": \"9c7662a99cc592bff13491eb77d2a8d558cc641f\", \"shell_dialogs_unittests\": \"cff42ed8a1264bfc30029e529ad6d98b6e3af156\", \"skia_unittests\": \"9da0037833cd3d3cf163ae7f05304467452aa565\", \"snapshot_unittests\": \"9b38dbec7dc79e2815a10a3cd72205561a7c1929\", \"sql_unittests\": \"653458f12f5a10d67dfa36b7654310ca936007d7\", \"storage_unittests\": \"898e97198de9ee02ef100098b801eaa809a909ae\", \"sync_integration_tests\": \"a737defc2306f071f4d157c4e33a110e0692b3b6\", \"telemetry_gpu_unittests\": \"dd79d1a9bd143dfaf9fa65488a661c5ec312ec33\", \"telemetry_perf_unittests\": \"265835050135904b896220574c6a2ed523f454a0\", \"telemetry_unittests\": \"6371a7eadd78fd052b1570370deb8915f18fe27c\", \"traffic_annotation_auditor_unittests\": \"0340d7c634cc55f51e6ca077d5685967c0049477\", \"ui_base_unittests\": \"90b040a67777bd11ae3de0bc11777e695ed0b77a\", \"ui_touch_selection_unittests\": \"7a8319171b5d30ea37a674959f1dc8b0bc44d65c\", \"unit_tests\": \"53493812af6c06b9103238d0d75bdcc69bbdbf9e\", \"url_unittests\": \"aa26a7f60394d29c518eb7a79ad09207243e1923\", \"views_perftests\": \"15ddfc5e2165fac6096cda09285e1a973c17af99\", \"views_unittests\": \"bdab9ac7722891af868a8005658da3ab4e4dac2c\", \"viz_unittests\": \"1994236fb6b4c961327557d3ded92fec72594c5b\", \"vr_common_unittests\": \"45c9672612aa0b4957d0e66833dca1420af9a0f1\", \"vr_pixeltests\": \"ee4d4681592a141ac85d0b59cb9b46552fe7c951\", \"webdriver_wpt_tests\": \"4e578b0b2a1f7511dac0bf8c2faefc48f23cd178\", \"weblayer_browsertests\": \"bb4435e3bf226fdd30c10459f0c6692e5f4b6a67\", \"wm_unittests\": \"7d30e218ed22b6f3b1101749b6004045043d74d5\", \"wtf_unittests\": \"123624500e53004c79e64a95875b44650ebe2bf3\", \"xr_browser_tests\": \"182f0ae290dd56b397cd32971dfa7b1b7b7e96da\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_361cbaa79261c75a92fc63a8f8c6fc117764238b3277286fa51086e6da3301df_v2\", \"builder_36472ddafb4960b563fa0dfd4883d4c097bf9805cea97d60ada20c6be0c80514_v2\", \"builder_5031bc3d586fdedb2b02f62dae64b9ebfd5c405012b7a28b41092bb1d66cfccb_v2\", \"builder_8851890e994e29b56fba2042f90feba99073c8e56d0ea67af5ee13ebe9f87cf6_v2\", \"builder_97ff76ae173a9ce5e244c07639f8a3e6b9cacff7958414e43d82a5f30a20f3d2_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-48-uh1s\"], \"image\": [\"chrome-xenial-19121500-b03549ec744\"], \"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\": [\"4760-d9a0e6d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1579080184079808",
"status": "COMPLETED",
"status_changed_ts": "1579082931816618",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/167395",
"builder:Linux Builder (dbg)",
"buildset:commit/git/475c6e24bb912ee26fa03b0efef2ce569c5262bc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/475c6e24bb912ee26fa03b0efef2ce569c5262bc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9056638543147959792",
"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/8891208480422460272/+/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:49c1508818dfc910",
"user_agent:luci-scheduler"
],
"updated_ts": "1579082931832518",
"url": "https://ci.chromium.org/b/8891208480422460272",
"utcnow_ts": "1579082932231460"
}
}
[10:08:52.242] Invocation finished in 51m21.610590935s with status SUCCEEDED