[19:58:12.433] New invocation is queued and will start shortly
[19:58:13.638] Starting the invocation (attempt 1)
[19:58:13.672] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:58:13.672] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:58:13.672] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9031593471307089024",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"8b0fb11f1bb8e9d1490b11fd252f17df9b851cbf\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9031593471307089024",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/8b0fb11f1bb8e9d1490b11fd252f17df9b851cbf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8b0fb11f1bb8e9d1490b11fd252f17df9b851cbf",
"gitiles_ref:refs/heads/master"
]
}
[19:58:15.131] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1602964693801125",
"id": "8866163409191626272",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8b0fb11f1bb8e9d1490b11fd252f17df9b851cbf\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1602964694899357",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/176765",
"builder:Linux Builder (dbg)",
"buildset:commit/git/8b0fb11f1bb8e9d1490b11fd252f17df9b851cbf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8b0fb11f1bb8e9d1490b11fd252f17df9b851cbf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031593471307089024",
"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/8866163409191626272/+/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": "1602964694899616",
"url": "https://ci.chromium.org/b/8866163409191626272",
"utcnow_ts": "1602964695120553"
}
}
[19:58:15.131] Task URL: https://ci.chromium.org/b/8866163409191626272
[19:58:15.131] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:2:0) after 1m0s
[19:59:15.187] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:2:0)
[19:59:15.187] Timer tick, asking Buildbucket for the build status
[19:59:15.360] Build 8866163409191626272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:59:15.360] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:3:0) after 1m0s
[20:00:15.384] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:3:0)
[20:00:15.384] Timer tick, asking Buildbucket for the build status
[20:00:15.615] Build 8866163409191626272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:00:15.615] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:4:0) after 1m0s
[20:01:15.687] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:4:0)
[20:01:15.687] Timer tick, asking Buildbucket for the build status
[20:01:15.875] Build 8866163409191626272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:01:15.875] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:5:0) after 1m0s
[20:02:15.898] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:5:0)
[20:02:15.898] Timer tick, asking Buildbucket for the build status
[20:02:15.977] Build 8866163409191626272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:02:15.977] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:6:0) after 1m0s
[20:03:16.033] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:6:0)
[20:03:16.033] Timer tick, asking Buildbucket for the build status
[20:03:16.186] Build 8866163409191626272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:03:16.186] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:7:0) after 1m0s
[20:04:16.207] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:7:0)
[20:04:16.207] Timer tick, asking Buildbucket for the build status
[20:04:16.278] Build 8866163409191626272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:04:16.278] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:8:0) after 1m0s
[20:05:16.393] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:8:0)
[20:05:16.393] Timer tick, asking Buildbucket for the build status
[20:05:16.487] Build 8866163409191626272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:05:16.487] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:9:0) after 1m0s
[20:06:16.518] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:9:0)
[20:06:16.518] Timer tick, asking Buildbucket for the build status
[20:06:16.591] Build 8866163409191626272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:06:16.591] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:10:0) after 1m0s
[20:07:16.706] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:10:0)
[20:07:16.706] Timer tick, asking Buildbucket for the build status
[20:07:16.814] Build 8866163409191626272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:07:16.814] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:11:0) after 1m0s
[20:08:17.003] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:11:0)
[20:08:17.003] Timer tick, asking Buildbucket for the build status
[20:08:17.220] Build 8866163409191626272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:08:17.220] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:12:0) after 1m0s
[20:09:17.391] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:12:0)
[20:09:17.391] Timer tick, asking Buildbucket for the build status
[20:09:17.561] Build 8866163409191626272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:09:17.561] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:13:0) after 1m0s
[20:10:17.691] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:13:0)
[20:10:17.691] Timer tick, asking Buildbucket for the build status
[20:10:17.764] Build 8866163409191626272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:10:17.764] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:14:0) after 1m0s
[20:11:17.899] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:14:0)
[20:11:17.899] Timer tick, asking Buildbucket for the build status
[20:11:18.096] Build 8866163409191626272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:11:18.097] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:15:0) after 1m0s
[20:12:18.185] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:15:0)
[20:12:18.185] Timer tick, asking Buildbucket for the build status
[20:12:18.280] Build 8866163409191626272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:12:18.280] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:16:0) after 1m0s
[20:13:18.448] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:16:0)
[20:13:18.448] Timer tick, asking Buildbucket for the build status
[20:13:18.604] Build 8866163409191626272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:13:18.604] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:17:0) after 1m0s
[20:14:18.854] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:17:0)
[20:14:18.854] Timer tick, asking Buildbucket for the build status
[20:14:18.937] Build 8866163409191626272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:14:18.937] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:18:0) after 1m0s
[20:15:19.015] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:18:0)
[20:15:19.015] Timer tick, asking Buildbucket for the build status
[20:15:19.349] Build 8866163409191626272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:15:19.349] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:19:0) after 1m0s
[20:16:19.474] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:19:0)
[20:16:19.474] Timer tick, asking Buildbucket for the build status
[20:16:19.598] Build 8866163409191626272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:16:19.598] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:20:0) after 1m0s
[20:17:19.691] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:20:0)
[20:17:19.691] Timer tick, asking Buildbucket for the build status
[20:17:19.782] Build 8866163409191626272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:17:19.782] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:21:0) after 1m0s
[20:18:19.996] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:21:0)
[20:18:19.996] Timer tick, asking Buildbucket for the build status
[20:18:20.282] Build 8866163409191626272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:18:20.282] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:22:0) after 1m0s
[20:19:20.460] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:22:0)
[20:19:20.460] Timer tick, asking Buildbucket for the build status
[20:19:20.533] Build 8866163409191626272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:19:20.533] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:23:0) after 1m0s
[20:20:20.659] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:23:0)
[20:20:20.659] Timer tick, asking Buildbucket for the build status
[20:20:20.751] Build 8866163409191626272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:20:20.751] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:24:0) after 1m0s
[20:21:20.921] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:24:0)
[20:21:20.921] Timer tick, asking Buildbucket for the build status
[20:21:21.011] Build 8866163409191626272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:21:21.011] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:25:0) after 1m0s
[20:22:21.112] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:25:0)
[20:22:21.112] Timer tick, asking Buildbucket for the build status
[20:22:21.184] Build 8866163409191626272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:22:21.184] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:26:0) after 1m0s
[20:23:21.395] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:26:0)
[20:23:21.395] Timer tick, asking Buildbucket for the build status
[20:23:21.500] Build 8866163409191626272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:23:21.500] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:27:0) after 1m0s
[20:24:21.832] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:27:0)
[20:24:21.832] Timer tick, asking Buildbucket for the build status
[20:24:22.180] Build 8866163409191626272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:24:22.180] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:28:0) after 1m0s
[20:25:22.238] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:28:0)
[20:25:22.238] Timer tick, asking Buildbucket for the build status
[20:25:22.389] Build 8866163409191626272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:25:22.389] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:29:0) after 1m0s
[20:26:22.497] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:29:0)
[20:26:22.497] Timer tick, asking Buildbucket for the build status
[20:26:22.577] Build 8866163409191626272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:26:22.577] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:30:0) after 1m0s
[20:27:22.602] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:30:0)
[20:27:22.602] Timer tick, asking Buildbucket for the build status
[20:27:22.682] Build 8866163409191626272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:27:22.682] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:31:0) after 1m0s
[20:28:22.709] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:31:0)
[20:28:22.709] Timer tick, asking Buildbucket for the build status
[20:28:22.806] Build 8866163409191626272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:28:22.806] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:32:0) after 1m0s
[20:29:22.885] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:32:0)
[20:29:22.885] Timer tick, asking Buildbucket for the build status
[20:29:22.975] Build 8866163409191626272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:29:22.975] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:33:0) after 1m0s
[20:30:23.044] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:33:0)
[20:30:23.044] Timer tick, asking Buildbucket for the build status
[20:30:23.130] Build 8866163409191626272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:30:23.130] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:34:0) after 1m0s
[20:30:39.482] Received PubSub notification, asking Buildbucket for the build status
[20:30:39.548] Build 8866163409191626272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:23.152] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:34:0)
[20:31:23.152] Timer tick, asking Buildbucket for the build status
[20:31:25.309] Build 8866163409191626272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:25.309] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:36:0) after 1m0s
[20:32:25.330] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:36:0)
[20:32:25.330] Timer tick, asking Buildbucket for the build status
[20:32:25.431] Build 8866163409191626272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:25.431] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:37:0) after 1m0s
[20:33:25.465] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:37:0)
[20:33:25.465] Timer tick, asking Buildbucket for the build status
[20:33:25.565] Build 8866163409191626272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:25.565] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:38:0) after 1m0s
[20:34:25.629] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:38:0)
[20:34:25.629] Timer tick, asking Buildbucket for the build status
[20:34:26.087] Build 8866163409191626272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:26.087] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:39:0) after 1m0s
[20:35:26.158] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:39:0)
[20:35:26.158] Timer tick, asking Buildbucket for the build status
[20:35:26.265] Build 8866163409191626272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:26.265] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:40:0) after 1m0s
[20:36:26.288] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:40:0)
[20:36:26.288] Timer tick, asking Buildbucket for the build status
[20:36:26.420] Build 8866163409191626272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:26.420] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:41:0) after 1m0s
[20:37:26.425] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:41:0)
[20:37:26.425] Timer tick, asking Buildbucket for the build status
[20:37:26.691] Build 8866163409191626272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:26.691] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:42:0) after 1m0s
[20:38:26.724] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:42:0)
[20:38:26.724] Timer tick, asking Buildbucket for the build status
[20:38:26.820] Build 8866163409191626272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:26.820] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:43:0) after 1m0s
[20:39:26.844] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:43:0)
[20:39:26.844] Timer tick, asking Buildbucket for the build status
[20:39:27.376] Build 8866163409191626272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:27.376] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:44:0) after 1m0s
[20:40:27.397] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:44:0)
[20:40:27.397] Timer tick, asking Buildbucket for the build status
[20:40:27.448] Build 8866163409191626272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:27.448] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:45:0) after 1m0s
[20:41:27.525] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:45:0)
[20:41:27.525] Timer tick, asking Buildbucket for the build status
[20:41:27.735] Build 8866163409191626272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:27.735] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:46:0) after 1m0s
[20:42:27.772] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:46:0)
[20:42:27.772] Timer tick, asking Buildbucket for the build status
[20:42:27.831] Build 8866163409191626272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:27.831] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:47:0) after 1m0s
[20:43:27.889] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:47:0)
[20:43:27.889] Timer tick, asking Buildbucket for the build status
[20:43:27.985] Build 8866163409191626272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:27.985] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:48:0) after 1m0s
[20:44:28.112] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:48:0)
[20:44:28.112] Timer tick, asking Buildbucket for the build status
[20:44:28.172] Build 8866163409191626272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:28.172] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:49:0) after 1m0s
[20:45:28.244] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:49:0)
[20:45:28.244] Timer tick, asking Buildbucket for the build status
[20:45:28.512] Build 8866163409191626272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:28.512] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:50:0) after 1m0s
[20:46:28.585] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:50:0)
[20:46:28.585] Timer tick, asking Buildbucket for the build status
[20:46:28.642] Build 8866163409191626272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:28.642] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:51:0) after 1m0s
[20:47:28.720] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:51:0)
[20:47:28.720] Timer tick, asking Buildbucket for the build status
[20:47:28.793] Build 8866163409191626272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:28.793] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:52:0) after 1m0s
[20:48:28.917] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:52:0)
[20:48:28.917] Timer tick, asking Buildbucket for the build status
[20:48:29.010] Build 8866163409191626272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:29.010] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:53:0) after 1m0s
[20:49:29.211] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:53:0)
[20:49:29.211] Timer tick, asking Buildbucket for the build status
[20:49:29.411] Build 8866163409191626272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:29.411] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:54:0) after 1m0s
[20:50:29.495] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:54:0)
[20:50:29.495] Timer tick, asking Buildbucket for the build status
[20:50:29.635] Build 8866163409191626272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:29.635] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:55:0) after 1m0s
[20:51:29.717] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:55:0)
[20:51:29.717] Timer tick, asking Buildbucket for the build status
[20:51:30.300] Build 8866163409191626272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:30.300] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:56:0) after 1m0s
[20:52:30.321] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:56:0)
[20:52:30.321] Timer tick, asking Buildbucket for the build status
[20:52:30.439] Build 8866163409191626272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:30.439] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:57:0) after 1m0s
[20:53:30.476] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:57:0)
[20:53:30.476] Timer tick, asking Buildbucket for the build status
[20:53:30.579] Build 8866163409191626272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:30.579] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:58:0) after 1m0s
[20:54:30.710] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:58:0)
[20:54:30.710] Timer tick, asking Buildbucket for the build status
[20:54:30.890] Build 8866163409191626272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:30.890] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:59:0) after 1m0s
[20:55:30.910] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:59:0)
[20:55:30.910] Timer tick, asking Buildbucket for the build status
[20:55:30.969] Build 8866163409191626272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:30.969] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:60:0) after 1m0s
[20:56:31.854] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:60:0)
[20:56:31.854] Timer tick, asking Buildbucket for the build status
[20:56:32.218] Build 8866163409191626272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:32.218] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:61:0) after 1m0s
[20:57:32.322] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:61:0)
[20:57:32.322] Timer tick, asking Buildbucket for the build status
[20:57:32.462] Build 8866163409191626272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:32.462] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031593471307089024:62:0) after 1m0s
[20:58:19.100] Received PubSub notification, asking Buildbucket for the build status
[20:58:19.526] Build 8866163409191626272: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:58:19.526] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1602968297969861",
"created_by": "project:chromium",
"created_ts": "1602964693801125",
"id": "8866163409191626272",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8b0fb11f1bb8e9d1490b11fd252f17df9b851cbf\"}}",
"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\": \"8b0fb11f1bb8e9d1490b11fd252f17df9b851cbf\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-71-ool0\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 176765, \"got_angle_revision\": \"07ea804e620132517b6af0ef92fe85ea737d0c27\", \"got_dawn_revision\": \"875091308b04ba87e29c929ed707f27889c660ea\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"8b0fb11f1bb8e9d1490b11fd252f17df9b851cbf\", \"got_revision_cp\": \"refs/heads/master@{#818261}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"992b13db26c29db225f812aa1dfc637940e99cb8\", \"got_v8_revision_cp\": \"refs/heads/8.8.119@{#1}\", \"got_webrtc_revision\": \"1f3ac1f8e0688f8eff467b7dedbdb3f202604aeb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32428}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8b0fb11f1bb8e9d1490b11fd252f17df9b851cbf\", \"swarm_hashes_refs/heads/master(at){#818261}_without_patch\": {\"absl_hardening_tests\": \"8c748dea6bbe07f26f69bbb0534ab2ca0802e235\", \"accessibility_unittests\": \"e5f090e268cc4135cdbf9bb1303286b9e64b2e78\", \"app_shell_unittests\": \"49b62826914c7a4fa4fb1149010f3d62c5521154\", \"aura_unittests\": \"50ec3ff8e206a279bc96910bd58dbea18408c437\", \"base_unittests\": \"d286f8ee5372dc718462fb5ab858cd2230620cb4\", \"base_util_unittests\": \"7a21595d9622f0e680a8ede465046a765522f5d6\", \"blink_common_unittests\": \"00a6aa82b4cc4244d0d8da30f16a8d255aa8a430\", \"blink_fuzzer_unittests\": \"049db64fcc6cca7d7722b42d57ba0b59fda6897c\", \"blink_heap_unittests\": \"5a97d9a2b20451f9f93838a0606d79710001e80c\", \"blink_platform_unittests\": \"e283e717fecb5f16b599509d7a4952ebdc17ef24\", \"blink_python_tests\": \"7b08d15d0de5c74590b1c67f4ccc39f585f13593\", \"blink_unittests\": \"cb0304c8ddb89869ec1957f2f838d5c0e7cb8f25\", \"blink_web_tests\": \"abf699a342fdb4a26cda96950cf8a7fd0fae3d7b\", \"boringssl_crypto_tests\": \"0fd6d501297f9b35122b8b1fc22d6ffa9f5716df\", \"boringssl_ssl_tests\": \"11c1c60612d4931d02bebffaeab56bc0f6db3bc2\", \"browser_tests\": \"a45c7ae8b5e43370694ffd5ccb5fcc0907e13030\", \"capture_unittests\": \"64b22239b9c42a20ee2fd75486b5e3793efb1498\", \"cast_unittests\": \"7853854974f94c23ec27b8ced27dfbead232546b\", \"cc_unittests\": \"a2d8b795ea89a63e9c97c3df1d060761425a7547\", \"chrome_app_unittests\": \"250788f79f847f348df076bbbc271cdd91df75a5\", \"chromedriver_unittests\": \"257c4e204159610e3395dd69492beab657aa5654\", \"components_browsertests\": \"cf40f461922c59e433fad31aee90b93fa7ccb192\", \"components_unittests\": \"4a0408effdc07ba63ee7147475cabcf59b3534cd\", \"compositor_unittests\": \"b0ae71a1d74578f96db396a7fc57f082f7ac4991\", \"content_browsertests\": \"67ef36e2f49564ea644f2662dac6e440160d7dec\", \"content_shell_crash_test\": \"b6f2918d9818ce3a1c3a4980b2ff2f368d2ea3bc\", \"content_unittests\": \"7ad325e8cc004a41daf308df3f42fb38ec1df9df\", \"crashpad_tests\": \"752fe1003c6647f9d2b2a3f878e489670a723e89\", \"cronet_tests\": \"2b0a08f89499152c260dec477328aec060df22ba\", \"cronet_unittests\": \"71320ba520d7f6e47fe81a4ab939df6ab77b6bb2\", \"crypto_unittests\": \"4503d96fbab2194e8ca8fbdb89b40a52965b397e\", \"dbus_unittests\": \"000c300753f39e25b4409c08220bd113d6f5a916\", \"device_unittests\": \"6a0e2e6f1fd7f6d27cebbf0437909cc354928394\", \"display_unittests\": \"b14e32f30d3a1c6d9a465e5815d89ce8c8ec432c\", \"events_unittests\": \"933a86fef73fd436669d3d01262adca805c2daeb\", \"extension_docserver_python_unittests\": \"f63b04a390222006832c09a8c4a08547b12ede68\", \"extensions_browsertests\": \"25daa65816bd2d1bb89daa8b4269e80014432ecf\", \"extensions_unittests\": \"d8bd29f7aa187988a4486d05044a67bfa093021c\", \"filesystem_service_unittests\": \"cdb665810f94162515143f730d2f6a3650e82745\", \"flatbuffers_unittests\": \"7c821f13730963d6e07deae074f4fffab315d766\", \"gcm_unit_tests\": \"53c7b6d693fa95e0a9069520a7cf629da51da290\", \"gfx_unittests\": \"3343c3889e3d56f7e60dd0f408cbe90ed9ce2c03\", \"gin_unittests\": \"7a843b9f12aaad19b6f05ee9c0cd43cfacfe85e4\", \"google_apis_unittests\": \"6a392d34c03f57479d9929783451f09e0add432f\", \"gpu_unittests\": \"e52580f07529f12953f237e54e2c7917830e767e\", \"grit_python_unittests\": \"8ff0b3de600ef80bc443ec65457d74cd6c46cf1a\", \"gwp_asan_unittests\": \"55205d0e6329790ce4aca4de94d08c4691355d45\", \"headless_browsertests\": \"7df153163fa9abc2fae84e2b7605b9e53f0ed463\", \"headless_unittests\": \"73d0a3ca085e67382e0ee5f85bef92a7d3a4d5cc\", \"interactive_ui_tests\": \"e4d5fc2ba73d057472d22d436acccf4a26c1b4ac\", \"ipc_tests\": \"5b4fbdb06742d83721739a4cc838bfe8fb988483\", \"jingle_unittests\": \"93e2613b9a088c373b6869b6b6f4ebf8bf31c648\", \"latency_unittests\": \"b366f4a9b5b556da75b473190bcfd82968c121ca\", \"libjingle_xmpp_unittests\": \"1e3109545c3d9acd8875b41830072fe4046da029\", \"media_blink_unittests\": \"5ae7fc386647e5663461648aebb761d0158b5798\", \"media_unittests\": \"f5f5d0d0f3fcf86c3ab7556e668c9db7a7df5710\", \"message_center_unittests\": \"ebd04aeebf4a522fda65bb38436cf48dd4e3660e\", \"metrics_python_tests\": \"529514dacf9f4b326e8edd62e33ab2deca863d72\", \"midi_unittests\": \"10eb3293d010323375430ac5195c93d722f56167\", \"mojo_core_unittests\": \"4b58deaddd6850d5b17c3d8daa3c8972823313de\", \"mojo_unittests\": \"f07434dcaef08649f337a42e9eaf457394de0156\", \"nacl_helper_nonsfi_unittests\": \"d9859e85487baf3329eb88c32ef93b6374171718\", \"nacl_loader_unittests\": \"b953e2990a777d959147df59e48193fcfd4f7b2f\", \"native_theme_unittests\": \"69d19b7ce963a2d11652f507f05015ce110819db\", \"net_unittests\": \"5ca7683ef02543e1fbf113407d750e9425f34f13\", \"openscreen_unittests\": \"8a8a6493925194dd61b3ac33d62612218c70564a\", \"pdf_unittests\": \"46289386883736c7784073310146403d9d6201c8\", \"perfetto_unittests\": \"7b094148c0d45588f4c1cbba2227ad6f429d20ae\", \"ppapi_unittests\": \"ec354f6e581174348f48c9d5ecd58016fcd4c6b2\", \"printing_unittests\": \"309357078ea62b16231c4a126dac38f0a542f478\", \"remoting_unittests\": \"d44c7161e00ec9815a2971e1bda8c2d61c839e67\", \"sandbox_linux_unittests\": \"c167d9018dd3a21484a873e0e6a21aad537ae731\", \"service_manager_unittests\": \"ace60da06e2d068009dd979802b337b2f7b96141\", \"services_unittests\": \"de3186fb86b0319a1ff8c812d1a8aae0a77dd298\", \"shell_dialogs_unittests\": \"4df5d29b7302da8f9b3ee7260600da2af04a37a3\", \"skia_unittests\": \"b5f0d60de13038f6bff6934fab885c418017b892\", \"snapshot_unittests\": \"e9131b90db76561ec96064d69c6b30a44621a6cf\", \"sql_unittests\": \"f0d34b31f6a8c2963c049bf993045002b4f1b77a\", \"standalone_angle_unittests\": \"330d52cfa0f54b5cdbca24812e753de85773685c\", \"storage_unittests\": \"b8bb64769e5242677e43813048192084300260fd\", \"sync_integration_tests\": \"73a57e2a9279bff3f543c5431e49d0b5c011bc02\", \"telemetry_gpu_unittests\": \"e8a60bda4fb9713b813af410cda9d8ae6ed713c2\", \"telemetry_perf_unittests\": \"86b3250857afe1f47d44d6ded2412f5b89d667e7\", \"telemetry_unittests\": \"d4f415c0ec3108a94092ad9a3209fe259d7ece6c\", \"traffic_annotation_auditor_unittests\": \"697ce2597f5f6f5fa0220f9e70f4f58962c4b524\", \"ui_base_unittests\": \"6759e8fa858de27b28d70076c45d3dd7ea6847ca\", \"ui_touch_selection_unittests\": \"04322b46d21366b2de63e0ce73c78dc2a035cfef\", \"unit_tests\": \"6bf7317c52c7218df83b9b6db0f4d1c19471b5e0\", \"url_unittests\": \"e6b828cced0ea81fe2872a0353421972aa2bb4f5\", \"views_perftests\": \"eaacf881a861f3764cbceec7e454d60645c661c0\", \"views_unittests\": \"84b6175d18059a8faf462f00f4a25baa2ca30878\", \"viz_unittests\": \"be2cc84a5e37b1687279e1f2a5995204a3f338b0\", \"vr_common_unittests\": \"eb3677f4b82c46cde248d4cc72cd5bd2686befff\", \"vr_pixeltests\": \"8ec4d26028c6ab2112fb692820163863720e2dff\", \"webdriver_wpt_tests\": \"39db6570fbbbaa2a0a6727295711ffb172c6e024\", \"weblayer_browsertests\": \"3133f1e61bddb2d00648a9c566b064f1b51c2937\", \"weblayer_unittests\": \"6ced0f42fe7af3ac2b4e5ffc9acf9fe4872a3bf0\", \"wm_unittests\": \"fe02f56423f7e1d42ec1851c8575f3db8c6c5f2e\", \"wtf_unittests\": \"3478d694a6042f18986bd892795784ec43f91b27\", \"x11_unittests\": \"0c49b4c8d58209f384ecdcae7f1aced49d8067a1\", \"xr_browser_tests\": \"c9eb87999ad279e573d5f9e606ff4f37def7446e\", \"zlib_unittests\": \"229cca615d3d9ec6ca52b3ad1ecb580e66e5a383\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3e35691df8e10f0f9a2876627ba5bcbf70dc06793975d132d4535f10bccc6635_v2\", \"builder_7d75f6999c07e42a7f7fde2313383264fbd8ed871e2008bde33b278973c1f4c8_v2\", \"builder_957c0f1a1c74c3ada6665996f2ff614223d5da32e2cc2316ff7cc4c9c4beae5c_v2\", \"builder_a1b9c6892397d61c3624774723419f5ae48fcf776e7d2304bd4682bf5cd4c049_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-71-ool0\"], \"image\": [\"chrome-xenial-20101000-265b45aa9e2\"], \"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\": [\"5595-820ff29\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1602966638741013",
"status": "COMPLETED",
"status_changed_ts": "1602968298416973",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/176765",
"builder:Linux Builder (dbg)",
"buildset:commit/git/8b0fb11f1bb8e9d1490b11fd252f17df9b851cbf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8b0fb11f1bb8e9d1490b11fd252f17df9b851cbf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031593471307089024",
"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/8866163409191626272/+/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:4f50f5b0a0e56410",
"user_agent:luci-scheduler"
],
"updated_ts": "1602968298428192",
"url": "https://ci.chromium.org/b/8866163409191626272",
"utcnow_ts": "1602968299507260"
}
}
[20:58:19.526] Invocation finished in 1h0m7.12625916s with status SUCCEEDED