[09:03:34.752] New invocation is queued and will start shortly
[09:03:35.899] Starting the invocation (attempt 1)
[09:03:35.940] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:03:35.940] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:03:35.940] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9032087641758074736",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"cd2cafa052cfa8c38d09a3022a927b6919aa1eab\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9032087641758074736",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/cd2cafa052cfa8c38d09a3022a927b6919aa1eab",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cd2cafa052cfa8c38d09a3022a927b6919aa1eab",
"gitiles_ref:refs/heads/master"
]
}
[09:03:36.846] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1602493416040436",
"id": "8866657579740863792",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cd2cafa052cfa8c38d09a3022a927b6919aa1eab\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1602493416616761",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/176570",
"builder:Linux Builder (dbg)",
"buildset:commit/git/cd2cafa052cfa8c38d09a3022a927b6919aa1eab",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cd2cafa052cfa8c38d09a3022a927b6919aa1eab",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9032087641758074736",
"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/8866657579740863792/+/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": "1602493416616926",
"url": "https://ci.chromium.org/b/8866657579740863792",
"utcnow_ts": "1602493416839017"
}
}
[09:03:36.846] Task URL: https://ci.chromium.org/b/8866657579740863792
[09:03:36.846] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:2:0) after 1m0s
[09:04:36.840] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:2:0)
[09:04:36.840] Timer tick, asking Buildbucket for the build status
[09:04:36.939] Build 8866657579740863792: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:04:36.939] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:3:0) after 1m0s
[09:05:37.005] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:3:0)
[09:05:37.006] Timer tick, asking Buildbucket for the build status
[09:05:37.074] Build 8866657579740863792: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:05:37.074] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:4:0) after 1m0s
[09:06:37.262] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:4:0)
[09:06:37.262] Timer tick, asking Buildbucket for the build status
[09:06:37.353] Build 8866657579740863792: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:06:37.353] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:5:0) after 1m0s
[09:07:37.408] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:5:0)
[09:07:37.408] Timer tick, asking Buildbucket for the build status
[09:07:37.603] Build 8866657579740863792: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:07:37.603] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:6:0) after 1m0s
[09:08:04.464] Received PubSub notification, asking Buildbucket for the build status
[09:08:04.587] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:37.666] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:6:0)
[09:08:37.666] Timer tick, asking Buildbucket for the build status
[09:08:37.848] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:37.848] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:8:0) after 1m0s
[09:09:37.948] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:8:0)
[09:09:37.948] Timer tick, asking Buildbucket for the build status
[09:09:38.119] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:38.119] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:9:0) after 1m0s
[09:10:38.136] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:9:0)
[09:10:38.136] Timer tick, asking Buildbucket for the build status
[09:10:38.224] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:38.224] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:10:0) after 1m0s
[09:11:38.244] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:10:0)
[09:11:38.244] Timer tick, asking Buildbucket for the build status
[09:11:38.347] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:38.347] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:11:0) after 1m0s
[09:12:38.530] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:11:0)
[09:12:38.530] Timer tick, asking Buildbucket for the build status
[09:12:38.850] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:38.850] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:12:0) after 1m0s
[09:13:39.021] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:12:0)
[09:13:39.021] Timer tick, asking Buildbucket for the build status
[09:13:39.178] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:39.178] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:13:0) after 1m0s
[09:14:39.207] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:13:0)
[09:14:39.207] Timer tick, asking Buildbucket for the build status
[09:14:39.292] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:39.292] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:14:0) after 1m0s
[09:15:39.429] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:14:0)
[09:15:39.429] Timer tick, asking Buildbucket for the build status
[09:15:39.493] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:39.493] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:15:0) after 1m0s
[09:16:39.517] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:15:0)
[09:16:39.517] Timer tick, asking Buildbucket for the build status
[09:16:41.342] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:41.342] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:16:0) after 1m0s
[09:17:41.364] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:16:0)
[09:17:41.364] Timer tick, asking Buildbucket for the build status
[09:17:41.462] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:41.462] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:17:0) after 1m0s
[09:18:41.511] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:17:0)
[09:18:41.511] Timer tick, asking Buildbucket for the build status
[09:18:41.640] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:41.640] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:18:0) after 1m0s
[09:19:41.659] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:18:0)
[09:19:41.659] Timer tick, asking Buildbucket for the build status
[09:19:41.740] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:41.740] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:19:0) after 1m0s
[09:20:41.823] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:19:0)
[09:20:41.823] Timer tick, asking Buildbucket for the build status
[09:20:41.882] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:41.882] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:20:0) after 1m0s
[09:21:41.860] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:20:0)
[09:21:41.860] Timer tick, asking Buildbucket for the build status
[09:21:41.943] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:41.943] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:21:0) after 1m0s
[09:22:41.931] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:21:0)
[09:22:41.931] Timer tick, asking Buildbucket for the build status
[09:22:41.997] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:41.997] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:22:0) after 1m0s
[09:23:42.021] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:22:0)
[09:23:42.021] Timer tick, asking Buildbucket for the build status
[09:23:42.129] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:42.129] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:23:0) after 1m0s
[09:24:42.170] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:23:0)
[09:24:42.170] Timer tick, asking Buildbucket for the build status
[09:24:42.696] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:42.696] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:24:0) after 1m0s
[09:25:42.731] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:24:0)
[09:25:42.731] Timer tick, asking Buildbucket for the build status
[09:25:42.796] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:42.796] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:25:0) after 1m0s
[09:26:42.819] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:25:0)
[09:26:42.819] Timer tick, asking Buildbucket for the build status
[09:26:42.881] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:42.881] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:26:0) after 1m0s
[09:27:42.916] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:26:0)
[09:27:42.916] Timer tick, asking Buildbucket for the build status
[09:27:43.295] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:43.295] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:27:0) after 1m0s
[09:28:43.355] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:27:0)
[09:28:43.355] Timer tick, asking Buildbucket for the build status
[09:28:43.535] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:43.536] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:28:0) after 1m0s
[09:29:43.548] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:28:0)
[09:29:43.548] Timer tick, asking Buildbucket for the build status
[09:29:43.626] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:43.626] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:29:0) after 1m0s
[09:30:43.687] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:29:0)
[09:30:43.687] Timer tick, asking Buildbucket for the build status
[09:30:43.752] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:43.752] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:30:0) after 1m0s
[09:31:43.767] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:30:0)
[09:31:43.767] Timer tick, asking Buildbucket for the build status
[09:31:43.828] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:43.828] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:31:0) after 1m0s
[09:32:43.893] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:31:0)
[09:32:43.893] Timer tick, asking Buildbucket for the build status
[09:32:43.959] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:43.959] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:32:0) after 1m0s
[09:33:44.008] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:32:0)
[09:33:44.008] Timer tick, asking Buildbucket for the build status
[09:33:44.124] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:44.124] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:33:0) after 1m0s
[09:34:44.182] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:33:0)
[09:34:44.182] Timer tick, asking Buildbucket for the build status
[09:34:44.304] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:44.304] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:34:0) after 1m0s
[09:35:44.354] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:34:0)
[09:35:44.354] Timer tick, asking Buildbucket for the build status
[09:35:44.417] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:44.417] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:35:0) after 1m0s
[09:36:44.428] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:35:0)
[09:36:44.428] Timer tick, asking Buildbucket for the build status
[09:36:44.502] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:44.502] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:36:0) after 1m0s
[09:37:44.557] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:36:0)
[09:37:44.557] Timer tick, asking Buildbucket for the build status
[09:37:44.667] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:44.667] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:37:0) after 1m0s
[09:38:44.794] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:37:0)
[09:38:44.794] Timer tick, asking Buildbucket for the build status
[09:38:45.188] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:45.188] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:38:0) after 1m0s
[09:39:45.287] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:38:0)
[09:39:45.287] Timer tick, asking Buildbucket for the build status
[09:39:45.361] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:45.361] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:39:0) after 1m0s
[09:40:45.795] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:39:0)
[09:40:45.795] Timer tick, asking Buildbucket for the build status
[09:40:45.897] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:45.897] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:40:0) after 1m0s
[09:41:46.033] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:40:0)
[09:41:46.033] Timer tick, asking Buildbucket for the build status
[09:41:46.222] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:46.222] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:41:0) after 1m0s
[09:42:46.364] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:41:0)
[09:42:46.364] Timer tick, asking Buildbucket for the build status
[09:42:46.440] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:46.440] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:42:0) after 1m0s
[09:43:46.508] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:42:0)
[09:43:46.508] Timer tick, asking Buildbucket for the build status
[09:43:46.626] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:46.626] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:43:0) after 1m0s
[09:44:46.689] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:43:0)
[09:44:46.689] Timer tick, asking Buildbucket for the build status
[09:44:46.764] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:46.764] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:44:0) after 1m0s
[09:45:46.831] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:44:0)
[09:45:46.831] Timer tick, asking Buildbucket for the build status
[09:45:47.019] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:47.019] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:45:0) after 1m0s
[09:46:47.053] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:45:0)
[09:46:47.053] Timer tick, asking Buildbucket for the build status
[09:46:47.142] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:47.142] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:46:0) after 1m0s
[09:47:47.168] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:46:0)
[09:47:47.168] Timer tick, asking Buildbucket for the build status
[09:47:47.578] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:47.578] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:47:0) after 1m0s
[09:48:47.632] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:47:0)
[09:48:47.632] Timer tick, asking Buildbucket for the build status
[09:48:47.745] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:47.745] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:48:0) after 1m0s
[09:49:47.821] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:48:0)
[09:49:47.821] Timer tick, asking Buildbucket for the build status
[09:49:48.096] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:48.096] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:49:0) after 1m0s
[09:50:48.143] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:49:0)
[09:50:48.143] Timer tick, asking Buildbucket for the build status
[09:50:48.686] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:48.686] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:50:0) after 1m0s
[09:51:48.890] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:50:0)
[09:51:48.890] Timer tick, asking Buildbucket for the build status
[09:51:48.960] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:48.960] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:51:0) after 1m0s
[09:52:49.020] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:51:0)
[09:52:49.020] Timer tick, asking Buildbucket for the build status
[09:52:49.495] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:49.495] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:52:0) after 1m0s
[09:53:49.573] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:52:0)
[09:53:49.573] Timer tick, asking Buildbucket for the build status
[09:53:49.691] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:49.691] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:53:0) after 1m0s
[09:54:49.713] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:53:0)
[09:54:49.713] Timer tick, asking Buildbucket for the build status
[09:54:49.772] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:49.772] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:54:0) after 1m0s
[09:55:49.777] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:54:0)
[09:55:49.777] Timer tick, asking Buildbucket for the build status
[09:55:49.863] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:49.863] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:55:0) after 1m0s
[09:56:49.890] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:55:0)
[09:56:49.890] Timer tick, asking Buildbucket for the build status
[09:56:49.991] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:49.991] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:56:0) after 1m0s
[09:57:50.021] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:56:0)
[09:57:50.021] Timer tick, asking Buildbucket for the build status
[09:57:50.123] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:50.123] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:57:0) after 1m0s
[09:58:50.166] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:57:0)
[09:58:50.166] Timer tick, asking Buildbucket for the build status
[09:58:50.392] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:50.392] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:58:0) after 1m0s
[09:59:50.497] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:58:0)
[09:59:50.497] Timer tick, asking Buildbucket for the build status
[09:59:50.595] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:50.595] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:59:0) after 1m0s
[10:00:50.618] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:59:0)
[10:00:50.618] Timer tick, asking Buildbucket for the build status
[10:00:50.702] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:50.703] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:60:0) after 1m0s
[10:01:50.772] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:60:0)
[10:01:50.772] Timer tick, asking Buildbucket for the build status
[10:01:50.838] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:50.838] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:61:0) after 1m0s
[10:02:50.902] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:61:0)
[10:02:50.902] Timer tick, asking Buildbucket for the build status
[10:02:50.961] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:50.961] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:62:0) after 1m0s
[10:03:51.024] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:62:0)
[10:03:51.024] Timer tick, asking Buildbucket for the build status
[10:03:51.246] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:51.246] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:63:0) after 1m0s
[10:04:51.277] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:63:0)
[10:04:51.277] Timer tick, asking Buildbucket for the build status
[10:04:51.409] Build 8866657579740863792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:51.409] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032087641758074736:64:0) after 1m0s
[10:04:58.484] Received PubSub notification, asking Buildbucket for the build status
[10:04:58.592] Build 8866657579740863792: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:04:58.593] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1602497097980482",
"created_by": "project:chromium",
"created_ts": "1602493416040436",
"id": "8866657579740863792",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cd2cafa052cfa8c38d09a3022a927b6919aa1eab\"}}",
"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\": \"cd2cafa052cfa8c38d09a3022a927b6919aa1eab\", \"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-170-e531\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 176570, \"got_angle_revision\": \"68bd685a76430f8dd392cdf5ca7e5976d58cb01f\", \"got_dawn_revision\": \"6c3da3dc5b875a9500770644e0966c9f731dae7f\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"cd2cafa052cfa8c38d09a3022a927b6919aa1eab\", \"got_revision_cp\": \"refs/heads/master@{#816090}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"e72c6099f9465df73f888a92071b70c924d74b0d\", \"got_v8_revision\": \"07b0b1dcde4a99294b8028d83f4ea244885cc091\", \"got_v8_revision_cp\": \"refs/heads/8.8.62@{#1}\", \"got_webrtc_revision\": \"3326535126e435f1ba647885ce43a8f0f3d317eb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32375}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cd2cafa052cfa8c38d09a3022a927b6919aa1eab\", \"swarm_hashes_refs/heads/master(at){#816090}_without_patch\": {\"absl_hardening_tests\": \"536e3c220400a5a8405a486ba5be3b3d886e77db\", \"accessibility_unittests\": \"29a7351d382a428060c199ce837fe9cf005b9782\", \"app_shell_unittests\": \"f2791f87612fbc4029b79f6c42f1bb24138e76ea\", \"aura_unittests\": \"be635a6836d5467a079bf15946bcdf703a24faeb\", \"base_unittests\": \"e5b6821fd42c0ace1059f255dcd9376e5df7df6d\", \"base_util_unittests\": \"a39de7f5d385ce7719b4854a4c811b339b88c48d\", \"blink_common_unittests\": \"507310d8d8463effbcb3450f3e466210b228893b\", \"blink_fuzzer_unittests\": \"f9a7bf3ad67552e580ff5859546434728b7c0eef\", \"blink_heap_unittests\": \"b73bfa9069e9ceae39ed0f8283c34743f5b188c7\", \"blink_platform_unittests\": \"213b8a0dd2ac0f745f2f475c89cd95251cffdf8d\", \"blink_python_tests\": \"4e87544e82b526ebf880136794e444ba7ca61cb3\", \"blink_unittests\": \"1adad8b8fd3e6d80154245fa5b46537c6853dd51\", \"blink_web_tests\": \"14fa967ea5a31e70061f77c7b5ac41b3e11c98af\", \"boringssl_crypto_tests\": \"679dfeb8baaf331d606f8fa04a8bcd073424213f\", \"boringssl_ssl_tests\": \"9e0f0438fa113467fb2448d62d109c899140242b\", \"browser_tests\": \"6e5a198cf37f154189afc7cdbbe2ed7c39ad26fb\", \"capture_unittests\": \"ad93b9e028460f5cf938c67a52a165cd3d637162\", \"cast_unittests\": \"d1e3464f06c998ccba3a92611c2ef67b26d75345\", \"cc_unittests\": \"c0fbee37371b041a9d1b0e8a5ec25361dc1fd1a1\", \"chrome_app_unittests\": \"5cb6d9475c5a849838d909db5f3e1a9208bfa90a\", \"chromedriver_unittests\": \"6e0a29d01583347a0c3e5ee026667deab49aded9\", \"components_browsertests\": \"0bc9f524b1dcddb2e88b69ca283aee01f13c3515\", \"components_unittests\": \"e38eab284ee028fa4e87711c69020a08b3369ae3\", \"compositor_unittests\": \"7d3057efb57bc7d5d21ee8ed7ebdb23d6726d90e\", \"content_browsertests\": \"f4d8d229108666217b476b7f73585cd88c93ee7e\", \"content_shell_crash_test\": \"d87e0d0788733694e13c20a8e84e2e77639dec50\", \"content_unittests\": \"6420fe70391b054b3e18308374914535a8dbb41b\", \"crashpad_tests\": \"ba83e11d4b855aa2d4bfa5eaea72d695b0406784\", \"cronet_tests\": \"1b85f638daf6309754675b051c4a051fe94909ba\", \"cronet_unittests\": \"0394a451e8ddad67456d48d746fe1abbabc47927\", \"crypto_unittests\": \"35982e2ad861821a12b0430527c75858661b6247\", \"dbus_unittests\": \"49f751be3b1f59652d3ca0a6a50d58ce3a6b4817\", \"device_unittests\": \"693949cba52e5e07075aa5592635c6c1494756c5\", \"display_unittests\": \"e3db137dfa48ba66010d746657027f8d8ab80cec\", \"events_unittests\": \"b5d20d47ac39703940f3d76f5634ad96094d390e\", \"extension_docserver_python_unittests\": \"b9d30c952ea004e9f28fa4cf613ea2fd54d1435e\", \"extensions_browsertests\": \"2b690ab2ff601fff7af538c1e75d1d3a06b2051c\", \"extensions_unittests\": \"6f31442ed95e77e516516e7878a0a0921ad318d5\", \"filesystem_service_unittests\": \"6f8e07c52625e2f9102ce0de184201047c88ade5\", \"flatbuffers_unittests\": \"7c821f13730963d6e07deae074f4fffab315d766\", \"gcm_unit_tests\": \"7b3243b4abd77b186a464bf26c0c54beb229554d\", \"gfx_unittests\": \"d753805df2a15c2f1f4e6f73807898fe05e9d7fb\", \"gin_unittests\": \"322d30b59a72976c5fc4c6eebbb09ef819bd349d\", \"google_apis_unittests\": \"b1fc42345f2521b05fa038a0e36fe42ec1ce69f7\", \"gpu_unittests\": \"48147e9bd8574d495731af74405e6e28f9e6f10d\", \"grit_python_unittests\": \"55fa961d85005331568451ce869e032331bd4b90\", \"gwp_asan_unittests\": \"75d500351911da6a0eba74d09fbaeff19604ac18\", \"headless_browsertests\": \"3c3d3e500017df2576433e65ec3368e6946d4614\", \"headless_unittests\": \"5a6c7f63094bcc0eaf14ba74b0da18dc3165364b\", \"interactive_ui_tests\": \"d827e3d09e89767838a76efb876b49f22b39e235\", \"ipc_tests\": \"45906fcfe7d019c005aa804f94a87c003e06495f\", \"jingle_unittests\": \"f6be8d7d79c1001fc8ffb2c318c1dc0f52073a85\", \"latency_unittests\": \"0d85a816d78dcbd28602143ad29b12d0120f3a2f\", \"libjingle_xmpp_unittests\": \"6e1591fdd959cb17d7878ee126335bfff8b554e5\", \"media_blink_unittests\": \"ef7a81b12c7a6eeb94f024f17edb496560881c3a\", \"media_unittests\": \"16e733d9233635834d00d269cd3f1ee8b6289f29\", \"message_center_unittests\": \"4bfc5125e786f8247f60cd92d1af1ef00abaec83\", \"metrics_python_tests\": \"c843fe2dceeea774ea978f3637eb7cd5a56f53e4\", \"midi_unittests\": \"654630bb5cc6247e5d6510fbfb2ee478b614e7c2\", \"mojo_core_unittests\": \"34d892a6be9bdca472b8205ffe1c93dc091c0b91\", \"mojo_unittests\": \"67784ad5969a45054bb26bbad4eac8756e60af56\", \"nacl_helper_nonsfi_unittests\": \"4b8c95b9220bed3c26293b45ce8757f6258d8186\", \"nacl_loader_unittests\": \"c306e112bcad40e2aa18987856c24804267942ec\", \"native_theme_unittests\": \"695805efd0b9b6c7a63688d51fdde010a043dae5\", \"net_unittests\": \"7aa0d2d856472e269841b32a302b90256b8482af\", \"openscreen_unittests\": \"fa4489406671f8bdc7f217ea62cec3add9abda7c\", \"pdf_unittests\": \"ad719ebb01ce7b792804ac92a1476b8731256bb8\", \"perfetto_unittests\": \"7435a890e517c391a34eebbebc01236d656b4daf\", \"ppapi_unittests\": \"596cceb71348ae5cbfe9b618f8f0aed3d73f7b8c\", \"printing_unittests\": \"0d9d2c1348406ebbb1ab3852cc17f5389b36797f\", \"remoting_unittests\": \"9801c734c633b29b79c3e23c4fe7b18323f4df69\", \"sandbox_linux_unittests\": \"1f1732bfeaf59c9c08f9e7bd81725bce3f7369f9\", \"service_manager_unittests\": \"e81e771a6e82ba9d3ab2bad47f1e2156eccdb1db\", \"services_unittests\": \"a030ec9023cb8767cf619605a27f4bd8d9213e1d\", \"shell_dialogs_unittests\": \"a613a1acdcddbb983d974181bf0752ac0970721b\", \"skia_unittests\": \"d6f20ec2c74ddc9b9c7f63a8561a627c057699fe\", \"snapshot_unittests\": \"3fbd5db7e2806a69434be632f95cf116df66450a\", \"sql_unittests\": \"7ef38c9f51758e449822079f0b8d4694cff05045\", \"standalone_angle_unittests\": \"9be82f8dc825550b705cddd011e56b9aba0b2322\", \"storage_unittests\": \"a0eab9109c4b62ff87995ab668a7040bcc57b347\", \"sync_integration_tests\": \"d95456bed1a62fe38a545902d003f4706ba43e6d\", \"telemetry_gpu_unittests\": \"0e929c7e04ed190d699a010103b07c84f4df0a6d\", \"telemetry_perf_unittests\": \"c249e7f20c9ac447e524de54cbc2bb642ff2fd2a\", \"telemetry_unittests\": \"a6843a1d2f9214372b1e87cf146529678b50819f\", \"traffic_annotation_auditor_unittests\": \"2d983aa09d09d38842c9ac87db0e4adef13099a8\", \"ui_base_unittests\": \"1f1c2b0a6f6c3ee91af8539c791ac7c70d1f6b8d\", \"ui_touch_selection_unittests\": \"6cf18a25ad9503c7a4489856339408fe3431715f\", \"unit_tests\": \"d31b25f499766dcc86c97a875ec08f1051d18d71\", \"url_unittests\": \"00cf845e16a675130f14a398032c6099e8dbf7a1\", \"views_perftests\": \"8e1d4a256327cf4b61ff416d3509ef29595c7b50\", \"views_unittests\": \"cad3f9b118edfd4cc473449099e8fbe7b2a6a13f\", \"viz_unittests\": \"213d8f30ff0242609f50dfc09e9dada5aaf5353c\", \"vr_common_unittests\": \"234cdef6ada046f808af5f84d197381db9fd2de0\", \"vr_pixeltests\": \"550963e407554b3a2496d277167673878db4449d\", \"webdriver_wpt_tests\": \"b9b5c9bd11dbaade554661a4f0baeba4647d98b9\", \"weblayer_browsertests\": \"8a0188906976496cd43558fa9496ab0d61a5dbaf\", \"weblayer_unittests\": \"c99f51a066e3e29d45270d02a737b4c6565f1093\", \"wm_unittests\": \"e8cf3b12557fdd0f777d9e0ab0666f784838c277\", \"wtf_unittests\": \"023d4abde66736205456db0fd06dff521a92b35b\", \"x11_unittests\": \"705ce7d8f854e5226fad3ba313ec4e1249b087e9\", \"xr_browser_tests\": \"179e68f3a683f1d3f7da750920c497aeb0a3fab7\", \"zlib_unittests\": \"f4aaad347ef607e6f92643d60a21964a791ef98c\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_98a60cf4ba341a05f49601a94ea91d205798f47ee731869ed66ec9c0f2c54ce9_v2\", \"builder_fa0031875b7f2f11c46443055ab400bfaeb07a1d2a142b58c631314016c04e0a_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-170-e531\"], \"image\": [\"chrome-xenial-20100800-ee496b8e3cf\"], \"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\": [\"5570-fa4adf0\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1602493682602457",
"status": "COMPLETED",
"status_changed_ts": "1602497098234541",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/176570",
"builder:Linux Builder (dbg)",
"buildset:commit/git/cd2cafa052cfa8c38d09a3022a927b6919aa1eab",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cd2cafa052cfa8c38d09a3022a927b6919aa1eab",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9032087641758074736",
"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/8866657579740863792/+/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:4f34de8de73f0610",
"user_agent:luci-scheduler"
],
"updated_ts": "1602497098238866",
"url": "https://ci.chromium.org/b/8866657579740863792",
"utcnow_ts": "1602497098580019"
}
}
[10:04:58.593] Invocation finished in 1h1m23.859576616s with status SUCCEEDED