[19:46:36.887] New invocation is queued and will start shortly
[19:46:38.391] Starting the invocation (attempt 1)
[19:46:38.463] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:46:38.463] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:46:38.463] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9061400602574988304",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d2c0e8facaaf4055ae6584221bc7ed083faa5423\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9061400602574988304",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/d2c0e8facaaf4055ae6584221bc7ed083faa5423",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d2c0e8facaaf4055ae6584221bc7ed083faa5423",
"gitiles_ref:refs/heads/master"
]
}
[19:46:39.316] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1574538398640549",
"id": "8895970540066097472",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d2c0e8facaaf4055ae6584221bc7ed083faa5423\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1574538399022797",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/165199",
"builder:Linux Builder (dbg)",
"buildset:commit/git/d2c0e8facaaf4055ae6584221bc7ed083faa5423",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d2c0e8facaaf4055ae6584221bc7ed083faa5423",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9061400602574988304",
"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/8895970540066097472/+/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": "1574538399022918",
"url": "https://ci.chromium.org/b/8895970540066097472",
"utcnow_ts": "1574538399308115"
}
}
[19:46:39.316] Task URL: https://ci.chromium.org/b/8895970540066097472
[19:46:39.316] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:2:0) after 1m0s
[19:47:39.305] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:2:0)
[19:47:39.305] Timer tick, asking Buildbucket for the build status
[19:47:40.096] Build 8895970540066097472: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:47:40.097] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:3:0) after 1m0s
[19:48:40.141] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:3:0)
[19:48:40.141] Timer tick, asking Buildbucket for the build status
[19:48:40.697] Build 8895970540066097472: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:48:40.697] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:4:0) after 1m0s
[19:49:40.830] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:4:0)
[19:49:40.830] Timer tick, asking Buildbucket for the build status
[19:49:41.024] Build 8895970540066097472: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:49:41.024] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:5:0) after 1m0s
[19:50:41.113] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:5:0)
[19:50:41.113] Timer tick, asking Buildbucket for the build status
[19:50:41.424] Build 8895970540066097472: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:50:41.424] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:6:0) after 1m0s
[19:51:08.067] Received PubSub notification, asking Buildbucket for the build status
[19:51:08.242] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:41.417] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:6:0)
[19:51:41.417] Timer tick, asking Buildbucket for the build status
[19:51:41.680] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:41.680] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:8:0) after 1m0s
[19:52:41.710] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:8:0)
[19:52:41.710] Timer tick, asking Buildbucket for the build status
[19:52:41.964] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:41.964] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:9:0) after 1m0s
[19:53:41.995] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:9:0)
[19:53:41.995] Timer tick, asking Buildbucket for the build status
[19:53:42.523] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:42.523] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:10:0) after 1m0s
[19:54:42.559] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:10:0)
[19:54:42.559] Timer tick, asking Buildbucket for the build status
[19:54:42.720] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:42.720] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:11:0) after 1m0s
[19:55:42.753] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:11:0)
[19:55:42.753] Timer tick, asking Buildbucket for the build status
[19:55:42.931] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:42.931] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:12:0) after 1m0s
[19:56:42.971] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:12:0)
[19:56:42.971] Timer tick, asking Buildbucket for the build status
[19:56:43.280] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:43.280] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:13:0) after 1m0s
[19:57:43.309] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:13:0)
[19:57:43.309] Timer tick, asking Buildbucket for the build status
[19:57:43.786] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:43.786] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:14:0) after 1m0s
[19:58:43.884] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:14:0)
[19:58:43.884] Timer tick, asking Buildbucket for the build status
[19:58:44.199] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:44.201] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:15:0) after 1m0s
[19:59:44.249] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:15:0)
[19:59:44.249] Timer tick, asking Buildbucket for the build status
[19:59:44.397] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:44.397] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:16:0) after 1m0s
[20:00:44.478] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:16:0)
[20:00:44.478] Timer tick, asking Buildbucket for the build status
[20:00:44.628] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:44.628] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:17:0) after 1m0s
[20:01:44.663] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:17:0)
[20:01:44.663] Timer tick, asking Buildbucket for the build status
[20:01:44.936] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:44.936] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:18:0) after 1m0s
[20:02:44.964] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:18:0)
[20:02:44.964] Timer tick, asking Buildbucket for the build status
[20:02:45.437] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:45.437] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:19:0) after 1m0s
[20:03:45.467] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:19:0)
[20:03:45.467] Timer tick, asking Buildbucket for the build status
[20:03:46.195] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:46.195] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:20:0) after 1m0s
[20:04:46.261] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:20:0)
[20:04:46.261] Timer tick, asking Buildbucket for the build status
[20:04:46.546] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:46.546] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:21:0) after 1m0s
[20:05:46.600] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:21:0)
[20:05:46.600] Timer tick, asking Buildbucket for the build status
[20:05:47.076] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:47.076] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:22:0) after 1m0s
[20:06:47.296] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:22:0)
[20:06:47.296] Timer tick, asking Buildbucket for the build status
[20:06:47.438] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:47.438] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:23:0) after 1m0s
[20:07:47.512] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:23:0)
[20:07:47.512] Timer tick, asking Buildbucket for the build status
[20:07:47.736] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:47.736] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:24:0) after 1m0s
[20:08:47.843] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:24:0)
[20:08:47.843] Timer tick, asking Buildbucket for the build status
[20:08:48.136] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:48.136] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:25:0) after 1m0s
[20:09:48.170] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:25:0)
[20:09:48.170] Timer tick, asking Buildbucket for the build status
[20:09:49.037] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:49.037] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:26:0) after 1m0s
[20:10:49.102] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:26:0)
[20:10:49.102] Timer tick, asking Buildbucket for the build status
[20:10:49.306] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:49.306] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:27:0) after 1m0s
[20:11:49.346] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:27:0)
[20:11:49.346] Timer tick, asking Buildbucket for the build status
[20:11:49.579] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:49.579] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:28:0) after 1m0s
[20:12:49.712] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:28:0)
[20:12:49.712] Timer tick, asking Buildbucket for the build status
[20:12:49.919] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:49.919] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:29:0) after 1m0s
[20:13:50.095] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:29:0)
[20:13:50.095] Timer tick, asking Buildbucket for the build status
[20:13:53.405] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:53.405] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:30:0) after 1m0s
[20:14:53.423] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:30:0)
[20:14:53.423] Timer tick, asking Buildbucket for the build status
[20:14:53.703] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:53.703] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:31:0) after 1m0s
[20:15:53.732] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:31:0)
[20:15:53.732] Timer tick, asking Buildbucket for the build status
[20:15:54.297] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:54.297] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:32:0) after 1m0s
[20:16:54.322] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:32:0)
[20:16:54.322] Timer tick, asking Buildbucket for the build status
[20:16:54.487] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:54.487] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:33:0) after 1m0s
[20:17:54.541] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:33:0)
[20:17:54.541] Timer tick, asking Buildbucket for the build status
[20:17:55.341] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:55.341] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:34:0) after 1m0s
[20:18:55.440] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:34:0)
[20:18:55.440] Timer tick, asking Buildbucket for the build status
[20:18:55.603] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:55.603] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:35:0) after 1m0s
[20:19:55.663] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:35:0)
[20:19:55.663] Timer tick, asking Buildbucket for the build status
[20:19:57.236] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:57.236] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:36:0) after 1m0s
[20:20:57.256] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:36:0)
[20:20:57.256] Timer tick, asking Buildbucket for the build status
[20:20:58.550] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:58.550] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:37:0) after 1m0s
[20:21:58.571] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:37:0)
[20:21:58.571] Timer tick, asking Buildbucket for the build status
[20:21:58.783] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:58.783] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:38:0) after 1m0s
[20:22:58.958] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:38:0)
[20:22:58.958] Timer tick, asking Buildbucket for the build status
[20:22:59.463] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:59.463] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:39:0) after 1m0s
[20:23:59.492] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:39:0)
[20:23:59.492] Timer tick, asking Buildbucket for the build status
[20:23:59.677] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:59.677] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:40:0) after 1m0s
[20:24:59.708] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:40:0)
[20:24:59.708] Timer tick, asking Buildbucket for the build status
[20:24:59.921] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:59.921] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:41:0) after 1m0s
[20:25:59.977] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:41:0)
[20:25:59.977] Timer tick, asking Buildbucket for the build status
[20:26:00.262] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:00.262] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:42:0) after 1m0s
[20:27:00.326] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:42:0)
[20:27:00.326] Timer tick, asking Buildbucket for the build status
[20:27:00.632] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:00.633] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:43:0) after 1m0s
[20:28:00.696] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:43:0)
[20:28:00.696] Timer tick, asking Buildbucket for the build status
[20:28:00.952] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:00.952] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:44:0) after 1m0s
[20:29:01.038] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:44:0)
[20:29:01.038] Timer tick, asking Buildbucket for the build status
[20:29:02.306] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:02.306] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:45:0) after 1m0s
[20:30:02.398] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:45:0)
[20:30:02.398] Timer tick, asking Buildbucket for the build status
[20:30:02.738] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:02.738] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:46:0) after 1m0s
[20:31:02.800] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:46:0)
[20:31:02.800] Timer tick, asking Buildbucket for the build status
[20:31:03.044] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:03.044] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:47:0) after 1m0s
[20:32:03.094] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:47:0)
[20:32:03.094] Timer tick, asking Buildbucket for the build status
[20:32:03.234] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:03.234] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:48:0) after 1m0s
[20:33:03.312] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:48:0)
[20:33:03.312] Timer tick, asking Buildbucket for the build status
[20:33:03.922] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:03.922] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:49:0) after 1m0s
[20:34:04.053] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:49:0)
[20:34:04.053] Timer tick, asking Buildbucket for the build status
[20:34:04.745] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:04.745] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:50:0) after 1m0s
[20:35:04.926] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:50:0)
[20:35:04.926] Timer tick, asking Buildbucket for the build status
[20:35:06.059] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:06.059] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:51:0) after 1m0s
[20:36:06.136] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:51:0)
[20:36:06.136] Timer tick, asking Buildbucket for the build status
[20:36:06.323] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:06.323] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:52:0) after 1m0s
[20:37:06.419] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:52:0)
[20:37:06.419] Timer tick, asking Buildbucket for the build status
[20:37:06.695] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:06.695] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:53:0) after 1m0s
[20:38:06.749] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:53:0)
[20:38:06.749] Timer tick, asking Buildbucket for the build status
[20:38:07.094] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:07.094] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:54:0) after 1m0s
[20:39:07.204] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:54:0)
[20:39:07.204] Timer tick, asking Buildbucket for the build status
[20:39:07.652] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:07.652] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:55:0) after 1m0s
[20:40:07.761] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:55:0)
[20:40:07.761] Timer tick, asking Buildbucket for the build status
[20:40:08.294] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:08.294] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:56:0) after 1m0s
[20:41:08.370] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:56:0)
[20:41:08.370] Timer tick, asking Buildbucket for the build status
[20:41:08.624] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:08.624] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:57:0) after 1m0s
[20:42:08.751] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:57:0)
[20:42:08.751] Timer tick, asking Buildbucket for the build status
[20:42:08.988] Build 8895970540066097472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:08.988] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9061400602574988304:58:0) after 1m0s
[20:42:38.872] Received PubSub notification, asking Buildbucket for the build status
[20:42:39.323] Build 8895970540066097472: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:42:39.323] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1574541757814156",
"created_by": "project:chromium",
"created_ts": "1574538398640549",
"id": "8895970540066097472",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d2c0e8facaaf4055ae6584221bc7ed083faa5423\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-118-6ojs\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 165199, \"got_angle_revision\": \"e9b68f332a30f60ba722c511b7335a38da6fa009\", \"got_dawn_revision\": \"8e9c3f663ccd270b8f047afe668e7cbc15e11bba\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"d2c0e8facaaf4055ae6584221bc7ed083faa5423\", \"got_revision_cp\": \"refs/heads/master@{#718452}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"4584a9c2ccb9f2a7bc7cd3c55f5b95507901e035\", \"got_v8_revision\": \"30319dfe043b83a37b6ba1c601a838d6544d4ec6\", \"got_v8_revision_cp\": \"refs/heads/8.0.353@{#1}\", \"got_webrtc_revision\": \"e43b53126600d247fbfde8b5c29b22ee22e59c86\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29873}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d2c0e8facaaf4055ae6584221bc7ed083faa5423\", \"swarm_hashes_refs/heads/master(at){#718452}_without_patch\": {\"accessibility_unittests\": \"d8a2c5625957743a79565758ac5281fc66b1bffa\", \"angle_unittests\": \"88d1e3e307fc6b5c992e16028f28397041a336da\", \"app_shell_unittests\": \"527451add7d913511a8c8b8901afeda4edcd503c\", \"aura_unittests\": \"8df157b00d0675c3ba8b8ea748766805df105f6a\", \"base_unittests\": \"337e7cff0d48d28551994c94c2f7e38163f49b70\", \"base_util_unittests\": \"77501f2793e1b18aa0a82c9abb13dbbfb18074f7\", \"blink_common_unittests\": \"a4700e4733c1f3d88bf72c70fe2290187d92d8c9\", \"blink_fuzzer_unittests\": \"ec899b2136bff74ec9ff65d25108fc40df97dba2\", \"blink_heap_unittests\": \"1533d7defcea6e123ed162a953fda1e81cc4d749\", \"blink_platform_unittests\": \"850ea061acc38f644aef06cd04dc42d66c7a5d52\", \"blink_python_tests\": \"db9992eab25567a229bb09bb65e31fcb920ab41c\", \"blink_unittests\": \"6a3d2738d5085ee37eaca30b1d9690e2991a2d1f\", \"blink_web_tests_exparchive\": \"3f2985938ee24e02c48737f418d10b7615f77f88\", \"boringssl_crypto_tests\": \"6846025d7dfb6d51bff3490a1a1bad6eeff1788b\", \"boringssl_ssl_tests\": \"fba7492a09c91823dcf7804c4af7a097591f8c1b\", \"browser_tests\": \"5990e311d058f39585c0fb062a1fd6b4bd103f4c\", \"cacheinvalidation_unittests\": \"84e7d6ffa377fab00543cb54aed6da7c1b5d5384\", \"capture_unittests\": \"92472ca44013b8fc656fc75b59613cf2c2ac2ac9\", \"cast_unittests\": \"2b8eb55a3989989992f5b57e027c1aebe8debffd\", \"cc_unittests\": \"f2f624c51e766400a00ec9471522b0a426a430da\", \"chrome_app_unittests\": \"5989ff9696b2b17c968861a64128fb5d0a9e8804\", \"chromedriver_unittests\": \"a2d841c8408bd02630499a20046498bb116b80c2\", \"color_unittests\": \"ed1335f81b3ab513f21208d8bd8da81ac6ed4488\", \"components_browsertests\": \"1d49afe00aebd3a08497ab4521f64a54ae718f8d\", \"components_unittests\": \"8dd2fe0f71c0ec20e76492ea4311d2e9a4672218\", \"compositor_unittests\": \"4979ff46feea2da4c0cbb132f6c4fbcfbc805316\", \"content_browsertests\": \"0371f2b428c8e3e6bb80cd4dcdf6e13fd1f2cae6\", \"content_shell_crash_test\": \"b61e4052a28bcf02eb899d02e29b070fcfa186dd\", \"content_unittests\": \"513ca7616998de6a19f808fb6085c41abe00ac5d\", \"crashpad_tests\": \"ce8c2075e8e1984ba32993d76a551a49c79d2e6a\", \"cronet_tests\": \"fa55b611306437eacc58953c68101818946719fe\", \"cronet_unittests\": \"dcaebbec8dbbaef49e988eaa2cb6558cbf4d4f1d\", \"crypto_unittests\": \"64ce5de414e86d1816b246a7ae8d63ffe160a889\", \"dbus_unittests\": \"b2e5aec10be3ede5a90cd8c18227d8cf601984b1\", \"device_unittests\": \"5a49a973b91f757804eff011cf9e010fdfd59015\", \"devtools_lint_check\": \"5bcbc1a1768a1980ddec922a979cebc08a7d380c\", \"devtools_type_check\": \"de90d91c8eaba6382055ec35a0fb769e2d503ab8\", \"display_unittests\": \"8e1a1bf969fc5ba9dadeae60a363aba21c7c37c7\", \"events_unittests\": \"9a3f8c91d2b33d975a3b91e3966299df5f46478a\", \"extensions_browsertests\": \"b04e6e6d6d7b0c055608a7483b83f2b3b0fdc616\", \"extensions_unittests\": \"254233b3e798127e758f23b273a90ad399119cd4\", \"filesystem_service_unittests\": \"f70fc4e86e95dd7c100fb630019e65ff3847dfe6\", \"flatbuffers_unittests\": \"68877d8b1262b0aa771438df1015a16a10098d5e\", \"gcm_unit_tests\": \"ba59e242cfd3174b3dc66b84cf3dda91a113d815\", \"gfx_unittests\": \"89f03ae0de290d7c2ffbc9281af5ac904615d005\", \"gin_unittests\": \"eef5dac3579c867e6d1559310d7f80440e9fb51f\", \"google_apis_unittests\": \"613b11b7f2dac064468ae33cc55e0414fad71561\", \"gpu_unittests\": \"77b46b3be020b521033b411c373c6a8530463147\", \"grit_python_unittests\": \"4267cdfe96cbb5881cc25cc5b15aab4b2f28c5f5\", \"gwp_asan_unittests\": \"8e180d23327cdd5e5ac91c51934f0a23cb9bfd40\", \"headless_browsertests\": \"bf946c607ae6ccc27c4c8f358aed8aff221b54ef\", \"headless_unittests\": \"1ec8c5b6a3aec5b214ec84163f29babc96dbf12c\", \"interactive_ui_tests\": \"e4b7986cc21011f051514b131ba09753eb71a0f4\", \"ipc_tests\": \"14698cd70b61ce891ede2bb735034435e97a2cc3\", \"jingle_unittests\": \"2db3e210a60225161ade4f40ad9719411f4ebbb1\", \"latency_unittests\": \"8358e38980ae1591de87bde445871a47e914bb91\", \"libjingle_xmpp_unittests\": \"5cde3b4d5df240a1355e060cabffecbe7b22a84f\", \"media_blink_unittests\": \"7b0df0031ed29d74b8bb0429f53c3981f2a40d22\", \"media_service_unittests\": \"52243228c63f67edf751a51be6738ac5ab6d5148\", \"media_unittests\": \"9242711bc0f9f441e6a049ad173c2d2ef2cfad5d\", \"message_center_unittests\": \"c07ff1b557821a0cac1dc70effd502e38e77617c\", \"metrics_python_tests\": \"d6b3a41330833f6671aac1668304e750fd7cb4dd\", \"midi_unittests\": \"5cd8c89082dfbf8e765aa05bf49fc32f25ea98f1\", \"mojo_core_unittests\": \"88708fbd0aa0b351785db75843b92717adda24c9\", \"mojo_unittests\": \"d468e7542c3e1646a13efe280291d4b1cd801f82\", \"nacl_helper_nonsfi_unittests\": \"c5f28b6522014b24830d2c406ddfdc26c3e27848\", \"nacl_loader_unittests\": \"c52377e6d98c848d1f092f7e9b05701808952b4b\", \"native_theme_unittests\": \"2a5fe3e44900c0dd9f55e45ddb55367ad542eb1b\", \"net_unittests\": \"19c109cdfa2ca4e148c3ef9e8454f07f183eed74\", \"pdf_unittests\": \"c9b33e7c3c5fd0bbc7b6284e9a74fd8066f67e2e\", \"perfetto_unittests\": \"bd2cb0f222d132f6b9fa74c6f36c428d1c76b4ea\", \"ppapi_unittests\": \"3098021c5109aa4a65ebe595abbd0f9aa6b3602a\", \"printing_unittests\": \"c92c974bb9de39dfb17d1897ea9a84df15489178\", \"remoting_unittests\": \"7034587c05fe41ec7a9a53f71ef7ff31d4ee4609\", \"sandbox_linux_unittests\": \"c2abc79a246c02be81f11be5a8cec2c1ae6a2ef0\", \"service_manager_unittests\": \"65271173687e05f2b48daafcb65783758b30d366\", \"services_unittests\": \"7942304886863ebbc5a31535842186085be5ee2e\", \"shell_dialogs_unittests\": \"eede09939776f935ab07e2603244fecc7f92b459\", \"skia_unittests\": \"91abad4babafdc1a5d36df116c0226bfce0f365b\", \"snapshot_unittests\": \"84af89d17652a4ae376f3c461d8020242ba484d1\", \"sql_unittests\": \"7b8353bd559d71db120a923765a3dfaadd586cc5\", \"storage_unittests\": \"a80160f9a601ddb176cf844894ce979fe2dcfb61\", \"sync_integration_tests\": \"a775f217b7889bee24b1ca7b51796f55c1c3560d\", \"telemetry_gpu_unittests\": \"f34741b7256505f074775bcd087bdc2762f7e26d\", \"telemetry_perf_unittests\": \"92f8e2b68f6d4e624392d368b791911dee85d2ce\", \"telemetry_unittests\": \"d40489924613e51f106cddcd35e4901fc73b547b\", \"traffic_annotation_auditor_unittests\": \"747d30659991c975b58647a9df90fd83aa60dabf\", \"ui_base_unittests\": \"6923dd163a00a2298ab53b3bcb1f08b7752127ba\", \"ui_touch_selection_unittests\": \"049e533bc2e09399f9e5e6192238c8f02824ac21\", \"unit_tests\": \"2dde777873abade7c542aad5eb60c1a577dceff8\", \"url_unittests\": \"0b578ef321232ac9b986ffb98b1417ae2e86232a\", \"views_perftests\": \"c92b2808e6e194067c7c8bc8f637d4caf0aea118\", \"views_unittests\": \"72de93842f4b4dbe6bdb232adea3cb2d6e483efd\", \"viz_unittests\": \"147d9e9ab7d6f506c3ef14d03dc072f64b546b44\", \"vr_common_unittests\": \"418063bd56c06e7c0af2f3f5ecea30bb09a58a0c\", \"vr_pixeltests\": \"44f014d42e58e12aec09d21357e875e55493bf11\", \"webdriver_wpt_tests\": \"8a301ce5e9d70a7b22f216966f249a6210d74c50\", \"weblayer_browsertests\": \"208eb111cc9eee373581168ca8c07a9e9357ef1f\", \"wm_unittests\": \"ae66f4be47c6d144f2dbb9a5b265938358329cff\", \"wtf_unittests\": \"70d7c6ce840f0a0bad7d5e3723bb7533ab4c78fc\", \"xr_browser_tests\": \"80084e522c60945f833643438bea4e64c1ed9328\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0e7d7e672723aea6cc752b70abb9e3aec1540865d07a8c2471e48d2b0cb9abe3_v2\", \"builder_497278b5819f10111ab639898a894ad19d361b24d185228ca986cf767de7a7ef_v2\", \"builder_980e79f61a9eb10b3ecd5f710f08f0308a5299da9889db3d2b6a7010c019cc1f_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-118-6ojs\"], \"image\": [\"chrome-xenial-19112100-3085293b610\"], \"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\": [\"4651-c74e250\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1574538667137678",
"status": "COMPLETED",
"status_changed_ts": "1574541758143769",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/165199",
"builder:Linux Builder (dbg)",
"buildset:commit/git/d2c0e8facaaf4055ae6584221bc7ed083faa5423",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d2c0e8facaaf4055ae6584221bc7ed083faa5423",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9061400602574988304",
"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/8895970540066097472/+/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:48b29ed709c5ed10",
"user_agent:luci-scheduler"
],
"updated_ts": "1574541758164175",
"url": "https://ci.chromium.org/b/8895970540066097472",
"utcnow_ts": "1574541759310990"
}
}
[20:42:39.323] Invocation finished in 56m2.459625861s with status SUCCEEDED