[11:30:16.942] New invocation is queued and will start shortly
[11:30:18.438] Starting the invocation (attempt 1)
[11:30:18.524] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:30:18.524] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:30:18.524] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022656327495772400",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"4c64daca250d28a919fbced435f24367f5c01115\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9022656327495772400",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/4c64daca250d28a919fbced435f24367f5c01115",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4c64daca250d28a919fbced435f24367f5c01115",
"gitiles_ref:refs/heads/master"
]
}
[11:30:19.399] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611487818670427",
"id": "8857226265008112560",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4c64daca250d28a919fbced435f24367f5c01115\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611487819199126",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22323",
"builder:linux-chromeos-dbg",
"buildset:commit/git/4c64daca250d28a919fbced435f24367f5c01115",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4c64daca250d28a919fbced435f24367f5c01115",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022656327495772400",
"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/8857226265008112560/+/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": "1611487819199275",
"url": "https://ci.chromium.org/b/8857226265008112560",
"utcnow_ts": "1611487819347145"
}
}
[11:30:19.399] Task URL: https://ci.chromium.org/b/8857226265008112560
[11:30:19.399] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:2:0) after 1m0s
[11:31:19.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:2:0)
[11:31:19.513] Timer tick, asking Buildbucket for the build status
[11:31:19.640] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:31:19.640] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:3:0) after 1m0s
[11:32:19.687] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:3:0)
[11:32:19.687] Timer tick, asking Buildbucket for the build status
[11:32:19.796] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:32:19.796] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:4:0) after 1m0s
[11:33:19.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:4:0)
[11:33:19.853] Timer tick, asking Buildbucket for the build status
[11:33:19.951] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:33:19.951] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:5:0) after 1m0s
[11:34:19.977] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:5:0)
[11:34:19.977] Timer tick, asking Buildbucket for the build status
[11:34:20.223] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:34:20.223] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:6:0) after 1m0s
[11:35:20.241] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:6:0)
[11:35:20.241] Timer tick, asking Buildbucket for the build status
[11:35:20.494] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:35:20.494] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:7:0) after 1m0s
[11:36:20.557] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:7:0)
[11:36:20.557] Timer tick, asking Buildbucket for the build status
[11:36:20.650] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:36:20.650] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:8:0) after 1m0s
[11:37:20.708] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:8:0)
[11:37:20.708] Timer tick, asking Buildbucket for the build status
[11:37:20.786] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:37:20.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:9:0) after 1m0s
[11:38:20.846] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:9:0)
[11:38:20.846] Timer tick, asking Buildbucket for the build status
[11:38:20.974] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:38:20.974] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:10:0) after 1m0s
[11:39:20.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:10:0)
[11:39:20.985] Timer tick, asking Buildbucket for the build status
[11:39:21.049] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:39:21.049] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:11:0) after 1m0s
[11:40:21.109] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:11:0)
[11:40:21.109] Timer tick, asking Buildbucket for the build status
[11:40:21.343] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:40:21.343] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:12:0) after 1m0s
[11:41:21.438] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:12:0)
[11:41:21.438] Timer tick, asking Buildbucket for the build status
[11:41:21.543] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:41:21.543] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:13:0) after 1m0s
[11:42:21.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:13:0)
[11:42:21.615] Timer tick, asking Buildbucket for the build status
[11:42:21.694] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:42:21.694] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:14:0) after 1m0s
[11:43:21.714] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:14:0)
[11:43:21.714] Timer tick, asking Buildbucket for the build status
[11:43:22.804] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:43:22.804] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:15:0) after 1m0s
[11:44:22.828] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:15:0)
[11:44:22.828] Timer tick, asking Buildbucket for the build status
[11:44:22.901] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:44:22.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:16:0) after 1m0s
[11:45:22.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:16:0)
[11:45:22.922] Timer tick, asking Buildbucket for the build status
[11:45:23.018] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:45:23.018] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:17:0) after 1m0s
[11:46:23.084] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:17:0)
[11:46:23.084] Timer tick, asking Buildbucket for the build status
[11:46:23.199] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:46:23.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:18:0) after 1m0s
[11:47:23.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:18:0)
[11:47:23.222] Timer tick, asking Buildbucket for the build status
[11:47:23.343] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:47:23.343] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:19:0) after 1m0s
[11:48:23.384] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:19:0)
[11:48:23.384] Timer tick, asking Buildbucket for the build status
[11:48:23.448] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:48:23.448] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:20:0) after 1m0s
[11:49:23.445] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:20:0)
[11:49:23.445] Timer tick, asking Buildbucket for the build status
[11:49:23.512] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:49:23.512] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:21:0) after 1m0s
[11:50:23.530] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:21:0)
[11:50:23.530] Timer tick, asking Buildbucket for the build status
[11:50:23.851] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:50:23.851] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:22:0) after 1m0s
[11:51:23.932] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:22:0)
[11:51:23.932] Timer tick, asking Buildbucket for the build status
[11:51:24.165] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:51:24.165] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:23:0) after 1m0s
[11:52:24.188] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:23:0)
[11:52:24.188] Timer tick, asking Buildbucket for the build status
[11:52:24.266] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:52:24.266] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:24:0) after 1m0s
[11:53:24.300] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:24:0)
[11:53:24.301] Timer tick, asking Buildbucket for the build status
[11:53:24.443] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:53:24.443] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:25:0) after 1m0s
[11:54:24.528] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:25:0)
[11:54:24.528] Timer tick, asking Buildbucket for the build status
[11:54:24.600] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:54:24.600] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:26:0) after 1m0s
[11:55:24.608] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:26:0)
[11:55:24.608] Timer tick, asking Buildbucket for the build status
[11:55:24.924] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:55:24.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:27:0) after 1m0s
[11:56:24.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:27:0)
[11:56:24.970] Timer tick, asking Buildbucket for the build status
[11:56:25.559] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:56:25.559] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:28:0) after 1m0s
[11:57:25.649] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:28:0)
[11:57:25.649] Timer tick, asking Buildbucket for the build status
[11:57:25.721] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:57:25.721] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:29:0) after 1m0s
[11:58:25.840] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:29:0)
[11:58:25.840] Timer tick, asking Buildbucket for the build status
[11:58:26.138] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:58:26.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:30:0) after 1m0s
[11:59:26.204] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:30:0)
[11:59:26.204] Timer tick, asking Buildbucket for the build status
[11:59:26.270] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:59:26.271] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:31:0) after 1m0s
[12:00:26.288] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:31:0)
[12:00:26.288] Timer tick, asking Buildbucket for the build status
[12:00:26.390] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:00:26.390] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:32:0) after 1m0s
[12:01:26.431] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:32:0)
[12:01:26.431] Timer tick, asking Buildbucket for the build status
[12:01:27.130] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:01:27.130] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:33:0) after 1m0s
[12:02:27.115] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:33:0)
[12:02:27.115] Timer tick, asking Buildbucket for the build status
[12:02:27.187] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:02:27.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:34:0) after 1m0s
[12:03:27.195] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:34:0)
[12:03:27.195] Timer tick, asking Buildbucket for the build status
[12:03:27.259] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:03:27.259] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:35:0) after 1m0s
[12:04:27.333] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:35:0)
[12:04:27.333] Timer tick, asking Buildbucket for the build status
[12:04:27.397] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:04:27.397] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:36:0) after 1m0s
[12:05:27.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:36:0)
[12:05:27.371] Timer tick, asking Buildbucket for the build status
[12:05:27.584] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:05:27.584] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:37:0) after 1m0s
[12:06:27.604] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:37:0)
[12:06:27.604] Timer tick, asking Buildbucket for the build status
[12:06:27.679] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:06:27.679] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:38:0) after 1m0s
[12:07:27.703] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:38:0)
[12:07:27.703] Timer tick, asking Buildbucket for the build status
[12:07:27.800] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:07:27.800] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:39:0) after 1m0s
[12:08:27.823] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:39:0)
[12:08:27.823] Timer tick, asking Buildbucket for the build status
[12:08:27.972] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:08:27.972] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:40:0) after 1m0s
[12:09:28.011] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:40:0)
[12:09:28.011] Timer tick, asking Buildbucket for the build status
[12:09:28.100] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:09:28.100] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:41:0) after 1m0s
[12:10:28.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:41:0)
[12:10:28.119] Timer tick, asking Buildbucket for the build status
[12:10:28.227] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:10:28.227] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:42:0) after 1m0s
[12:11:28.244] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:42:0)
[12:11:28.244] Timer tick, asking Buildbucket for the build status
[12:11:28.311] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:11:28.311] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:43:0) after 1m0s
[12:12:28.341] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:43:0)
[12:12:28.341] Timer tick, asking Buildbucket for the build status
[12:12:28.642] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:12:28.642] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:44:0) after 1m0s
[12:13:28.677] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:44:0)
[12:13:28.677] Timer tick, asking Buildbucket for the build status
[12:13:28.725] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:13:28.725] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:45:0) after 1m0s
[12:14:28.708] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:45:0)
[12:14:28.708] Timer tick, asking Buildbucket for the build status
[12:14:28.782] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:14:28.782] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:46:0) after 1m0s
[12:15:28.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:46:0)
[12:15:28.857] Timer tick, asking Buildbucket for the build status
[12:15:29.011] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:15:29.011] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:47:0) after 1m0s
[12:16:29.013] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:47:0)
[12:16:29.013] Timer tick, asking Buildbucket for the build status
[12:16:29.082] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:16:29.082] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:48:0) after 1m0s
[12:17:29.105] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:48:0)
[12:17:29.105] Timer tick, asking Buildbucket for the build status
[12:17:29.239] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:17:29.239] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:49:0) after 1m0s
[12:18:29.261] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:49:0)
[12:18:29.261] Timer tick, asking Buildbucket for the build status
[12:18:29.426] Build 8857226265008112560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:18:29.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:50:0) after 1m0s
[12:18:48.427] Received PubSub notification, asking Buildbucket for the build status
[12:18:48.483] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:29.477] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:50:0)
[12:19:29.477] Timer tick, asking Buildbucket for the build status
[12:19:29.551] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:29.551] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:52:0) after 1m0s
[12:20:29.699] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:52:0)
[12:20:29.699] Timer tick, asking Buildbucket for the build status
[12:20:29.792] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:29.792] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:53:0) after 1m0s
[12:21:29.803] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:53:0)
[12:21:29.803] Timer tick, asking Buildbucket for the build status
[12:21:29.996] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:29.996] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:54:0) after 1m0s
[12:22:30.139] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:54:0)
[12:22:30.139] Timer tick, asking Buildbucket for the build status
[12:22:30.240] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:30.240] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:55:0) after 1m0s
[12:23:30.272] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:55:0)
[12:23:30.272] Timer tick, asking Buildbucket for the build status
[12:23:30.372] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:30.372] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:56:0) after 1m0s
[12:24:30.441] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:56:0)
[12:24:30.441] Timer tick, asking Buildbucket for the build status
[12:24:30.510] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:30.510] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:57:0) after 1m0s
[12:25:30.530] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:57:0)
[12:25:30.530] Timer tick, asking Buildbucket for the build status
[12:25:31.392] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:31.392] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:58:0) after 1m0s
[12:26:31.494] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:58:0)
[12:26:31.494] Timer tick, asking Buildbucket for the build status
[12:26:31.633] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:31.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:59:0) after 1m0s
[12:27:31.739] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:59:0)
[12:27:31.739] Timer tick, asking Buildbucket for the build status
[12:27:31.792] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:31.792] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:60:0) after 1m0s
[12:28:31.805] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:60:0)
[12:28:31.805] Timer tick, asking Buildbucket for the build status
[12:28:32.236] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:32.236] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:61:0) after 1m0s
[12:29:32.256] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:61:0)
[12:29:32.256] Timer tick, asking Buildbucket for the build status
[12:29:32.327] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:32.327] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:62:0) after 1m0s
[12:30:32.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:62:0)
[12:30:32.349] Timer tick, asking Buildbucket for the build status
[12:30:32.446] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:32.446] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:63:0) after 1m0s
[12:31:32.466] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:63:0)
[12:31:32.466] Timer tick, asking Buildbucket for the build status
[12:31:32.543] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:32.543] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:64:0) after 1m0s
[12:32:32.562] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:64:0)
[12:32:32.562] Timer tick, asking Buildbucket for the build status
[12:32:32.659] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:32.659] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:65:0) after 1m0s
[12:33:32.695] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:65:0)
[12:33:32.695] Timer tick, asking Buildbucket for the build status
[12:33:32.796] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:32.796] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:66:0) after 1m0s
[12:34:32.891] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:66:0)
[12:34:32.891] Timer tick, asking Buildbucket for the build status
[12:34:33.139] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:33.139] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:67:0) after 1m0s
[12:35:33.229] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:67:0)
[12:35:33.229] Timer tick, asking Buildbucket for the build status
[12:35:33.333] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:33.333] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:68:0) after 1m0s
[12:36:33.391] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:68:0)
[12:36:33.391] Timer tick, asking Buildbucket for the build status
[12:36:33.462] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:33.462] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:69:0) after 1m0s
[12:37:33.487] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:69:0)
[12:37:33.488] Timer tick, asking Buildbucket for the build status
[12:37:33.562] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:33.562] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:70:0) after 1m0s
[12:38:33.670] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:70:0)
[12:38:33.670] Timer tick, asking Buildbucket for the build status
[12:38:33.779] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:33.779] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:71:0) after 1m0s
[12:39:33.799] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:71:0)
[12:39:33.799] Timer tick, asking Buildbucket for the build status
[12:39:34.044] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:34.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:72:0) after 1m0s
[12:40:34.068] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:72:0)
[12:40:34.068] Timer tick, asking Buildbucket for the build status
[12:40:34.164] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:34.164] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:73:0) after 1m0s
[12:41:34.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:73:0)
[12:41:34.198] Timer tick, asking Buildbucket for the build status
[12:41:34.290] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:34.290] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:74:0) after 1m0s
[12:42:34.332] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:74:0)
[12:42:34.332] Timer tick, asking Buildbucket for the build status
[12:42:34.531] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:34.531] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:75:0) after 1m0s
[12:43:34.562] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:75:0)
[12:43:34.562] Timer tick, asking Buildbucket for the build status
[12:43:34.816] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:34.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:76:0) after 1m0s
[12:44:34.913] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:76:0)
[12:44:34.913] Timer tick, asking Buildbucket for the build status
[12:44:34.996] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:34.996] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:77:0) after 1m0s
[12:45:35.015] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:77:0)
[12:45:35.015] Timer tick, asking Buildbucket for the build status
[12:45:35.101] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:35.101] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:78:0) after 1m0s
[12:46:35.154] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:78:0)
[12:46:35.154] Timer tick, asking Buildbucket for the build status
[12:46:35.430] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:35.430] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:79:0) after 1m0s
[12:47:35.479] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:79:0)
[12:47:35.479] Timer tick, asking Buildbucket for the build status
[12:47:35.537] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:35.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:80:0) after 1m0s
[12:48:35.610] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:80:0)
[12:48:35.611] Timer tick, asking Buildbucket for the build status
[12:48:35.854] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:35.854] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:81:0) after 1m0s
[12:49:35.874] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:81:0)
[12:49:35.874] Timer tick, asking Buildbucket for the build status
[12:49:35.932] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:35.932] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:82:0) after 1m0s
[12:50:35.999] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:82:0)
[12:50:35.999] Timer tick, asking Buildbucket for the build status
[12:50:36.104] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:36.104] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:83:0) after 1m0s
[12:51:36.192] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:83:0)
[12:51:36.192] Timer tick, asking Buildbucket for the build status
[12:51:36.359] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:36.359] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:84:0) after 1m0s
[12:52:36.431] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:84:0)
[12:52:36.431] Timer tick, asking Buildbucket for the build status
[12:52:36.487] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:36.487] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:85:0) after 1m0s
[12:53:36.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:85:0)
[12:53:36.508] Timer tick, asking Buildbucket for the build status
[12:53:36.587] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:36.587] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:86:0) after 1m0s
[12:54:36.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:86:0)
[12:54:36.615] Timer tick, asking Buildbucket for the build status
[12:54:36.668] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:36.668] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:87:0) after 1m0s
[12:55:36.721] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:87:0)
[12:55:36.721] Timer tick, asking Buildbucket for the build status
[12:55:36.987] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:36.987] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:88:0) after 1m0s
[12:56:37.014] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:88:0)
[12:56:37.014] Timer tick, asking Buildbucket for the build status
[12:56:37.076] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:37.076] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:89:0) after 1m0s
[12:57:37.188] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:89:0)
[12:57:37.188] Timer tick, asking Buildbucket for the build status
[12:57:37.733] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:37.733] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:90:0) after 1m0s
[12:58:37.726] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:90:0)
[12:58:37.726] Timer tick, asking Buildbucket for the build status
[12:58:38.046] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:38.046] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:91:0) after 1m0s
[12:59:38.047] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:91:0)
[12:59:38.047] Timer tick, asking Buildbucket for the build status
[12:59:38.101] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:38.101] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:92:0) after 1m0s
[13:00:38.133] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:92:0)
[13:00:38.133] Timer tick, asking Buildbucket for the build status
[13:00:38.435] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:38.435] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:93:0) after 1m0s
[13:01:38.533] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:93:0)
[13:01:38.533] Timer tick, asking Buildbucket for the build status
[13:01:38.715] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:38.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:94:0) after 1m0s
[13:02:38.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:94:0)
[13:02:38.748] Timer tick, asking Buildbucket for the build status
[13:02:39.029] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:39.029] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:95:0) after 1m0s
[13:03:39.052] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:95:0)
[13:03:39.052] Timer tick, asking Buildbucket for the build status
[13:03:39.106] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:39.106] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:96:0) after 1m0s
[13:04:39.133] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:96:0)
[13:04:39.133] Timer tick, asking Buildbucket for the build status
[13:04:39.216] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:39.216] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:97:0) after 1m0s
[13:05:39.313] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:97:0)
[13:05:39.313] Timer tick, asking Buildbucket for the build status
[13:05:39.421] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:39.421] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:98:0) after 1m0s
[13:06:39.457] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:98:0)
[13:06:39.457] Timer tick, asking Buildbucket for the build status
[13:06:39.553] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:39.553] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:99:0) after 1m0s
[13:07:39.630] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:99:0)
[13:07:39.630] Timer tick, asking Buildbucket for the build status
[13:07:39.735] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:39.735] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:100:0) after 1m0s
[13:08:39.843] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:100:0)
[13:08:39.843] Timer tick, asking Buildbucket for the build status
[13:08:39.909] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:39.909] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:101:0) after 1m0s
[13:09:39.946] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:101:0)
[13:09:39.946] Timer tick, asking Buildbucket for the build status
[13:09:40.010] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:40.010] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:102:0) after 1m0s
[13:10:40.046] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:102:0)
[13:10:40.046] Timer tick, asking Buildbucket for the build status
[13:10:40.141] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:40.141] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:103:0) after 1m0s
[13:11:40.187] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:103:0)
[13:11:40.187] Timer tick, asking Buildbucket for the build status
[13:11:40.465] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:40.465] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:104:0) after 1m0s
[13:12:40.460] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:104:0)
[13:12:40.460] Timer tick, asking Buildbucket for the build status
[13:12:40.517] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:40.517] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:105:0) after 1m0s
[13:13:40.604] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:105:0)
[13:13:40.604] Timer tick, asking Buildbucket for the build status
[13:13:40.731] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:40.731] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:106:0) after 1m0s
[13:14:40.917] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:106:0)
[13:14:40.917] Timer tick, asking Buildbucket for the build status
[13:14:40.969] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:40.969] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:107:0) after 1m0s
[13:15:41.051] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:107:0)
[13:15:41.051] Timer tick, asking Buildbucket for the build status
[13:15:41.164] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:41.164] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:108:0) after 1m0s
[13:16:41.233] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:108:0)
[13:16:41.233] Timer tick, asking Buildbucket for the build status
[13:16:41.547] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:41.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:109:0) after 1m0s
[13:17:41.623] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:109:0)
[13:17:41.623] Timer tick, asking Buildbucket for the build status
[13:17:41.717] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:41.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:110:0) after 1m0s
[13:18:41.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:110:0)
[13:18:41.711] Timer tick, asking Buildbucket for the build status
[13:18:41.782] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:41.782] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:111:0) after 1m0s
[13:19:41.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:111:0)
[13:19:41.971] Timer tick, asking Buildbucket for the build status
[13:19:42.044] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:42.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:112:0) after 1m0s
[13:20:42.202] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:112:0)
[13:20:42.202] Timer tick, asking Buildbucket for the build status
[13:20:42.595] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:42.595] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:113:0) after 1m0s
[13:21:44.297] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:113:0)
[13:21:44.297] Timer tick, asking Buildbucket for the build status
[13:21:44.413] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:44.413] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:114:0) after 1m0s
[13:22:44.504] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:114:0)
[13:22:44.504] Timer tick, asking Buildbucket for the build status
[13:22:44.694] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:44.694] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:115:0) after 1m0s
[13:23:44.716] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:115:0)
[13:23:44.716] Timer tick, asking Buildbucket for the build status
[13:23:44.857] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:44.857] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:116:0) after 1m0s
[13:24:44.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:116:0)
[13:24:44.878] Timer tick, asking Buildbucket for the build status
[13:24:45.042] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:45.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:117:0) after 1m0s
[13:25:45.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:117:0)
[13:25:45.067] Timer tick, asking Buildbucket for the build status
[13:25:45.177] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:45.177] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:118:0) after 1m0s
[13:26:45.290] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:118:0)
[13:26:45.290] Timer tick, asking Buildbucket for the build status
[13:26:45.638] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:45.638] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:119:0) after 1m0s
[13:27:45.700] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:119:0)
[13:27:45.700] Timer tick, asking Buildbucket for the build status
[13:27:45.825] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:45.825] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:120:0) after 1m0s
[13:28:45.883] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:120:0)
[13:28:45.883] Timer tick, asking Buildbucket for the build status
[13:28:46.002] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:46.002] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:121:0) after 1m0s
[13:29:46.041] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:121:0)
[13:29:46.041] Timer tick, asking Buildbucket for the build status
[13:29:46.108] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:46.108] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:122:0) after 1m0s
[13:30:46.158] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:122:0)
[13:30:46.158] Timer tick, asking Buildbucket for the build status
[13:30:46.262] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:46.262] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:123:0) after 1m0s
[13:31:46.368] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:123:0)
[13:31:46.368] Timer tick, asking Buildbucket for the build status
[13:31:46.452] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:46.452] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:124:0) after 1m0s
[13:32:46.500] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:124:0)
[13:32:46.500] Timer tick, asking Buildbucket for the build status
[13:32:46.723] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:46.723] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:125:0) after 1m0s
[13:33:46.796] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:125:0)
[13:33:46.796] Timer tick, asking Buildbucket for the build status
[13:33:47.031] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:47.031] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:126:0) after 1m0s
[13:34:47.082] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:126:0)
[13:34:47.082] Timer tick, asking Buildbucket for the build status
[13:34:47.499] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:47.499] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:127:0) after 1m0s
[13:35:47.472] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:127:0)
[13:35:47.472] Timer tick, asking Buildbucket for the build status
[13:35:47.610] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:47.610] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:128:0) after 1m0s
[13:36:47.610] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:128:0)
[13:36:47.610] Timer tick, asking Buildbucket for the build status
[13:36:47.686] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:47.686] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:129:0) after 1m0s
[13:37:47.709] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:129:0)
[13:37:47.709] Timer tick, asking Buildbucket for the build status
[13:37:47.878] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:47.878] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:130:0) after 1m0s
[13:38:47.913] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:130:0)
[13:38:47.913] Timer tick, asking Buildbucket for the build status
[13:38:48.024] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:48.024] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:131:0) after 1m0s
[13:39:48.047] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:131:0)
[13:39:48.047] Timer tick, asking Buildbucket for the build status
[13:39:48.118] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:48.118] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:132:0) after 1m0s
[13:40:48.141] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:132:0)
[13:40:48.141] Timer tick, asking Buildbucket for the build status
[13:40:48.241] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:48.241] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:133:0) after 1m0s
[13:41:48.290] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:133:0)
[13:41:48.290] Timer tick, asking Buildbucket for the build status
[13:41:48.415] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:48.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:134:0) after 1m0s
[13:42:48.459] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:134:0)
[13:42:48.459] Timer tick, asking Buildbucket for the build status
[13:42:48.664] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:48.664] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:135:0) after 1m0s
[13:43:49.001] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:135:0)
[13:43:49.001] Timer tick, asking Buildbucket for the build status
[13:43:49.163] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:49.163] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:136:0) after 1m0s
[13:44:49.352] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:136:0)
[13:44:49.352] Timer tick, asking Buildbucket for the build status
[13:44:49.507] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:49.507] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:137:0) after 1m0s
[13:45:49.589] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:137:0)
[13:45:49.589] Timer tick, asking Buildbucket for the build status
[13:45:49.711] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:49.711] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:138:0) after 1m0s
[13:46:49.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:138:0)
[13:46:49.792] Timer tick, asking Buildbucket for the build status
[13:46:49.870] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:49.870] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:139:0) after 1m0s
[13:47:49.889] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:139:0)
[13:47:49.889] Timer tick, asking Buildbucket for the build status
[13:47:49.967] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:49.967] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:140:0) after 1m0s
[13:48:50.046] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:140:0)
[13:48:50.046] Timer tick, asking Buildbucket for the build status
[13:48:50.102] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:50.102] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:141:0) after 1m0s
[13:49:50.395] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:141:0)
[13:49:50.395] Timer tick, asking Buildbucket for the build status
[13:49:50.479] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:50.479] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:142:0) after 1m0s
[13:50:50.578] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:142:0)
[13:50:50.579] Timer tick, asking Buildbucket for the build status
[13:50:51.022] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:51.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:143:0) after 1m0s
[13:51:51.224] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:143:0)
[13:51:51.224] Timer tick, asking Buildbucket for the build status
[13:51:51.301] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:51.301] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:144:0) after 1m0s
[13:52:51.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:144:0)
[13:52:51.402] Timer tick, asking Buildbucket for the build status
[13:52:51.462] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:51.462] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:145:0) after 1m0s
[13:53:51.518] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:145:0)
[13:53:51.518] Timer tick, asking Buildbucket for the build status
[13:53:51.586] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:51.586] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:146:0) after 1m0s
[13:54:51.597] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:146:0)
[13:54:51.597] Timer tick, asking Buildbucket for the build status
[13:54:51.714] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:51.714] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:147:0) after 1m0s
[13:55:51.773] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:147:0)
[13:55:51.773] Timer tick, asking Buildbucket for the build status
[13:55:51.875] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:51.876] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:148:0) after 1m0s
[13:56:51.964] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:148:0)
[13:56:51.964] Timer tick, asking Buildbucket for the build status
[13:56:52.036] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:52.036] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:149:0) after 1m0s
[13:57:52.066] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:149:0)
[13:57:52.066] Timer tick, asking Buildbucket for the build status
[13:57:52.192] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:52.192] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:150:0) after 1m0s
[13:58:52.183] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:150:0)
[13:58:52.183] Timer tick, asking Buildbucket for the build status
[13:58:52.257] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:52.257] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:151:0) after 1m0s
[13:59:52.352] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:151:0)
[13:59:52.352] Timer tick, asking Buildbucket for the build status
[13:59:52.410] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:52.410] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:152:0) after 1m0s
[14:00:52.488] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:152:0)
[14:00:52.488] Timer tick, asking Buildbucket for the build status
[14:00:52.618] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:52.618] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:153:0) after 1m0s
[14:01:52.597] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:153:0)
[14:01:52.597] Timer tick, asking Buildbucket for the build status
[14:01:52.747] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:52.747] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:154:0) after 1m0s
[14:02:52.770] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:154:0)
[14:02:52.770] Timer tick, asking Buildbucket for the build status
[14:02:52.844] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:52.844] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:155:0) after 1m0s
[14:03:53.223] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:155:0)
[14:03:53.223] Timer tick, asking Buildbucket for the build status
[14:03:53.286] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:53.286] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:156:0) after 1m0s
[14:04:53.326] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:156:0)
[14:04:53.326] Timer tick, asking Buildbucket for the build status
[14:04:53.400] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:53.400] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:157:0) after 1m0s
[14:05:53.401] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:157:0)
[14:05:53.401] Timer tick, asking Buildbucket for the build status
[14:05:53.556] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:53.556] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:158:0) after 1m0s
[14:06:53.582] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:158:0)
[14:06:53.582] Timer tick, asking Buildbucket for the build status
[14:06:53.643] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:53.643] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:159:0) after 1m0s
[14:07:53.699] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:159:0)
[14:07:53.699] Timer tick, asking Buildbucket for the build status
[14:07:53.777] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:53.777] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:160:0) after 1m0s
[14:08:53.801] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:160:0)
[14:08:53.801] Timer tick, asking Buildbucket for the build status
[14:08:54.287] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:54.287] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:161:0) after 1m0s
[14:09:54.390] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:161:0)
[14:09:54.390] Timer tick, asking Buildbucket for the build status
[14:09:54.494] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:54.494] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:162:0) after 1m0s
[14:10:54.560] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:162:0)
[14:10:54.560] Timer tick, asking Buildbucket for the build status
[14:10:54.662] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:54.662] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:163:0) after 1m0s
[14:11:54.749] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:163:0)
[14:11:54.749] Timer tick, asking Buildbucket for the build status
[14:11:55.200] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:55.200] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:164:0) after 1m0s
[14:12:55.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:164:0)
[14:12:55.238] Timer tick, asking Buildbucket for the build status
[14:12:55.304] Build 8857226265008112560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:55.304] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022656327495772400:165:0) after 1m0s
[14:13:13.785] Received PubSub notification, asking Buildbucket for the build status
[14:13:13.857] Build 8857226265008112560: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:13:13.857] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611497591981536",
"created_by": "project:chromium",
"created_ts": "1611487818670427",
"id": "8857226265008112560",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4c64daca250d28a919fbced435f24367f5c01115\"}}",
"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\": \"4c64daca250d28a919fbced435f24367f5c01115\", \"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-10-jn47\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22323, \"got_angle_revision\": \"3c3b82abcf0a5c18b4d97ae49726045ce6d3b832\", \"got_dawn_revision\": \"f1f8394de04ea9532de763dfb2f968fc9610683b\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"4c64daca250d28a919fbced435f24367f5c01115\", \"got_revision_cp\": \"refs/heads/master@{#846577}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"413f7cb17c77c95e4cc3ba141f3c0f049ac2ecb2\", \"got_v8_revision\": \"f2b2f28304b332e59226ee6c0688307ed9982884\", \"got_v8_revision_cp\": \"refs/heads/9.0.57@{#1}\", \"got_webrtc_revision\": \"90776cb0ef72d437983c8d29e5a7f2ac264c107d\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33064}\", \"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\": \"4c64daca250d28a919fbced435f24367f5c01115\", \"swarm_hashes_refs/heads/master(at){#846577}_without_patch\": {\"absl_hardening_tests\": \"a3bd4b078a9f594562a4f2c6252dbdce7dbaf521\", \"accessibility_unittests\": \"f6221dc04ceea61f2962214e6b2298086b54b641\", \"angle_unittests\": \"b115aa65c3d018216f882663c23552155eaa230a\", \"app_list_unittests\": \"6327f3c63deb77714586af071bc608351d69c477\", \"app_shell_unittests\": \"11bf63de73245be28e60600aa079ad78d660d8e7\", \"ash_unittests\": \"9fe1aaec432bb903955e62e46e0886d72bdc99e7\", \"aura_unittests\": \"c30c14e03e0de8dc82776e87b68d5476b30aba19\", \"base_unittests\": \"5d89cf795c3193c3368e1bab3719cfe8f5928140\", \"base_util_unittests\": \"12dae3edfad4eb2a751d11c33684e3f9711ddca6\", \"blink_common_unittests\": \"7e6b7ac28539795d7c2b24cbc587540cead9bde9\", \"blink_fuzzer_unittests\": \"e443c3826560255284ba2a7e38be334e462d3dba\", \"blink_heap_unittests\": \"c779ea88dee7d76d4d8d4a135e69b71aedfaf711\", \"blink_platform_unittests\": \"7b98513e49463fee46d59a9350d1841f1499c103\", \"blink_unittests\": \"4349628f6ecb47e69d7ce5df91e1764be13abe45\", \"boringssl_crypto_tests\": \"d18498d5161a89821f60049f177d17a189f1ac1c\", \"boringssl_ssl_tests\": \"203b25c35171c125cfbc18c61936df84ba20b908\", \"browser_tests\": \"4cd310bc680fdedda4d53daa4db0b30f7ec456f7\", \"capture_unittests\": \"ffab0c22b8ea1d4aa58c9124a3fca9aaa31cc25c\", \"cast_unittests\": \"4a425b12848363725ed6c1109be31d689956ff24\", \"cc_unittests\": \"ae34d27e33de2bb9ebcbf644e2ef4f164592fb02\", \"chrome_app_unittests\": \"985d022d4a7f17afb5db04740442adc40da1dc64\", \"chromedriver_unittests\": \"e7c1ef27807d25ea5d00f3dbe4da73d62bdcf1af\", \"chromeos_components_unittests\": \"7d189a27a890e460accd0949c5beaf38b020c09f\", \"chromeos_unittests\": \"a9834a6c3ea5a39191fecb49a964251a9c6b686c\", \"components_browsertests\": \"4672e30bb99fa746b45af891a0c621925f85652d\", \"components_unittests\": \"fb4d2ce48a566111a05c549505c8cb1ce5af21c2\", \"compositor_unittests\": \"52bef0053447bed8c88e8918e346c962f7e699a6\", \"content_browsertests\": \"85d3690264ec76a2d7e607859aff9d3f6c3bb9a3\", \"content_unittests\": \"bf52e2c01236561ffa6f828ea9cd0aa88b476af4\", \"crashpad_tests\": \"d0420808fbffdfeaec058facb56adb0daebf6a3f\", \"crypto_unittests\": \"23e9e54a086c15aaea103dc19c18ac00db0795cb\", \"dbus_unittests\": \"cf80aaaa41d01df8af2b134e3cebe1d3d0d980e8\", \"device_unittests\": \"3460e44593a3ee381d162314a4bb0579c25d1e51\", \"display_unittests\": \"1fe791f83ef4ada65023dc7894f01d0b962089b0\", \"events_unittests\": \"a40c290ce407e172f5cddc7ad9fa951ce229c391\", \"exo_unittests\": \"b5bf0873555c647ba7056bd141b834163a3c0f4d\", \"extensions_browsertests\": \"ed6c545fcb4996c10053b5d5a6f1ed0931ad9256\", \"extensions_unittests\": \"41d3a4df60173c77dee6f35daeee9158b6ea0105\", \"filesystem_service_unittests\": \"b80a984bfcfa470cfc45932e3bc7de9b284172d9\", \"gcm_unit_tests\": \"67ab003fafa205497955b271cec4eb3909df006f\", \"gfx_unittests\": \"ffc254b8a688e021aac1a28da364b23a8151bb97\", \"gin_unittests\": \"c22309d9e0f76160b07aeaa4877cc90b9f9c4869\", \"gl_unittests_ozone\": \"756cdb9d6883361eb42cf11eabd9e9279240c491\", \"google_apis_unittests\": \"ee78507532f278e5c827e1f51cdedf69dda2e3c4\", \"gpu_unittests\": \"a634bcadff50a2bec662f4590cab56deb4c11409\", \"gwp_asan_unittests\": \"33e5463c96ba9d12d5050976a9bde30f38bf0c2f\", \"interactive_ui_tests\": \"a293c31322a468ef11127129ad8a60d798659a00\", \"ipc_tests\": \"caace76828c07d0cfa8ce7c06a9f6265b9d49331\", \"jingle_unittests\": \"b56360f8ea3f8e70c4037ea75362b52b582c9ba4\", \"keyboard_unittests\": \"d45600cb4d9b597fc3ad6c3eec09032ec1499520\", \"latency_unittests\": \"cabb90f00b6fb4455c7485105c5d605bc5b5215f\", \"libjingle_xmpp_unittests\": \"2d44f5307d33f186cea3c89c81ee41955c2fc47a\", \"liburlpattern_unittests\": \"4dcc14172e32b2470af3c1ef92fe8b928f005a83\", \"media_blink_unittests\": \"4031b76fe47376c54a515c8be027047d55df7004\", \"media_unittests\": \"19ac068e5b5dd189bf5e5360588e78a9276a2f4b\", \"message_center_unittests\": \"73fcec02f7b58f87f5658eb3af007766f40799bd\", \"midi_unittests\": \"59d9d04e01f4d13e9818b0e35df99fc1206e73ab\", \"mojo_core_unittests\": \"2d6068938942d1043c61d8a2c1068497a12419ff\", \"mojo_unittests\": \"d3eb3db8f98bf06639d7a7214501f716e2f728ea\", \"nacl_helper_nonsfi_unittests\": \"f3c7be4dfb040885b8dedaf44399517a302df467\", \"nacl_loader_unittests\": \"1a115efc09d449653c7541ce45eb0f466d95b086\", \"native_theme_unittests\": \"5eb595b2e87b604d9e99ffe488db032ed762b4df\", \"net_unittests\": \"f47422dde97533466d11614ce253206571a433b5\", \"ozone_gl_unittests\": \"570c7376936befc035eb2cec451634e2748406d8\", \"ozone_unittests\": \"aebc027e04f22f051747bde76931f2cf02597c21\", \"ozone_x11_unittests\": \"38599bda73c02e03a41bf7343ab0a43e0b092d05\", \"pdf_unittests\": \"fdd2468233591fbc862630c5aa140df7ed05ac63\", \"perfetto_unittests\": \"51f87dd4922912657977133b98ecff9edb228492\", \"ppapi_unittests\": \"7e121d24ba9d5bd2d1945abe664f9d4d16f3fb13\", \"printing_unittests\": \"34745c6067640ea848719339ccbb3e5b86e0a2ac\", \"remoting_unittests\": \"25d75c1a4866c8884d6f8f54222254d443ee1ae0\", \"sandbox_linux_unittests\": \"87fddbcf7184b9e45062242efdf5a1d185f7d271\", \"service_manager_unittests\": \"f97ea74b4fb3807b652a8a38ff80136e73cae716\", \"services_unittests\": \"6dd9a6935bbb24df4d9d8ca871c6ecde1ac5db54\", \"shell_dialogs_unittests\": \"20035cf15ebb6d2ab7b76117d9b78db663c34032\", \"shell_encryption_unittests\": \"97f72235aaeab1f242ae8785ba54f60e6f683d86\", \"skia_unittests\": \"8075dccc5f28e98a03392015b229cc86d8111220\", \"snapshot_unittests\": \"e80b8e37dfa34d3630dd085d4e767ff26b0f881a\", \"sql_unittests\": \"e9b8134b70cb790b78419755f5741a9f15c1e5fa\", \"storage_unittests\": \"2c1fbb7b8776a53f91c3bfa49bffe8908896b6d1\", \"sync_integration_tests\": \"c9d98e5308ebccc201d9c6ec2e208334b15306d9\", \"traffic_annotation_auditor_unittests\": \"b1583a5cd46900bdd6eb56d6dd3a70e1bbff888d\", \"ui_base_unittests\": \"8e2cf022e6b916b0e95564d9c475a440165eaf86\", \"ui_chromeos_unittests\": \"f2e1ec50cbbab614d0dc1f70521626e875ef60d0\", \"ui_touch_selection_unittests\": \"5b857cd1b30fb1152b587fa42a4f1666a4dd8e20\", \"unit_tests\": \"9bcba8f76257c61db7679b96994143fb8f46fb57\", \"url_unittests\": \"57d1481c20b737ba4027526b833052f0c84c3aa9\", \"usage_time_limit_unittests\": \"ac2a9500c9568098f93af80e23a5a29ad935706c\", \"views_unittests\": \"293b2e893843d58a99b858fd0f01d62bb1b19a08\", \"viz_unittests\": \"352c9a7e0ad05e928db18e28f351c1db09a208b8\", \"wm_unittests\": \"541ce637a9a45b8b488cebf94180b9dd05c39220\", \"wtf_unittests\": \"53d7311a3abb72a43db1571fdfda5ec5f27abf37\", \"zlib_unittests\": \"3a4b441cf295279b23fd9b4be9dec5a39012eb65\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1cac3a12be5110575bfda3df59662d0c101b80b5d04053a56e3716a56e114d29_v2\", \"builder_40238b720ec4feb1f57c327a3b72021d0e440ababc8fca32fd370c36be82ffcf_v2\", \"builder_53a0dbabd2cebac1b8e64bcbfab336eb0021d1dc40b2d4ba5321eb0a070d508c_v2\", \"builder_9f02bd2de6eac19c457931accbc0b1e66d92a355209524fd30dfc8de3911a1f0_v2\", \"builder_a27b44a1648dd298adda85735042ac3d0ffdcfd6d22ed3e792b03614ce2ee968_v2\", \"builder_dacf669b49e3ec352df995227b58e62a545590985cca62e76e0831f920af4ccd_v2\", \"builder_ebb06fb409ef3255b3561ad6bc0df7706a15849e85ba50b708bdfb917530d411_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-10-jn47\"], \"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": "1611490727699703",
"status": "COMPLETED",
"status_changed_ts": "1611497592638856",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22323",
"builder:linux-chromeos-dbg",
"buildset:commit/git/4c64daca250d28a919fbced435f24367f5c01115",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4c64daca250d28a919fbced435f24367f5c01115",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022656327495772400",
"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/8857226265008112560/+/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:514cfa3ff752df10",
"user_agent:luci-scheduler"
],
"updated_ts": "1611497592684369",
"url": "https://ci.chromium.org/b/8857226265008112560",
"utcnow_ts": "1611497593848800"
}
}
[14:13:13.857] Invocation finished in 2h42m56.943210568s with status SUCCEEDED