[00:08:19.152] New invocation is queued and will start shortly
[00:08:20.418] Starting the invocation (attempt 1)
[00:08:20.456] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:08:20.458] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:08:20.458] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028406841780918816",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"4f32cabc761bef0a5c48f282fd5716a0af5abc52\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9028406841780918816",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/4f32cabc761bef0a5c48f282fd5716a0af5abc52",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4f32cabc761bef0a5c48f282fd5716a0af5abc52",
"gitiles_ref:refs/heads/master"
]
}
[00:08:21.939] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606003700584737",
"id": "8862976779614446576",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4f32cabc761bef0a5c48f282fd5716a0af5abc52\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606003701444596",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21415",
"builder:linux-chromeos-dbg",
"buildset:commit/git/4f32cabc761bef0a5c48f282fd5716a0af5abc52",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4f32cabc761bef0a5c48f282fd5716a0af5abc52",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028406841780918816",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8862976779614446576/+/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": "1606003701444720",
"url": "https://ci.chromium.org/b/8862976779614446576",
"utcnow_ts": "1606003701875759"
}
}
[00:08:21.939] Task URL: https://ci.chromium.org/b/8862976779614446576
[00:08:21.939] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:2:0) after 1m0s
[00:09:21.991] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:2:0)
[00:09:21.991] Timer tick, asking Buildbucket for the build status
[00:09:22.157] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:09:22.157] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:3:0) after 1m0s
[00:10:22.179] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:3:0)
[00:10:22.179] Timer tick, asking Buildbucket for the build status
[00:10:22.490] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:10:22.490] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:4:0) after 1m0s
[00:11:22.541] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:4:0)
[00:11:22.541] Timer tick, asking Buildbucket for the build status
[00:11:22.621] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:11:22.621] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:5:0) after 1m0s
[00:12:22.640] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:5:0)
[00:12:22.640] Timer tick, asking Buildbucket for the build status
[00:12:23.325] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:12:23.325] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:6:0) after 1m0s
[00:13:23.346] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:6:0)
[00:13:23.346] Timer tick, asking Buildbucket for the build status
[00:13:23.455] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:13:23.456] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:7:0) after 1m0s
[00:14:23.518] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:7:0)
[00:14:23.518] Timer tick, asking Buildbucket for the build status
[00:14:23.596] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:14:23.596] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:8:0) after 1m0s
[00:15:23.639] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:8:0)
[00:15:23.639] Timer tick, asking Buildbucket for the build status
[00:15:24.013] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:15:24.013] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:9:0) after 1m0s
[00:16:24.035] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:9:0)
[00:16:24.035] Timer tick, asking Buildbucket for the build status
[00:16:24.106] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:16:24.106] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:10:0) after 1m0s
[00:17:24.124] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:10:0)
[00:17:24.124] Timer tick, asking Buildbucket for the build status
[00:17:24.192] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:17:24.192] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:11:0) after 1m0s
[00:18:24.239] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:11:0)
[00:18:24.239] Timer tick, asking Buildbucket for the build status
[00:18:24.503] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:18:24.503] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:12:0) after 1m0s
[00:19:24.480] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:12:0)
[00:19:24.480] Timer tick, asking Buildbucket for the build status
[00:19:24.561] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:19:24.561] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:13:0) after 1m0s
[00:20:24.585] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:13:0)
[00:20:24.585] Timer tick, asking Buildbucket for the build status
[00:20:24.675] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:20:24.675] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:14:0) after 1m0s
[00:21:24.692] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:14:0)
[00:21:24.692] Timer tick, asking Buildbucket for the build status
[00:21:24.767] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:21:24.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:15:0) after 1m0s
[00:22:24.774] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:15:0)
[00:22:24.774] Timer tick, asking Buildbucket for the build status
[00:22:24.860] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:22:24.860] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:16:0) after 1m0s
[00:23:24.946] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:16:0)
[00:23:24.946] Timer tick, asking Buildbucket for the build status
[00:23:25.044] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:23:25.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:17:0) after 1m0s
[00:24:25.129] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:17:0)
[00:24:25.129] Timer tick, asking Buildbucket for the build status
[00:24:25.310] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:24:25.310] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:18:0) after 1m0s
[00:25:25.315] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:18:0)
[00:25:25.315] Timer tick, asking Buildbucket for the build status
[00:25:25.716] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:25:25.716] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:19:0) after 1m0s
[00:26:25.749] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:19:0)
[00:26:25.749] Timer tick, asking Buildbucket for the build status
[00:26:25.825] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:26:25.825] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:20:0) after 1m0s
[00:27:25.883] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:20:0)
[00:27:25.883] Timer tick, asking Buildbucket for the build status
[00:27:25.974] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:27:25.974] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:21:0) after 1m0s
[00:28:26.021] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:21:0)
[00:28:26.021] Timer tick, asking Buildbucket for the build status
[00:28:26.154] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:28:26.154] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:22:0) after 1m0s
[00:29:26.178] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:22:0)
[00:29:26.178] Timer tick, asking Buildbucket for the build status
[00:29:26.430] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:29:26.430] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:23:0) after 1m0s
[00:30:26.470] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:23:0)
[00:30:26.471] Timer tick, asking Buildbucket for the build status
[00:30:26.749] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:30:26.749] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:24:0) after 1m0s
[00:31:26.775] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:24:0)
[00:31:26.775] Timer tick, asking Buildbucket for the build status
[00:31:26.856] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:31:26.856] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:25:0) after 1m0s
[00:32:26.916] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:25:0)
[00:32:26.916] Timer tick, asking Buildbucket for the build status
[00:32:26.999] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:32:26.999] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:26:0) after 1m0s
[00:33:27.075] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:26:0)
[00:33:27.075] Timer tick, asking Buildbucket for the build status
[00:33:27.200] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:33:27.200] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:27:0) after 1m0s
[00:34:27.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:27:0)
[00:34:27.222] Timer tick, asking Buildbucket for the build status
[00:34:27.292] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:34:27.292] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:28:0) after 1m0s
[00:35:27.302] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:28:0)
[00:35:27.302] Timer tick, asking Buildbucket for the build status
[00:35:27.645] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:35:27.645] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:29:0) after 1m0s
[00:36:27.695] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:29:0)
[00:36:27.695] Timer tick, asking Buildbucket for the build status
[00:36:27.769] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:36:27.769] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:30:0) after 1m0s
[00:37:27.872] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:30:0)
[00:37:27.872] Timer tick, asking Buildbucket for the build status
[00:37:27.964] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:37:27.964] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:31:0) after 1m0s
[00:38:28.010] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:31:0)
[00:38:28.010] Timer tick, asking Buildbucket for the build status
[00:38:28.315] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:38:28.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:32:0) after 1m0s
[00:39:28.315] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:32:0)
[00:39:28.315] Timer tick, asking Buildbucket for the build status
[00:39:28.388] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:39:28.388] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:33:0) after 1m0s
[00:40:28.444] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:33:0)
[00:40:28.444] Timer tick, asking Buildbucket for the build status
[00:40:28.536] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:40:28.536] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:34:0) after 1m0s
[00:41:28.565] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:34:0)
[00:41:28.565] Timer tick, asking Buildbucket for the build status
[00:41:28.637] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:41:28.637] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:35:0) after 1m0s
[00:42:28.699] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:35:0)
[00:42:28.699] Timer tick, asking Buildbucket for the build status
[00:42:28.836] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:42:28.836] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:36:0) after 1m0s
[00:43:28.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:36:0)
[00:43:28.888] Timer tick, asking Buildbucket for the build status
[00:43:29.125] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:43:29.125] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:37:0) after 1m0s
[00:44:29.223] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:37:0)
[00:44:29.223] Timer tick, asking Buildbucket for the build status
[00:44:29.307] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:44:29.307] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:38:0) after 1m0s
[00:45:29.359] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:38:0)
[00:45:29.359] Timer tick, asking Buildbucket for the build status
[00:45:29.457] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:45:29.457] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:39:0) after 1m0s
[00:46:29.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:39:0)
[00:46:29.454] Timer tick, asking Buildbucket for the build status
[00:46:29.526] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:46:29.526] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:40:0) after 1m0s
[00:47:29.609] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:40:0)
[00:47:29.609] Timer tick, asking Buildbucket for the build status
[00:47:29.829] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:47:29.829] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:41:0) after 1m0s
[00:48:29.973] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:41:0)
[00:48:29.973] Timer tick, asking Buildbucket for the build status
[00:48:30.156] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:48:30.156] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:42:0) after 1m0s
[00:49:30.288] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:42:0)
[00:49:30.288] Timer tick, asking Buildbucket for the build status
[00:49:30.369] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:49:30.369] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:43:0) after 1m0s
[00:50:30.645] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:43:0)
[00:50:30.645] Timer tick, asking Buildbucket for the build status
[00:50:30.756] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:50:30.756] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:44:0) after 1m0s
[00:51:30.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:44:0)
[00:51:30.920] Timer tick, asking Buildbucket for the build status
[00:51:31.034] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:51:31.034] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:45:0) after 1m0s
[00:52:31.210] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:45:0)
[00:52:31.210] Timer tick, asking Buildbucket for the build status
[00:52:32.416] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:52:32.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:46:0) after 1m0s
[00:53:32.438] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:46:0)
[00:53:32.438] Timer tick, asking Buildbucket for the build status
[00:53:32.537] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:53:32.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:47:0) after 1m0s
[00:54:32.622] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:47:0)
[00:54:32.622] Timer tick, asking Buildbucket for the build status
[00:54:33.544] Build 8862976779614446576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:54:33.544] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:48:0) after 1m0s
[00:55:20.505] Received PubSub notification, asking Buildbucket for the build status
[00:55:20.751] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:33.565] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:48:0)
[00:55:33.565] Timer tick, asking Buildbucket for the build status
[00:55:33.634] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:33.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:50:0) after 1m0s
[00:56:33.655] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:50:0)
[00:56:33.655] Timer tick, asking Buildbucket for the build status
[00:56:33.744] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:33.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:51:0) after 1m0s
[00:57:33.765] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:51:0)
[00:57:33.765] Timer tick, asking Buildbucket for the build status
[00:57:33.841] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:33.841] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:52:0) after 1m0s
[00:58:33.884] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:52:0)
[00:58:33.884] Timer tick, asking Buildbucket for the build status
[00:58:33.978] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:33.979] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:53:0) after 1m0s
[00:59:34.021] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:53:0)
[00:59:34.021] Timer tick, asking Buildbucket for the build status
[00:59:34.272] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:34.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:54:0) after 1m0s
[01:00:34.297] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:54:0)
[01:00:34.297] Timer tick, asking Buildbucket for the build status
[01:00:34.383] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:34.384] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:55:0) after 1m0s
[01:01:34.407] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:55:0)
[01:01:34.407] Timer tick, asking Buildbucket for the build status
[01:01:34.745] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:34.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:56:0) after 1m0s
[01:02:34.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:56:0)
[01:02:34.762] Timer tick, asking Buildbucket for the build status
[01:02:34.851] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:34.851] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:57:0) after 1m0s
[01:03:34.875] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:57:0)
[01:03:34.875] Timer tick, asking Buildbucket for the build status
[01:03:34.985] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:34.985] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:58:0) after 1m0s
[01:04:35.022] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:58:0)
[01:04:35.022] Timer tick, asking Buildbucket for the build status
[01:04:35.095] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:35.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:59:0) after 1m0s
[01:05:35.135] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:59:0)
[01:05:35.135] Timer tick, asking Buildbucket for the build status
[01:05:35.202] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:35.202] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:60:0) after 1m0s
[01:06:35.320] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:60:0)
[01:06:35.320] Timer tick, asking Buildbucket for the build status
[01:06:35.418] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:35.418] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:61:0) after 1m0s
[01:07:35.446] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:61:0)
[01:07:35.446] Timer tick, asking Buildbucket for the build status
[01:07:35.582] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:35.582] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:62:0) after 1m0s
[01:08:35.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:62:0)
[01:08:35.638] Timer tick, asking Buildbucket for the build status
[01:08:35.740] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:35.740] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:63:0) after 1m0s
[01:09:35.786] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:63:0)
[01:09:35.786] Timer tick, asking Buildbucket for the build status
[01:09:35.992] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:35.992] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:64:0) after 1m0s
[01:10:36.044] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:64:0)
[01:10:36.044] Timer tick, asking Buildbucket for the build status
[01:10:36.172] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:36.172] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:65:0) after 1m0s
[01:11:36.256] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:65:0)
[01:11:36.256] Timer tick, asking Buildbucket for the build status
[01:11:36.632] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:36.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:66:0) after 1m0s
[01:12:36.674] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:66:0)
[01:12:36.674] Timer tick, asking Buildbucket for the build status
[01:12:36.740] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:36.740] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:67:0) after 1m0s
[01:13:36.814] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:67:0)
[01:13:36.814] Timer tick, asking Buildbucket for the build status
[01:13:37.002] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:37.002] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:68:0) after 1m0s
[01:14:37.032] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:68:0)
[01:14:37.032] Timer tick, asking Buildbucket for the build status
[01:14:37.137] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:37.137] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:69:0) after 1m0s
[01:15:37.200] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:69:0)
[01:15:37.200] Timer tick, asking Buildbucket for the build status
[01:15:37.297] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:37.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:70:0) after 1m0s
[01:16:37.352] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:70:0)
[01:16:37.352] Timer tick, asking Buildbucket for the build status
[01:16:37.505] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:37.505] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:71:0) after 1m0s
[01:17:37.565] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:71:0)
[01:17:37.565] Timer tick, asking Buildbucket for the build status
[01:17:37.733] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:37.733] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:72:0) after 1m0s
[01:18:37.777] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:72:0)
[01:18:37.777] Timer tick, asking Buildbucket for the build status
[01:18:37.891] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:37.891] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:73:0) after 1m0s
[01:19:37.939] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:73:0)
[01:19:37.939] Timer tick, asking Buildbucket for the build status
[01:19:38.514] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:38.514] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:74:0) after 1m0s
[01:20:38.578] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:74:0)
[01:20:38.578] Timer tick, asking Buildbucket for the build status
[01:20:38.667] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:38.667] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:75:0) after 1m0s
[01:21:38.850] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:75:0)
[01:21:38.850] Timer tick, asking Buildbucket for the build status
[01:21:38.924] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:38.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:76:0) after 1m0s
[01:22:39.080] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:76:0)
[01:22:39.080] Timer tick, asking Buildbucket for the build status
[01:22:39.682] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:39.682] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:77:0) after 1m0s
[01:23:39.791] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:77:0)
[01:23:39.791] Timer tick, asking Buildbucket for the build status
[01:23:39.894] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:39.894] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:78:0) after 1m0s
[01:24:39.962] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:78:0)
[01:24:39.962] Timer tick, asking Buildbucket for the build status
[01:24:40.029] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:40.029] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:79:0) after 1m0s
[01:25:40.038] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:79:0)
[01:25:40.038] Timer tick, asking Buildbucket for the build status
[01:25:40.239] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:40.239] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:80:0) after 1m0s
[01:26:40.262] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:80:0)
[01:26:40.262] Timer tick, asking Buildbucket for the build status
[01:26:40.364] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:40.364] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:81:0) after 1m0s
[01:27:40.385] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:81:0)
[01:27:40.385] Timer tick, asking Buildbucket for the build status
[01:27:40.455] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:40.455] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:82:0) after 1m0s
[01:28:40.517] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:82:0)
[01:28:40.517] Timer tick, asking Buildbucket for the build status
[01:28:40.827] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:40.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:83:0) after 1m0s
[01:29:40.884] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:83:0)
[01:29:40.884] Timer tick, asking Buildbucket for the build status
[01:29:40.953] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:40.953] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:84:0) after 1m0s
[01:30:40.951] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:84:0)
[01:30:40.951] Timer tick, asking Buildbucket for the build status
[01:30:41.013] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:41.013] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:85:0) after 1m0s
[01:31:41.035] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:85:0)
[01:31:41.035] Timer tick, asking Buildbucket for the build status
[01:31:41.269] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:41.269] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:86:0) after 1m0s
[01:32:41.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:86:0)
[01:32:41.327] Timer tick, asking Buildbucket for the build status
[01:32:41.424] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:41.424] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:87:0) after 1m0s
[01:33:41.481] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:87:0)
[01:33:41.481] Timer tick, asking Buildbucket for the build status
[01:33:41.587] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:41.587] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:88:0) after 1m0s
[01:34:41.656] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:88:0)
[01:34:41.656] Timer tick, asking Buildbucket for the build status
[01:34:41.745] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:41.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:89:0) after 1m0s
[01:35:41.757] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:89:0)
[01:35:41.757] Timer tick, asking Buildbucket for the build status
[01:35:41.830] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:41.830] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:90:0) after 1m0s
[01:36:41.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:90:0)
[01:36:41.845] Timer tick, asking Buildbucket for the build status
[01:36:41.898] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:41.898] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:91:0) after 1m0s
[01:37:41.909] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:91:0)
[01:37:41.909] Timer tick, asking Buildbucket for the build status
[01:37:42.746] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:42.746] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:92:0) after 1m0s
[01:38:42.757] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:92:0)
[01:38:42.757] Timer tick, asking Buildbucket for the build status
[01:38:42.864] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:42.864] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:93:0) after 1m0s
[01:39:42.891] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:93:0)
[01:39:42.891] Timer tick, asking Buildbucket for the build status
[01:39:42.945] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:42.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:94:0) after 1m0s
[01:40:42.953] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:94:0)
[01:40:42.953] Timer tick, asking Buildbucket for the build status
[01:40:43.127] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:43.127] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:95:0) after 1m0s
[01:41:43.138] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:95:0)
[01:41:43.138] Timer tick, asking Buildbucket for the build status
[01:41:43.199] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:43.200] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:96:0) after 1m0s
[01:42:43.230] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:96:0)
[01:42:43.230] Timer tick, asking Buildbucket for the build status
[01:42:43.720] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:43.720] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:97:0) after 1m0s
[01:43:43.814] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:97:0)
[01:43:43.814] Timer tick, asking Buildbucket for the build status
[01:43:43.935] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:43.935] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:98:0) after 1m0s
[01:44:44.060] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:98:0)
[01:44:44.060] Timer tick, asking Buildbucket for the build status
[01:44:44.216] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:44.216] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:99:0) after 1m0s
[01:45:44.381] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:99:0)
[01:45:44.381] Timer tick, asking Buildbucket for the build status
[01:45:44.463] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:44.463] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:100:0) after 1m0s
[01:46:44.438] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:100:0)
[01:46:44.438] Timer tick, asking Buildbucket for the build status
[01:46:44.557] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:44.557] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:101:0) after 1m0s
[01:47:44.583] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:101:0)
[01:47:44.583] Timer tick, asking Buildbucket for the build status
[01:47:44.652] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:44.652] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:102:0) after 1m0s
[01:48:44.644] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:102:0)
[01:48:44.644] Timer tick, asking Buildbucket for the build status
[01:48:44.746] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:44.746] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:103:0) after 1m0s
[01:49:44.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:103:0)
[01:49:44.820] Timer tick, asking Buildbucket for the build status
[01:49:44.886] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:44.886] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:104:0) after 1m0s
[01:50:44.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:104:0)
[01:50:44.934] Timer tick, asking Buildbucket for the build status
[01:50:45.002] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:45.002] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:105:0) after 1m0s
[01:51:45.038] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:105:0)
[01:51:45.038] Timer tick, asking Buildbucket for the build status
[01:51:45.091] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:45.091] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:106:0) after 1m0s
[01:52:45.112] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:106:0)
[01:52:45.112] Timer tick, asking Buildbucket for the build status
[01:52:45.181] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:45.181] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:107:0) after 1m0s
[01:53:45.242] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:107:0)
[01:53:45.242] Timer tick, asking Buildbucket for the build status
[01:53:45.346] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:45.346] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:108:0) after 1m0s
[01:54:45.409] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:108:0)
[01:54:45.409] Timer tick, asking Buildbucket for the build status
[01:54:45.468] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:45.468] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:109:0) after 1m0s
[01:55:45.472] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:109:0)
[01:55:45.472] Timer tick, asking Buildbucket for the build status
[01:55:45.713] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:45.713] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:110:0) after 1m0s
[01:56:45.836] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:110:0)
[01:56:45.836] Timer tick, asking Buildbucket for the build status
[01:56:46.228] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:46.228] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:111:0) after 1m0s
[01:57:46.281] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:111:0)
[01:57:46.281] Timer tick, asking Buildbucket for the build status
[01:57:46.448] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:46.448] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:112:0) after 1m0s
[01:58:46.471] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:112:0)
[01:58:46.471] Timer tick, asking Buildbucket for the build status
[01:58:46.582] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:46.582] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:113:0) after 1m0s
[01:59:46.608] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:113:0)
[01:59:46.608] Timer tick, asking Buildbucket for the build status
[01:59:46.878] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:46.878] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:114:0) after 1m0s
[02:00:46.900] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:114:0)
[02:00:46.900] Timer tick, asking Buildbucket for the build status
[02:00:47.159] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:47.159] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:115:0) after 1m0s
[02:01:47.148] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:115:0)
[02:01:47.148] Timer tick, asking Buildbucket for the build status
[02:01:47.629] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:47.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:116:0) after 1m0s
[02:02:47.668] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:116:0)
[02:02:47.668] Timer tick, asking Buildbucket for the build status
[02:02:47.817] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:47.817] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:117:0) after 1m0s
[02:03:47.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:117:0)
[02:03:47.940] Timer tick, asking Buildbucket for the build status
[02:03:48.075] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:48.076] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:118:0) after 1m0s
[02:04:48.138] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:118:0)
[02:04:48.138] Timer tick, asking Buildbucket for the build status
[02:04:48.252] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:48.252] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:119:0) after 1m0s
[02:05:48.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:119:0)
[02:05:48.305] Timer tick, asking Buildbucket for the build status
[02:05:48.744] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:48.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:120:0) after 1m0s
[02:06:48.752] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:120:0)
[02:06:48.752] Timer tick, asking Buildbucket for the build status
[02:06:48.951] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:48.951] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:121:0) after 1m0s
[02:07:49.092] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:121:0)
[02:07:49.092] Timer tick, asking Buildbucket for the build status
[02:07:49.229] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:49.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:122:0) after 1m0s
[02:08:49.872] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:122:0)
[02:08:49.872] Timer tick, asking Buildbucket for the build status
[02:08:50.031] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:50.031] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:123:0) after 1m0s
[02:09:50.077] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:123:0)
[02:09:50.077] Timer tick, asking Buildbucket for the build status
[02:09:50.457] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:50.457] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:124:0) after 1m0s
[02:10:50.530] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:124:0)
[02:10:50.530] Timer tick, asking Buildbucket for the build status
[02:10:50.616] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:50.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:125:0) after 1m0s
[02:11:50.942] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:125:0)
[02:11:50.942] Timer tick, asking Buildbucket for the build status
[02:11:51.392] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:51.392] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:126:0) after 1m0s
[02:12:51.647] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:126:0)
[02:12:51.647] Timer tick, asking Buildbucket for the build status
[02:12:51.792] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:51.792] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:127:0) after 1m0s
[02:13:51.906] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:127:0)
[02:13:51.906] Timer tick, asking Buildbucket for the build status
[02:13:52.034] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:52.034] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:128:0) after 1m0s
[02:14:52.171] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:128:0)
[02:14:52.171] Timer tick, asking Buildbucket for the build status
[02:14:52.307] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:52.307] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:129:0) after 1m0s
[02:15:52.469] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:129:0)
[02:15:52.469] Timer tick, asking Buildbucket for the build status
[02:15:52.570] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:52.570] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:130:0) after 1m0s
[02:16:52.594] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:130:0)
[02:16:52.594] Timer tick, asking Buildbucket for the build status
[02:16:52.834] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:52.834] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:131:0) after 1m0s
[02:17:52.904] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:131:0)
[02:17:52.904] Timer tick, asking Buildbucket for the build status
[02:17:55.567] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:55.567] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:132:0) after 1m0s
[02:18:55.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:132:0)
[02:18:55.682] Timer tick, asking Buildbucket for the build status
[02:18:56.163] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:56.163] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:133:0) after 1m0s
[02:19:56.258] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:133:0)
[02:19:56.258] Timer tick, asking Buildbucket for the build status
[02:19:56.325] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:56.325] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:134:0) after 1m0s
[02:20:56.400] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:134:0)
[02:20:56.400] Timer tick, asking Buildbucket for the build status
[02:20:56.613] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:56.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:135:0) after 1m0s
[02:21:56.673] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:135:0)
[02:21:56.674] Timer tick, asking Buildbucket for the build status
[02:21:56.947] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:56.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:136:0) after 1m0s
[02:22:57.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:136:0)
[02:22:57.304] Timer tick, asking Buildbucket for the build status
[02:22:57.437] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:57.437] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:137:0) after 1m0s
[02:23:57.526] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:137:0)
[02:23:57.526] Timer tick, asking Buildbucket for the build status
[02:23:57.915] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:57.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:138:0) after 1m0s
[02:24:57.908] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:138:0)
[02:24:57.908] Timer tick, asking Buildbucket for the build status
[02:24:58.145] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:58.145] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:139:0) after 1m0s
[02:25:58.316] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:139:0)
[02:25:58.316] Timer tick, asking Buildbucket for the build status
[02:25:58.888] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:58.888] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:140:0) after 1m0s
[02:26:58.956] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:140:0)
[02:26:58.956] Timer tick, asking Buildbucket for the build status
[02:26:59.096] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:59.096] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:141:0) after 1m0s
[02:27:59.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:141:0)
[02:27:59.304] Timer tick, asking Buildbucket for the build status
[02:27:59.395] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:59.395] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:142:0) after 1m0s
[02:28:59.769] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:142:0)
[02:28:59.769] Timer tick, asking Buildbucket for the build status
[02:28:59.924] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:59.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:143:0) after 1m0s
[02:29:59.949] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:143:0)
[02:29:59.949] Timer tick, asking Buildbucket for the build status
[02:30:00.147] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:00.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:144:0) after 1m0s
[02:31:00.273] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:144:0)
[02:31:00.273] Timer tick, asking Buildbucket for the build status
[02:31:00.344] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:00.344] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:145:0) after 1m0s
[02:32:00.543] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:145:0)
[02:32:00.543] Timer tick, asking Buildbucket for the build status
[02:32:00.779] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:00.779] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:146:0) after 1m0s
[02:33:01.405] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:146:0)
[02:33:01.405] Timer tick, asking Buildbucket for the build status
[02:33:01.494] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:01.494] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:147:0) after 1m0s
[02:34:01.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:147:0)
[02:34:01.520] Timer tick, asking Buildbucket for the build status
[02:34:01.701] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:01.701] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:148:0) after 1m0s
[02:35:01.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:148:0)
[02:35:01.813] Timer tick, asking Buildbucket for the build status
[02:35:01.894] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:01.894] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:149:0) after 1m0s
[02:36:01.971] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:149:0)
[02:36:01.971] Timer tick, asking Buildbucket for the build status
[02:36:02.052] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:02.052] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:150:0) after 1m0s
[02:37:02.112] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:150:0)
[02:37:02.112] Timer tick, asking Buildbucket for the build status
[02:37:02.204] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:02.204] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:151:0) after 1m0s
[02:38:02.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:151:0)
[02:38:02.308] Timer tick, asking Buildbucket for the build status
[02:38:02.473] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:02.473] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:152:0) after 1m0s
[02:39:02.572] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:152:0)
[02:39:02.572] Timer tick, asking Buildbucket for the build status
[02:39:02.761] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:02.761] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:153:0) after 1m0s
[02:40:02.827] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:153:0)
[02:40:02.827] Timer tick, asking Buildbucket for the build status
[02:40:02.917] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:02.917] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:154:0) after 1m0s
[02:41:03.088] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:154:0)
[02:41:03.088] Timer tick, asking Buildbucket for the build status
[02:41:03.179] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:03.179] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:155:0) after 1m0s
[02:42:03.226] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:155:0)
[02:42:03.226] Timer tick, asking Buildbucket for the build status
[02:42:03.317] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:03.317] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:156:0) after 1m0s
[02:43:03.464] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:156:0)
[02:43:03.464] Timer tick, asking Buildbucket for the build status
[02:43:03.545] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:03.545] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:157:0) after 1m0s
[02:44:03.573] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:157:0)
[02:44:03.573] Timer tick, asking Buildbucket for the build status
[02:44:03.689] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:03.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:158:0) after 1m0s
[02:45:03.795] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:158:0)
[02:45:03.795] Timer tick, asking Buildbucket for the build status
[02:45:03.939] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:03.939] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:159:0) after 1m0s
[02:46:04.108] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:159:0)
[02:46:04.108] Timer tick, asking Buildbucket for the build status
[02:46:04.181] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:04.181] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:160:0) after 1m0s
[02:47:04.291] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:160:0)
[02:47:04.291] Timer tick, asking Buildbucket for the build status
[02:47:04.367] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:04.367] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:161:0) after 1m0s
[02:48:04.493] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:161:0)
[02:48:04.493] Timer tick, asking Buildbucket for the build status
[02:48:04.600] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:04.600] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:162:0) after 1m0s
[02:49:04.722] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:162:0)
[02:49:04.722] Timer tick, asking Buildbucket for the build status
[02:49:04.871] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:04.872] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:163:0) after 1m0s
[02:50:04.944] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:163:0)
[02:50:04.944] Timer tick, asking Buildbucket for the build status
[02:50:05.027] Build 8862976779614446576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:05.027] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028406841780918816:164:0) after 1m0s
[02:50:29.643] Received PubSub notification, asking Buildbucket for the build status
[02:50:29.709] Build 8862976779614446576: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[02:50:29.709] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606013427907733",
"created_by": "project:chromium",
"created_ts": "1606003700584737",
"failure_reason": "BUILD_FAILURE",
"id": "8862976779614446576",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4f32cabc761bef0a5c48f282fd5716a0af5abc52\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- RecordingServiceBrowserTest.RecordingInterruptedOnCaptureLocked\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"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\": \"4f32cabc761bef0a5c48f282fd5716a0af5abc52\", \"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-78-rqah\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21415, \"got_angle_revision\": \"e51c9068a84f14e42157c097eb764ec3009e0e54\", \"got_dawn_revision\": \"546a7c98c89718f2dadf1ae07088fa7cf2ccb53f\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"4f32cabc761bef0a5c48f282fd5716a0af5abc52\", \"got_revision_cp\": \"refs/heads/master@{#830012}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"6d612051c083238db89541be4fbb2d624a9baef4\", \"got_v8_revision\": \"22f2e5ef66ed5c820532f27b141096d3ddb1966e\", \"got_v8_revision_cp\": \"refs/heads/8.9.31@{#1}\", \"got_webrtc_revision\": \"7d75f2ca782f38006bb65bc67533e582190454e8\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32659}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-dbg\", \"tryserver.chromium.chromiumos:linux-chromeos-compile-dbg\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4f32cabc761bef0a5c48f282fd5716a0af5abc52\", \"swarm_hashes_refs/heads/master(at){#830012}_without_patch\": {\"absl_hardening_tests\": \"bab17941a8426673cecd2ba1c171827729a43936\", \"accessibility_unittests\": \"3b8a4465d89b43df43fa0600feb0ad7316095975\", \"angle_unittests\": \"a2031a4c94fc84893f177c585e83af986d41b3cf\", \"app_list_unittests\": \"b965e7f512b36ee8c17764d3f3a51c4086d83801\", \"app_shell_unittests\": \"cff442ed101e05cc89acae67b40e257b1ed771de\", \"ash_unittests\": \"10d7f75c8095ef7c8cf4f311989db192d9f35a2b\", \"aura_unittests\": \"7198a4417dfb70dd42be7d60989a7c7d3db0580d\", \"base_unittests\": \"0abd41893daa5641b78acb02af73b710778acf75\", \"base_util_unittests\": \"51483e7d88ab82be3d11a12f5290996116daeb5d\", \"blink_common_unittests\": \"3f123baad9f248fd8b6992648c54cfcffd75b197\", \"blink_fuzzer_unittests\": \"b4c7350941bda9bd6f3df42eb116598d91cb414a\", \"blink_heap_unittests\": \"09891b1bcb98f2c549962136f07593bd32bbe0f8\", \"blink_platform_unittests\": \"b18092f2dbb29f2b71a5ad8bf3103b4363c00613\", \"blink_unittests\": \"b16a63291e4fbe2fc8711fe2f08e16c89529b5d9\", \"boringssl_crypto_tests\": \"759047396816eafb873208c92f90b32edbffdbe1\", \"boringssl_ssl_tests\": \"26ab3eac59b4eddd709d482174f4aff932125bf1\", \"browser_tests\": \"e54ab5d3f170b4b00c6d849e28e64384f34d3d02\", \"capture_unittests\": \"d7b5ec76e970d4919731eb787f08d3ab00e7f75b\", \"cast_unittests\": \"33439af7318d719cbaaf16a7a01913ec4c2a0f56\", \"cc_unittests\": \"e9c9021adc616784fb46a986bd91d23aec6d9bd6\", \"chrome_app_unittests\": \"2e700ad51cb0b55db89fbe1355ad6e9719922408\", \"chromedriver_unittests\": \"280439f00bddf4193cf8be028577261e482e79e1\", \"chromeos_components_unittests\": \"a1d2e2b2da078e619f807109fdb579e7543a0a87\", \"chromeos_unittests\": \"4cebfba91368aa3dd3ef4f8dd1579e7ab66755ba\", \"components_browsertests\": \"c31987d5146136a5214a2303abf9163c261911db\", \"components_unittests\": \"79c0e2e5349dd7a37c9edca6a1508d8737ea8701\", \"compositor_unittests\": \"1e0b55885c455433d51f65f6075921a349da71c5\", \"content_browsertests\": \"bfda62d278b6e98c6eb1868f616314ce2d84a683\", \"content_unittests\": \"9334f9dfe8e35ea4abb73d9ffa021f771e572aed\", \"crashpad_tests\": \"e55d70adefd0c1128209f73eedbb11da3f8c6de9\", \"crypto_unittests\": \"6920b4ed35541f63906c63d6da86548d87d24ab2\", \"dbus_unittests\": \"ba8880ac83ba852465f73a4ecdbe2bbfcd032fdf\", \"device_unittests\": \"f10f1d7abe107cae3b049ada1647e7de0fed2116\", \"display_unittests\": \"b07af53db8b6c7ded0ae9cfc73b03910356beee7\", \"events_unittests\": \"06c4c1404be2658459e754d09e64ed8a7a718743\", \"exo_unittests\": \"0a7e72859edf3eb8303d2f2b3a3c4cc8f4a04c2a\", \"extensions_browsertests\": \"a9ce8c9f18cacb8b61c797f74a06e90b036697b1\", \"extensions_unittests\": \"2a4cc741afcdba5c5bc67fb35e86968d8a589959\", \"filesystem_service_unittests\": \"148439324e8b0eab977da4729065f9ba1d49a7e0\", \"gcm_unit_tests\": \"da37dc8292ed7a3bd5e9453e0af9ff0c2450129e\", \"gfx_unittests\": \"29a033722d4c4840bffe9e89c99406536d5b4cd5\", \"gin_unittests\": \"e29de65f20073e6e0a9f93e48bd4cd3284321bf0\", \"gl_unittests_ozone\": \"b1abc249658437e1f3964e99c7dadef242c51988\", \"google_apis_unittests\": \"a31c25a33f62d5678c57db068ca959c76b3bcf0e\", \"gpu_unittests\": \"2698545e3ae3a11a13e19895ee34c5a4d7dc7123\", \"gwp_asan_unittests\": \"c99833dcbb0e2f833fb989ccb2b56c9f3ca5703e\", \"interactive_ui_tests\": \"e75e2e601521562f1df7cfaed6faf798a7a6dee7\", \"ipc_tests\": \"01762122dbd00356ea7b2d93a21d938aa3388798\", \"jingle_unittests\": \"762371ede5a1738fc73adc1c92450f9d0d8330a1\", \"keyboard_unittests\": \"2a757943083f4584f7553cf6aba411ed9d324e48\", \"latency_unittests\": \"bda8b664ebce4e6e6e28639d45f2c491dac4e7b7\", \"libjingle_xmpp_unittests\": \"d7a25e9ced377a864233f1c17b1dfc10c55de8f4\", \"liburlpattern_unittests\": \"3afdcaf466a2ad8b2006b1866a578a54c5e6f305\", \"media_blink_unittests\": \"675ce69f2e6614a429621872de8b9a8a16a421e4\", \"media_unittests\": \"21dbc4315a62cc9d26cc31be55b6b04f3e774f78\", \"message_center_unittests\": \"29c0ba5ba6acfb861cecaa1837eab3db7083332d\", \"midi_unittests\": \"3e8aa7fbe147c1541428ccf9ae24f913f09fa065\", \"mojo_core_unittests\": \"56f9d4f5a00eda3a367f62e49adbbc9f0d8ee779\", \"mojo_unittests\": \"f6b2460d5d190c13932f6e060a8caf7a73cf6430\", \"nacl_helper_nonsfi_unittests\": \"070470da83fe73fa5608b900f6d2de65b0752e1b\", \"nacl_loader_unittests\": \"2a40e69c10609be5c9aeb861a4ba36b877547587\", \"native_theme_unittests\": \"19aadccf2f7fdd8e2b4302148eb56e0a8c388bd2\", \"net_unittests\": \"e6e938aaa70c3e2c0f6391768475cbfd85285a02\", \"ozone_gl_unittests\": \"5b862a128b991b5a6e294312ac2eec4de6c132b9\", \"ozone_unittests\": \"9d963a1d4378213b208aca44b7972940e6091e23\", \"ozone_x11_unittests\": \"435885f9e98ff2f417cd7f2ba92867c82d2e5bab\", \"pdf_unittests\": \"99e0cdcd431d63399b44342881dc1d397afd6bbd\", \"perfetto_unittests\": \"1051db82915c1155c85db38f7fd2fc453e88bcef\", \"ppapi_unittests\": \"1c089ae9813d72b24fbe7abcbb7858549e8a294c\", \"printing_unittests\": \"266ad41483d52da7ad4d031e187fe2f0c4696ada\", \"remoting_unittests\": \"698a13952770691310c32efbc7f7975e44205853\", \"sandbox_linux_unittests\": \"ef548146519ac7bbc3431a46200d54c7bcab4587\", \"service_manager_unittests\": \"35775b19ed93be4b430b7f7c811c90e0117594d3\", \"services_unittests\": \"a360b2cb22e7cfc58153e8cea89fa7b6b6cedd24\", \"shell_dialogs_unittests\": \"82f7a850803c46ce267732fd0418da0e89066bc0\", \"skia_unittests\": \"7d6ada8ffac89f4f9e257cb4512d79a0274be813\", \"snapshot_unittests\": \"f8ae4033fcf15e802c400f7e42ee168ca543d2e0\", \"sql_unittests\": \"982aaffe149e2ca4e37673e669ee723af186e179\", \"storage_unittests\": \"903c138592299d51f4d8450ee5dee47e26acc39a\", \"sync_integration_tests\": \"43c557225fa9c19551bacf729523a27a01ecdbc0\", \"traffic_annotation_auditor_unittests\": \"ff3a2f5bf1c19ab7f1d65b1eeaa5800e3b21bacf\", \"ui_base_unittests\": \"cda2f4d6cdc1cee713278e63ff45ee628d8b843b\", \"ui_chromeos_unittests\": \"887402d579f5b5d090bd6c38c8eb38f1699121a3\", \"ui_touch_selection_unittests\": \"38ea17cf71ba77f608c5de1415c9638cfb8dd002\", \"unit_tests\": \"8323c587ed4d4c1299372a53cb45dd71762b3307\", \"url_unittests\": \"03adf97baff6d0528d415aee39418543aff7b1d4\", \"usage_time_limit_unittests\": \"e4957f97361f13e59385afed25b2c2d14c96b356\", \"views_unittests\": \"d15d39c5a9318f79fcb8f1a6736490576fc8525c\", \"viz_unittests\": \"434e25831df9bcbbebde283fb3ad961e935b2986\", \"wm_unittests\": \"88f880c099077c78331c74054140693f9a2f32e4\", \"wtf_unittests\": \"8d6f63c53e9117739a066abd3316d7bebfee1ea0\", \"zlib_unittests\": \"aecb9de89d942f1f1bf64b2cf68d2f965f8bac10\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1415e99d1ada386cfb0c84043d2495490d2cdcd28ad7785eb6837a9119e6428f_v2\", \"builder_6887d226fea03ae8e203d0a1d4c9e197b929dd99abf2bafb38063e06e39bc1ba_v2\", \"builder_70f3607e3f7d84b5c3698c0eed74813ee5c700477d5aec13835ae2ecc5ee2d5b_v2\", \"builder_84395cd86c4615c28c38755187d54d1bbe2dcea268d302d74191d04ce3a055d0_v2\", \"builder_ebb06fb409ef3255b3561ad6bc0df7706a15849e85ba50b708bdfb917530d411_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-78-rqah\"], \"image\": [\"chrome-xenial-20110800-08efb743065\"], \"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-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- RecordingServiceBrowserTest.RecordingInterruptedOnCaptureLocked\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1606006519839580",
"status": "COMPLETED",
"status_changed_ts": "1606006520314508",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21415",
"builder:linux-chromeos-dbg",
"buildset:commit/git/4f32cabc761bef0a5c48f282fd5716a0af5abc52",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4f32cabc761bef0a5c48f282fd5716a0af5abc52",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028406841780918816",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8862976779614446576/+/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:5006193ffc141610",
"user_agent:luci-scheduler"
],
"updated_ts": "1606013429372328",
"url": "https://ci.chromium.org/b/8862976779614446576",
"utcnow_ts": "1606013429700001"
}
}
[02:50:29.709] Invocation finished in 2h42m10.573423896s with status FAILED