[11:06:18.963] New invocation is queued and will start shortly
[11:06:20.223] Starting the invocation (attempt 1)
[11:06:20.257] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:06:20.263] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:06:20.263] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028365444198009984",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"1ede3c474eb166874b41e88ab2523d0491b5b7c1\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9028365444198009984",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/1ede3c474eb166874b41e88ab2523d0491b5b7c1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1ede3c474eb166874b41e88ab2523d0491b5b7c1",
"gitiles_ref:refs/heads/master"
]
}
[11:06:20.779] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606043180353566",
"id": "8862935382076770320",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1ede3c474eb166874b41e88ab2523d0491b5b7c1\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606043180667660",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43055",
"builder:linux-chromeos-rel",
"buildset:commit/git/1ede3c474eb166874b41e88ab2523d0491b5b7c1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1ede3c474eb166874b41e88ab2523d0491b5b7c1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028365444198009984",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8862935382076770320/+/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": "1606043180667774",
"url": "https://ci.chromium.org/b/8862935382076770320",
"utcnow_ts": "1606043180762852"
}
}
[11:06:20.779] Task URL: https://ci.chromium.org/b/8862935382076770320
[11:06:20.780] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:2:0) after 1m0s
[11:07:20.848] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:2:0)
[11:07:20.848] Timer tick, asking Buildbucket for the build status
[11:07:20.954] Build 8862935382076770320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:07:20.954] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:3:0) after 1m0s
[11:08:20.976] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:3:0)
[11:08:20.976] Timer tick, asking Buildbucket for the build status
[11:08:21.052] Build 8862935382076770320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:08:21.052] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:4:0) after 1m0s
[11:09:21.110] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:4:0)
[11:09:21.110] Timer tick, asking Buildbucket for the build status
[11:09:21.189] Build 8862935382076770320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:09:21.189] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:5:0) after 1m0s
[11:10:21.303] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:5:0)
[11:10:21.303] Timer tick, asking Buildbucket for the build status
[11:10:21.875] Build 8862935382076770320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:10:21.875] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:6:0) after 1m0s
[11:11:21.897] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:6:0)
[11:11:21.897] Timer tick, asking Buildbucket for the build status
[11:11:21.993] Build 8862935382076770320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:11:21.993] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:7:0) after 1m0s
[11:12:22.078] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:7:0)
[11:12:22.078] Timer tick, asking Buildbucket for the build status
[11:12:22.414] Build 8862935382076770320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:12:22.414] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:8:0) after 1m0s
[11:13:22.382] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:8:0)
[11:13:22.382] Timer tick, asking Buildbucket for the build status
[11:13:22.452] Build 8862935382076770320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:13:22.452] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:9:0) after 1m0s
[11:14:22.426] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:9:0)
[11:14:22.426] Timer tick, asking Buildbucket for the build status
[11:14:22.498] Build 8862935382076770320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:14:22.498] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:10:0) after 1m0s
[11:15:22.567] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:10:0)
[11:15:22.567] Timer tick, asking Buildbucket for the build status
[11:15:22.647] Build 8862935382076770320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:15:22.647] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:11:0) after 1m0s
[11:16:22.720] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:11:0)
[11:16:22.720] Timer tick, asking Buildbucket for the build status
[11:16:22.834] Build 8862935382076770320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:16:22.834] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:12:0) after 1m0s
[11:17:22.855] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:12:0)
[11:17:22.855] Timer tick, asking Buildbucket for the build status
[11:17:23.187] Build 8862935382076770320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:17:23.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:13:0) after 1m0s
[11:18:23.248] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:13:0)
[11:18:23.248] Timer tick, asking Buildbucket for the build status
[11:18:23.514] Build 8862935382076770320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:18:23.514] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:14:0) after 1m0s
[11:19:23.625] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:14:0)
[11:19:23.625] Timer tick, asking Buildbucket for the build status
[11:19:23.703] Build 8862935382076770320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:19:23.703] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:15:0) after 1m0s
[11:20:23.700] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:15:0)
[11:20:23.701] Timer tick, asking Buildbucket for the build status
[11:20:23.781] Build 8862935382076770320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:20:23.781] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:16:0) after 1m0s
[11:21:23.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:16:0)
[11:21:23.813] Timer tick, asking Buildbucket for the build status
[11:21:24.109] Build 8862935382076770320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:21:24.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:17:0) after 1m0s
[11:22:24.129] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:17:0)
[11:22:24.129] Timer tick, asking Buildbucket for the build status
[11:22:24.718] Build 8862935382076770320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:22:24.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:18:0) after 1m0s
[11:23:24.739] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:18:0)
[11:23:24.739] Timer tick, asking Buildbucket for the build status
[11:23:24.822] Build 8862935382076770320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:23:24.822] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:19:0) after 1m0s
[11:24:24.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:19:0)
[11:24:24.882] Timer tick, asking Buildbucket for the build status
[11:24:24.964] Build 8862935382076770320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:24:24.964] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:20:0) after 1m0s
[11:25:24.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:20:0)
[11:25:24.983] Timer tick, asking Buildbucket for the build status
[11:25:25.129] Build 8862935382076770320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:25:25.129] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:21:0) after 1m0s
[11:26:25.149] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:21:0)
[11:26:25.149] Timer tick, asking Buildbucket for the build status
[11:26:25.293] Build 8862935382076770320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:26:25.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:22:0) after 1m0s
[11:27:25.199] Received PubSub notification, asking Buildbucket for the build status
[11:27:25.316] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:25.526] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:22:0)
[11:27:25.526] Timer tick, asking Buildbucket for the build status
[11:27:25.597] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:25.597] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:24:0) after 1m0s
[11:28:25.635] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:24:0)
[11:28:25.635] Timer tick, asking Buildbucket for the build status
[11:28:25.703] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:25.703] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:25:0) after 1m0s
[11:29:25.741] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:25:0)
[11:29:25.741] Timer tick, asking Buildbucket for the build status
[11:29:25.819] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:25.819] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:26:0) after 1m0s
[11:30:25.852] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:26:0)
[11:30:25.852] Timer tick, asking Buildbucket for the build status
[11:30:25.982] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:25.982] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:27:0) after 1m0s
[11:31:26.240] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:27:0)
[11:31:26.240] Timer tick, asking Buildbucket for the build status
[11:31:26.348] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:26.348] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:28:0) after 1m0s
[11:32:26.404] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:28:0)
[11:32:26.405] Timer tick, asking Buildbucket for the build status
[11:32:26.652] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:26.652] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:29:0) after 1m0s
[11:33:26.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:29:0)
[11:33:26.730] Timer tick, asking Buildbucket for the build status
[11:33:26.948] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:26.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:30:0) after 1m0s
[11:34:26.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:30:0)
[11:34:26.970] Timer tick, asking Buildbucket for the build status
[11:34:27.036] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:27.036] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:31:0) after 1m0s
[11:35:27.059] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:31:0)
[11:35:27.059] Timer tick, asking Buildbucket for the build status
[11:35:27.226] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:27.226] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:32:0) after 1m0s
[11:36:27.306] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:32:0)
[11:36:27.306] Timer tick, asking Buildbucket for the build status
[11:36:27.410] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:27.411] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:33:0) after 1m0s
[11:37:27.486] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:33:0)
[11:37:27.486] Timer tick, asking Buildbucket for the build status
[11:37:27.668] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:27.668] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:34:0) after 1m0s
[11:38:27.798] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:34:0)
[11:38:27.798] Timer tick, asking Buildbucket for the build status
[11:38:27.860] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:27.860] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:35:0) after 1m0s
[11:39:27.929] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:35:0)
[11:39:27.929] Timer tick, asking Buildbucket for the build status
[11:39:27.983] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:27.983] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:36:0) after 1m0s
[11:40:28.008] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:36:0)
[11:40:28.008] Timer tick, asking Buildbucket for the build status
[11:40:28.065] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:28.065] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:37:0) after 1m0s
[11:41:28.092] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:37:0)
[11:41:28.092] Timer tick, asking Buildbucket for the build status
[11:41:28.527] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:28.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:38:0) after 1m0s
[11:42:28.575] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:38:0)
[11:42:28.575] Timer tick, asking Buildbucket for the build status
[11:42:28.685] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:28.685] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:39:0) after 1m0s
[11:43:28.716] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:39:0)
[11:43:28.716] Timer tick, asking Buildbucket for the build status
[11:43:28.827] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:28.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:40:0) after 1m0s
[11:44:28.849] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:40:0)
[11:44:28.849] Timer tick, asking Buildbucket for the build status
[11:44:28.915] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:28.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:41:0) after 1m0s
[11:45:29.016] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:41:0)
[11:45:29.016] Timer tick, asking Buildbucket for the build status
[11:45:29.073] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:29.073] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:42:0) after 1m0s
[11:46:29.143] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:42:0)
[11:46:29.143] Timer tick, asking Buildbucket for the build status
[11:46:29.270] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:29.270] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:43:0) after 1m0s
[11:47:29.295] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:43:0)
[11:47:29.295] Timer tick, asking Buildbucket for the build status
[11:47:29.365] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:29.365] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:44:0) after 1m0s
[11:48:29.385] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:44:0)
[11:48:29.385] Timer tick, asking Buildbucket for the build status
[11:48:29.575] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:29.575] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:45:0) after 1m0s
[11:49:29.700] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:45:0)
[11:49:29.701] Timer tick, asking Buildbucket for the build status
[11:49:29.767] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:29.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:46:0) after 1m0s
[11:50:29.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:46:0)
[11:50:29.888] Timer tick, asking Buildbucket for the build status
[11:50:29.947] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:29.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:47:0) after 1m0s
[11:51:29.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:47:0)
[11:51:29.970] Timer tick, asking Buildbucket for the build status
[11:51:30.083] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:30.083] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:48:0) after 1m0s
[11:52:30.108] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:48:0)
[11:52:30.108] Timer tick, asking Buildbucket for the build status
[11:52:30.169] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:30.169] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:49:0) after 1m0s
[11:53:30.188] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:49:0)
[11:53:30.188] Timer tick, asking Buildbucket for the build status
[11:53:30.248] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:30.248] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:50:0) after 1m0s
[11:54:30.275] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:50:0)
[11:54:30.275] Timer tick, asking Buildbucket for the build status
[11:54:30.336] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:30.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:51:0) after 1m0s
[11:55:30.357] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:51:0)
[11:55:30.357] Timer tick, asking Buildbucket for the build status
[11:55:30.425] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:30.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:52:0) after 1m0s
[11:56:30.448] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:52:0)
[11:56:30.448] Timer tick, asking Buildbucket for the build status
[11:56:30.543] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:30.543] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:53:0) after 1m0s
[11:57:30.564] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:53:0)
[11:57:30.564] Timer tick, asking Buildbucket for the build status
[11:57:30.987] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:30.987] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:54:0) after 1m0s
[11:58:31.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:54:0)
[11:58:31.007] Timer tick, asking Buildbucket for the build status
[11:58:31.104] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:31.104] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:55:0) after 1m0s
[11:59:31.126] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:55:0)
[11:59:31.126] Timer tick, asking Buildbucket for the build status
[11:59:31.218] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:31.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:56:0) after 1m0s
[12:00:31.268] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:56:0)
[12:00:31.268] Timer tick, asking Buildbucket for the build status
[12:00:31.344] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:31.344] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:57:0) after 1m0s
[12:01:31.414] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:57:0)
[12:01:31.414] Timer tick, asking Buildbucket for the build status
[12:01:31.533] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:31.533] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:58:0) after 1m0s
[12:02:31.605] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:58:0)
[12:02:31.605] Timer tick, asking Buildbucket for the build status
[12:02:32.132] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:32.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:59:0) after 1m0s
[12:03:32.208] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:59:0)
[12:03:32.208] Timer tick, asking Buildbucket for the build status
[12:03:32.310] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:32.310] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:60:0) after 1m0s
[12:04:32.331] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:60:0)
[12:04:32.331] Timer tick, asking Buildbucket for the build status
[12:04:32.395] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:32.395] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:61:0) after 1m0s
[12:05:32.417] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:61:0)
[12:05:32.417] Timer tick, asking Buildbucket for the build status
[12:05:32.745] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:32.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:62:0) after 1m0s
[12:06:32.776] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:62:0)
[12:06:32.776] Timer tick, asking Buildbucket for the build status
[12:06:32.924] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:32.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:63:0) after 1m0s
[12:07:32.972] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:63:0)
[12:07:32.972] Timer tick, asking Buildbucket for the build status
[12:07:33.060] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:33.060] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:64:0) after 1m0s
[12:08:33.138] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:64:0)
[12:08:33.138] Timer tick, asking Buildbucket for the build status
[12:08:33.194] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:33.194] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:65:0) after 1m0s
[12:09:33.269] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:65:0)
[12:09:33.269] Timer tick, asking Buildbucket for the build status
[12:09:33.350] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:33.350] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:66:0) after 1m0s
[12:10:33.407] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:66:0)
[12:10:33.407] Timer tick, asking Buildbucket for the build status
[12:10:33.472] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:33.472] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:67:0) after 1m0s
[12:11:33.499] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:67:0)
[12:11:33.499] Timer tick, asking Buildbucket for the build status
[12:11:33.634] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:33.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:68:0) after 1m0s
[12:12:33.703] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:68:0)
[12:12:33.703] Timer tick, asking Buildbucket for the build status
[12:12:33.898] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:33.898] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:69:0) after 1m0s
[12:13:33.979] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:69:0)
[12:13:33.979] Timer tick, asking Buildbucket for the build status
[12:13:34.056] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:34.056] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:70:0) after 1m0s
[12:14:34.093] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:70:0)
[12:14:34.093] Timer tick, asking Buildbucket for the build status
[12:14:34.193] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:34.193] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:71:0) after 1m0s
[12:15:34.263] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:71:0)
[12:15:34.263] Timer tick, asking Buildbucket for the build status
[12:15:34.752] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:34.752] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:72:0) after 1m0s
[12:16:34.793] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:72:0)
[12:16:34.793] Timer tick, asking Buildbucket for the build status
[12:16:35.067] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:35.068] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:73:0) after 1m0s
[12:17:35.092] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:73:0)
[12:17:35.092] Timer tick, asking Buildbucket for the build status
[12:17:35.243] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:35.243] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:74:0) after 1m0s
[12:18:35.290] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:74:0)
[12:18:35.290] Timer tick, asking Buildbucket for the build status
[12:18:35.377] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:35.377] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:75:0) after 1m0s
[12:19:35.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:75:0)
[12:19:35.402] Timer tick, asking Buildbucket for the build status
[12:19:35.550] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:35.550] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:76:0) after 1m0s
[12:20:35.574] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:76:0)
[12:20:35.574] Timer tick, asking Buildbucket for the build status
[12:20:35.638] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:35.638] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:77:0) after 1m0s
[12:21:35.674] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:77:0)
[12:21:35.674] Timer tick, asking Buildbucket for the build status
[12:21:35.803] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:35.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:78:0) after 1m0s
[12:22:35.827] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:78:0)
[12:22:35.827] Timer tick, asking Buildbucket for the build status
[12:22:35.914] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:35.914] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:79:0) after 1m0s
[12:23:35.944] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:79:0)
[12:23:35.944] Timer tick, asking Buildbucket for the build status
[12:23:36.014] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:36.014] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:80:0) after 1m0s
[12:24:36.048] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:80:0)
[12:24:36.048] Timer tick, asking Buildbucket for the build status
[12:24:36.133] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:36.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:81:0) after 1m0s
[12:25:36.217] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:81:0)
[12:25:36.217] Timer tick, asking Buildbucket for the build status
[12:25:36.299] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:36.299] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:82:0) after 1m0s
[12:26:36.326] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:82:0)
[12:26:36.326] Timer tick, asking Buildbucket for the build status
[12:26:36.445] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:36.445] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:83:0) after 1m0s
[12:27:36.471] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:83:0)
[12:27:36.471] Timer tick, asking Buildbucket for the build status
[12:27:36.750] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:36.750] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:84:0) after 1m0s
[12:28:36.756] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:84:0)
[12:28:36.756] Timer tick, asking Buildbucket for the build status
[12:28:36.868] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:36.868] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:85:0) after 1m0s
[12:29:36.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:85:0)
[12:29:36.845] Timer tick, asking Buildbucket for the build status
[12:29:36.909] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:36.909] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:86:0) after 1m0s
[12:30:36.906] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:86:0)
[12:30:36.906] Timer tick, asking Buildbucket for the build status
[12:30:36.974] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:36.974] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:87:0) after 1m0s
[12:31:36.999] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:87:0)
[12:31:36.999] Timer tick, asking Buildbucket for the build status
[12:31:37.112] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:37.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:88:0) after 1m0s
[12:32:37.156] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:88:0)
[12:32:37.156] Timer tick, asking Buildbucket for the build status
[12:32:37.242] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:37.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:89:0) after 1m0s
[12:33:37.267] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:89:0)
[12:33:37.267] Timer tick, asking Buildbucket for the build status
[12:33:37.780] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:37.780] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:90:0) after 1m0s
[12:34:37.825] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:90:0)
[12:34:37.825] Timer tick, asking Buildbucket for the build status
[12:34:37.969] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:37.969] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:91:0) after 1m0s
[12:35:38.103] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:91:0)
[12:35:38.103] Timer tick, asking Buildbucket for the build status
[12:35:38.166] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:38.166] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:92:0) after 1m0s
[12:36:38.289] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:92:0)
[12:36:38.289] Timer tick, asking Buildbucket for the build status
[12:36:38.399] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:38.399] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:93:0) after 1m0s
[12:37:38.435] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:93:0)
[12:37:38.435] Timer tick, asking Buildbucket for the build status
[12:37:38.686] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:38.686] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:94:0) after 1m0s
[12:38:38.698] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:94:0)
[12:38:38.698] Timer tick, asking Buildbucket for the build status
[12:38:38.855] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:38.855] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:95:0) after 1m0s
[12:39:38.879] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:95:0)
[12:39:38.879] Timer tick, asking Buildbucket for the build status
[12:39:39.460] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:39.460] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:96:0) after 1m0s
[12:40:39.487] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:96:0)
[12:40:39.487] Timer tick, asking Buildbucket for the build status
[12:40:39.856] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:39.856] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:97:0) after 1m0s
[12:41:39.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:97:0)
[12:41:39.925] Timer tick, asking Buildbucket for the build status
[12:41:40.115] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:40.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:98:0) after 1m0s
[12:42:40.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:98:0)
[12:42:40.329] Timer tick, asking Buildbucket for the build status
[12:42:40.845] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:40.845] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:99:0) after 1m0s
[12:43:42.022] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:99:0)
[12:43:42.022] Timer tick, asking Buildbucket for the build status
[12:43:42.143] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:42.143] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:100:0) after 1m0s
[12:44:42.596] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:100:0)
[12:44:42.596] Timer tick, asking Buildbucket for the build status
[12:44:42.711] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:42.711] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:101:0) after 1m0s
[12:45:42.890] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:101:0)
[12:45:42.890] Timer tick, asking Buildbucket for the build status
[12:45:42.991] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:42.991] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:102:0) after 1m0s
[12:46:43.086] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:102:0)
[12:46:43.086] Timer tick, asking Buildbucket for the build status
[12:46:43.409] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:43.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:103:0) after 1m0s
[12:47:43.484] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:103:0)
[12:47:43.484] Timer tick, asking Buildbucket for the build status
[12:47:43.650] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:43.650] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:104:0) after 1m0s
[12:48:43.720] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:104:0)
[12:48:43.720] Timer tick, asking Buildbucket for the build status
[12:48:43.828] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:43.828] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:105:0) after 1m0s
[12:49:43.991] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:105:0)
[12:49:43.991] Timer tick, asking Buildbucket for the build status
[12:49:44.195] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:44.196] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:106:0) after 1m0s
[12:50:44.220] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:106:0)
[12:50:44.220] Timer tick, asking Buildbucket for the build status
[12:50:44.358] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:44.358] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:107:0) after 1m0s
[12:51:44.500] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:107:0)
[12:51:44.500] Timer tick, asking Buildbucket for the build status
[12:51:44.612] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:44.612] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:108:0) after 1m0s
[12:52:44.859] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:108:0)
[12:52:44.859] Timer tick, asking Buildbucket for the build status
[12:52:45.022] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:45.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:109:0) after 1m0s
[12:53:45.132] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:109:0)
[12:53:45.132] Timer tick, asking Buildbucket for the build status
[12:53:45.260] Build 8862935382076770320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:45.261] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028365444198009984:110:0) after 1m0s
[12:54:11.825] Received PubSub notification, asking Buildbucket for the build status
[12:54:11.896] Build 8862935382076770320: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:54:11.896] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606049650679087",
"created_by": "project:chromium",
"created_ts": "1606043180353566",
"id": "8862935382076770320",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1ede3c474eb166874b41e88ab2523d0491b5b7c1\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"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\": \"1ede3c474eb166874b41e88ab2523d0491b5b7c1\", \"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-rel\", \"buildnumber\": 43055, \"got_angle_revision\": \"ebf890fcf9f3e297dcb0736b31bce3e63d63c4d7\", \"got_dawn_revision\": \"546a7c98c89718f2dadf1ae07088fa7cf2ccb53f\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"1ede3c474eb166874b41e88ab2523d0491b5b7c1\", \"got_revision_cp\": \"refs/heads/master@{#830037}\", \"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\": \"7d75f2ca782f38006bb65bc67533e582190454e8\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32659}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1ede3c474eb166874b41e88ab2523d0491b5b7c1\", \"swarm_hashes_refs/heads/master(at){#830037}_without_patch\": {\"absl_hardening_tests\": \"1275f5b9dc7d3b2cf668af4b1e5dd0b0802fd348\", \"accessibility_unittests\": \"49327800766d501393985b12d04d7923bacaa893\", \"angle_unittests\": \"3db6269bca9557533de33ba1bf85681db4e3f959\", \"app_list_unittests\": \"454ea166fd0fbe32caa156ef89911e70148833fc\", \"app_shell_unittests\": \"fb937d3ba1ee8159cd040de79f32d8f5dc93320e\", \"ash_unittests\": \"d251c9a46ae2777b391972d8d2f508810a17ab35\", \"aura_unittests\": \"7610bc138474df483a1d4098a1b480842559456a\", \"base_unittests\": \"0717324579b2d46e293d5c5fee32e0f9e0831ed9\", \"base_util_unittests\": \"0639181a0c5a7521769fed74dfecbcef59efc9dc\", \"blink_common_unittests\": \"2678d9f6bfcd736452c88129e9d36a268b6e4dd5\", \"blink_fuzzer_unittests\": \"cfdb9203804320e75ae883c9122890d120759c89\", \"blink_heap_unittests\": \"c4d4b5aa8956fb04ae1250538579e7bcc2eda732\", \"blink_platform_unittests\": \"820bc69302ffa509a9a8bc6e1724b0c417f4e591\", \"blink_unittests\": \"d3de750e784058711155dd38cc64031313eb6deb\", \"boringssl_crypto_tests\": \"8fd5161edf0c75d2bbef10080e86312301e4a7a3\", \"boringssl_ssl_tests\": \"4f47fed6a41556e792b7cc407473d2c34df24c09\", \"browser_tests\": \"a4cdd5702a0844de736a76a9b4df20b2ec042b4a\", \"capture_unittests\": \"91dba95b35c91d752d0627aca7451baa0d0c72e5\", \"cast_unittests\": \"19668a8ffb9308cab9bfb7ccdab5d7bc5f3c4be6\", \"cc_unittests\": \"214db31fdef3560f68c167a78a6ea2357650969d\", \"chrome_app_unittests\": \"bfbea071dc7ca6119c0ad861cff2c3f295a61798\", \"chromedriver_unittests\": \"fd2aee1462c6d0e402e1bf36c04e4e54f5906168\", \"chromeos_components_unittests\": \"1f17fcd4ca418ee0227208b093273aba8dcae19a\", \"chromeos_unittests\": \"9f1decc8bb0054025b1cda15bb9578138c6578c6\", \"components_browsertests\": \"fc5d19856151e67d085effde2377324a887b2cbd\", \"components_unittests\": \"8cebebc8c348679ed6b313511826b418c4216f2a\", \"compositor_unittests\": \"7147bd2bb5d70b9824c8dcb79db637cbfe1af328\", \"content_browsertests\": \"71e5bcc90d3bb6d9fb1d63e0b70e73d64ed67830\", \"content_unittests\": \"2d91302e354a1d80b581313e6faf6ca6caafcc94\", \"crashpad_tests\": \"a193d3c8fd977b59691811972fcfe8c75ab98331\", \"crypto_unittests\": \"ffbea861ff40ca63557bf9e0dbdece399f089f71\", \"dbus_unittests\": \"b30fda846fb981fced9fe364e0f5741785b30239\", \"device_unittests\": \"e82cabaea6de4125e57486f945d7ef381f0ac348\", \"display_unittests\": \"43102dc2418d4ec5f2479a2ea3c97917a4de4749\", \"events_unittests\": \"9381c4ca2aca4eb11faa795f5b7354894b4fd179\", \"exo_unittests\": \"7f72de74668f7f7d7e8f4ad6d89c96b8b7e22e2d\", \"extensions_browsertests\": \"0c4fa324770093c00e5f7075670950392cfb2df4\", \"extensions_unittests\": \"e97eaf4530e311f3f9d3ac47ab9524b2e45da6fd\", \"filesystem_service_unittests\": \"2f1f45f343fef805081edcedd48b5b574042e5e5\", \"gcm_unit_tests\": \"9478d4ab66729189c66f5dad4c828729b5d8cf2d\", \"gfx_unittests\": \"9151654e972c1980cbfeee0ff95e7e32c1c44a02\", \"gin_unittests\": \"616eb73c094d76c5e1b1cd406a6c4a59bc9222c1\", \"gl_unittests_ozone\": \"2693b8b2d394dc3e92f687c9b769cfc9dc14279b\", \"google_apis_unittests\": \"3d46f3b6f82064ce8b2d5b4189e83daaca9edb7a\", \"gpu_unittests\": \"8e7e690a3773ae689da11c950f757337572ee2c0\", \"gwp_asan_unittests\": \"d65b1d2535acc5e12b11ac1f06edeaabbd0199d7\", \"interactive_ui_tests\": \"1a3122e5f9f7f631d84a1657633d4db376fd103d\", \"ipc_tests\": \"7b805138acd41f306e0deb0f03372d607626c340\", \"jingle_unittests\": \"9bb00f4cf6b28097093916a0d49903ea0fe6131a\", \"keyboard_unittests\": \"9044b5d08645ab290b1b98e5e6977fba58b1c345\", \"latency_unittests\": \"ce9a2c9f8b8bd7008d55bb4eacbb31b71927ddf3\", \"libjingle_xmpp_unittests\": \"b5db31201688aef291126f97c63d9709e9f70629\", \"liburlpattern_unittests\": \"c4f95f31208321e19a0917611331c145f1753f84\", \"media_blink_unittests\": \"4d79e0aae3f7a6684d7987bca1cc85b06d4c3428\", \"media_unittests\": \"a2adeb97f620b2751d9a15cc4ae7f1f08d8b1778\", \"message_center_unittests\": \"80b31001112877ec06795c4108bdd7c495fd90de\", \"midi_unittests\": \"75adc5694b22900af5ede6584d24a2f60ba48b43\", \"mojo_core_unittests\": \"e96594339dc2b1f7613fe2e58f2e213c5683ac70\", \"mojo_unittests\": \"f8b4ddd6db467a93dd3b591ef1ef769fb6e0e7d6\", \"nacl_helper_nonsfi_unittests\": \"0c529112e84422506f83264a7850ab1510f252a0\", \"nacl_loader_unittests\": \"b3b4d66c625adf9621d6c6560eefe6ee1b7cfd26\", \"native_theme_unittests\": \"7a554ffd03c7557f395f351a77862caf7d143532\", \"net_unittests\": \"b989c4c77c5fd639f4c1128097707862a4b11dd9\", \"ozone_gl_unittests\": \"cbabc31877c5de58e19a613357dcea1a0d6550bc\", \"ozone_unittests\": \"52660061af650da8a81db1da0d1625da8707038e\", \"ozone_x11_unittests\": \"4f42d47c071b9a34e7141c9662de63e469ddf536\", \"pdf_unittests\": \"3809564315b5de9931b0c0323141d8247016083d\", \"perfetto_unittests\": \"0e17c8f024261b8610ac61a4acb8aa0d6337da8f\", \"ppapi_unittests\": \"6ac35dd07ee86d644b272ca4c483b89b05ee063f\", \"printing_unittests\": \"d5c26e59062453eb9b7fa10f52f2b8eae84cca43\", \"remoting_unittests\": \"3f34ed668d02881270b211eca86b6530d7df1cea\", \"sandbox_linux_unittests\": \"e6f29da3918a2b546731c585ec11a6845e2751de\", \"service_manager_unittests\": \"51f430f3378bd40fd0ada00324e98c0fd11640da\", \"services_unittests\": \"c49f0f604736937b5337b7876e86f1cf48f7da51\", \"shell_dialogs_unittests\": \"968501ed39da6a95ee36b2c032d27a4f0cee204d\", \"skia_unittests\": \"16dfa323524a783ee6d67b6bb824e1cd5e2337c9\", \"snapshot_unittests\": \"2b3a98e9678fa2134d36f1c16d80436436e64dd6\", \"sql_unittests\": \"8dcd0679665edbd2df178372b0cb764bfc7b6ed0\", \"storage_unittests\": \"352f83ebe56f48965167c8cbb20761e677628674\", \"sync_integration_tests\": \"3932a24a4b8a6f91c2d7d2348c734a819b9d816e\", \"traffic_annotation_auditor_unittests\": \"4a918482781668a7aa782e241b9d04bb9ac8658b\", \"ui_base_unittests\": \"bed29dda796e7483fad2a8447ce18880f6f1e3e9\", \"ui_chromeos_unittests\": \"c613aec201bf78453a0ccee4074a30a3083945e2\", \"ui_touch_selection_unittests\": \"303d9cd8e2b121438c4ceb8133ac4a807a8f79c5\", \"unit_tests\": \"1ff0afb5fc924f90d781d266bc9dba350c114360\", \"url_unittests\": \"5204538271f44926c4413caf9fc70b5e8a363e65\", \"usage_time_limit_unittests\": \"571aaaafee5ce095a92207d1888b092ada91200c\", \"views_unittests\": \"72e3a07bdbf0d96bf3781b801dbd2ecfe3b62b96\", \"viz_unittests\": \"f3606df42ad22a3f3b6001c36934928af904a906\", \"wayland_client_perftests\": \"100096996cf902efaea8ef902d2afad594f9c037\", \"wm_unittests\": \"64f4071c85d6d4e739709f1d5e3183387d52a8f9\", \"wtf_unittests\": \"d4ea2a6fef260eb835a188374f636a0fa5d2866b\", \"zlib_unittests\": \"012c3225ce92d10544c0d497e95c4b5ee6655e43\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0eb0a6f6f49375c133e7af8048caaf1812a31b1811f4b52b8753fe729d0821de_v2\", \"builder_423c17966b99e0a79c01db6cfc0136b5313fefdfff3f88d25a8a4e9f8c30f88c_v2\", \"builder_51829829c31fbaf3768e3309e640f1ed37e0867e138bde8c875431bcab07adc2_v2\", \"builder_61626c7085ee1f9730db9e25e8ceef3d7b395de70268d432aed853b8a16eb295_v2\", \"builder_859368e171259d521efea13da6023dc28f5117d74d565299fe323cf1e9b3ffc9_v2\", \"builder_c9091f6bc58db7983401393b6dacc93b3db8fae2c2ae9b40177b9e0904c8bc80_v2\", \"builder_db6a6033e460ced730b3940170fe4cf923f58c29fb56731f98470df5edf70e65_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\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1606044444455945",
"status": "COMPLETED",
"status_changed_ts": "1606049651294702",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43055",
"builder:linux-chromeos-rel",
"buildset:commit/git/1ede3c474eb166874b41e88ab2523d0491b5b7c1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1ede3c474eb166874b41e88ab2523d0491b5b7c1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028365444198009984",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8862935382076770320/+/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:500873a8b6399210",
"user_agent:luci-scheduler"
],
"updated_ts": "1606049651303098",
"url": "https://ci.chromium.org/b/8862935382076770320",
"utcnow_ts": "1606049651887262"
}
}
[12:54:11.896] Invocation finished in 1h47m52.95039868s with status SUCCEEDED