[05:14:11.469] New invocation is queued and will start shortly
[05:14:12.687] Starting the invocation (attempt 1)
[05:14:12.727] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:14:12.727] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:14:12.727] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9026032076854313056",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f866e5cafb1f13e0ce5ba986c9629082d6a21f65\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9026032076854313056",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/f866e5cafb1f13e0ce5ba986c9629082d6a21f65",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f866e5cafb1f13e0ce5ba986c9629082d6a21f65",
"gitiles_ref:refs/heads/master"
]
}
[05:14:13.523] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1608268452847760",
"id": "8860602014746002944",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f866e5cafb1f13e0ce5ba986c9629082d6a21f65\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1608268453367079",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178778",
"builder:Linux Builder (dbg)",
"buildset:commit/git/f866e5cafb1f13e0ce5ba986c9629082d6a21f65",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f866e5cafb1f13e0ce5ba986c9629082d6a21f65",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026032076854313056",
"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/8860602014746002944/+/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": "1608268453367197",
"url": "https://ci.chromium.org/b/8860602014746002944",
"utcnow_ts": "1608268453514196"
}
}
[05:14:13.523] Task URL: https://ci.chromium.org/b/8860602014746002944
[05:14:13.523] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:2:0) after 1m0s
[05:14:15.932] Received PubSub notification, asking Buildbucket for the build status
[05:14:15.998] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:13.542] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:2:0)
[05:15:13.542] Timer tick, asking Buildbucket for the build status
[05:15:13.737] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:13.737] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:4:0) after 1m0s
[05:16:13.739] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:4:0)
[05:16:13.739] Timer tick, asking Buildbucket for the build status
[05:16:13.807] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:13.807] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:5:0) after 1m0s
[05:17:13.831] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:5:0)
[05:17:13.831] Timer tick, asking Buildbucket for the build status
[05:17:13.933] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:13.933] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:6:0) after 1m0s
[05:18:13.941] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:6:0)
[05:18:13.941] Timer tick, asking Buildbucket for the build status
[05:18:14.064] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:14.064] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:7:0) after 1m0s
[05:19:14.196] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:7:0)
[05:19:14.196] Timer tick, asking Buildbucket for the build status
[05:19:14.326] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:14.326] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:8:0) after 1m0s
[05:20:14.369] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:8:0)
[05:20:14.369] Timer tick, asking Buildbucket for the build status
[05:20:14.445] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:14.445] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:9:0) after 1m0s
[05:21:14.543] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:9:0)
[05:21:14.543] Timer tick, asking Buildbucket for the build status
[05:21:14.732] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:14.732] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:10:0) after 1m0s
[05:22:14.800] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:10:0)
[05:22:14.800] Timer tick, asking Buildbucket for the build status
[05:22:14.868] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:14.868] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:11:0) after 1m0s
[05:23:14.872] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:11:0)
[05:23:14.872] Timer tick, asking Buildbucket for the build status
[05:23:14.948] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:14.948] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:12:0) after 1m0s
[05:24:14.957] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:12:0)
[05:24:14.957] Timer tick, asking Buildbucket for the build status
[05:24:15.080] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:15.080] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:13:0) after 1m0s
[05:25:15.202] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:13:0)
[05:25:15.202] Timer tick, asking Buildbucket for the build status
[05:25:15.303] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:15.303] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:14:0) after 1m0s
[05:26:15.299] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:14:0)
[05:26:15.299] Timer tick, asking Buildbucket for the build status
[05:26:15.441] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:15.441] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:15:0) after 1m0s
[05:27:15.529] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:15:0)
[05:27:15.529] Timer tick, asking Buildbucket for the build status
[05:27:15.744] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:15.744] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:16:0) after 1m0s
[05:28:15.766] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:16:0)
[05:28:15.766] Timer tick, asking Buildbucket for the build status
[05:28:15.886] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:15.887] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:17:0) after 1m0s
[05:29:15.909] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:17:0)
[05:29:15.909] Timer tick, asking Buildbucket for the build status
[05:29:16.018] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:16.018] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:18:0) after 1m0s
[05:30:16.043] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:18:0)
[05:30:16.043] Timer tick, asking Buildbucket for the build status
[05:30:16.312] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:16.312] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:19:0) after 1m0s
[05:31:16.339] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:19:0)
[05:31:16.339] Timer tick, asking Buildbucket for the build status
[05:31:16.391] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:16.391] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:20:0) after 1m0s
[05:32:16.409] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:20:0)
[05:32:16.409] Timer tick, asking Buildbucket for the build status
[05:32:16.463] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:16.463] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:21:0) after 1m0s
[05:33:16.547] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:21:0)
[05:33:16.547] Timer tick, asking Buildbucket for the build status
[05:33:16.708] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:16.708] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:22:0) after 1m0s
[05:34:16.754] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:22:0)
[05:34:16.754] Timer tick, asking Buildbucket for the build status
[05:34:16.863] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:16.863] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:23:0) after 1m0s
[05:35:16.864] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:23:0)
[05:35:16.864] Timer tick, asking Buildbucket for the build status
[05:35:16.924] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:16.924] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:24:0) after 1m0s
[05:36:17.017] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:24:0)
[05:36:17.017] Timer tick, asking Buildbucket for the build status
[05:36:17.132] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:17.132] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:25:0) after 1m0s
[05:37:17.202] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:25:0)
[05:37:17.202] Timer tick, asking Buildbucket for the build status
[05:37:17.280] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:17.280] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:26:0) after 1m0s
[05:38:17.393] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:26:0)
[05:38:17.393] Timer tick, asking Buildbucket for the build status
[05:38:17.538] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:17.538] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:27:0) after 1m0s
[05:39:17.571] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:27:0)
[05:39:17.571] Timer tick, asking Buildbucket for the build status
[05:39:17.677] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:17.677] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:28:0) after 1m0s
[05:40:17.739] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:28:0)
[05:40:17.739] Timer tick, asking Buildbucket for the build status
[05:40:17.927] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:17.927] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:29:0) after 1m0s
[05:41:17.976] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:29:0)
[05:41:17.976] Timer tick, asking Buildbucket for the build status
[05:41:18.051] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:18.051] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:30:0) after 1m0s
[05:42:18.127] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:30:0)
[05:42:18.127] Timer tick, asking Buildbucket for the build status
[05:42:18.180] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:18.180] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:31:0) after 1m0s
[05:43:18.312] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:31:0)
[05:43:18.312] Timer tick, asking Buildbucket for the build status
[05:43:18.508] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:18.508] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:32:0) after 1m0s
[05:44:18.680] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:32:0)
[05:44:18.680] Timer tick, asking Buildbucket for the build status
[05:44:18.818] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:18.818] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:33:0) after 1m0s
[05:45:18.878] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:33:0)
[05:45:18.878] Timer tick, asking Buildbucket for the build status
[05:45:19.335] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:19.335] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:34:0) after 1m0s
[05:46:19.373] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:34:0)
[05:46:19.373] Timer tick, asking Buildbucket for the build status
[05:46:19.468] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:19.469] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:35:0) after 1m0s
[05:47:19.510] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:35:0)
[05:47:19.510] Timer tick, asking Buildbucket for the build status
[05:47:19.568] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:19.568] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:36:0) after 1m0s
[05:48:19.575] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:36:0)
[05:48:19.575] Timer tick, asking Buildbucket for the build status
[05:48:19.636] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:19.636] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:37:0) after 1m0s
[05:49:19.730] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:37:0)
[05:49:19.730] Timer tick, asking Buildbucket for the build status
[05:49:19.819] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:19.819] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:38:0) after 1m0s
[05:50:19.958] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:38:0)
[05:50:19.958] Timer tick, asking Buildbucket for the build status
[05:50:20.030] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:20.030] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:39:0) after 1m0s
[05:51:20.099] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:39:0)
[05:51:20.099] Timer tick, asking Buildbucket for the build status
[05:51:20.172] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:20.172] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:40:0) after 1m0s
[05:52:20.188] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:40:0)
[05:52:20.188] Timer tick, asking Buildbucket for the build status
[05:52:20.253] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:20.253] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:41:0) after 1m0s
[05:53:20.304] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:41:0)
[05:53:20.304] Timer tick, asking Buildbucket for the build status
[05:53:20.618] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:20.618] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:42:0) after 1m0s
[05:54:20.643] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:42:0)
[05:54:20.643] Timer tick, asking Buildbucket for the build status
[05:54:20.753] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:20.753] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:43:0) after 1m0s
[05:55:20.778] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:43:0)
[05:55:20.778] Timer tick, asking Buildbucket for the build status
[05:55:20.961] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:20.961] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:44:0) after 1m0s
[05:56:20.981] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:44:0)
[05:56:20.981] Timer tick, asking Buildbucket for the build status
[05:56:21.088] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:21.088] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:45:0) after 1m0s
[05:57:21.177] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:45:0)
[05:57:21.177] Timer tick, asking Buildbucket for the build status
[05:57:21.331] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:21.331] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:46:0) after 1m0s
[05:58:21.333] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:46:0)
[05:58:21.333] Timer tick, asking Buildbucket for the build status
[05:58:21.393] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:21.393] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:47:0) after 1m0s
[05:59:21.484] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:47:0)
[05:59:21.484] Timer tick, asking Buildbucket for the build status
[05:59:22.004] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:22.004] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:48:0) after 1m0s
[06:00:22.032] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:48:0)
[06:00:22.032] Timer tick, asking Buildbucket for the build status
[06:00:22.163] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:22.163] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:49:0) after 1m0s
[06:01:30.978] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:49:0)
[06:01:30.978] Timer tick, asking Buildbucket for the build status
[06:01:31.058] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:31.058] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:50:0) after 1m0s
[06:02:31.092] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:50:0)
[06:02:31.092] Timer tick, asking Buildbucket for the build status
[06:02:31.426] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:31.426] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:51:0) after 1m0s
[06:03:31.401] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:51:0)
[06:03:31.401] Timer tick, asking Buildbucket for the build status
[06:03:31.456] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:31.456] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:52:0) after 1m0s
[06:04:31.517] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:52:0)
[06:04:31.517] Timer tick, asking Buildbucket for the build status
[06:04:31.624] Build 8860602014746002944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:31.624] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9026032076854313056:53:0) after 1m0s
[06:05:20.669] Received PubSub notification, asking Buildbucket for the build status
[06:05:20.921] Build 8860602014746002944: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:05:20.921] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1608271519873392",
"created_by": "project:chromium",
"created_ts": "1608268452847760",
"id": "8860602014746002944",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f866e5cafb1f13e0ce5ba986c9629082d6a21f65\"}}",
"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\": \"f866e5cafb1f13e0ce5ba986c9629082d6a21f65\", \"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-42-aieu\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 178778, \"got_angle_revision\": \"c47b951ecbcbbba653db801bc7eb5f4fa5d72042\", \"got_dawn_revision\": \"ee977a0df8e3f3a12a6f2983db98838bf65566da\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"f866e5cafb1f13e0ce5ba986c9629082d6a21f65\", \"got_revision_cp\": \"refs/heads/master@{#838415}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1cc5b3357d2ff3c81ef7ec0b07a6660796bde5cd\", \"got_v8_revision\": \"af6738a7d0a2708809a9c21e9dacc6fcface7939\", \"got_v8_revision_cp\": \"refs/heads/8.9.173@{#1}\", \"got_webrtc_revision\": \"8592111e458d253e53806db65d23d21bfe9d9db4\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32849}\", \"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\": \"f866e5cafb1f13e0ce5ba986c9629082d6a21f65\", \"swarm_hashes_refs/heads/master(at){#838415}_without_patch\": {\"absl_hardening_tests\": \"eaf06a038a2116b57a32fc59a7c13aa18ef01f13\", \"accessibility_unittests\": \"c1a1fb0d02f4a3e84af38d6611f7bb0fe466900b\", \"angle_unittests\": \"eee779597973e7192da464dd108140ab0de249f0\", \"app_shell_unittests\": \"dc9fa8e30368ba395b0debf6bc17b0f0e296b69a\", \"aura_unittests\": \"49b3963c6ae5fa1d36db3913f6da7185fd53b8a1\", \"base_unittests\": \"61b6515ec8b38888566eff298628d01e1a696d47\", \"base_util_unittests\": \"6e4fe802deeedc20a5bfd08f5d4c0b11caa1a90f\", \"blink_common_unittests\": \"2a260269145afa489ed8d251e729c3e756738094\", \"blink_fuzzer_unittests\": \"1cae63f4cf4163b156ae60d112be6346fd60d641\", \"blink_heap_unittests\": \"53d0437d525727b02018e322e422c8de9cd11073\", \"blink_platform_unittests\": \"56089b57472e14c66d228986bcbc5551b34938d1\", \"blink_python_tests\": \"8c140fba619046f083560a819ee34d1aedcdbe53\", \"blink_unittests\": \"068f651b5a6f461df19bee188c9e2edd971f285e\", \"blink_web_tests\": \"4ce2253295a3b6fd686942173cebb4e8da51b955\", \"boringssl_crypto_tests\": \"e96b287a896c3dd273678360f8885d0bfc4c6824\", \"boringssl_ssl_tests\": \"01a45a8f8e8bce868bbf4c215601295eb817eceb\", \"browser_tests\": \"3996483b4217b31a866e665b9879b348f83423e5\", \"capture_unittests\": \"a2bd440b7f9ef686942e927ec53c59b9ae47a06f\", \"cast_unittests\": \"0548633798ea5c83646894c51d8474aee9a20eb7\", \"cc_unittests\": \"43ece283fabd4cb315c486884d8d57273f4f96b4\", \"chrome_app_unittests\": \"ecb7f41bb4b04c175f9ff47a63ba5ce4eff9f778\", \"chromedriver_unittests\": \"8eb81ce12c75b549bda1b8d1d1f0957c2f3b94b7\", \"components_browsertests\": \"30d4c017dc3725bdb004e9c66043eda0d4c3d6d3\", \"components_unittests\": \"2f7d857be77a9e5adf89c9c63b152ff2bfb86f75\", \"compositor_unittests\": \"0a31cb0e42f8f77cc7df8d37db80bbd77ddc4bf3\", \"content_browsertests\": \"e9304e2a15b33e880ffa51722016b7f0313270ed\", \"content_shell_crash_test\": \"bc9099ba38087f1710a8e646528b03f98467ee2e\", \"content_unittests\": \"4f3c80fab1d4b185b14b4427bb3c8f35e4093a19\", \"crashpad_tests\": \"b0f6236e78169c702b9e8483e17d0b0e4037520c\", \"cronet_tests\": \"16675f3a409dd1d8e42ef119ee18a1bd764b4643\", \"cronet_unittests\": \"7c6a62c6c36783a70bd66ca8e255236939d653aa\", \"crypto_unittests\": \"9d0301c66aaea0799cd37fda93e0eaac3f0db2db\", \"dbus_unittests\": \"4fdfb9cfbffce68e4089a54628e899172affc2b5\", \"device_unittests\": \"f49662bd36d570cbb90fb4ce7acea7305bcb1b59\", \"display_unittests\": \"6edee99a11046ee2d722913f4eb5010440514d93\", \"events_unittests\": \"676285928c2d2b002d947fc4a80ff373fd518d3c\", \"extension_docserver_python_unittests\": \"d2c9142966a0b67f7aec9c3117242150c75cd902\", \"extensions_browsertests\": \"93a46ff6644e69f91ecb8524b0b6a6ffe795bc55\", \"extensions_unittests\": \"a8b11df995c29144d36c32d1be3af39f501ba8c9\", \"filesystem_service_unittests\": \"45ae8f046a23888101ec8ca3b5512c856438d10a\", \"flatbuffers_unittests\": \"d051d66da1ab229778a7e9a8f6ace686eaf5e782\", \"gcm_unit_tests\": \"d0ff1577441718bb66fde35f1cacfbc4632d4a55\", \"gfx_unittests\": \"f35bf2647852a059b6ea41824517f7dbe9f7a384\", \"gin_unittests\": \"c88772dddbc263f19c7a1cb2277a4e1c6d028bae\", \"google_apis_unittests\": \"14fdf1df1fb1dda8cbd522c9a4d852ace0acbd86\", \"gpu_unittests\": \"bcbfd39616f673cb21fd7cd3536f49f0e9f0f1d0\", \"grit_python_unittests\": \"275c161e38b800af0a18bf8ee2ae20e83dfa4ea2\", \"gwp_asan_unittests\": \"02ae1da2e4cf33a79d47627302a2d0bfca94d9ec\", \"headless_browsertests\": \"6137d5a089e940c5a57f9973d2ce5be8713e8bad\", \"headless_unittests\": \"38fa7f52635c79e5b9967b6098f25c4b35739497\", \"interactive_ui_tests\": \"62a42631b227875c7549b2ef4bb63f68ab565c67\", \"ipc_tests\": \"8dbd868ff9da0ee7cf7d13ca0c1fa4a6322f4c9e\", \"jingle_unittests\": \"1a3a758650d759ce38e3166f89e998e4f6ab6a99\", \"latency_unittests\": \"c2ce04bd29a1c97097068a98d6433279e01b551d\", \"libjingle_xmpp_unittests\": \"a11d50e42725f62b04200057bcace936c29e1a50\", \"liburlpattern_unittests\": \"eef5fd40ecae557983f2f5be8ff103086be8de56\", \"media_blink_unittests\": \"b3aa622ef6a6c0b27ca492db1c06e8d60c2ebafb\", \"media_unittests\": \"191e019c42fc904d75c8a91fff178b00e0cf1ee7\", \"message_center_unittests\": \"0875c1a2dc387cd7454ddb4d1ed95cc9640057b1\", \"metrics_python_tests\": \"b3fb44da079f6e56669a16177c9b3de500b1ed1a\", \"midi_unittests\": \"1a659afb73239433f48b8ba53ef9412837aa1988\", \"mojo_core_unittests\": \"84a6d38d871af85b3b1a122f6075512a3f77bdb6\", \"mojo_unittests\": \"d560367db62ccaa2ada95afcaa2e899ad3c026a3\", \"nacl_helper_nonsfi_unittests\": \"715bcdfde09a00bbff6690069ca5ae5beef8e258\", \"nacl_loader_unittests\": \"d19e1fef11c072bcc16fcddaef2aec6a6f9f0c50\", \"native_theme_unittests\": \"5e8afcccddaae1f410f9876f4163f9f39458e0aa\", \"net_unittests\": \"613fbfa93261449e3a240524c79f5bf941056886\", \"openscreen_unittests\": \"c499b8937aac406399dc8693b68ddc722772213a\", \"pdf_unittests\": \"ff0613c111713d9e73f6a6d0c11848da7bcd426d\", \"perfetto_unittests\": \"e169f48c95be5667714fd23559051a3084fa6749\", \"ppapi_unittests\": \"e1b9e416326aef99c9ddd6644f82f8eb70d2ceb7\", \"printing_unittests\": \"751a70261cb09a6df0b64c7b04a7cb5214bfc5a1\", \"remoting_unittests\": \"4e5502e9433d629c884d77afc0cc40d5728b407e\", \"sandbox_linux_unittests\": \"449c6368444c152d140c0d4058f94d5c535d9155\", \"service_manager_unittests\": \"efb1f4a6172e10cd7532235dfd96a6bac285df1d\", \"services_unittests\": \"979ce2444aee8c9891da194e05320bfb020f8f8a\", \"shell_dialogs_unittests\": \"4c2fdd94784544d247238890e5b490a30e5a1270\", \"skia_unittests\": \"81a04899bc211e8c452404c9070d13596a1efd27\", \"snapshot_unittests\": \"220f5c4deecaf02a4a33365fa2a934d3086ff67d\", \"sql_unittests\": \"15a77726e10a2bf9f58a220f6c164defdca53993\", \"storage_unittests\": \"282b1aaa610b6a035031e2d49330b46246eaf907\", \"sync_integration_tests\": \"b160314368ca5533f8e4761387fc6514ad7eb7aa\", \"telemetry_gpu_unittests\": \"45520c25994698a6a87f7ff3480f0bd7e9e48a40\", \"telemetry_perf_unittests\": \"84b405ea9c8f964fa6be43adbd34e772a10a4153\", \"telemetry_unittests\": \"9ba20a72dd5ae359115288cc5c63a38b15772899\", \"traffic_annotation_auditor_unittests\": \"97cdb56bf2ede919508900bb33941750f83fe039\", \"ui_base_unittests\": \"0d43d3d6b3331d7b68dbd2de29977b5f25cf9c5b\", \"ui_touch_selection_unittests\": \"65d1cf3709d8af46ea6b93ed8b13a6e7f9f8e72c\", \"unit_tests\": \"0d4e2003f0327cc75a1c6e430fd937bea1355304\", \"url_unittests\": \"8aaaf9e20990fab843fa231a1d219f00ed7edd4a\", \"views_perftests\": \"70fda6f92dbce9fa825ce559e6b0d840e5ad57ef\", \"views_unittests\": \"7876b915339121c5ac568e21b13589a86a52ec4c\", \"viz_unittests\": \"f30177bc01c41ccbf4329858b825fa87677f09ce\", \"vr_common_unittests\": \"27be6f6bf754a7829a253d2b12d5388ac887fe66\", \"vr_pixeltests\": \"f661597e7c362193134ba1e87d0b476c1c231d35\", \"webdriver_wpt_tests\": \"52ae93b01f1c2f2b88dd9b3856b3e6fb8793da4a\", \"weblayer_browsertests\": \"80b9fac93a1de11d133aa5a8d211f993b9c643e4\", \"weblayer_unittests\": \"4479c27cc081d6d55c3b95c8970c6ead6a8e1dd7\", \"wm_unittests\": \"8b7f8fd8384e04e6dd44a089a7bbca8cbd09cdbd\", \"wtf_unittests\": \"83dac639a5fce19097844c5abd67fcf1ab8d268f\", \"x11_unittests\": \"e09afb7d0d029f1f2c22314d7411754bf249b603\", \"xr_browser_tests\": \"0c408df760c118ed3ffc13903049c1a2c5907c22\", \"zlib_unittests\": \"10cfc3ba05d252ff4b635d4f30422b18990d0e5b\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"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-42-aieu\"], \"image\": [\"chrome-xenial-20121300-d43316a0aad\"], \"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\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1608268455441573",
"status": "COMPLETED",
"status_changed_ts": "1608271520235074",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178778",
"builder:Linux Builder (dbg)",
"buildset:commit/git/f866e5cafb1f13e0ce5ba986c9629082d6a21f65",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f866e5cafb1f13e0ce5ba986c9629082d6a21f65",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026032076854313056",
"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/8860602014746002944/+/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:508d169ee0572710",
"user_agent:luci-scheduler"
],
"updated_ts": "1608271520239564",
"url": "https://ci.chromium.org/b/8860602014746002944",
"utcnow_ts": "1608271520907662"
}
}
[06:05:20.921] Invocation finished in 51m9.467988135s with status SUCCEEDED