[20:10:48.801] New invocation is queued and will start shortly
[20:10:50.361] Starting the invocation (attempt 1)
[20:10:50.399] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:10:50.399] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:10:50.399] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028331187388894432",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"5b99c2cf98847ca540fc471063decc66cf492c37\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9028331187388894432",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/5b99c2cf98847ca540fc471063decc66cf492c37",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5b99c2cf98847ca540fc471063decc66cf492c37",
"gitiles_ref:refs/heads/master"
]
}
[20:10:50.950] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1606075850478946",
"id": "8862901124967183536",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5b99c2cf98847ca540fc471063decc66cf492c37\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606075850818788",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/177916",
"builder:Linux Builder (dbg)",
"buildset:commit/git/5b99c2cf98847ca540fc471063decc66cf492c37",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5b99c2cf98847ca540fc471063decc66cf492c37",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028331187388894432",
"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/8862901124967183536/+/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": "1606075850818895",
"url": "https://ci.chromium.org/b/8862901124967183536",
"utcnow_ts": "1606075850942141"
}
}
[20:10:50.950] Task URL: https://ci.chromium.org/b/8862901124967183536
[20:10:50.950] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:2:0) after 1m0s
[20:11:50.928] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:2:0)
[20:11:50.928] Timer tick, asking Buildbucket for the build status
[20:11:51.048] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:11:51.048] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:3:0) after 1m0s
[20:12:51.065] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:3:0)
[20:12:51.065] Timer tick, asking Buildbucket for the build status
[20:12:51.601] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:12:51.601] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:4:0) after 1m0s
[20:13:51.642] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:4:0)
[20:13:51.642] Timer tick, asking Buildbucket for the build status
[20:13:51.722] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:13:51.722] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:5:0) after 1m0s
[20:14:51.730] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:5:0)
[20:14:51.730] Timer tick, asking Buildbucket for the build status
[20:14:51.789] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:14:51.789] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:6:0) after 1m0s
[20:15:51.813] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:6:0)
[20:15:51.813] Timer tick, asking Buildbucket for the build status
[20:15:51.940] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:15:51.940] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:7:0) after 1m0s
[20:16:51.918] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:7:0)
[20:16:51.918] Timer tick, asking Buildbucket for the build status
[20:16:52.304] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:16:52.304] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:8:0) after 1m0s
[20:17:52.313] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:8:0)
[20:17:52.313] Timer tick, asking Buildbucket for the build status
[20:17:53.048] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:17:53.048] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:9:0) after 1m0s
[20:18:53.093] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:9:0)
[20:18:53.093] Timer tick, asking Buildbucket for the build status
[20:18:53.173] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:18:53.173] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:10:0) after 1m0s
[20:19:53.203] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:10:0)
[20:19:53.203] Timer tick, asking Buildbucket for the build status
[20:19:53.277] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:19:53.277] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:11:0) after 1m0s
[20:20:53.283] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:11:0)
[20:20:53.283] Timer tick, asking Buildbucket for the build status
[20:20:53.541] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:20:53.541] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:12:0) after 1m0s
[20:21:53.595] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:12:0)
[20:21:53.595] Timer tick, asking Buildbucket for the build status
[20:21:53.677] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:21:53.677] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:13:0) after 1m0s
[20:22:53.762] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:13:0)
[20:22:53.762] Timer tick, asking Buildbucket for the build status
[20:22:53.835] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:22:53.835] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:14:0) after 1m0s
[20:23:53.884] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:14:0)
[20:23:53.884] Timer tick, asking Buildbucket for the build status
[20:23:53.953] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:23:53.953] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:15:0) after 1m0s
[20:24:53.997] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:15:0)
[20:24:53.997] Timer tick, asking Buildbucket for the build status
[20:24:54.384] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:24:54.384] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:16:0) after 1m0s
[20:25:54.355] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:16:0)
[20:25:54.355] Timer tick, asking Buildbucket for the build status
[20:25:54.815] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:25:54.815] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:17:0) after 1m0s
[20:26:54.871] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:17:0)
[20:26:54.871] Timer tick, asking Buildbucket for the build status
[20:26:54.952] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:26:54.952] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:18:0) after 1m0s
[20:27:55.134] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:18:0)
[20:27:55.134] Timer tick, asking Buildbucket for the build status
[20:27:55.226] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:27:55.226] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:19:0) after 1m0s
[20:28:55.273] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:19:0)
[20:28:55.273] Timer tick, asking Buildbucket for the build status
[20:28:55.329] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:28:55.329] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:20:0) after 1m0s
[20:29:55.354] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:20:0)
[20:29:55.354] Timer tick, asking Buildbucket for the build status
[20:29:55.425] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:29:55.425] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:21:0) after 1m0s
[20:30:55.483] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:21:0)
[20:30:55.483] Timer tick, asking Buildbucket for the build status
[20:30:55.609] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:30:55.609] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:22:0) after 1m0s
[20:31:55.635] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:22:0)
[20:31:55.635] Timer tick, asking Buildbucket for the build status
[20:31:55.704] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:31:55.704] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:23:0) after 1m0s
[20:32:55.710] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:23:0)
[20:32:55.710] Timer tick, asking Buildbucket for the build status
[20:32:55.953] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:32:55.953] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:24:0) after 1m0s
[20:33:55.959] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:24:0)
[20:33:55.959] Timer tick, asking Buildbucket for the build status
[20:33:56.034] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:33:56.034] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:25:0) after 1m0s
[20:34:56.043] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:25:0)
[20:34:56.043] Timer tick, asking Buildbucket for the build status
[20:34:56.111] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:34:56.111] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:26:0) after 1m0s
[20:35:56.166] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:26:0)
[20:35:56.166] Timer tick, asking Buildbucket for the build status
[20:35:56.301] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:35:56.301] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:27:0) after 1m0s
[20:36:56.321] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:27:0)
[20:36:56.321] Timer tick, asking Buildbucket for the build status
[20:36:56.396] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:36:56.396] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:28:0) after 1m0s
[20:37:56.426] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:28:0)
[20:37:56.426] Timer tick, asking Buildbucket for the build status
[20:37:56.504] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:37:56.505] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:29:0) after 1m0s
[20:38:56.629] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:29:0)
[20:38:56.629] Timer tick, asking Buildbucket for the build status
[20:38:57.081] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:38:57.081] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:30:0) after 1m0s
[20:39:57.159] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:30:0)
[20:39:57.159] Timer tick, asking Buildbucket for the build status
[20:39:57.432] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:39:57.432] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:31:0) after 1m0s
[20:40:57.493] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:31:0)
[20:40:57.493] Timer tick, asking Buildbucket for the build status
[20:40:57.594] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:40:57.594] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:32:0) after 1m0s
[20:41:57.616] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:32:0)
[20:41:57.616] Timer tick, asking Buildbucket for the build status
[20:41:57.692] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:41:57.692] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:33:0) after 1m0s
[20:42:57.715] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:33:0)
[20:42:57.715] Timer tick, asking Buildbucket for the build status
[20:42:57.787] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:42:57.787] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:34:0) after 1m0s
[20:43:57.814] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:34:0)
[20:43:57.814] Timer tick, asking Buildbucket for the build status
[20:43:57.889] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:43:57.889] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:35:0) after 1m0s
[20:44:57.925] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:35:0)
[20:44:57.926] Timer tick, asking Buildbucket for the build status
[20:44:58.001] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:44:58.001] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:36:0) after 1m0s
[20:45:58.013] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:36:0)
[20:45:58.013] Timer tick, asking Buildbucket for the build status
[20:45:58.111] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:45:58.111] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:37:0) after 1m0s
[20:46:58.143] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:37:0)
[20:46:58.143] Timer tick, asking Buildbucket for the build status
[20:46:59.377] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:46:59.377] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:38:0) after 1m0s
[20:48:00.217] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:38:0)
[20:48:00.217] Timer tick, asking Buildbucket for the build status
[20:48:00.343] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:48:00.343] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:39:0) after 1m0s
[20:49:00.715] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:39:0)
[20:49:00.715] Timer tick, asking Buildbucket for the build status
[20:49:00.780] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:49:00.780] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:40:0) after 1m0s
[20:50:01.119] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:40:0)
[20:50:01.119] Timer tick, asking Buildbucket for the build status
[20:50:01.195] Build 8862901124967183536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:50:01.195] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:41:0) after 1m0s
[20:50:08.031] Received PubSub notification, asking Buildbucket for the build status
[20:50:08.112] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:01.390] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:41:0)
[20:51:01.390] Timer tick, asking Buildbucket for the build status
[20:51:01.844] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:01.844] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:43:0) after 1m0s
[20:52:02.178] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:43:0)
[20:52:02.178] Timer tick, asking Buildbucket for the build status
[20:52:02.248] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:02.248] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:44:0) after 1m0s
[20:53:02.274] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:44:0)
[20:53:02.274] Timer tick, asking Buildbucket for the build status
[20:53:02.748] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:02.748] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:45:0) after 1m0s
[20:54:02.854] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:45:0)
[20:54:02.854] Timer tick, asking Buildbucket for the build status
[20:54:02.927] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:02.927] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:46:0) after 1m0s
[20:55:03.081] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:46:0)
[20:55:03.081] Timer tick, asking Buildbucket for the build status
[20:55:03.509] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:03.509] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:47:0) after 1m0s
[20:56:03.534] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:47:0)
[20:56:03.534] Timer tick, asking Buildbucket for the build status
[20:56:03.784] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:03.784] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:48:0) after 1m0s
[20:57:03.826] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:48:0)
[20:57:03.826] Timer tick, asking Buildbucket for the build status
[20:57:03.928] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:03.928] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:49:0) after 1m0s
[20:58:03.923] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:49:0)
[20:58:03.923] Timer tick, asking Buildbucket for the build status
[20:58:04.087] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:04.087] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:50:0) after 1m0s
[20:59:04.116] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:50:0)
[20:59:04.116] Timer tick, asking Buildbucket for the build status
[20:59:04.209] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:04.209] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:51:0) after 1m0s
[21:00:04.253] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:51:0)
[21:00:04.253] Timer tick, asking Buildbucket for the build status
[21:00:04.407] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:04.407] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:52:0) after 1m0s
[21:01:04.595] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:52:0)
[21:01:04.595] Timer tick, asking Buildbucket for the build status
[21:01:04.761] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:04.761] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:53:0) after 1m0s
[21:02:04.792] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:53:0)
[21:02:04.792] Timer tick, asking Buildbucket for the build status
[21:02:04.924] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:04.924] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:54:0) after 1m0s
[21:03:05.102] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:54:0)
[21:03:05.102] Timer tick, asking Buildbucket for the build status
[21:03:05.217] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:05.217] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:55:0) after 1m0s
[21:04:05.292] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:55:0)
[21:04:05.292] Timer tick, asking Buildbucket for the build status
[21:04:05.428] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:05.428] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:56:0) after 1m0s
[21:05:05.589] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:56:0)
[21:05:05.589] Timer tick, asking Buildbucket for the build status
[21:05:05.813] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:05.813] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:57:0) after 1m0s
[21:06:05.911] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:57:0)
[21:06:05.911] Timer tick, asking Buildbucket for the build status
[21:06:06.307] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:06.307] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:58:0) after 1m0s
[21:07:06.358] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:58:0)
[21:07:06.358] Timer tick, asking Buildbucket for the build status
[21:07:06.416] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:06.416] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:59:0) after 1m0s
[21:08:06.542] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:59:0)
[21:08:06.542] Timer tick, asking Buildbucket for the build status
[21:08:06.615] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:06.615] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:60:0) after 1m0s
[21:09:06.643] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:60:0)
[21:09:06.643] Timer tick, asking Buildbucket for the build status
[21:09:06.697] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:06.697] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:61:0) after 1m0s
[21:10:06.764] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:61:0)
[21:10:06.764] Timer tick, asking Buildbucket for the build status
[21:10:06.977] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:06.977] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:62:0) after 1m0s
[21:11:07.004] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:62:0)
[21:11:07.004] Timer tick, asking Buildbucket for the build status
[21:11:07.166] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:07.166] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:63:0) after 1m0s
[21:12:07.224] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:63:0)
[21:12:07.224] Timer tick, asking Buildbucket for the build status
[21:12:07.285] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:07.285] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:64:0) after 1m0s
[21:13:07.351] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:64:0)
[21:13:07.351] Timer tick, asking Buildbucket for the build status
[21:13:07.423] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:07.423] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:65:0) after 1m0s
[21:14:07.455] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:65:0)
[21:14:07.455] Timer tick, asking Buildbucket for the build status
[21:14:07.523] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:07.523] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:66:0) after 1m0s
[21:15:07.594] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:66:0)
[21:15:07.594] Timer tick, asking Buildbucket for the build status
[21:15:07.658] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:07.658] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:67:0) after 1m0s
[21:16:07.689] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:67:0)
[21:16:07.689] Timer tick, asking Buildbucket for the build status
[21:16:07.787] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:07.787] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:68:0) after 1m0s
[21:17:07.828] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:68:0)
[21:17:07.828] Timer tick, asking Buildbucket for the build status
[21:17:07.906] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:07.906] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:69:0) after 1m0s
[21:18:07.994] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:69:0)
[21:18:07.994] Timer tick, asking Buildbucket for the build status
[21:18:08.134] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:08.134] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:70:0) after 1m0s
[21:19:08.156] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:70:0)
[21:19:08.156] Timer tick, asking Buildbucket for the build status
[21:19:08.218] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:08.218] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:71:0) after 1m0s
[21:20:08.336] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:71:0)
[21:20:08.336] Timer tick, asking Buildbucket for the build status
[21:20:08.435] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:08.435] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:72:0) after 1m0s
[21:21:08.492] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:72:0)
[21:21:08.492] Timer tick, asking Buildbucket for the build status
[21:21:08.604] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:08.604] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:73:0) after 1m0s
[21:22:08.629] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:73:0)
[21:22:08.629] Timer tick, asking Buildbucket for the build status
[21:22:08.697] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:08.697] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:74:0) after 1m0s
[21:23:08.779] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:74:0)
[21:23:08.779] Timer tick, asking Buildbucket for the build status
[21:23:08.850] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:08.850] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:75:0) after 1m0s
[21:24:08.884] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:75:0)
[21:24:08.884] Timer tick, asking Buildbucket for the build status
[21:24:08.954] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:08.954] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:76:0) after 1m0s
[21:25:08.979] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:76:0)
[21:25:08.979] Timer tick, asking Buildbucket for the build status
[21:25:09.053] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:09.053] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:77:0) after 1m0s
[21:26:09.078] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:77:0)
[21:26:09.078] Timer tick, asking Buildbucket for the build status
[21:26:09.192] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:09.192] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:78:0) after 1m0s
[21:27:09.241] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:78:0)
[21:27:09.241] Timer tick, asking Buildbucket for the build status
[21:27:09.492] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:09.492] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:79:0) after 1m0s
[21:28:09.566] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:79:0)
[21:28:09.566] Timer tick, asking Buildbucket for the build status
[21:28:09.630] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:09.630] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:80:0) after 1m0s
[21:29:09.710] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:80:0)
[21:29:09.710] Timer tick, asking Buildbucket for the build status
[21:29:09.843] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:09.843] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:81:0) after 1m0s
[21:30:09.981] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:81:0)
[21:30:09.981] Timer tick, asking Buildbucket for the build status
[21:30:10.039] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:10.039] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:82:0) after 1m0s
[21:31:10.181] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:82:0)
[21:31:10.181] Timer tick, asking Buildbucket for the build status
[21:31:10.295] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:10.295] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:83:0) after 1m0s
[21:32:10.333] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:83:0)
[21:32:10.333] Timer tick, asking Buildbucket for the build status
[21:32:10.484] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:10.484] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:84:0) after 1m0s
[21:33:10.519] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:84:0)
[21:33:10.519] Timer tick, asking Buildbucket for the build status
[21:33:10.707] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:10.707] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:85:0) after 1m0s
[21:34:10.768] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:85:0)
[21:34:10.768] Timer tick, asking Buildbucket for the build status
[21:34:10.824] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:10.824] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:86:0) after 1m0s
[21:35:10.874] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:86:0)
[21:35:10.874] Timer tick, asking Buildbucket for the build status
[21:35:11.222] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:11.222] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:87:0) after 1m0s
[21:36:11.375] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:87:0)
[21:36:11.375] Timer tick, asking Buildbucket for the build status
[21:36:12.003] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:12.003] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:88:0) after 1m0s
[21:37:12.036] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:88:0)
[21:37:12.036] Timer tick, asking Buildbucket for the build status
[21:37:12.730] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:12.730] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:89:0) after 1m0s
[21:38:12.788] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:89:0)
[21:38:12.788] Timer tick, asking Buildbucket for the build status
[21:38:12.837] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:12.837] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:90:0) after 1m0s
[21:39:12.919] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:90:0)
[21:39:12.919] Timer tick, asking Buildbucket for the build status
[21:39:12.975] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:12.975] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:91:0) after 1m0s
[21:40:13.165] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:91:0)
[21:40:13.165] Timer tick, asking Buildbucket for the build status
[21:40:13.242] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:13.242] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:92:0) after 1m0s
[21:41:13.269] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:92:0)
[21:41:13.269] Timer tick, asking Buildbucket for the build status
[21:41:13.369] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:13.369] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:93:0) after 1m0s
[21:42:13.446] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:93:0)
[21:42:13.446] Timer tick, asking Buildbucket for the build status
[21:42:13.530] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:13.530] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:94:0) after 1m0s
[21:43:13.570] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:94:0)
[21:43:13.570] Timer tick, asking Buildbucket for the build status
[21:43:13.876] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:13.876] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:95:0) after 1m0s
[21:44:13.900] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:95:0)
[21:44:13.900] Timer tick, asking Buildbucket for the build status
[21:44:14.010] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:14.010] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:96:0) after 1m0s
[21:45:14.084] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:96:0)
[21:45:14.084] Timer tick, asking Buildbucket for the build status
[21:45:14.561] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:14.561] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:97:0) after 1m0s
[21:46:14.619] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:97:0)
[21:46:14.619] Timer tick, asking Buildbucket for the build status
[21:46:14.802] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:14.802] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:98:0) after 1m0s
[21:47:14.860] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:98:0)
[21:47:14.860] Timer tick, asking Buildbucket for the build status
[21:47:14.951] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:14.951] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:99:0) after 1m0s
[21:48:14.977] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:99:0)
[21:48:14.977] Timer tick, asking Buildbucket for the build status
[21:48:15.037] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:15.037] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:100:0) after 1m0s
[21:49:15.064] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:100:0)
[21:49:15.064] Timer tick, asking Buildbucket for the build status
[21:49:15.119] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:15.119] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:101:0) after 1m0s
[21:50:15.215] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:101:0)
[21:50:15.215] Timer tick, asking Buildbucket for the build status
[21:50:15.285] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:15.285] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:102:0) after 1m0s
[21:51:16.888] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:102:0)
[21:51:16.888] Timer tick, asking Buildbucket for the build status
[21:51:17.107] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:17.107] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:103:0) after 1m0s
[21:52:17.428] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:103:0)
[21:52:17.428] Timer tick, asking Buildbucket for the build status
[21:52:17.615] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:17.615] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:104:0) after 1m0s
[21:53:17.937] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:104:0)
[21:53:17.937] Timer tick, asking Buildbucket for the build status
[21:53:18.390] Build 8862901124967183536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:18.390] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028331187388894432:105:0) after 1m0s
[21:53:46.537] Received PubSub notification, asking Buildbucket for the build status
[21:53:46.630] Build 8862901124967183536: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:53:46.630] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1606082025667649",
"created_by": "project:chromium",
"created_ts": "1606075850478946",
"id": "8862901124967183536",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5b99c2cf98847ca540fc471063decc66cf492c37\"}}",
"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\": \"5b99c2cf98847ca540fc471063decc66cf492c37\", \"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-east1-d-8-40-14hz\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 177916, \"got_angle_revision\": \"ebf890fcf9f3e297dcb0736b31bce3e63d63c4d7\", \"got_dawn_revision\": \"546a7c98c89718f2dadf1ae07088fa7cf2ccb53f\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"5b99c2cf98847ca540fc471063decc66cf492c37\", \"got_revision_cp\": \"refs/heads/master@{#830056}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"6d612051c083238db89541be4fbb2d624a9baef4\", \"got_v8_revision\": \"805e8b5987e5fd07adbe998f0c21f84cb20468b8\", \"got_v8_revision_cp\": \"refs/heads/8.9.32@{#1}\", \"got_webrtc_revision\": \"d96634781e537685496ce6e207bf41b4a98de492\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32661}\", \"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\": \"5b99c2cf98847ca540fc471063decc66cf492c37\", \"swarm_hashes_refs/heads/master(at){#830056}_without_patch\": {\"absl_hardening_tests\": \"f230be7c7c414ae108a264661edadb5bc6c02700\", \"accessibility_unittests\": \"5a7902c2db09d5c4c470e78a0fee29b61c9f0d7a\", \"angle_unittests\": \"c6132a138bb3610f24ffc9338696fd46cebb821e\", \"app_shell_unittests\": \"583cfe3b4f284e3cc0589d9c7206dc63e10250d5\", \"aura_unittests\": \"254def5cc15f9ed8f112f58905911a1159f11290\", \"base_unittests\": \"5495d5d21b3f1cf5f292a9decbe8fcbbd7ddec9c\", \"base_util_unittests\": \"ac2e272a7697da614f5f4806e6c2b0d2ce4a1489\", \"blink_common_unittests\": \"65a195d38f52b3e65ce62db8e807fe633b95e7d4\", \"blink_fuzzer_unittests\": \"9c7ce2efdb8c6872611231cbc8abff3b1a722ec6\", \"blink_heap_unittests\": \"1ea0b0c8b7f31e5eca73dc09e9542cf4ce586a8a\", \"blink_platform_unittests\": \"6d2d4d9441e509151f04c254a65f26f0f2b1f23f\", \"blink_python_tests\": \"a24790c78fd8b95dc62ae77b52c63d63114aafb2\", \"blink_unittests\": \"b03470dfe48b34bb8d4f869dc9e4627fdf918693\", \"blink_web_tests\": \"b5b3e699e22300e7496b172e74f372c562c2bdb4\", \"boringssl_crypto_tests\": \"681225ee260342e3613837a037c9de5371b0ac04\", \"boringssl_ssl_tests\": \"536df60b5226ff17910f4e6525f312238f92b7da\", \"browser_tests\": \"0df553690eff681d56b7b25f56d5eda97ccd2127\", \"capture_unittests\": \"da6996dbaf6b9788fa0b903cdb16d47e56b394d9\", \"cast_unittests\": \"d62500bbe9c54f4d245b9304efa2ffe821b176f5\", \"cc_unittests\": \"46b5af4bc1408f603ff2ad7ab1f8fb71f9382a9a\", \"chrome_app_unittests\": \"99b4a1ee7071501efdf5e928b9dc2d3fcaa3e1cf\", \"chromedriver_unittests\": \"675356f63b77b94a7eaae4b125caa7f7732ec94c\", \"components_browsertests\": \"d6396db97ffc86cc779dfb285efe67b9c3d86cf7\", \"components_unittests\": \"be71f366937518967ed71a533a92151826ee6da1\", \"compositor_unittests\": \"694b11f26f664c68ac0f4997f90ef5baf00ea88b\", \"content_browsertests\": \"2398a5c6690ee679cb6b8b6d914b3da1f8805445\", \"content_shell_crash_test\": \"bcbd057c9bed6ccd1e4b2012b2d16e01c96bf4de\", \"content_unittests\": \"a67ea1f191e8d3853c34bd64c67b7c5f1254bf7b\", \"crashpad_tests\": \"92aa998ce4e1e8a303c8252deb21d44f59b59d36\", \"cronet_tests\": \"1f9c0590a6dba2f615ca1a28070783e5d7f9cbb7\", \"cronet_unittests\": \"4c3d5cac9918b4086d01e32a5d19347c139e172d\", \"crypto_unittests\": \"32c701212b5dc4d65f7789c962c2e90a0893c7f5\", \"dbus_unittests\": \"1ddd7a1826c4b0c65cf864ef28f40b54bfc567d7\", \"device_unittests\": \"404037df18a12a325b58ca53385d710e128dd0da\", \"display_unittests\": \"7edd49dd3fce539e5d978025190094f5dc55637a\", \"events_unittests\": \"b4e610d19756e755256f6a20187fd2a9a6a177a9\", \"extension_docserver_python_unittests\": \"3f97f9b3ffee18736eb04c3a3bfc00004b62b489\", \"extensions_browsertests\": \"fd30fe12bd2f6ff815138a48b45d3e67d172a4c7\", \"extensions_unittests\": \"174612fb9a17967e1a1d6e20303c2f47f60fb453\", \"filesystem_service_unittests\": \"05bd72be97de7b3b7f677b4b053b73d4030e1101\", \"flatbuffers_unittests\": \"dd6267ccaa5ef4f5de95507aa468128ed4c0a477\", \"gcm_unit_tests\": \"d365b3b5b70f8918f8fbeb58babd2f3d80f4b7ee\", \"gfx_unittests\": \"a89993994c111d5cb7b73a89797c342d2d51beff\", \"gin_unittests\": \"14e3f8003cbd22f96257d9ff5da3151799da2e03\", \"google_apis_unittests\": \"c9583848d180b2048301025dd6fea520f33804e7\", \"gpu_unittests\": \"fa621950dc41ccde39a131e9f05b17b0d8e52006\", \"grit_python_unittests\": \"b20d4d77fd059e1da02f2886f0fe402b433cc81c\", \"gwp_asan_unittests\": \"b22cdc023cde90b5398c23d4e704761e7fd521eb\", \"headless_browsertests\": \"3f1be6b23c42ec908dbac3d66d76beada59dd766\", \"headless_unittests\": \"cd73bd6945a06ee62d76590681991828242e3cd7\", \"interactive_ui_tests\": \"af620aa9d3d144d655aade11435a25c3d03ca6bc\", \"ipc_tests\": \"8fb294128ca74b2f21cfcf4422467f96384282ef\", \"jingle_unittests\": \"2091e19b0d9d8c0a80df217a35761e2b5865a104\", \"latency_unittests\": \"ebd1145782a51ab01dc2767c7b3daedd137a0d5d\", \"libjingle_xmpp_unittests\": \"3874cf729c896cf792c2dfc5b6beedff776775e8\", \"liburlpattern_unittests\": \"e5d343f5ea6c02433664d9d668c1804efecf7b50\", \"media_blink_unittests\": \"69c58a301f024941426d54151d4f3ad34b4baf26\", \"media_unittests\": \"1c7bcb66ac5e3673dad2bbcdd95eba3a24e5ce13\", \"message_center_unittests\": \"f584176ee368e655f94e8057cce9cd989caa5dc6\", \"metrics_python_tests\": \"785dcaee5c82a634802f47ed524d717e70759e22\", \"midi_unittests\": \"660ba696690c2a3e0427ee4f7c5402ab62255ac5\", \"mojo_core_unittests\": \"9f08d7b8f677af2239698246731c55122985739f\", \"mojo_unittests\": \"ba968402c26a5dee59099b4a31bcb746c73abbed\", \"nacl_helper_nonsfi_unittests\": \"352fa522fe90f37aea9ae8a328d99a8495399046\", \"nacl_loader_unittests\": \"3d3538272d944d90148e7045332a78a643dd7703\", \"native_theme_unittests\": \"05dd2e1353e160d89e6198aee9de759ff0ad66d9\", \"net_unittests\": \"8bb3339f3fd62dbd224ba10f684f2bfd310ab76c\", \"openscreen_unittests\": \"3a3b015292cb353dc62077827099147e18ceed79\", \"pdf_unittests\": \"4b2a2f0ebefdb6aea3c20157a739a6a0a9b612d7\", \"perfetto_unittests\": \"6e33d0881b2add317cd8c4b7bfd01d9af6d34af4\", \"ppapi_unittests\": \"56b142e57de1527a25de5b5f38d7d481d9973c17\", \"printing_unittests\": \"22b589db35c3aef84406c8dd480271b04d75df87\", \"remoting_unittests\": \"3c23acb0863d66bd312f4480cf53581470c23241\", \"sandbox_linux_unittests\": \"1f3850610f45925b2674db9f17c2eedd3409359d\", \"service_manager_unittests\": \"819009b44249b86ca61af2fd193048f0ee9151eb\", \"services_unittests\": \"5ef51d579765b9c03fe69ef6b80bb2115258b219\", \"shell_dialogs_unittests\": \"5cee08da42dc309f21d001139e9277e8e15ed6d3\", \"skia_unittests\": \"0b83ee69c47f7848756223280d3ea3a85f56675d\", \"snapshot_unittests\": \"012edb4732092403a3da3ca2321f750f2aae1f17\", \"sql_unittests\": \"e7813fccc793bec0d5b7427b41a9d61b6982b008\", \"storage_unittests\": \"a8e02a1744befc0d2099ac09809144909a2299b4\", \"sync_integration_tests\": \"898373b1e188e292443925372db7b40efaaea255\", \"telemetry_gpu_unittests\": \"8420a496d2f09e573097c274eb98de418e8ce6be\", \"telemetry_perf_unittests\": \"60b9a9a10cbabe03abf26ca58f2564b65084a94d\", \"telemetry_unittests\": \"5ac91729b36c744ed9731b72372feb5ece8b4718\", \"traffic_annotation_auditor_unittests\": \"c5787a0851e810922228e85a9872e5915bca530c\", \"ui_base_unittests\": \"7c1ef60a0361c75714c5a9cf95a2d6df87746557\", \"ui_touch_selection_unittests\": \"314cc62cb283c967841d2bce74a20275a17c7c0e\", \"unit_tests\": \"de80b4acd3513a7fd18879d9409b6b0d204b1ad5\", \"url_unittests\": \"47c3c365bc28fa4137eb0381725b6b9eb28376cc\", \"views_perftests\": \"ca320b499bc8682675756c6a7f444125b0b41d1b\", \"views_unittests\": \"709abf652ae4247ef6f7327c3ae6a38cd0564726\", \"viz_unittests\": \"c1a226ca2d714ddd71ed80f475ccfb45d8af329d\", \"vr_common_unittests\": \"b55426fd71b6a6d5abc6c3b43827329ea643f5e6\", \"vr_pixeltests\": \"12d710710b1d3041fc67f0ceb0cfd887d298ff2d\", \"webdriver_wpt_tests\": \"e840c5ab518b7fb86730e5d7cafb44c2a922c7da\", \"weblayer_browsertests\": \"5543a33c654d534443c032326270221204835b28\", \"weblayer_unittests\": \"d749dd34880aa1037ce41bc447838d15029bb74e\", \"wm_unittests\": \"88ad3dca771397d780ca39c370137766b29196f1\", \"wtf_unittests\": \"e12bea87c6fd1ef3aa7c32240bfbdcf728c9bb84\", \"x11_unittests\": \"f4c5cfa3120ddb6a30252d566e74e1b3036e5306\", \"xr_browser_tests\": \"14a9c0cc3d16a746230ee7c2cb69e50d40050672\", \"zlib_unittests\": \"af65c26298aa3af97f142a5fbe6007775cf5fdcc\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1415e99d1ada386cfb0c84043d2495490d2cdcd28ad7785eb6837a9119e6428f_v2\", \"builder_6e4a31244c7251e88cf04b6a466eafe8dff7b745833b61f340cac0d6618c3644_v2\", \"builder_f5610824250c57fc28679fbc8606252c3dbaca731fb7f2a4bebf1e0fc7f48a3a_v2\", \"builder_f5b4454e99a04aaa5ba743b59cc70de19e20bebedef65e50e3b90534a8d6a5e4_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-east1-d-8-40-14hz\"], \"image\": [\"chrome-xenial-20111600-a937a23cefb\"], \"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\": [\"5637-4d8b832\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1606078203882467",
"status": "COMPLETED",
"status_changed_ts": "1606082026120755",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/177916",
"builder:Linux Builder (dbg)",
"buildset:commit/git/5b99c2cf98847ca540fc471063decc66cf492c37",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5b99c2cf98847ca540fc471063decc66cf492c37",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028331187388894432",
"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/8862901124967183536/+/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:500a662989760310",
"user_agent:luci-scheduler"
],
"updated_ts": "1606082026128596",
"url": "https://ci.chromium.org/b/8862901124967183536",
"utcnow_ts": "1606082026617994"
}
}
[21:53:46.631] Invocation finished in 1h42m57.845606242s with status SUCCEEDED