[08:53:32.458] New invocation is queued and will start shortly
[08:53:33.570] Starting the invocation (attempt 1)
[08:53:33.611] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:53:33.611] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:53:33.611] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022847382734829808",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"89d93205354b47cad3319d96640f8eb141346759\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9022847382734829808",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/89d93205354b47cad3319d96640f8eb141346759",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/89d93205354b47cad3319d96640f8eb141346759",
"gitiles_ref:refs/heads/master"
]
}
[08:53:34.187] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611305613688820",
"id": "8857417320780087920",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"89d93205354b47cad3319d96640f8eb141346759\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611305614045766",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22299",
"builder:linux-chromeos-dbg",
"buildset:commit/git/89d93205354b47cad3319d96640f8eb141346759",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/89d93205354b47cad3319d96640f8eb141346759",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022847382734829808",
"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/8857417320780087920/+/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": "1611305614045877",
"url": "https://ci.chromium.org/b/8857417320780087920",
"utcnow_ts": "1611305614178358"
}
}
[08:53:34.187] Task URL: https://ci.chromium.org/b/8857417320780087920
[08:53:34.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:2:0) after 1m0s
[08:53:37.897] Received PubSub notification, asking Buildbucket for the build status
[08:53:37.970] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:34.172] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:2:0)
[08:54:34.172] Timer tick, asking Buildbucket for the build status
[08:54:34.326] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:34.326] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:4:0) after 1m0s
[08:55:34.348] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:4:0)
[08:55:34.348] Timer tick, asking Buildbucket for the build status
[08:55:34.416] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:34.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:5:0) after 1m0s
[08:56:34.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:5:0)
[08:56:34.442] Timer tick, asking Buildbucket for the build status
[08:56:34.534] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:34.534] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:6:0) after 1m0s
[08:57:34.565] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:6:0)
[08:57:34.565] Timer tick, asking Buildbucket for the build status
[08:57:34.672] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:34.672] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:7:0) after 1m0s
[08:58:34.661] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:7:0)
[08:58:34.661] Timer tick, asking Buildbucket for the build status
[08:58:34.743] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:34.743] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:8:0) after 1m0s
[08:59:34.814] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:8:0)
[08:59:34.815] Timer tick, asking Buildbucket for the build status
[08:59:35.023] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:35.023] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:9:0) after 1m0s
[09:00:35.108] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:9:0)
[09:00:35.108] Timer tick, asking Buildbucket for the build status
[09:00:35.543] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:35.543] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:10:0) after 1m0s
[09:01:35.580] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:10:0)
[09:01:35.580] Timer tick, asking Buildbucket for the build status
[09:01:35.645] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:35.645] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:11:0) after 1m0s
[09:02:35.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:11:0)
[09:02:35.682] Timer tick, asking Buildbucket for the build status
[09:02:35.750] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:35.750] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:12:0) after 1m0s
[09:03:35.816] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:12:0)
[09:03:35.816] Timer tick, asking Buildbucket for the build status
[09:03:35.912] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:35.912] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:13:0) after 1m0s
[09:04:35.931] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:13:0)
[09:04:35.931] Timer tick, asking Buildbucket for the build status
[09:04:36.025] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:36.025] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:14:0) after 1m0s
[09:05:36.083] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:14:0)
[09:05:36.083] Timer tick, asking Buildbucket for the build status
[09:05:36.388] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:36.388] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:15:0) after 1m0s
[09:06:36.449] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:15:0)
[09:06:36.449] Timer tick, asking Buildbucket for the build status
[09:06:36.534] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:36.534] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:16:0) after 1m0s
[09:07:36.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:16:0)
[09:07:36.682] Timer tick, asking Buildbucket for the build status
[09:07:36.824] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:36.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:17:0) after 1m0s
[09:08:36.910] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:17:0)
[09:08:36.910] Timer tick, asking Buildbucket for the build status
[09:08:37.066] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:37.066] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:18:0) after 1m0s
[09:09:37.136] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:18:0)
[09:09:37.136] Timer tick, asking Buildbucket for the build status
[09:09:37.200] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:37.200] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:19:0) after 1m0s
[09:10:37.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:19:0)
[09:10:37.238] Timer tick, asking Buildbucket for the build status
[09:10:37.392] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:37.393] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:20:0) after 1m0s
[09:11:37.485] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:20:0)
[09:11:37.485] Timer tick, asking Buildbucket for the build status
[09:11:37.554] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:37.554] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:21:0) after 1m0s
[09:12:37.611] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:21:0)
[09:12:37.611] Timer tick, asking Buildbucket for the build status
[09:12:37.683] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:37.683] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:22:0) after 1m0s
[09:13:37.756] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:22:0)
[09:13:37.756] Timer tick, asking Buildbucket for the build status
[09:13:38.224] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:38.224] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:23:0) after 1m0s
[09:14:38.258] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:23:0)
[09:14:38.258] Timer tick, asking Buildbucket for the build status
[09:14:38.634] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:38.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:24:0) after 1m0s
[09:15:38.653] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:24:0)
[09:15:38.653] Timer tick, asking Buildbucket for the build status
[09:15:38.708] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:38.708] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:25:0) after 1m0s
[09:16:38.724] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:25:0)
[09:16:38.724] Timer tick, asking Buildbucket for the build status
[09:16:39.043] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:39.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:26:0) after 1m0s
[09:17:39.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:26:0)
[09:17:39.095] Timer tick, asking Buildbucket for the build status
[09:17:39.201] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:39.201] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:27:0) after 1m0s
[09:18:39.270] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:27:0)
[09:18:39.270] Timer tick, asking Buildbucket for the build status
[09:18:39.386] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:39.386] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:28:0) after 1m0s
[09:19:39.425] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:28:0)
[09:19:39.425] Timer tick, asking Buildbucket for the build status
[09:19:39.511] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:39.511] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:29:0) after 1m0s
[09:20:39.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:29:0)
[09:20:39.613] Timer tick, asking Buildbucket for the build status
[09:20:39.763] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:39.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:30:0) after 1m0s
[09:21:39.918] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:30:0)
[09:21:39.918] Timer tick, asking Buildbucket for the build status
[09:21:40.209] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:40.209] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:31:0) after 1m0s
[09:22:40.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:31:0)
[09:22:40.222] Timer tick, asking Buildbucket for the build status
[09:22:40.356] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:40.356] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:32:0) after 1m0s
[09:23:44.952] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:32:0)
[09:23:44.952] Timer tick, asking Buildbucket for the build status
[09:23:45.397] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:45.397] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:33:0) after 1m0s
[09:24:45.422] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:33:0)
[09:24:45.422] Timer tick, asking Buildbucket for the build status
[09:24:45.763] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:45.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:34:0) after 1m0s
[09:25:45.798] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:34:0)
[09:25:45.798] Timer tick, asking Buildbucket for the build status
[09:25:45.897] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:45.897] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:35:0) after 1m0s
[09:26:45.939] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:35:0)
[09:26:45.939] Timer tick, asking Buildbucket for the build status
[09:26:46.026] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:46.026] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:36:0) after 1m0s
[09:27:46.048] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:36:0)
[09:27:46.048] Timer tick, asking Buildbucket for the build status
[09:27:46.418] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:46.418] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:37:0) after 1m0s
[09:28:46.512] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:37:0)
[09:28:46.512] Timer tick, asking Buildbucket for the build status
[09:28:46.647] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:46.647] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:38:0) after 1m0s
[09:29:46.719] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:38:0)
[09:29:46.719] Timer tick, asking Buildbucket for the build status
[09:29:46.781] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:46.781] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:39:0) after 1m0s
[09:30:46.885] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:39:0)
[09:30:46.885] Timer tick, asking Buildbucket for the build status
[09:30:47.318] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:47.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:40:0) after 1m0s
[09:31:47.344] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:40:0)
[09:31:47.344] Timer tick, asking Buildbucket for the build status
[09:31:47.529] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:47.529] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:41:0) after 1m0s
[09:32:47.562] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:41:0)
[09:32:47.562] Timer tick, asking Buildbucket for the build status
[09:32:47.616] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:47.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:42:0) after 1m0s
[09:33:47.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:42:0)
[09:33:47.638] Timer tick, asking Buildbucket for the build status
[09:33:47.902] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:47.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:43:0) after 1m0s
[09:34:47.946] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:43:0)
[09:34:47.946] Timer tick, asking Buildbucket for the build status
[09:34:48.034] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:48.034] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:44:0) after 1m0s
[09:35:48.055] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:44:0)
[09:35:48.055] Timer tick, asking Buildbucket for the build status
[09:35:48.123] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:48.123] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:45:0) after 1m0s
[09:36:48.180] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:45:0)
[09:36:48.180] Timer tick, asking Buildbucket for the build status
[09:36:48.233] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:48.233] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:46:0) after 1m0s
[09:37:48.298] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:46:0)
[09:37:48.298] Timer tick, asking Buildbucket for the build status
[09:37:48.620] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:48.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:47:0) after 1m0s
[09:38:48.649] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:47:0)
[09:38:48.649] Timer tick, asking Buildbucket for the build status
[09:38:48.935] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:48.935] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:48:0) after 1m0s
[09:39:48.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:48:0)
[09:39:48.985] Timer tick, asking Buildbucket for the build status
[09:39:49.238] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:49.238] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:49:0) after 1m0s
[09:40:49.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:49:0)
[09:40:49.349] Timer tick, asking Buildbucket for the build status
[09:40:49.821] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:49.821] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:50:0) after 1m0s
[09:41:49.909] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:50:0)
[09:41:49.909] Timer tick, asking Buildbucket for the build status
[09:41:50.005] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:50.005] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:51:0) after 1m0s
[09:42:50.056] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:51:0)
[09:42:50.056] Timer tick, asking Buildbucket for the build status
[09:42:50.209] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:50.209] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:52:0) after 1m0s
[09:43:50.229] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:52:0)
[09:43:50.229] Timer tick, asking Buildbucket for the build status
[09:43:50.543] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:50.543] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:53:0) after 1m0s
[09:44:50.595] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:53:0)
[09:44:50.595] Timer tick, asking Buildbucket for the build status
[09:44:50.762] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:50.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:54:0) after 1m0s
[09:45:50.786] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:54:0)
[09:45:50.786] Timer tick, asking Buildbucket for the build status
[09:45:50.910] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:50.910] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:55:0) after 1m0s
[09:46:50.966] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:55:0)
[09:46:50.966] Timer tick, asking Buildbucket for the build status
[09:46:51.204] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:51.204] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:56:0) after 1m0s
[09:47:51.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:56:0)
[09:47:51.186] Timer tick, asking Buildbucket for the build status
[09:47:51.826] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:51.826] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:57:0) after 1m0s
[09:48:51.955] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:57:0)
[09:48:51.955] Timer tick, asking Buildbucket for the build status
[09:48:52.319] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:52.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:58:0) after 1m0s
[09:49:52.352] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:58:0)
[09:49:52.352] Timer tick, asking Buildbucket for the build status
[09:49:52.689] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:52.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:59:0) after 1m0s
[09:50:52.661] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:59:0)
[09:50:52.661] Timer tick, asking Buildbucket for the build status
[09:50:52.773] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:52.773] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:60:0) after 1m0s
[09:51:52.804] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:60:0)
[09:51:52.804] Timer tick, asking Buildbucket for the build status
[09:51:53.242] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:53.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:61:0) after 1m0s
[09:52:53.260] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:61:0)
[09:52:53.260] Timer tick, asking Buildbucket for the build status
[09:52:53.584] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:53.584] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:62:0) after 1m0s
[09:53:53.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:62:0)
[09:53:53.638] Timer tick, asking Buildbucket for the build status
[09:53:53.750] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:53.750] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:63:0) after 1m0s
[09:54:53.749] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:63:0)
[09:54:53.750] Timer tick, asking Buildbucket for the build status
[09:54:53.824] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:53.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:64:0) after 1m0s
[09:55:53.840] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:64:0)
[09:55:53.840] Timer tick, asking Buildbucket for the build status
[09:55:56.321] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:56.321] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:65:0) after 1m0s
[09:56:56.437] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:65:0)
[09:56:56.437] Timer tick, asking Buildbucket for the build status
[09:56:56.532] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:56.532] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:66:0) after 1m0s
[09:57:56.569] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:66:0)
[09:57:56.569] Timer tick, asking Buildbucket for the build status
[09:57:56.698] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:56.698] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:67:0) after 1m0s
[09:58:56.738] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:67:0)
[09:58:56.738] Timer tick, asking Buildbucket for the build status
[09:58:56.918] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:56.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:68:0) after 1m0s
[09:59:56.994] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:68:0)
[09:59:56.994] Timer tick, asking Buildbucket for the build status
[09:59:58.113] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:58.114] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:69:0) after 1m0s
[10:00:58.164] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:69:0)
[10:00:58.164] Timer tick, asking Buildbucket for the build status
[10:00:58.230] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:58.230] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:70:0) after 1m0s
[10:01:58.383] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:70:0)
[10:01:58.383] Timer tick, asking Buildbucket for the build status
[10:01:58.517] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:58.517] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:71:0) after 1m0s
[10:02:58.583] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:71:0)
[10:02:58.583] Timer tick, asking Buildbucket for the build status
[10:02:58.796] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:58.796] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:72:0) after 1m0s
[10:03:58.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:72:0)
[10:03:58.853] Timer tick, asking Buildbucket for the build status
[10:03:58.963] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:58.963] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:73:0) after 1m0s
[10:04:58.999] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:73:0)
[10:04:58.999] Timer tick, asking Buildbucket for the build status
[10:04:59.633] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:59.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:74:0) after 1m0s
[10:05:59.726] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:74:0)
[10:05:59.726] Timer tick, asking Buildbucket for the build status
[10:05:59.988] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:59.988] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:75:0) after 1m0s
[10:07:00.026] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:75:0)
[10:07:00.026] Timer tick, asking Buildbucket for the build status
[10:07:00.345] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:00.345] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:76:0) after 1m0s
[10:08:00.377] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:76:0)
[10:08:00.377] Timer tick, asking Buildbucket for the build status
[10:08:00.636] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:00.636] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:77:0) after 1m0s
[10:09:00.712] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:77:0)
[10:09:00.712] Timer tick, asking Buildbucket for the build status
[10:09:00.845] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:00.845] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:78:0) after 1m0s
[10:10:00.868] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:78:0)
[10:10:00.868] Timer tick, asking Buildbucket for the build status
[10:10:00.943] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:00.943] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:79:0) after 1m0s
[10:11:00.977] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:79:0)
[10:11:00.977] Timer tick, asking Buildbucket for the build status
[10:11:01.089] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:01.089] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:80:0) after 1m0s
[10:12:01.133] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:80:0)
[10:12:01.133] Timer tick, asking Buildbucket for the build status
[10:12:01.215] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:01.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:81:0) after 1m0s
[10:13:01.298] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:81:0)
[10:13:01.298] Timer tick, asking Buildbucket for the build status
[10:13:01.645] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:01.645] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:82:0) after 1m0s
[10:14:01.643] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:82:0)
[10:14:01.643] Timer tick, asking Buildbucket for the build status
[10:14:02.215] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:02.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:83:0) after 1m0s
[10:15:02.331] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:83:0)
[10:15:02.331] Timer tick, asking Buildbucket for the build status
[10:15:02.396] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:02.396] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:84:0) after 1m0s
[10:16:02.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:84:0)
[10:16:02.454] Timer tick, asking Buildbucket for the build status
[10:16:02.540] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:02.540] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:85:0) after 1m0s
[10:17:02.654] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:85:0)
[10:17:02.654] Timer tick, asking Buildbucket for the build status
[10:17:02.954] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:02.954] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:86:0) after 1m0s
[10:18:02.939] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:86:0)
[10:18:02.939] Timer tick, asking Buildbucket for the build status
[10:18:03.019] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:03.020] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:87:0) after 1m0s
[10:19:03.021] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:87:0)
[10:19:03.021] Timer tick, asking Buildbucket for the build status
[10:19:03.180] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:03.180] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:88:0) after 1m0s
[10:20:03.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:88:0)
[10:20:03.198] Timer tick, asking Buildbucket for the build status
[10:20:03.282] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:03.282] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:89:0) after 1m0s
[10:21:03.316] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:89:0)
[10:21:03.316] Timer tick, asking Buildbucket for the build status
[10:21:03.401] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:03.401] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:90:0) after 1m0s
[10:22:03.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:90:0)
[10:22:03.454] Timer tick, asking Buildbucket for the build status
[10:22:03.598] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:03.598] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:91:0) after 1m0s
[10:23:03.661] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:91:0)
[10:23:03.661] Timer tick, asking Buildbucket for the build status
[10:23:03.881] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:03.881] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:92:0) after 1m0s
[10:24:03.944] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:92:0)
[10:24:03.944] Timer tick, asking Buildbucket for the build status
[10:24:04.418] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:04.418] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:93:0) after 1m0s
[10:25:04.451] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:93:0)
[10:25:04.451] Timer tick, asking Buildbucket for the build status
[10:25:04.527] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:04.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:94:0) after 1m0s
[10:26:04.600] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:94:0)
[10:26:04.600] Timer tick, asking Buildbucket for the build status
[10:26:04.725] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:04.725] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:95:0) after 1m0s
[10:27:04.778] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:95:0)
[10:27:04.778] Timer tick, asking Buildbucket for the build status
[10:27:04.962] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:04.962] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:96:0) after 1m0s
[10:28:05.058] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:96:0)
[10:28:05.058] Timer tick, asking Buildbucket for the build status
[10:28:05.195] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:05.195] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:97:0) after 1m0s
[10:29:05.320] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:97:0)
[10:29:05.320] Timer tick, asking Buildbucket for the build status
[10:29:05.638] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:05.638] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:98:0) after 1m0s
[10:30:05.747] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:98:0)
[10:30:05.747] Timer tick, asking Buildbucket for the build status
[10:30:06.041] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:06.041] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:99:0) after 1m0s
[10:31:06.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:99:0)
[10:31:06.216] Timer tick, asking Buildbucket for the build status
[10:31:06.295] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:06.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:100:0) after 1m0s
[10:32:06.432] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:100:0)
[10:32:06.432] Timer tick, asking Buildbucket for the build status
[10:32:06.573] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:06.573] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:101:0) after 1m0s
[10:33:06.606] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:101:0)
[10:33:06.606] Timer tick, asking Buildbucket for the build status
[10:33:06.676] Build 8857417320780087920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:06.677] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022847382734829808:102:0) after 1m0s
[10:33:10.645] Received PubSub notification, asking Buildbucket for the build status
[10:33:10.752] Build 8857417320780087920: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:33:10.752] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611311588049989",
"created_by": "project:chromium",
"created_ts": "1611305613688820",
"id": "8857417320780087920",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"89d93205354b47cad3319d96640f8eb141346759\"}}",
"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\": \"89d93205354b47cad3319d96640f8eb141346759\", \"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-89-mvey\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22299, \"got_angle_revision\": \"ff5f715e5c4af1f2195da69c4b7bb03efa5a91f8\", \"got_dawn_revision\": \"db383498c5c68ccc3c0eb10a72369c8dbe1c476a\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"89d93205354b47cad3319d96640f8eb141346759\", \"got_revision_cp\": \"refs/heads/master@{#846016}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1d5174b9dc3be500d63daf227b163b5e86bbc7b5\", \"got_v8_revision\": \"f84a78cfaacc36cf1bbe47f3ecace565750fc92d\", \"got_v8_revision_cp\": \"refs/heads/9.0.48@{#1}\", \"got_webrtc_revision\": \"e4fd1ba3198932d4c4ca0e0cc98635758555adee\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33053}\", \"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\": \"89d93205354b47cad3319d96640f8eb141346759\", \"swarm_hashes_refs/heads/master(at){#846016}_without_patch\": {\"absl_hardening_tests\": \"97cfbdeb28e023d66fcebb6cf046b2f1b75c474e\", \"accessibility_unittests\": \"28671fe14f222cbaf8432c36f9d73d80eb6a4f25\", \"angle_unittests\": \"186a2c676764dd2a0b0e4d5c0a3a743d437bea5c\", \"app_list_unittests\": \"3a3c3aef31b217fcf1fbf7aa5d5461134ce646b8\", \"app_shell_unittests\": \"b52c027047c2ba598ef5caf1c9a61214711ce6f5\", \"ash_unittests\": \"010e3083e62d3c342dacd37e2bdf2ee861e66a2a\", \"aura_unittests\": \"5258ebf74a31efaa62de701e002120347f68837d\", \"base_unittests\": \"50c8795a3d62228cefcdd47c4e8ccefe06600288\", \"base_util_unittests\": \"4020066a4c88a73b47611873007b579f27fa8ced\", \"blink_common_unittests\": \"cb4586b5cc333b46b1de811376736b8a1130b44e\", \"blink_fuzzer_unittests\": \"b5d8cab9cf924ce06def80f6dc9bd95a1b956257\", \"blink_heap_unittests\": \"da7f4173d56ccdbfae6018860281c58954a1d05b\", \"blink_platform_unittests\": \"f4810621e15863cfa0a8e04dbbc911b09cdadc35\", \"blink_unittests\": \"64c4eb9f294c1d48386c926aa5e3dc4d04c57665\", \"boringssl_crypto_tests\": \"caa384841cc49892b5c6178102170f53ce4c7f25\", \"boringssl_ssl_tests\": \"cc7deb8c70568e4d328af7d062e4ab3bba3cac4e\", \"browser_tests\": \"128f0af8d48c80c8239e62f6e12e637455d691cb\", \"capture_unittests\": \"f2e2f7a3ff8c86028533819741034a19e86009ba\", \"cast_unittests\": \"22f0a0a7eb351410895f4a945b84494ef766d62a\", \"cc_unittests\": \"494894ebf08a5f0627680fca429e8f2dc3704770\", \"chrome_app_unittests\": \"2ce527f755febf29cfd3e33744f2cbc29bae1e08\", \"chromedriver_unittests\": \"8c39f8b0e3942e7766ab59a3bbc228eb8d685edc\", \"chromeos_components_unittests\": \"89688cf0bf640a8a24d9bf32e079ecd4b8eff6b4\", \"chromeos_unittests\": \"c9af011b8ffe9f74646d132b8d33fbea473e6c75\", \"components_browsertests\": \"3e16eb37a7c6167a4e9de06823d2cac6506294e2\", \"components_unittests\": \"36f2d2d6da65f9793e83070835cd63a3b932291f\", \"compositor_unittests\": \"7283ff716c38799f26ce140ecca919e22253bcf1\", \"content_browsertests\": \"b075a7deffa39f6828070b2811f60920164230b9\", \"content_unittests\": \"2dff5a0666fe5e6abb520b48c16edf371ac2769d\", \"crashpad_tests\": \"3ef582c5f5dae30b333eb3f7300d6e20b83f9b39\", \"crypto_unittests\": \"9b479139567037a8f04a7be77024d0c569219993\", \"dbus_unittests\": \"0a3e5aed1e5fb27efd52bb6391767e30e2c5ee2f\", \"device_unittests\": \"961d51c169d118b4c6224144e09ca1e5248036cd\", \"display_unittests\": \"d4928902c3dae549a8681a4dff67fa233b5b938a\", \"events_unittests\": \"058cd3335c070e272cf9c96b639327c1cebd50b7\", \"exo_unittests\": \"4c1c078eaf8098ff308a91311766658ff8097976\", \"extensions_browsertests\": \"e7a6c20d64d8776c110c139d18f4ef6f1af12627\", \"extensions_unittests\": \"02fbbe9ebd89d1cb88e66eaac8eae4e9359cd064\", \"filesystem_service_unittests\": \"34fa505a87a1ec795522b7e12b123665b6c50f46\", \"gcm_unit_tests\": \"824b3e3f2a243414c7fde034bc0a288db50e2700\", \"gfx_unittests\": \"03e7b51b0072d8b1c2863d67cec9161543a8de0e\", \"gin_unittests\": \"11834fe1cc98154741b54ece0cb881a64dbad9e0\", \"gl_unittests_ozone\": \"b1e2e9410fdf94371dd8a239a25a4d25262e542d\", \"google_apis_unittests\": \"bea6ace87d348f231c69aeb3d7d2fcd6792813b6\", \"gpu_unittests\": \"acdbb2680841040636d1d3c1b354888b570c5c82\", \"gwp_asan_unittests\": \"c131565644c2c74b956e17bfd3c7fe84c626a783\", \"interactive_ui_tests\": \"67e83430884add1675b7e7544fe7ac1a253939b9\", \"ipc_tests\": \"c40cd6e8abc335ab0de1427a224e1a5a984ff381\", \"jingle_unittests\": \"3c73a9a29e2fc85a0459e6c361f3f27494de444b\", \"keyboard_unittests\": \"4cf2c45de82025033228b13c2965aea2ee89a6dd\", \"latency_unittests\": \"6ecf0c6612ac34b0fb119446caf31d25209f3ce7\", \"libjingle_xmpp_unittests\": \"b5b0e41fbe13eae1928fc8cdb974ff7f3985e402\", \"liburlpattern_unittests\": \"7915efe92e65ec4efbddc0465034d8889c161b26\", \"media_blink_unittests\": \"0c643bc1c8e7285315d013b3dd71852687a82a85\", \"media_unittests\": \"035273890e9b8e7f482d595b129820941a47a82e\", \"message_center_unittests\": \"ae60eec64ecf7b81cbe9c64f31a0e8f6574fa7cf\", \"midi_unittests\": \"3c81b54e4714c2e68c556e281f473aeda463f8ac\", \"mojo_core_unittests\": \"05569e48290e69d29cf410a3dd0121ee0498d52a\", \"mojo_unittests\": \"93c315cb3852d7a419a5672e02476f9aef7a2b15\", \"nacl_helper_nonsfi_unittests\": \"d9118cd6a9ee4c0e0102cea9c83e652372393e87\", \"nacl_loader_unittests\": \"058ee8f3b5b6505722ccd03fd738daf759980d27\", \"native_theme_unittests\": \"1291c203c17662c24c1d9bef677a44fc43cf9bc1\", \"net_unittests\": \"eaba80fab61322d23c9efec4998023270e3776b7\", \"ozone_gl_unittests\": \"83851b05fc57dc9b74db8eda03f3abc34b4b6bb8\", \"ozone_unittests\": \"e2afe3afa02decfc2e03cd79dcb745dcfa2d6cf2\", \"ozone_x11_unittests\": \"36b3688be8110233ebb3b236b945ece3deaab705\", \"pdf_unittests\": \"4ef394767db9f57be222b510b7d474dd28757ec2\", \"perfetto_unittests\": \"0fd90c7dcd467fc6241c9ec5289e3d2112b6d10a\", \"ppapi_unittests\": \"5e35c5a04f456352a8bf87f231ae05e6a2106de8\", \"printing_unittests\": \"7c4d6300babb9f5d6e8ab4e218ef587cf781fa75\", \"remoting_unittests\": \"28379180d1da7eb1106c9e2216556736e3e0b9d8\", \"sandbox_linux_unittests\": \"3e88921c153ab3d6fdd075b8529a17052c187357\", \"service_manager_unittests\": \"5e2881a2ca671aa6ed12405bb434e64207c1a069\", \"services_unittests\": \"80465baed36e3315c7abe89b796e32ee171dc07a\", \"shell_dialogs_unittests\": \"88908beefb8c4695d0d9350a022a94536aa9ff83\", \"shell_encryption_unittests\": \"96871ecab5ee9bcc9278232d945d4acfc0185fba\", \"skia_unittests\": \"2d5fe5d28e3daf8527820a5337bf257a701702ba\", \"snapshot_unittests\": \"1a6d45134ede08a05c872103217d66c8f1c5958e\", \"sql_unittests\": \"47dccfc102d6cbb925ae524f10cbc8c67cfdf7d6\", \"storage_unittests\": \"5326efe7d1135dae72562c3222e390e236f3a7f2\", \"sync_integration_tests\": \"94b98c11d45bc706fc371c4f382fc490033949a8\", \"traffic_annotation_auditor_unittests\": \"6dcdbf0bdffd551966e7509b1a0317848b3c76ed\", \"ui_base_unittests\": \"3f75bff52091c22908233cf31229e788123a2426\", \"ui_chromeos_unittests\": \"5d8d95bf8139b7bda81b429c03beeb5657749db7\", \"ui_touch_selection_unittests\": \"eec49a2e92df36bd456c946720d425e5aed816ae\", \"unit_tests\": \"2b7c4da6f95c579e6b033f07087a2901b1d68774\", \"url_unittests\": \"21f815571ef29e9a91ebaf60441e315d5d992ee5\", \"usage_time_limit_unittests\": \"b94d9f2d93dd3e570674dd1dc07daf656bd5728d\", \"views_unittests\": \"05f0b75d65479efaf10f74580104610f4831b009\", \"viz_unittests\": \"89d5aa938dbcc1934c68c04a8ff86eb7d6c5e322\", \"wm_unittests\": \"7362f42576edbc7784336c3c93b19ce443a812ef\", \"wtf_unittests\": \"74635fc7253703fc60b38f955524be39d1419380\", \"zlib_unittests\": \"e7834c8fe0a195731f5ca7369f4ba6cd6ff264e5\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_093e8a6336a6e6d4670d6f5128e7c73730afadf3bd7f9284d26d8f79182f8ce5_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_61faa0d0c1c079ecf670d8cfa4f78ad3b1687a5534233c7377462c3ee6819708_v2\", \"builder_8e7ad9a10a7772feba5b42dda56992e918fe88f23579c3ddaf696dde66ee4238_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-89-mvey\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"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\": [\"5671-1d9dea8\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611305616937484",
"status": "COMPLETED",
"status_changed_ts": "1611311589012855",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22299",
"builder:linux-chromeos-dbg",
"buildset:commit/git/89d93205354b47cad3319d96640f8eb141346759",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/89d93205354b47cad3319d96640f8eb141346759",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022847382734829808",
"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/8857417320780087920/+/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:51421e05ea911f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1611311589060009",
"url": "https://ci.chromium.org/b/8857417320780087920",
"utcnow_ts": "1611311590742181"
}
}
[10:33:10.752] Invocation finished in 1h39m38.311923784s with status SUCCEEDED