[21:16:08.581] New invocation is queued and will start shortly
[21:16:09.663] Starting the invocation (attempt 1)
[21:16:09.702] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:16:09.702] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:16:09.703] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9052697661163367664",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d7e0211189498697ccc172476680adec021ded0d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9052697661163367664",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/d7e0211189498697ccc172476680adec021ded0d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d7e0211189498697ccc172476680adec021ded0d",
"gitiles_ref:refs/heads/master"
]
}
[21:16:10.266] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1582838169787438",
"id": "8887267599235195216",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d7e0211189498697ccc172476680adec021ded0d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1582838170152359",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169100",
"builder:Linux Builder (dbg)",
"buildset:commit/git/d7e0211189498697ccc172476680adec021ded0d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d7e0211189498697ccc172476680adec021ded0d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052697661163367664",
"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/8887267599235195216/+/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": "1582838170152464",
"url": "https://ci.chromium.org/b/8887267599235195216",
"utcnow_ts": "1582838170259364"
}
}
[21:16:10.266] Task URL: https://ci.chromium.org/b/8887267599235195216
[21:16:10.266] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:2:0) after 1m0s
[21:17:10.336] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:2:0)
[21:17:10.336] Timer tick, asking Buildbucket for the build status
[21:17:10.585] Build 8887267599235195216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:17:10.585] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:3:0) after 1m0s
[21:18:10.754] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:3:0)
[21:18:10.754] Timer tick, asking Buildbucket for the build status
[21:18:10.868] Build 8887267599235195216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:18:10.868] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:4:0) after 1m0s
[21:19:10.915] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:4:0)
[21:19:10.915] Timer tick, asking Buildbucket for the build status
[21:19:11.061] Build 8887267599235195216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:19:11.061] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:5:0) after 1m0s
[21:20:11.134] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:5:0)
[21:20:11.134] Timer tick, asking Buildbucket for the build status
[21:20:11.367] Build 8887267599235195216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:20:11.367] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:6:0) after 1m0s
[21:21:03.933] Received PubSub notification, asking Buildbucket for the build status
[21:21:04.150] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:11.445] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:6:0)
[21:21:11.445] Timer tick, asking Buildbucket for the build status
[21:21:11.516] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:11.516] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:8:0) after 1m0s
[21:22:11.550] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:8:0)
[21:22:11.550] Timer tick, asking Buildbucket for the build status
[21:22:11.687] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:11.687] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:9:0) after 1m0s
[21:23:11.703] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:9:0)
[21:23:11.703] Timer tick, asking Buildbucket for the build status
[21:23:11.943] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:11.943] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:10:0) after 1m0s
[21:24:12.027] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:10:0)
[21:24:12.027] Timer tick, asking Buildbucket for the build status
[21:24:12.178] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:12.178] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:11:0) after 1m0s
[21:25:12.542] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:11:0)
[21:25:12.542] Timer tick, asking Buildbucket for the build status
[21:25:12.594] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:12.594] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:12:0) after 1m0s
[21:26:12.824] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:12:0)
[21:26:12.824] Timer tick, asking Buildbucket for the build status
[21:26:12.945] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:12.945] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:13:0) after 1m0s
[21:27:13.072] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:13:0)
[21:27:13.072] Timer tick, asking Buildbucket for the build status
[21:27:13.190] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:13.190] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:14:0) after 1m0s
[21:28:13.428] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:14:0)
[21:28:13.428] Timer tick, asking Buildbucket for the build status
[21:28:13.655] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:13.655] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:15:0) after 1m0s
[21:29:13.822] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:15:0)
[21:29:13.822] Timer tick, asking Buildbucket for the build status
[21:29:14.041] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:14.041] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:16:0) after 1m0s
[21:30:14.115] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:16:0)
[21:30:14.115] Timer tick, asking Buildbucket for the build status
[21:30:14.312] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:14.312] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:17:0) after 1m0s
[21:31:14.449] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:17:0)
[21:31:14.449] Timer tick, asking Buildbucket for the build status
[21:31:14.791] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:14.791] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:18:0) after 1m0s
[21:32:14.983] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:18:0)
[21:32:14.983] Timer tick, asking Buildbucket for the build status
[21:32:15.390] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:15.390] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:19:0) after 1m0s
[21:33:15.466] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:19:0)
[21:33:15.466] Timer tick, asking Buildbucket for the build status
[21:33:15.605] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:15.605] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:20:0) after 1m0s
[21:34:15.748] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:20:0)
[21:34:15.748] Timer tick, asking Buildbucket for the build status
[21:34:16.083] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:16.083] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:21:0) after 1m0s
[21:35:16.341] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:21:0)
[21:35:16.341] Timer tick, asking Buildbucket for the build status
[21:35:16.502] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:16.502] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:22:0) after 1m0s
[21:36:16.743] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:22:0)
[21:36:16.743] Timer tick, asking Buildbucket for the build status
[21:36:16.850] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:16.850] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:23:0) after 1m0s
[21:37:17.277] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:23:0)
[21:37:17.277] Timer tick, asking Buildbucket for the build status
[21:37:17.411] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:17.411] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:24:0) after 1m0s
[21:38:17.657] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:24:0)
[21:38:17.658] Timer tick, asking Buildbucket for the build status
[21:38:18.228] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:18.228] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:25:0) after 1m0s
[21:39:18.261] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:25:0)
[21:39:18.261] Timer tick, asking Buildbucket for the build status
[21:39:18.687] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:18.687] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:26:0) after 1m0s
[21:40:18.798] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:26:0)
[21:40:18.798] Timer tick, asking Buildbucket for the build status
[21:40:18.935] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:18.935] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:27:0) after 1m0s
[21:41:19.092] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:27:0)
[21:41:19.092] Timer tick, asking Buildbucket for the build status
[21:41:19.211] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:19.211] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:28:0) after 1m0s
[21:42:19.355] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:28:0)
[21:42:19.356] Timer tick, asking Buildbucket for the build status
[21:42:19.531] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:19.531] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:29:0) after 1m0s
[21:43:19.655] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:29:0)
[21:43:19.655] Timer tick, asking Buildbucket for the build status
[21:43:19.760] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:19.760] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:30:0) after 1m0s
[21:44:19.819] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:30:0)
[21:44:19.819] Timer tick, asking Buildbucket for the build status
[21:44:19.950] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:19.950] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:31:0) after 1m0s
[21:45:20.055] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:31:0)
[21:45:20.055] Timer tick, asking Buildbucket for the build status
[21:45:20.349] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:20.349] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:32:0) after 1m0s
[21:46:20.357] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:32:0)
[21:46:20.357] Timer tick, asking Buildbucket for the build status
[21:46:20.487] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:20.487] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:33:0) after 1m0s
[21:47:20.612] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:33:0)
[21:47:20.612] Timer tick, asking Buildbucket for the build status
[21:47:21.008] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:21.008] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:34:0) after 1m0s
[21:48:21.028] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:34:0)
[21:48:21.028] Timer tick, asking Buildbucket for the build status
[21:48:21.175] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:21.175] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:35:0) after 1m0s
[21:49:21.255] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:35:0)
[21:49:21.255] Timer tick, asking Buildbucket for the build status
[21:49:21.417] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:21.417] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:36:0) after 1m0s
[21:50:21.475] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:36:0)
[21:50:21.475] Timer tick, asking Buildbucket for the build status
[21:50:21.583] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:21.583] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:37:0) after 1m0s
[21:51:21.645] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:37:0)
[21:51:21.645] Timer tick, asking Buildbucket for the build status
[21:51:21.786] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:21.786] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:38:0) after 1m0s
[21:52:21.842] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:38:0)
[21:52:21.842] Timer tick, asking Buildbucket for the build status
[21:52:21.935] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:21.935] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:39:0) after 1m0s
[21:53:21.954] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:39:0)
[21:53:21.954] Timer tick, asking Buildbucket for the build status
[21:53:22.168] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:22.168] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:40:0) after 1m0s
[21:54:22.259] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:40:0)
[21:54:22.260] Timer tick, asking Buildbucket for the build status
[21:54:22.683] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:22.683] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:41:0) after 1m0s
[21:55:22.708] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:41:0)
[21:55:22.708] Timer tick, asking Buildbucket for the build status
[21:55:22.942] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:22.942] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:42:0) after 1m0s
[21:56:23.047] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:42:0)
[21:56:23.047] Timer tick, asking Buildbucket for the build status
[21:56:23.308] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:23.308] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:43:0) after 1m0s
[21:57:23.341] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:43:0)
[21:57:23.341] Timer tick, asking Buildbucket for the build status
[21:57:23.601] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:23.601] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:44:0) after 1m0s
[21:58:23.691] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:44:0)
[21:58:23.691] Timer tick, asking Buildbucket for the build status
[21:58:23.835] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:23.835] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:45:0) after 1m0s
[21:59:23.868] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:45:0)
[21:59:23.868] Timer tick, asking Buildbucket for the build status
[21:59:23.985] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:23.985] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:46:0) after 1m0s
[22:00:24.116] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:46:0)
[22:00:24.116] Timer tick, asking Buildbucket for the build status
[22:00:24.347] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:24.347] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:47:0) after 1m0s
[22:01:24.467] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:47:0)
[22:01:24.467] Timer tick, asking Buildbucket for the build status
[22:01:24.606] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:24.606] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:48:0) after 1m0s
[22:02:24.843] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:48:0)
[22:02:24.843] Timer tick, asking Buildbucket for the build status
[22:02:24.960] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:24.960] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:49:0) after 1m0s
[22:03:25.136] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:49:0)
[22:03:25.136] Timer tick, asking Buildbucket for the build status
[22:03:25.263] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:25.263] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:50:0) after 1m0s
[22:04:25.556] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:50:0)
[22:04:25.556] Timer tick, asking Buildbucket for the build status
[22:04:25.751] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:25.751] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:51:0) after 1m0s
[22:05:25.754] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:51:0)
[22:05:25.754] Timer tick, asking Buildbucket for the build status
[22:05:25.953] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:25.953] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:52:0) after 1m0s
[22:06:26.000] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:52:0)
[22:06:26.001] Timer tick, asking Buildbucket for the build status
[22:06:26.192] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:26.192] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:53:0) after 1m0s
[22:07:26.356] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:53:0)
[22:07:26.356] Timer tick, asking Buildbucket for the build status
[22:07:26.479] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:26.479] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:54:0) after 1m0s
[22:08:26.748] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:54:0)
[22:08:26.748] Timer tick, asking Buildbucket for the build status
[22:08:26.882] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:26.882] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:55:0) after 1m0s
[22:09:26.917] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:55:0)
[22:09:26.917] Timer tick, asking Buildbucket for the build status
[22:09:27.095] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:27.095] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:56:0) after 1m0s
[22:10:27.200] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:56:0)
[22:10:27.200] Timer tick, asking Buildbucket for the build status
[22:10:27.449] Build 8887267599235195216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:27.449] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052697661163367664:57:0) after 1m0s
[22:11:15.666] Received PubSub notification, asking Buildbucket for the build status
[22:11:15.903] Build 8887267599235195216: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:11:15.903] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1582841474593885",
"created_by": "project:chromium",
"created_ts": "1582838169787438",
"id": "8887267599235195216",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d7e0211189498697ccc172476680adec021ded0d\"}}",
"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\"}, \"$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-23-3f0g\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 169100, \"got_angle_revision\": \"4d2040a6f9737e27e65e17343abb337ac292777d\", \"got_dawn_revision\": \"0363c3e46d35b4b9eebb48c0720ddcaded2dce25\", \"got_nacl_revision\": \"cd2eb2e2d632e9815415268970e793076a65cdcf\", \"got_revision\": \"d7e0211189498697ccc172476680adec021ded0d\", \"got_revision_cp\": \"refs/heads/master@{#745190}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"ad3e42a439e2963654d47288cdf407134df4b442\", \"got_v8_revision\": \"bfa4dadb209f32c2690fd1fedcaa2d10b0315e57\", \"got_v8_revision_cp\": \"refs/heads/8.2.205@{#1}\", \"got_webrtc_revision\": \"c93595b4b9165f2e03960c80eac8534cbb7e29da\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30627}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d7e0211189498697ccc172476680adec021ded0d\", \"swarm_hashes_refs/heads/master(at){#745190}_without_patch\": {\"accessibility_unittests\": \"00284b502c1bcdcc1d91db1f72bd1fad4aaec3a8\", \"angle_unittests\": \"e5be86566ae049cb33be17f18f9e08c25f08358d\", \"app_shell_unittests\": \"6d470626fe7bb67e9b8d34da137bb744b8961fcd\", \"aura_unittests\": \"ae95e00a268701bb05ecac7233d30bbf0b1c5a29\", \"base_unittests\": \"765b1c8a53f4c5c4ae17184a237eb776890c9cb3\", \"base_util_unittests\": \"c6634e3a990034acab5c97e4161a5f35f8442312\", \"blink_common_unittests\": \"b600565dfd5a42abbb5f09eb21b4179e402339bc\", \"blink_fuzzer_unittests\": \"54741e6f370e5bedab63e0cdb9b4e0b6eb275a3d\", \"blink_heap_unittests\": \"2cc23893db29ed58db69c6e80779ab0687ca6412\", \"blink_platform_unittests\": \"c82e85bda4de2c7d58e1172a94d408bce6d879e6\", \"blink_python_tests\": \"c044fd98a1718373765dc28a5e2fa3203a46d078\", \"blink_unittests\": \"64382693a9c31bb289bd50ddb332cb3cb004a86f\", \"blink_web_tests\": \"815a49e5769045493acf31ac82207db6a1ad82ba\", \"boringssl_crypto_tests\": \"9c0e8733e5e91c469854a5817f63e2196e82e7e4\", \"boringssl_ssl_tests\": \"7083e76c15d55421ca7870fc20d425d42ecafcaa\", \"browser_tests\": \"952992eb874c2b4213df9b0d515c827835099263\", \"cacheinvalidation_unittests\": \"1056de2f7b1de093be19a7e291aa386406de6c10\", \"capture_unittests\": \"c7988eaa8f876cc2e81afa57afab1b8337e500ec\", \"cast_unittests\": \"6ebe8e64f2ce3bbd166fdb5d91a2b94f6b248f93\", \"cc_unittests\": \"fce2404e7a6bd3b144628d33753364e8e7237530\", \"chrome_app_unittests\": \"a64901a943613b45de69fe2fe50f01c8c272ec43\", \"chromedriver_unittests\": \"e4ec6f9daebea04a85bdac34843176a974d7e57b\", \"components_browsertests\": \"8b4a529fc00df1da44c8b5ac2726cc3d2201c817\", \"components_unittests\": \"fb0dac0f73953f43d72bdb1e16ea8fca6135a5e0\", \"compositor_unittests\": \"5f483b0e11804401a8c3ffe258d6de3dc32c97b0\", \"content_browsertests\": \"59443258c6a0d652eb42dbdecf64f59687a3d442\", \"content_shell_crash_test\": \"e0556abc614deaba04082b6179440b9d6da19c57\", \"content_unittests\": \"a7ee044520983839e43b31e596c0dc42d89b5bbd\", \"crashpad_tests\": \"24a76e0df6327376f14fac957971012d7051ceb9\", \"cronet_tests\": \"a06b6b171ec57e28a415d7045089cfa4499e59e3\", \"cronet_unittests\": \"d40270437492d0f506c1bc06326a55481f781f93\", \"crypto_unittests\": \"33232b210534fd56aa153144ae19290c224c11d5\", \"dbus_unittests\": \"2164ab5b04a90a96adbdfe6b82a5d149bb1c1954\", \"device_unittests\": \"593083e690a269f7c0fb22725b9afda6a58facf9\", \"display_unittests\": \"d92c2c4ad9250e53d1d5cb326b11efb9322700cb\", \"events_unittests\": \"a4f3dcf9e21aac31e1a320e3f8edf05dfd81830c\", \"extensions_browsertests\": \"b4671d2fe61ddc893ee03f68b9fbd9b05c4928e6\", \"extensions_unittests\": \"346eb6d7f81c6bf0b02fbadd706526a0f963a7b4\", \"filesystem_service_unittests\": \"7fa6fcd5c9f9a7276fb964dfe582c374b6b5e722\", \"flatbuffers_unittests\": \"9b972b84314b0e944fad99f4c5be3f50c351ec0c\", \"gcm_unit_tests\": \"53728bf75026fab58f49ee9251a1a553eeafe6de\", \"gfx_unittests\": \"16e93bd943a07b76e214b4b38814e1275357e542\", \"gin_unittests\": \"93bc61721425fb281d32331f9b03fd4c68870dee\", \"google_apis_unittests\": \"c824b36d194111692d26117ec52d4007eff72fc7\", \"gpu_unittests\": \"3a3db216b3d1dd0947ef1812d1b8b054db26c442\", \"grit_python_unittests\": \"8d3af1ca6ce7611b3ef6d2516a78cd61f915c28b\", \"gwp_asan_unittests\": \"da719f5c0a0f8b0c559d4efdb235ebbd437b18cc\", \"headless_browsertests\": \"95a91a016fba72c728b2da65ee73b39f00db7e00\", \"headless_unittests\": \"d00db43c543f67ad6947c92be903a3257463e491\", \"interactive_ui_tests\": \"2812386ca363a54574be070a6269ec4d48b3880d\", \"ipc_tests\": \"f5424972f8e1fb6af2795b0c0febd2762d7fb94c\", \"jingle_unittests\": \"063d02da75f8b33c0b99d7954ff1043e64d7b291\", \"latency_unittests\": \"fd28e05477bdc166894ed31bbeaa9a2f04022bb1\", \"libjingle_xmpp_unittests\": \"31ba41818ce565b37edcb0003f0319d1ae52d9f7\", \"media_blink_unittests\": \"bcf51fc5780df1d99b1fa30687448e448cc37e42\", \"media_service_unittests\": \"f42ab2974a179afb3bfd12ba922e99e0ed15ab0a\", \"media_unittests\": \"104e9bdbda54444937f5ac58d1e75c6115f3a2cd\", \"message_center_unittests\": \"0fa700530fa964829f4a9a60cffde4a67c4e7a67\", \"metrics_python_tests\": \"2fc7f85a479ead5b1cef5b5bfb7ea7b66532efb4\", \"midi_unittests\": \"6163f0c9db8be5bd5305be8c2139ff3ecf7f8481\", \"mojo_core_unittests\": \"94155ca72ad02fddb748e9e3f7216c99a67e4bff\", \"mojo_unittests\": \"6357bc7e62f3162dae2a0a0c57f26680e5863d47\", \"nacl_helper_nonsfi_unittests\": \"60cbe1f726a3d40708f57d75819bdb30c0704929\", \"nacl_loader_unittests\": \"a8a48045caa1cc4a76096fde5cc3619be515d2a1\", \"native_theme_unittests\": \"c4d875357df79b6858a3b35ca2cc8cc01d56060f\", \"net_unittests\": \"8fc9163b4e679294c9285f3b307b1007c079770a\", \"pdf_unittests\": \"a519c6cbb250b728b10bcc8f0e678377fbf674e9\", \"perfetto_unittests\": \"999dfb2ce71173b8490dfde923f066538de00289\", \"ppapi_unittests\": \"7756a3d235f7e028ff7644568b6487f2d41c9b92\", \"printing_unittests\": \"ace5def86fd4cd11df11320538a649215ef92c20\", \"remoting_unittests\": \"57da78b51ae18e631044dcc3063e5e6ba588850c\", \"sandbox_linux_unittests\": \"5ab52bf4107deb9fc333256465cd26e316e9105b\", \"service_manager_unittests\": \"c9338191ed9808263a538198693a7876a59ec89b\", \"services_unittests\": \"2bd4e008dd5248cfd4a557fa1997e08a6079ee5d\", \"shell_dialogs_unittests\": \"2fb1c5101be361f6ce80dfd4ea3fa9d1ca75d9eb\", \"skia_unittests\": \"ce8c4a26f0df66a63b51bea5cd94192bb6b53462\", \"snapshot_unittests\": \"4c52d61128322495748ac51b1009b06a0723b796\", \"sql_unittests\": \"2d17fdc5d87af82763229ef0475757c5f464be28\", \"storage_unittests\": \"c737a394bc11858574bffc8248b87952ed1efd01\", \"sync_integration_tests\": \"c7766072f5832fe7a94ede4cc66b6cfa246f2cbb\", \"telemetry_gpu_unittests\": \"546b7e2be4e08900a06d404433a1b7710697505c\", \"telemetry_perf_unittests\": \"1a76e0cd7f05077b40ed07795848dd7258cfe49d\", \"telemetry_unittests\": \"a1dc4217ab4d057f372ffa17a23d91739f56833f\", \"traffic_annotation_auditor_unittests\": \"428e9a31825939cb4124ae1af7fdd21edd0718d4\", \"ui_base_unittests\": \"eedae4af6c2b5f8a36f681ef1c9470d058e35288\", \"ui_touch_selection_unittests\": \"735cfcdfc6b654ebb3fc89754c34979e7b730994\", \"unit_tests\": \"52b2a715a9fb9950495bcd79f94420ea580898fa\", \"url_unittests\": \"3b42253a5a8e52ed774dcb592cdafaa43db1b40c\", \"views_perftests\": \"9680343b51f0c5b9f9c807e4006c4348f679a4de\", \"views_unittests\": \"1672850205f0852ac9e6844ce0a72846519e3f22\", \"viz_unittests\": \"fe61aa36986422f4f710477892e6af92a566b93a\", \"vr_common_unittests\": \"55b5bd9120bb5a3faf811726672c85e0f49e7b72\", \"vr_pixeltests\": \"e092befbaf7560e8a6d6e5ac04168ce997eb681c\", \"webdriver_wpt_tests\": \"d0994155b512b52f9c1069748da66a687017c8cf\", \"weblayer_browsertests\": \"40b3c9d2a2936ffbd76243efff57db8c6a2fe2fb\", \"wm_unittests\": \"1855a341314494b70a6418fa598ad1f73c45d296\", \"wtf_unittests\": \"f1672f85d295e1453f8f1feab2013f29864ba858\", \"xr_browser_tests\": \"9186d2d5befd99af2d37bc87a0f176b78f1083ac\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3e75b41c9bcf12a22209c03b338cce1fafa12941d3074ed1e1ed2450e6b71594_v2\", \"builder_6e17dc7623fba43c9632527d18d71e4843b504e37694b559b7b91daecd01d18c_v2\", \"builder_b624744545b53f30069a9e0f9d655dd80cb0688eb6f8753c5d4d1f02e2478691_v2\", \"builder_f2d41554cc5e5ccdd409a1e3331deca1f73b654eb50c3540ea4abf5478e808d4_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-23-3f0g\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"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\": [\"4838-b69615e\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1582838462836507",
"status": "COMPLETED",
"status_changed_ts": "1582841475193953",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169100",
"builder:Linux Builder (dbg)",
"buildset:commit/git/d7e0211189498697ccc172476680adec021ded0d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d7e0211189498697ccc172476680adec021ded0d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052697661163367664",
"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/8887267599235195216/+/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:4aa1534b6731c910",
"user_agent:luci-scheduler"
],
"updated_ts": "1582841475212504",
"url": "https://ci.chromium.org/b/8887267599235195216",
"utcnow_ts": "1582841475887849"
}
}
[22:11:15.903] Invocation finished in 55m7.338192523s with status SUCCEEDED