[19:26:38.309] New invocation is queued and will start shortly
[19:26:39.380] Starting the invocation (attempt 1)
[19:26:39.453] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:26:39.453] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:26:39.453] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9052070371827771584",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d49f0f21eec162aee80c5999a18540cfb205178e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9052070371827771584",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/d49f0f21eec162aee80c5999a18540cfb205178e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d49f0f21eec162aee80c5999a18540cfb205178e",
"gitiles_ref:refs/heads/master"
]
}
[19:26:40.449] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1583436399579542",
"id": "8886640309833347312",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d49f0f21eec162aee80c5999a18540cfb205178e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1583436400124656",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169379",
"builder:Linux Builder (dbg)",
"buildset:commit/git/d49f0f21eec162aee80c5999a18540cfb205178e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d49f0f21eec162aee80c5999a18540cfb205178e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052070371827771584",
"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/8886640309833347312/+/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": "1583436400124768",
"url": "https://ci.chromium.org/b/8886640309833347312",
"utcnow_ts": "1583436400427098"
}
}
[19:26:40.449] Task URL: https://ci.chromium.org/b/8886640309833347312
[19:26:40.449] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:2:0) after 1m0s
[19:27:40.541] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:2:0)
[19:27:40.541] Timer tick, asking Buildbucket for the build status
[19:27:40.633] Build 8886640309833347312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:27:40.633] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:3:0) after 1m0s
[19:28:40.680] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:3:0)
[19:28:40.680] Timer tick, asking Buildbucket for the build status
[19:28:40.792] Build 8886640309833347312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:28:40.792] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:4:0) after 1m0s
[19:29:40.856] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:4:0)
[19:29:40.856] Timer tick, asking Buildbucket for the build status
[19:29:40.993] Build 8886640309833347312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:29:40.993] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:5:0) after 1m0s
[19:30:41.048] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:5:0)
[19:30:41.048] Timer tick, asking Buildbucket for the build status
[19:30:41.184] Build 8886640309833347312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:30:41.184] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:6:0) after 1m0s
[19:31:06.956] Received PubSub notification, asking Buildbucket for the build status
[19:31:07.192] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:41.204] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:6:0)
[19:31:41.204] Timer tick, asking Buildbucket for the build status
[19:31:41.339] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:41.339] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:8:0) after 1m0s
[19:32:41.379] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:8:0)
[19:32:41.379] Timer tick, asking Buildbucket for the build status
[19:32:41.546] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:41.546] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:9:0) after 1m0s
[19:33:41.573] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:9:0)
[19:33:41.573] Timer tick, asking Buildbucket for the build status
[19:33:41.977] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:41.977] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:10:0) after 1m0s
[19:34:42.032] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:10:0)
[19:34:42.032] Timer tick, asking Buildbucket for the build status
[19:34:42.323] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:42.323] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:11:0) after 1m0s
[19:35:42.469] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:11:0)
[19:35:42.469] Timer tick, asking Buildbucket for the build status
[19:35:42.550] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:42.550] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:12:0) after 1m0s
[19:36:42.823] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:12:0)
[19:36:42.823] Timer tick, asking Buildbucket for the build status
[19:36:44.034] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:44.034] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:13:0) after 1m0s
[19:37:44.242] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:13:0)
[19:37:44.242] Timer tick, asking Buildbucket for the build status
[19:37:44.411] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:44.411] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:14:0) after 1m0s
[19:38:44.524] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:14:0)
[19:38:44.524] Timer tick, asking Buildbucket for the build status
[19:38:44.764] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:44.764] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:15:0) after 1m0s
[19:39:44.842] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:15:0)
[19:39:44.842] Timer tick, asking Buildbucket for the build status
[19:39:45.034] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:45.034] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:16:0) after 1m0s
[19:40:45.142] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:16:0)
[19:40:45.142] Timer tick, asking Buildbucket for the build status
[19:40:45.293] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:45.293] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:17:0) after 1m0s
[19:41:45.305] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:17:0)
[19:41:45.305] Timer tick, asking Buildbucket for the build status
[19:41:45.429] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:45.429] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:18:0) after 1m0s
[19:42:45.449] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:18:0)
[19:42:45.449] Timer tick, asking Buildbucket for the build status
[19:42:45.745] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:45.745] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:19:0) after 1m0s
[19:43:45.911] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:19:0)
[19:43:45.911] Timer tick, asking Buildbucket for the build status
[19:43:46.016] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:46.016] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:20:0) after 1m0s
[19:44:46.077] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:20:0)
[19:44:46.077] Timer tick, asking Buildbucket for the build status
[19:44:46.193] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:46.193] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:21:0) after 1m0s
[19:45:46.353] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:21:0)
[19:45:46.353] Timer tick, asking Buildbucket for the build status
[19:45:46.694] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:46.694] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:22:0) after 1m0s
[19:46:46.728] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:22:0)
[19:46:46.728] Timer tick, asking Buildbucket for the build status
[19:46:46.823] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:46.823] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:23:0) after 1m0s
[19:47:46.895] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:23:0)
[19:47:46.895] Timer tick, asking Buildbucket for the build status
[19:47:47.173] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:47.173] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:24:0) after 1m0s
[19:48:47.210] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:24:0)
[19:48:47.210] Timer tick, asking Buildbucket for the build status
[19:48:47.304] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:47.304] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:25:0) after 1m0s
[19:49:47.345] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:25:0)
[19:49:47.345] Timer tick, asking Buildbucket for the build status
[19:49:47.605] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:47.605] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:26:0) after 1m0s
[19:50:47.802] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:26:0)
[19:50:47.802] Timer tick, asking Buildbucket for the build status
[19:50:47.898] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:47.898] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:27:0) after 1m0s
[19:51:48.082] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:27:0)
[19:51:48.082] Timer tick, asking Buildbucket for the build status
[19:51:48.188] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:48.188] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:28:0) after 1m0s
[19:52:48.326] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:28:0)
[19:52:48.326] Timer tick, asking Buildbucket for the build status
[19:52:48.428] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:48.428] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:29:0) after 1m0s
[19:53:48.487] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:29:0)
[19:53:48.487] Timer tick, asking Buildbucket for the build status
[19:53:48.950] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:48.950] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:30:0) after 1m0s
[19:54:48.978] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:30:0)
[19:54:48.978] Timer tick, asking Buildbucket for the build status
[19:54:49.447] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:49.447] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:31:0) after 1m0s
[19:55:49.557] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:31:0)
[19:55:49.557] Timer tick, asking Buildbucket for the build status
[19:55:49.773] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:49.773] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:32:0) after 1m0s
[19:56:49.826] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:32:0)
[19:56:49.826] Timer tick, asking Buildbucket for the build status
[19:56:49.915] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:49.915] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:33:0) after 1m0s
[19:57:49.970] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:33:0)
[19:57:49.970] Timer tick, asking Buildbucket for the build status
[19:57:50.232] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:50.232] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:34:0) after 1m0s
[19:58:50.465] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:34:0)
[19:58:50.465] Timer tick, asking Buildbucket for the build status
[19:58:50.853] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:50.853] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:35:0) after 1m0s
[19:59:51.010] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:35:0)
[19:59:51.010] Timer tick, asking Buildbucket for the build status
[19:59:51.153] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:51.153] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:36:0) after 1m0s
[20:00:51.206] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:36:0)
[20:00:51.206] Timer tick, asking Buildbucket for the build status
[20:00:51.439] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:51.439] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:37:0) after 1m0s
[20:01:51.474] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:37:0)
[20:01:51.474] Timer tick, asking Buildbucket for the build status
[20:01:51.568] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:51.568] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:38:0) after 1m0s
[20:02:51.617] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:38:0)
[20:02:51.617] Timer tick, asking Buildbucket for the build status
[20:02:51.712] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:51.712] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:39:0) after 1m0s
[20:03:51.820] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:39:0)
[20:03:51.820] Timer tick, asking Buildbucket for the build status
[20:03:52.212] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:52.212] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:40:0) after 1m0s
[20:04:52.312] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:40:0)
[20:04:52.312] Timer tick, asking Buildbucket for the build status
[20:04:52.415] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:52.415] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:41:0) after 1m0s
[20:05:52.479] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:41:0)
[20:05:52.479] Timer tick, asking Buildbucket for the build status
[20:05:52.668] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:52.668] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:42:0) after 1m0s
[20:06:52.723] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:42:0)
[20:06:52.723] Timer tick, asking Buildbucket for the build status
[20:06:52.848] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:52.848] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:43:0) after 1m0s
[20:07:52.922] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:43:0)
[20:07:52.922] Timer tick, asking Buildbucket for the build status
[20:07:53.493] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:53.493] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:44:0) after 1m0s
[20:08:53.555] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:44:0)
[20:08:53.555] Timer tick, asking Buildbucket for the build status
[20:08:53.778] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:53.778] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:45:0) after 1m0s
[20:09:53.889] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:45:0)
[20:09:53.889] Timer tick, asking Buildbucket for the build status
[20:09:54.189] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:54.189] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:46:0) after 1m0s
[20:10:54.344] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:46:0)
[20:10:54.344] Timer tick, asking Buildbucket for the build status
[20:10:56.881] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:56.881] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:47:0) after 1m0s
[20:11:56.967] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:47:0)
[20:11:56.967] Timer tick, asking Buildbucket for the build status
[20:11:57.481] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:57.481] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:48:0) after 1m0s
[20:12:57.552] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:48:0)
[20:12:57.552] Timer tick, asking Buildbucket for the build status
[20:12:57.659] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:57.659] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:49:0) after 1m0s
[20:13:57.665] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:49:0)
[20:13:57.665] Timer tick, asking Buildbucket for the build status
[20:13:57.983] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:57.983] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:50:0) after 1m0s
[20:14:57.987] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:50:0)
[20:14:57.987] Timer tick, asking Buildbucket for the build status
[20:15:00.338] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:00.338] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:51:0) after 1m0s
[20:16:00.410] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:51:0)
[20:16:00.410] Timer tick, asking Buildbucket for the build status
[20:16:00.904] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:00.904] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:52:0) after 1m0s
[20:17:01.044] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:52:0)
[20:17:01.044] Timer tick, asking Buildbucket for the build status
[20:17:01.545] Build 8886640309833347312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:01.545] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052070371827771584:53:0) after 1m0s
[20:17:06.001] Received PubSub notification, asking Buildbucket for the build status
[20:17:06.073] Build 8886640309833347312: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:17:06.073] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1583439425015254",
"created_by": "project:chromium",
"created_ts": "1583436399579542",
"id": "8886640309833347312",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d49f0f21eec162aee80c5999a18540cfb205178e\"}}",
"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-65-woit\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 169379, \"got_angle_revision\": \"852653954526386c86f120f6120b70fb74904b94\", \"got_dawn_revision\": \"56f1678437ba88107630c97033615eaf22eb996c\", \"got_nacl_revision\": \"35bcc9f6d5e81c3c39ad57de97ef9cd22301ee9e\", \"got_revision\": \"d49f0f21eec162aee80c5999a18540cfb205178e\", \"got_revision_cp\": \"refs/heads/master@{#747365}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"51b2800bb317d9ab6026e6123c62f013dd5cf5e4\", \"got_v8_revision\": \"fbadeeaf76d8a5000c7c5cd6e913be73ad46d524\", \"got_v8_revision_cp\": \"refs/heads/8.2.266@{#1}\", \"got_webrtc_revision\": \"b05ca4b6168ccad0db5f6350d438272e59a3b9ca\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30691}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d49f0f21eec162aee80c5999a18540cfb205178e\", \"swarm_hashes_refs/heads/master(at){#747365}_without_patch\": {\"accessibility_unittests\": \"9588f0e9f87ebe0c1f5404c24b233478ad0276e3\", \"angle_unittests\": \"4f303405ef67c11ee05c0a25d209f1a07cf7ff3b\", \"app_shell_unittests\": \"5aabb6735703da6a03d6b8567cad0c4de2496bbe\", \"aura_unittests\": \"9e6abc668e2dd105f6900bce87fd0546e554183d\", \"base_unittests\": \"7097f39fb55cf768bf92b6a63eefce3d2b626040\", \"base_util_unittests\": \"794d4196d5413fe16d119d15ef5778f721a45194\", \"blink_common_unittests\": \"dd88e8240032c6c70a9d0371a1068b38d131fa7e\", \"blink_fuzzer_unittests\": \"a23cbe400a43213ae9470f17cac7258ff09b18f0\", \"blink_heap_unittests\": \"f0539fd8e08d4cc8e378fbe3eead43fc3270715c\", \"blink_platform_unittests\": \"59d4de7a1630b4f2fc577e7da993f618e56107ea\", \"blink_python_tests\": \"6e2ac86836f25bf1d9f1dc252e8938580aee3948\", \"blink_unittests\": \"ab44ad2f508002a75cc4fc93c260bab3497e594e\", \"blink_web_tests\": \"5d97fe41f7e97e1640784ad3fa1f8ec4c67ff623\", \"boringssl_crypto_tests\": \"41bc75bc54f631ffc15295ff4a9eac7feb96eb67\", \"boringssl_ssl_tests\": \"16144a8618586b0ebf9314902e8e89ca1769b98f\", \"browser_tests\": \"55d0d14bed5d68960eb4ef3ab1898e4d38cd8670\", \"cacheinvalidation_unittests\": \"2ba7f0b39e1f5843974c10cc6d89d6d5236d7493\", \"capture_unittests\": \"94686c5a50aae0b94e701be28ee7192f81331337\", \"cast_unittests\": \"702d8523727dff5317b544b7e8928207064d195e\", \"cc_unittests\": \"df74cd95f3d16d75f442e84be33b98bbd0a50497\", \"chrome_app_unittests\": \"717cfa0038a33ab39356fea2622ccebc626b5f3f\", \"chromedriver_unittests\": \"3c894e6bc66474e6841ca161c56500272cd81d8a\", \"components_browsertests\": \"3d6f7b20107f1d0843a347887a99a448d75b3421\", \"components_unittests\": \"66e5bb20cdbf1eac3de74795cfc4c12a9c4d8d81\", \"compositor_unittests\": \"522d815a5c6c0aaf9c2e23853870a2c67b2b2db1\", \"content_browsertests\": \"2dcefee28c63ad9be4991c95cb5b9a79dd77aff5\", \"content_shell_crash_test\": \"0440f1d756924b55434f3f8fed6393f06ef141e7\", \"content_unittests\": \"dd86cb73e0c2feddaa88d9c79b8a6580ca15e5a4\", \"crashpad_tests\": \"694f888812a8fca95481bcb36c1ed69c807632de\", \"cronet_tests\": \"e2690338df0428e165e07f1ac0ec501680facc7c\", \"cronet_unittests\": \"aa2a545531255ab2fd568d6bd8804a7fd4f1f25e\", \"crypto_unittests\": \"0b61de918892db44da73d9b70a7ee891dde037e5\", \"dbus_unittests\": \"338a4b27b75bfc442e205b88099033dd05bff6a6\", \"device_unittests\": \"c1be4a6193ff683aa1b8fa7133e5ead7c805c27d\", \"display_unittests\": \"3bec9fd91b07de14f3a4ec3d213c7a4db99bdbb7\", \"events_unittests\": \"6b4d0ebb156477951ba38980315a8ab4471ee3f2\", \"extensions_browsertests\": \"d7dbbe8b15a80ce3ec1d8330ba38b33e1c9f7270\", \"extensions_unittests\": \"3fd4f94af8c507fc46936a6a040b7bc0bf26fc9f\", \"filesystem_service_unittests\": \"7742796d4352446f88530748d75871c2321fd159\", \"flatbuffers_unittests\": \"501dfa51280eae93fccecaec30d9257cff6dbcc8\", \"gcm_unit_tests\": \"91f306fcd8c8db9a66a98ad6e906057878cded1b\", \"gfx_unittests\": \"1163e2be889e018a2d3d2f009a09b057338a63db\", \"gin_unittests\": \"559901184bcea452e3a8256345728a97ac0e73e2\", \"google_apis_unittests\": \"2a7b0feea6d5d388546bb8485f6111bd4bf5ac8a\", \"gpu_unittests\": \"35f824a77ea41e2ee2f475aec9117fed936deca6\", \"grit_python_unittests\": \"300ea8455288eab00cd459e887bd99a4f6468e8a\", \"gwp_asan_unittests\": \"d1a9e10846dcde4687cc06ce79679093a25325a0\", \"headless_browsertests\": \"87637e802c36c28ef08c78072f746cd42b0fed5b\", \"headless_unittests\": \"ebbff892840b8c05bba2530bba7c4c07336a0695\", \"interactive_ui_tests\": \"af145dfb1ceb917cdfb3b09d4bad54b883622895\", \"ipc_tests\": \"f64c4a286864b2e4c2e8c7f22806ba93f5cf83cd\", \"jingle_unittests\": \"c933ceb8ae2ede67d433bb9f34f4f8ccb4d2c271\", \"latency_unittests\": \"8baab49f2e9a55bba4d5db868795f71a4b56ba83\", \"libjingle_xmpp_unittests\": \"723a5a95e848f068de5bf59969a6a06e50d3d028\", \"media_blink_unittests\": \"4b84f5a99c4d054f99d8fe325597c712fef3b23c\", \"media_service_unittests\": \"f65a50b20cdc43232af330de07589bee8fd9f489\", \"media_unittests\": \"0f3135981cfcc1d5dbf2e2f710d00d9cf9b3b4ba\", \"message_center_unittests\": \"80e4d7289824dd01a0d8f5d09d88f1daf5688e65\", \"metrics_python_tests\": \"cc997a8acb50c05f404eae817c648d279f8ff3f7\", \"midi_unittests\": \"34f07d24c6b271e6258b20018e246d57a5fbfe16\", \"mojo_core_unittests\": \"d3de3f095815d6b6ef0741cbcb08539075ad5f44\", \"mojo_unittests\": \"d5ced4dc5f3df861a922086fb0aa6cc47b41d043\", \"nacl_helper_nonsfi_unittests\": \"5fd1bc43e6818ace9af48c79a6fe5d98c95c6085\", \"nacl_loader_unittests\": \"a1f8ec9195ba7e176ce6285acf8febb59e29f9d1\", \"native_theme_unittests\": \"c1f5dad9aa40abb035ec64e0eccff3bc6c848f25\", \"net_unittests\": \"25b90ab19453e83ac7d007891dd7de545f71339d\", \"pdf_unittests\": \"b807dcef5184e6482bbf58762d582cade23ced5c\", \"perfetto_unittests\": \"699afc08d6b9227ca6bd1acf7365fc3c2d781616\", \"ppapi_unittests\": \"306fff2147a2e6b168fd9531051a8121f32ccf43\", \"printing_unittests\": \"671dda7957e86e0c98749ff2ab2bf61996bc2ed6\", \"remoting_unittests\": \"2ca547cb902435a6425d3c4c04fbcc2f82a3b003\", \"sandbox_linux_unittests\": \"42b18f9cf007583d857c8057377b9b25a2d2c99c\", \"service_manager_unittests\": \"033f18da7734b8a38ff9e06d4ca314a094fbde17\", \"services_unittests\": \"7a67969a9f40632bbc3081d2836c4e7c63f9ad3a\", \"shell_dialogs_unittests\": \"04e8c1d876f4be61c67d73f32f945d939a2f39f6\", \"skia_unittests\": \"e961b91061f1dafb7e581115d21ad2f929e8e40d\", \"snapshot_unittests\": \"4dc60337eed607d701d6af941605052a2a5dcbd6\", \"sql_unittests\": \"332ac45001eedaab46320decddd57bf03936858d\", \"storage_unittests\": \"1595de1fbcc6cd9355b45e2c1219c4df1bf0337a\", \"sync_integration_tests\": \"f2927b6a6f4a019a0948a5582dbbefdecfcc4c49\", \"telemetry_gpu_unittests\": \"72ec4705043fc8de1f551b0c8d1df5630100c714\", \"telemetry_perf_unittests\": \"26ed9e366a523b7af126fcdf931378a85ea781e0\", \"telemetry_unittests\": \"c5ec9521cee9f3f8efc84467dd56646725799754\", \"traffic_annotation_auditor_unittests\": \"ae8da293fbe5f04297c69f9c87024668810f98e7\", \"ui_base_unittests\": \"203562554c6784e37cbf7fda002216a9cc57aca8\", \"ui_touch_selection_unittests\": \"7441542a3e353557238b509e0b3ca496cf6365b0\", \"unit_tests\": \"511938b157b7a1cb45ec722650e299631868b9a0\", \"url_unittests\": \"f86f81594de90ec7399b5a3d34ae6aa2826840df\", \"views_perftests\": \"f190daa101b377638a8319033f257e7d7d096467\", \"views_unittests\": \"02394921ffd7d5cd5f1e82548d6cfd20726cea6d\", \"viz_unittests\": \"22d42446476a88cced109145c5192a4f61309f07\", \"vr_common_unittests\": \"0ed4683e528e11a8fd650c87d3222cbbb204ef62\", \"vr_pixeltests\": \"42b0c43574d67b1162042fd4a6703fb3d8376cac\", \"webdriver_wpt_tests\": \"468e942d34443f71c854f64e867c59f7b23b9135\", \"weblayer_browsertests\": \"1ff25d3721afc6222a6c8e4315e25c8c09a18c36\", \"wm_unittests\": \"35439bfefd94701a46c35336d3d24280d3d04dea\", \"wtf_unittests\": \"4be56d71b00429653d01d12fe7cb27dad5e69a82\", \"xr_browser_tests\": \"48a119e8688ec68e00d9dd3b5a323c1c26ac09d5\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_28bbe8e6e9c00f2d4cca6bb7518e2e3abcc6dba52c0db172294f96352b49589a_v2\", \"builder_d78b729059d6d7166c1c60b6c63641496a1541bf700cb46d40203a280149f161_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-65-woit\"], \"image\": [\"chrome-xenial-20030100-2bddf837f90\"], \"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\": [\"4851-268d16b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1583436665972994",
"status": "COMPLETED",
"status_changed_ts": "1583439425347433",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169379",
"builder:Linux Builder (dbg)",
"buildset:commit/git/d49f0f21eec162aee80c5999a18540cfb205178e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d49f0f21eec162aee80c5999a18540cfb205178e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052070371827771584",
"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/8886640309833347312/+/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:4ac4fb8ffd960110",
"user_agent:luci-scheduler"
],
"updated_ts": "1583439425352489",
"url": "https://ci.chromium.org/b/8886640309833347312",
"utcnow_ts": "1583439426057016"
}
}
[20:17:06.073] Invocation finished in 50m27.780444252s with status SUCCEEDED