[17:36:11.254] New invocation is queued and will start shortly
[17:36:12.332] Starting the invocation (attempt 1)
[17:36:12.366] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:36:12.366] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:36:12.366] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9025894797510334944",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"bd1c53145ea4f5ac012ea62ef3378d0d18326515\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9025894797510334944",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/bd1c53145ea4f5ac012ea62ef3378d0d18326515",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bd1c53145ea4f5ac012ea62ef3378d0d18326515",
"gitiles_ref:refs/heads/master"
]
}
[17:36:12.976] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1608399372457169",
"id": "8860464735584508368",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bd1c53145ea4f5ac012ea62ef3378d0d18326515\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1608399372853440",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178829",
"builder:Linux Builder (dbg)",
"buildset:commit/git/bd1c53145ea4f5ac012ea62ef3378d0d18326515",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bd1c53145ea4f5ac012ea62ef3378d0d18326515",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025894797510334944",
"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/8860464735584508368/+/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": "1608399372853549",
"url": "https://ci.chromium.org/b/8860464735584508368",
"utcnow_ts": "1608399372969124"
}
}
[17:36:12.976] Task URL: https://ci.chromium.org/b/8860464735584508368
[17:36:12.976] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:2:0) after 1m0s
[17:37:12.995] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:2:0)
[17:37:12.995] Timer tick, asking Buildbucket for the build status
[17:37:13.192] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:37:13.192] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:3:0) after 1m0s
[17:38:13.213] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:3:0)
[17:38:13.213] Timer tick, asking Buildbucket for the build status
[17:38:13.390] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:38:13.390] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:4:0) after 1m0s
[17:39:13.449] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:4:0)
[17:39:13.449] Timer tick, asking Buildbucket for the build status
[17:39:13.512] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:39:13.512] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:5:0) after 1m0s
[17:40:13.539] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:5:0)
[17:40:13.539] Timer tick, asking Buildbucket for the build status
[17:40:13.601] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:40:13.601] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:6:0) after 1m0s
[17:41:13.623] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:6:0)
[17:41:13.623] Timer tick, asking Buildbucket for the build status
[17:41:14.019] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:41:14.019] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:7:0) after 1m0s
[17:42:14.042] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:7:0)
[17:42:14.042] Timer tick, asking Buildbucket for the build status
[17:42:14.172] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:42:14.172] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:8:0) after 1m0s
[17:43:14.192] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:8:0)
[17:43:14.192] Timer tick, asking Buildbucket for the build status
[17:43:14.338] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:43:14.338] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:9:0) after 1m0s
[17:44:14.359] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:9:0)
[17:44:14.359] Timer tick, asking Buildbucket for the build status
[17:44:14.436] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:44:14.436] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:10:0) after 1m0s
[17:45:14.504] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:10:0)
[17:45:14.504] Timer tick, asking Buildbucket for the build status
[17:45:14.809] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:45:14.809] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:11:0) after 1m0s
[17:46:14.874] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:11:0)
[17:46:14.874] Timer tick, asking Buildbucket for the build status
[17:46:14.950] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:46:14.950] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:12:0) after 1m0s
[17:47:14.976] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:12:0)
[17:47:14.976] Timer tick, asking Buildbucket for the build status
[17:47:15.066] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:47:15.066] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:13:0) after 1m0s
[17:48:15.133] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:13:0)
[17:48:15.133] Timer tick, asking Buildbucket for the build status
[17:48:15.195] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:48:15.195] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:14:0) after 1m0s
[17:49:15.227] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:14:0)
[17:49:15.227] Timer tick, asking Buildbucket for the build status
[17:49:15.326] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:49:15.326] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:15:0) after 1m0s
[17:50:15.310] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:15:0)
[17:50:15.310] Timer tick, asking Buildbucket for the build status
[17:50:15.604] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:50:15.604] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:16:0) after 1m0s
[17:51:15.671] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:16:0)
[17:51:15.671] Timer tick, asking Buildbucket for the build status
[17:51:15.762] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:51:15.762] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:17:0) after 1m0s
[17:52:15.917] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:17:0)
[17:52:15.917] Timer tick, asking Buildbucket for the build status
[17:52:16.006] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:52:16.006] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:18:0) after 1m0s
[17:53:16.061] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:18:0)
[17:53:16.061] Timer tick, asking Buildbucket for the build status
[17:53:16.301] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:53:16.301] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:19:0) after 1m0s
[17:54:16.389] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:19:0)
[17:54:16.389] Timer tick, asking Buildbucket for the build status
[17:54:16.530] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:54:16.530] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:20:0) after 1m0s
[17:55:16.548] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:20:0)
[17:55:16.548] Timer tick, asking Buildbucket for the build status
[17:55:16.611] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:55:16.611] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:21:0) after 1m0s
[17:56:16.614] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:21:0)
[17:56:16.614] Timer tick, asking Buildbucket for the build status
[17:56:16.715] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:56:16.715] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:22:0) after 1m0s
[17:57:16.780] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:22:0)
[17:57:16.781] Timer tick, asking Buildbucket for the build status
[17:57:16.852] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:57:16.852] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:23:0) after 1m0s
[17:58:16.889] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:23:0)
[17:58:16.889] Timer tick, asking Buildbucket for the build status
[17:58:16.954] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:58:16.954] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:24:0) after 1m0s
[17:59:16.985] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:24:0)
[17:59:16.985] Timer tick, asking Buildbucket for the build status
[17:59:17.047] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:59:17.047] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:25:0) after 1m0s
[18:00:17.133] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:25:0)
[18:00:17.133] Timer tick, asking Buildbucket for the build status
[18:00:17.260] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:00:17.260] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:26:0) after 1m0s
[18:01:17.292] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:26:0)
[18:01:17.292] Timer tick, asking Buildbucket for the build status
[18:01:17.421] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:01:17.421] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:27:0) after 1m0s
[18:02:17.446] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:27:0)
[18:02:17.446] Timer tick, asking Buildbucket for the build status
[18:02:17.568] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:02:17.568] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:28:0) after 1m0s
[18:03:17.641] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:28:0)
[18:03:17.641] Timer tick, asking Buildbucket for the build status
[18:03:17.718] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:03:17.718] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:29:0) after 1m0s
[18:04:17.766] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:29:0)
[18:04:17.766] Timer tick, asking Buildbucket for the build status
[18:04:17.839] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:04:17.839] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:30:0) after 1m0s
[18:05:17.923] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:30:0)
[18:05:17.923] Timer tick, asking Buildbucket for the build status
[18:05:17.995] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:05:17.995] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:31:0) after 1m0s
[18:06:18.039] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:31:0)
[18:06:18.039] Timer tick, asking Buildbucket for the build status
[18:06:18.241] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:06:18.241] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:32:0) after 1m0s
[18:07:18.281] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:32:0)
[18:07:18.281] Timer tick, asking Buildbucket for the build status
[18:07:18.339] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:07:18.339] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:33:0) after 1m0s
[18:08:18.350] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:33:0)
[18:08:18.350] Timer tick, asking Buildbucket for the build status
[18:08:18.423] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:08:18.423] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:34:0) after 1m0s
[18:09:18.394] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:34:0)
[18:09:18.394] Timer tick, asking Buildbucket for the build status
[18:09:18.877] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:09:18.877] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:35:0) after 1m0s
[18:10:18.984] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:35:0)
[18:10:18.984] Timer tick, asking Buildbucket for the build status
[18:10:19.064] Build 8860464735584508368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:10:19.064] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:36:0) after 1m0s
[18:10:26.220] Received PubSub notification, asking Buildbucket for the build status
[18:10:26.657] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:19.138] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:36:0)
[18:11:19.138] Timer tick, asking Buildbucket for the build status
[18:11:19.232] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:19.232] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:38:0) after 1m0s
[18:12:19.316] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:38:0)
[18:12:19.316] Timer tick, asking Buildbucket for the build status
[18:12:19.390] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:19.390] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:39:0) after 1m0s
[18:13:23.279] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:39:0)
[18:13:23.279] Timer tick, asking Buildbucket for the build status
[18:13:23.361] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:23.361] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:40:0) after 1m0s
[18:14:23.469] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:40:0)
[18:14:23.469] Timer tick, asking Buildbucket for the build status
[18:14:23.561] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:23.561] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:41:0) after 1m0s
[18:15:23.584] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:41:0)
[18:15:23.584] Timer tick, asking Buildbucket for the build status
[18:15:23.739] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:23.739] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:42:0) after 1m0s
[18:16:23.798] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:42:0)
[18:16:23.798] Timer tick, asking Buildbucket for the build status
[18:16:23.877] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:23.877] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:43:0) after 1m0s
[18:17:23.897] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:43:0)
[18:17:23.897] Timer tick, asking Buildbucket for the build status
[18:17:24.002] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:24.002] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:44:0) after 1m0s
[18:18:24.037] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:44:0)
[18:18:24.037] Timer tick, asking Buildbucket for the build status
[18:18:24.138] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:24.138] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:45:0) after 1m0s
[18:19:24.224] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:45:0)
[18:19:24.224] Timer tick, asking Buildbucket for the build status
[18:19:24.273] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:24.273] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:46:0) after 1m0s
[18:20:24.362] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:46:0)
[18:20:24.362] Timer tick, asking Buildbucket for the build status
[18:20:24.515] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:24.515] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:47:0) after 1m0s
[18:21:24.517] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:47:0)
[18:21:24.517] Timer tick, asking Buildbucket for the build status
[18:21:24.620] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:24.620] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:48:0) after 1m0s
[18:22:24.656] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:48:0)
[18:22:24.656] Timer tick, asking Buildbucket for the build status
[18:22:24.816] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:24.816] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:49:0) after 1m0s
[18:23:24.869] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:49:0)
[18:23:24.869] Timer tick, asking Buildbucket for the build status
[18:23:25.023] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:25.023] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:50:0) after 1m0s
[18:24:25.053] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:50:0)
[18:24:25.053] Timer tick, asking Buildbucket for the build status
[18:24:25.106] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:25.106] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:51:0) after 1m0s
[18:25:25.189] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:51:0)
[18:25:25.189] Timer tick, asking Buildbucket for the build status
[18:25:25.411] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:25.411] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:52:0) after 1m0s
[18:26:25.432] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:52:0)
[18:26:25.432] Timer tick, asking Buildbucket for the build status
[18:26:25.904] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:25.904] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:53:0) after 1m0s
[18:27:25.922] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:53:0)
[18:27:25.922] Timer tick, asking Buildbucket for the build status
[18:27:26.007] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:26.007] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:54:0) after 1m0s
[18:28:26.035] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:54:0)
[18:28:26.035] Timer tick, asking Buildbucket for the build status
[18:28:26.202] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:26.202] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:55:0) after 1m0s
[18:29:26.243] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:55:0)
[18:29:26.243] Timer tick, asking Buildbucket for the build status
[18:29:26.401] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:26.401] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:56:0) after 1m0s
[18:30:26.425] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:56:0)
[18:30:26.425] Timer tick, asking Buildbucket for the build status
[18:30:26.502] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:26.502] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:57:0) after 1m0s
[18:31:26.523] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:57:0)
[18:31:26.523] Timer tick, asking Buildbucket for the build status
[18:31:26.613] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:26.613] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:58:0) after 1m0s
[18:32:26.664] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:58:0)
[18:32:26.664] Timer tick, asking Buildbucket for the build status
[18:32:26.796] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:26.796] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:59:0) after 1m0s
[18:33:26.826] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:59:0)
[18:33:26.826] Timer tick, asking Buildbucket for the build status
[18:33:26.879] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:26.879] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:60:0) after 1m0s
[18:34:26.900] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:60:0)
[18:34:26.900] Timer tick, asking Buildbucket for the build status
[18:34:26.954] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:26.954] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:61:0) after 1m0s
[18:35:26.987] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:61:0)
[18:35:26.987] Timer tick, asking Buildbucket for the build status
[18:35:27.052] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:27.052] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:62:0) after 1m0s
[18:36:27.095] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:62:0)
[18:36:27.095] Timer tick, asking Buildbucket for the build status
[18:36:27.191] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:27.191] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:63:0) after 1m0s
[18:37:27.216] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:63:0)
[18:37:27.216] Timer tick, asking Buildbucket for the build status
[18:37:27.269] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:27.269] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:64:0) after 1m0s
[18:38:27.302] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:64:0)
[18:38:27.302] Timer tick, asking Buildbucket for the build status
[18:38:27.361] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:27.361] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:65:0) after 1m0s
[18:39:27.441] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:65:0)
[18:39:27.441] Timer tick, asking Buildbucket for the build status
[18:39:27.508] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:27.508] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:66:0) after 1m0s
[18:40:27.539] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:66:0)
[18:40:27.539] Timer tick, asking Buildbucket for the build status
[18:40:27.759] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:27.759] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:67:0) after 1m0s
[18:41:27.857] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:67:0)
[18:41:27.857] Timer tick, asking Buildbucket for the build status
[18:41:27.967] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:27.967] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:68:0) after 1m0s
[18:42:28.161] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:68:0)
[18:42:28.161] Timer tick, asking Buildbucket for the build status
[18:42:28.236] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:28.236] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:69:0) after 1m0s
[18:43:28.390] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:69:0)
[18:43:28.390] Timer tick, asking Buildbucket for the build status
[18:43:28.446] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:28.446] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:70:0) after 1m0s
[18:44:28.640] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:70:0)
[18:44:28.640] Timer tick, asking Buildbucket for the build status
[18:44:28.704] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:28.704] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:71:0) after 1m0s
[18:45:28.860] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:71:0)
[18:45:28.860] Timer tick, asking Buildbucket for the build status
[18:45:28.957] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:28.957] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:72:0) after 1m0s
[18:46:29.042] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:72:0)
[18:46:29.042] Timer tick, asking Buildbucket for the build status
[18:46:29.155] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:29.155] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:73:0) after 1m0s
[18:47:30.792] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:73:0)
[18:47:30.792] Timer tick, asking Buildbucket for the build status
[18:47:30.918] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:30.919] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:74:0) after 1m0s
[18:48:30.955] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:74:0)
[18:48:30.955] Timer tick, asking Buildbucket for the build status
[18:48:31.164] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:31.164] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:75:0) after 1m0s
[18:49:31.146] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:75:0)
[18:49:31.146] Timer tick, asking Buildbucket for the build status
[18:49:31.285] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:31.285] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:76:0) after 1m0s
[18:50:31.345] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:76:0)
[18:50:31.345] Timer tick, asking Buildbucket for the build status
[18:50:31.434] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:31.434] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:77:0) after 1m0s
[18:51:31.434] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:77:0)
[18:51:31.434] Timer tick, asking Buildbucket for the build status
[18:51:31.567] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:31.567] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:78:0) after 1m0s
[18:52:31.602] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:78:0)
[18:52:31.602] Timer tick, asking Buildbucket for the build status
[18:52:31.677] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:31.677] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:79:0) after 1m0s
[18:53:31.655] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:79:0)
[18:53:31.655] Timer tick, asking Buildbucket for the build status
[18:53:31.709] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:31.709] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:80:0) after 1m0s
[18:54:31.731] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:80:0)
[18:54:31.731] Timer tick, asking Buildbucket for the build status
[18:54:31.817] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:31.817] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:81:0) after 1m0s
[18:55:31.853] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:81:0)
[18:55:31.853] Timer tick, asking Buildbucket for the build status
[18:55:31.918] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:31.918] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:82:0) after 1m0s
[18:56:31.946] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:82:0)
[18:56:31.946] Timer tick, asking Buildbucket for the build status
[18:56:32.065] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:32.065] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:83:0) after 1m0s
[18:57:32.092] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:83:0)
[18:57:32.092] Timer tick, asking Buildbucket for the build status
[18:57:32.143] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:32.143] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:84:0) after 1m0s
[18:58:32.180] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:84:0)
[18:58:32.180] Timer tick, asking Buildbucket for the build status
[18:58:32.301] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:32.301] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:85:0) after 1m0s
[18:59:32.357] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:85:0)
[18:59:32.357] Timer tick, asking Buildbucket for the build status
[18:59:32.804] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:32.804] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:86:0) after 1m0s
[19:00:32.831] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:86:0)
[19:00:32.831] Timer tick, asking Buildbucket for the build status
[19:00:32.901] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:32.901] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:87:0) after 1m0s
[19:01:32.942] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:87:0)
[19:01:32.942] Timer tick, asking Buildbucket for the build status
[19:01:33.176] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:33.176] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:88:0) after 1m0s
[19:02:33.205] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:88:0)
[19:02:33.205] Timer tick, asking Buildbucket for the build status
[19:02:33.258] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:33.258] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:89:0) after 1m0s
[19:03:33.281] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:89:0)
[19:03:33.281] Timer tick, asking Buildbucket for the build status
[19:03:33.361] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:33.361] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:90:0) after 1m0s
[19:04:33.383] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:90:0)
[19:04:33.383] Timer tick, asking Buildbucket for the build status
[19:04:33.434] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:33.434] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:91:0) after 1m0s
[19:05:33.465] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:91:0)
[19:05:33.465] Timer tick, asking Buildbucket for the build status
[19:05:33.529] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:33.529] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:92:0) after 1m0s
[19:06:33.562] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:92:0)
[19:06:33.562] Timer tick, asking Buildbucket for the build status
[19:06:33.721] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:33.721] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:93:0) after 1m0s
[19:07:33.717] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:93:0)
[19:07:33.717] Timer tick, asking Buildbucket for the build status
[19:07:33.772] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:33.772] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:94:0) after 1m0s
[19:08:33.826] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:94:0)
[19:08:33.826] Timer tick, asking Buildbucket for the build status
[19:08:33.878] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:33.878] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:95:0) after 1m0s
[19:09:33.902] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:95:0)
[19:09:33.902] Timer tick, asking Buildbucket for the build status
[19:09:35.989] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:35.989] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:96:0) after 1m0s
[19:10:35.998] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:96:0)
[19:10:35.998] Timer tick, asking Buildbucket for the build status
[19:10:36.126] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:36.126] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:97:0) after 1m0s
[19:11:36.149] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:97:0)
[19:11:36.149] Timer tick, asking Buildbucket for the build status
[19:11:36.726] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:36.726] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:98:0) after 1m0s
[19:12:36.780] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:98:0)
[19:12:36.780] Timer tick, asking Buildbucket for the build status
[19:12:36.976] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:36.976] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:99:0) after 1m0s
[19:13:37.039] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:99:0)
[19:13:37.039] Timer tick, asking Buildbucket for the build status
[19:13:37.133] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:37.133] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:100:0) after 1m0s
[19:14:37.207] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:100:0)
[19:14:37.207] Timer tick, asking Buildbucket for the build status
[19:14:37.288] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:37.288] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:101:0) after 1m0s
[19:15:37.313] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:101:0)
[19:15:37.313] Timer tick, asking Buildbucket for the build status
[19:15:37.376] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:37.376] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:102:0) after 1m0s
[19:16:37.409] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:102:0)
[19:16:37.409] Timer tick, asking Buildbucket for the build status
[19:16:37.522] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:37.522] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:103:0) after 1m0s
[19:17:37.546] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:103:0)
[19:17:37.546] Timer tick, asking Buildbucket for the build status
[19:17:37.610] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:37.610] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:104:0) after 1m0s
[19:18:37.641] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:104:0)
[19:18:37.641] Timer tick, asking Buildbucket for the build status
[19:18:37.976] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:37.976] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:105:0) after 1m0s
[19:19:38.061] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:105:0)
[19:19:38.061] Timer tick, asking Buildbucket for the build status
[19:19:38.133] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:38.133] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:106:0) after 1m0s
[19:20:39.283] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:106:0)
[19:20:39.283] Timer tick, asking Buildbucket for the build status
[19:20:39.364] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:39.364] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:107:0) after 1m0s
[19:21:39.521] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:107:0)
[19:21:39.521] Timer tick, asking Buildbucket for the build status
[19:21:39.717] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:39.717] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:108:0) after 1m0s
[19:22:40.240] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:108:0)
[19:22:40.240] Timer tick, asking Buildbucket for the build status
[19:22:40.337] Build 8860464735584508368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:40.337] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9025894797510334944:109:0) after 1m0s
[19:23:36.662] Received PubSub notification, asking Buildbucket for the build status
[19:23:36.879] Build 8860464735584508368: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:23:36.879] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1608405813429366",
"created_by": "project:chromium",
"created_ts": "1608399372457169",
"id": "8860464735584508368",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bd1c53145ea4f5ac012ea62ef3378d0d18326515\"}}",
"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\": \"bd1c53145ea4f5ac012ea62ef3378d0d18326515\", \"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-31-v2cj\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 178829, \"got_angle_revision\": \"ed9213bca0643edb65b7d39a938210419398a1b3\", \"got_dawn_revision\": \"5d4fd88a7403aa255d49919d011af54c691b344a\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"bd1c53145ea4f5ac012ea62ef3378d0d18326515\", \"got_revision_cp\": \"refs/heads/master@{#838525}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1cc5b3357d2ff3c81ef7ec0b07a6660796bde5cd\", \"got_v8_revision\": \"c4b600873d9668aeeb4f28e20f86d82b5c75379c\", \"got_v8_revision_cp\": \"refs/heads/8.9.177@{#1}\", \"got_webrtc_revision\": \"d7f750f7be4b2f61018d3cb55a995d09daa226e6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32862}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux-clang-tidy-dbg\", \"tryserver.chromium.linux:linux_chromium_dbg_ng\", \"tryserver.chromium.linux:linux_chromium_compile_dbg_ng\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bd1c53145ea4f5ac012ea62ef3378d0d18326515\", \"swarm_hashes_refs/heads/master(at){#838525}_without_patch\": {\"absl_hardening_tests\": \"8f375d384e5b8a2ebdecc24bca0624147a11a2f1\", \"accessibility_unittests\": \"96d1640efb7cf3fb6616657f48e33a32d1bf0245\", \"angle_unittests\": \"6291cbe995b57c402b427dcd62f8f6abc7b60ab2\", \"app_shell_unittests\": \"799cfc02ecb2b94054b7a905b37ef321559331e7\", \"aura_unittests\": \"b726d374338f6b86eeac39232ba5ed536f64c07f\", \"base_unittests\": \"d707ed28b15b976451dca9fc89e14bff4ab070bc\", \"base_util_unittests\": \"84b03bad7f08af7e4c9c18e185422390f121e9d4\", \"blink_common_unittests\": \"fc50bd0ca5cd990d2849765889df43e266d221e8\", \"blink_fuzzer_unittests\": \"58f9f75724ea692eaf6859ab40a227f7119dbb74\", \"blink_heap_unittests\": \"d69aa2c1ce116afdd2f41e4fe5598654bb8ad486\", \"blink_platform_unittests\": \"d0a8663caa8a4437d522cf70f5806dd4240f6652\", \"blink_python_tests\": \"a850068bffdc4a670df6ad15aeda052beec9a023\", \"blink_unittests\": \"fc03efeee739b6a44ce38b3e1fd862b3da519fc9\", \"blink_web_tests\": \"93401c75e54e9d3e9901f67a9ee4f8d52455b17d\", \"boringssl_crypto_tests\": \"339c2652771d7b3e164a30240cc807aad06fc5f2\", \"boringssl_ssl_tests\": \"4125b55d8cb2aefef23667153037cfe9fe874c0e\", \"browser_tests\": \"bbb6f23f0392dbf62d740fcc40579229ff3b8571\", \"capture_unittests\": \"dae59914bc379620e02682fe3afbd5a5b416045f\", \"cast_unittests\": \"0b26fdd017227d3ced4163b84e987a55a95e32ab\", \"cc_unittests\": \"acb51f4e74e4f4164fead47d1491c77b8f985fe5\", \"chrome_app_unittests\": \"72d93a2025e8ec15e1d22dee45c4e70ffc85a1df\", \"chromedriver_unittests\": \"6cec6f3bc4a85fe1cb6a967d9947f54622206bcf\", \"components_browsertests\": \"4c74887c4f9211fe31211179f1837e0915955a56\", \"components_unittests\": \"df6222b538306c37cae193e98eec1ba4b77e94b4\", \"compositor_unittests\": \"5945919ccd0d11a50eaa928aaf1e5a7e91da3cf7\", \"content_browsertests\": \"ce7d3c7023ee096f2028cb50074a3fae0fb94a34\", \"content_shell_crash_test\": \"a874357362781cb112351914e99785ddae5601cc\", \"content_unittests\": \"c91a9819ac20739d8e39838c97d50cd8a7f7f424\", \"crashpad_tests\": \"49f3237b435657bd0a41708c953bbb6e2282e049\", \"cronet_tests\": \"b3083194d91cd5974dbe4e5a061d21a307589f97\", \"cronet_unittests\": \"4a06513acb5948251e6c6389f9c8475572522816\", \"crypto_unittests\": \"b4ea65d67dbc4046191211f280ea3161f64e3024\", \"dbus_unittests\": \"97b1705f3871e03b4dd6c1be2b4fd003b75ee19e\", \"device_unittests\": \"653aa958aec70309234df0d6dcf80f74c2bc1548\", \"display_unittests\": \"1c1488fcfa9585b82ac28da69227dda2355b6d2e\", \"events_unittests\": \"ba7464e4aa9af929d965396091d2c568ef39ad9c\", \"extension_docserver_python_unittests\": \"d2c9142966a0b67f7aec9c3117242150c75cd902\", \"extensions_browsertests\": \"1c7f449d923fb39eb64fdfafc1eadcdc54625778\", \"extensions_unittests\": \"32b85a98e8e09723f2acea36db6886a872dd37f1\", \"filesystem_service_unittests\": \"0b40852fd3775977720bbc5f6e20cd46754b1bb3\", \"flatbuffers_unittests\": \"d051d66da1ab229778a7e9a8f6ace686eaf5e782\", \"gcm_unit_tests\": \"f0d0767d92bc9e9cba567b7f078ed42e37d1e269\", \"gfx_unittests\": \"d80a33fcc75e2896c72da7413bc49df4d33995b3\", \"gin_unittests\": \"5c6034a67d6750055bc208588173f0d47f5d3c28\", \"google_apis_unittests\": \"b297688d2acc895a454e55d5aefc9d8b1492c55a\", \"gpu_unittests\": \"dba44cd938b126a9050d94a737f9a3ba870f7c43\", \"grit_python_unittests\": \"275c161e38b800af0a18bf8ee2ae20e83dfa4ea2\", \"gwp_asan_unittests\": \"85a4409656e25530c6e025787387b24b69465007\", \"headless_browsertests\": \"611458bdde3836eef00085fc59945fab1f220d98\", \"headless_unittests\": \"a0153f6154518a629822bf867660dfbd092c06c8\", \"interactive_ui_tests\": \"6463be53faf9ddcfe9674063070e073a366dfb24\", \"ipc_tests\": \"2b1624151520172c529bfbe9fb113c1d5013ff29\", \"jingle_unittests\": \"00ea73e21ffc129de2407e9e79dd0f562a648c97\", \"latency_unittests\": \"1f6b809923b319be1fb8e042ad9330f1ee73733b\", \"libjingle_xmpp_unittests\": \"ee7c00a4b74ab5c1ce3f1a562ade3985b8ed5b64\", \"liburlpattern_unittests\": \"2474b765488b21a51c6bda6602ca1fc506c1de64\", \"media_blink_unittests\": \"96c63617d859dcfbf01f7020696fc25dff10a266\", \"media_unittests\": \"9cfe80bc7d420b0ac0fd351190246d98edfd012b\", \"message_center_unittests\": \"55b88a8ff715bd6d803b86a3dc0b73d6ef2e36e5\", \"metrics_python_tests\": \"9a057f240d8e448aea1f99ca8cd2be4817085334\", \"midi_unittests\": \"57a890852d18c64577e69240879eddae32ad007f\", \"mojo_core_unittests\": \"abb7d61cbf24e8c91d09191c5de588526a852443\", \"mojo_unittests\": \"e66bae75ee57101cf064910cf33b3f032ede6dd4\", \"nacl_helper_nonsfi_unittests\": \"504b27c5496dae8f718aa86efc3942da9cd9266e\", \"nacl_loader_unittests\": \"853e72fe3dc4bcb41e3b93d9e7f36068ff67e719\", \"native_theme_unittests\": \"095c58f890dd164668aec7880c983a4f0a310d28\", \"net_unittests\": \"ed63b978e2b48113613bbefe2bcd473d2b071a8e\", \"openscreen_unittests\": \"18baf463fb88d9253744663dde7dedbc9ae3df24\", \"pdf_unittests\": \"d0277d638285b56fa02b609bdecf2889c55117ba\", \"perfetto_unittests\": \"2b4794f2711a3c606bb1b5db4b17b4c5bc51e90d\", \"ppapi_unittests\": \"1cc897984e64fc87d976f0678bd1bcfa7fe2bd1d\", \"printing_unittests\": \"aabacf70b8dd3c645b89dfcbb4c6f238e545fd3a\", \"remoting_unittests\": \"08f165300ffd2b5746cad0693d01d44395b209d6\", \"sandbox_linux_unittests\": \"7b6c06a037257977d5ce0d7d5edadaef9eb97a47\", \"service_manager_unittests\": \"bf338b4006bffdca8e3ed213a48673ffaa0bc226\", \"services_unittests\": \"5f5c13e641f128d275ad957c819928d571b4053a\", \"shell_dialogs_unittests\": \"2174767c1deabb101ca563e1e1d74e56ab987401\", \"skia_unittests\": \"8a160b4b94a76a09827149d11673f1ee5bf9e7a1\", \"snapshot_unittests\": \"635fc7436144015bbc899d7bc924096792f14e7d\", \"sql_unittests\": \"29d5e2732b97881338fedde8246ed0f24f84b4b7\", \"storage_unittests\": \"2ca15a59961458a6e89f20f719e74aa9886a9f22\", \"sync_integration_tests\": \"8a0111e488c7bcb0c4590d3cef76617e2d0c99aa\", \"telemetry_gpu_unittests\": \"72e49f1d6f8f2162e1e79a624e9ce46fee20ad43\", \"telemetry_perf_unittests\": \"3450508a3e80ffceda7d0b73695234021f39a40a\", \"telemetry_unittests\": \"493f6c05cbfd7034e1982b28160134d374fa898f\", \"traffic_annotation_auditor_unittests\": \"5fc96914b84f2ff7bb978b419faf57a1a1405c1b\", \"ui_base_unittests\": \"f4c20129fb398db6dc4934e01f1e78a07c4068f6\", \"ui_touch_selection_unittests\": \"d313af2bd1465c96eabe165908d29fb91da912b7\", \"unit_tests\": \"3645426a049e919d9df4b78379671f1df9c1aefc\", \"url_unittests\": \"5b822a9d7fbf590f3099afe3a26445eb7a924efb\", \"views_perftests\": \"8948909c1e8d51d1a14f4501a17b6b9cb1a28205\", \"views_unittests\": \"0d4fb47f93b0f1e31b7119df1585c779a83d2e6d\", \"viz_unittests\": \"e39f398786f672e2a849fdd7e03f5e52f1c70c55\", \"vr_common_unittests\": \"00ebcbd66fc8ac2ce64fc7422df8e6a16ba455fb\", \"vr_pixeltests\": \"3bb8652e4b323affb97f83cccd734973884be408\", \"webdriver_wpt_tests\": \"adb4577a09bcb99f6464a4a9337dd81e60b9db2c\", \"weblayer_browsertests\": \"2d86b69784c749ff53dc7b6af95a3551fe323dc7\", \"weblayer_unittests\": \"3a430d3ba02efd40cd5ce34bd985c9e5fb6c20a3\", \"wm_unittests\": \"4b1874ae7734c5239b2256b0dca90633b967ce91\", \"wtf_unittests\": \"ea97987cb8ff07bf290ea28cddaab972a075df9d\", \"x11_unittests\": \"66680cbb5846464724070a4fc78f702eb7f9e0bf\", \"xr_browser_tests\": \"bae763eff85fb281a13e8628cf87be1ab93f6498\", \"zlib_unittests\": \"d7b4949fd0c0340e972b0ab41b48f91449fbaa72\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_7701d7ffc8ab5fe38a709c77d4f18478e80f1a1d01dd8053f239f119334d81d1_v2\", \"builder_bea46eaeedb7de1bd52f00a0308b818fe481ae542888a2fa5825ab1ef5ba3493_v2\", \"builder_bee64b857be6df8b7c1ab34ae7b2c6eab296c35495667b8b8424b2083d103b1e_v2\", \"builder_d2010e0a6a440fb89731b061caf7d596c92723d209ffefd62489cc037db4f7a7_v2\", \"builder_e7fd4b7a9e211f8d968af60263c508e13e49814167aff980c2bf239c05ea48ef_v2\", \"builder_f2d41554cc5e5ccdd409a1e3331deca1f73b654eb50c3540ea4abf5478e808d4_v2\", \"builder_ffe623326ac74578ce917ff55ef6cefa75094e5ad3ad5fe3409a729d79be647a_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-31-v2cj\"], \"image\": [\"chrome-xenial-20121300-d43316a0aad\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1608401419616776",
"status": "COMPLETED",
"status_changed_ts": "1608405813670008",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/178829",
"builder:Linux Builder (dbg)",
"buildset:commit/git/bd1c53145ea4f5ac012ea62ef3378d0d18326515",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bd1c53145ea4f5ac012ea62ef3378d0d18326515",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025894797510334944",
"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/8860464735584508368/+/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:5094e44cf2ed3310",
"user_agent:luci-scheduler"
],
"updated_ts": "1608405813674525",
"url": "https://ci.chromium.org/b/8860464735584508368",
"utcnow_ts": "1608405816857466"
}
}
[19:23:36.879] Invocation finished in 1h47m25.642017002s with status SUCCEEDED