[15:02:43.395] New invocation is queued and will start shortly
[15:02:44.819] Starting the invocation (attempt 1)
[15:02:44.871] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:02:44.871] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:02:44.871] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029800122209005696",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"42dafa576390d0bf2e52f60cafbb1fd61c8e6f3a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9029800122209005696",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/42dafa576390d0bf2e52f60cafbb1fd61c8e6f3a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/42dafa576390d0bf2e52f60cafbb1fd61c8e6f3a",
"gitiles_ref:refs/heads/master"
]
}
[15:02:45.748] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604674964990085",
"id": "8864370059869244560",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"42dafa576390d0bf2e52f60cafbb1fd61c8e6f3a\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604674965496913",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21179",
"builder:linux-chromeos-dbg",
"buildset:commit/git/42dafa576390d0bf2e52f60cafbb1fd61c8e6f3a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/42dafa576390d0bf2e52f60cafbb1fd61c8e6f3a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029800122209005696",
"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/8864370059869244560/+/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": "1604674965497080",
"url": "https://ci.chromium.org/b/8864370059869244560",
"utcnow_ts": "1604674965728892"
}
}
[15:02:45.748] Task URL: https://ci.chromium.org/b/8864370059869244560
[15:02:45.748] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:2:0) after 1m0s
[15:03:00.224] Received PubSub notification, asking Buildbucket for the build status
[15:03:00.409] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:45.865] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:2:0)
[15:03:45.865] Timer tick, asking Buildbucket for the build status
[15:03:45.980] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:45.980] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:4:0) after 1m0s
[15:04:46.053] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:4:0)
[15:04:46.053] Timer tick, asking Buildbucket for the build status
[15:04:46.130] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:46.130] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:5:0) after 1m0s
[15:05:46.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:5:0)
[15:05:46.222] Timer tick, asking Buildbucket for the build status
[15:05:46.651] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:46.651] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:6:0) after 1m0s
[15:06:46.751] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:6:0)
[15:06:46.751] Timer tick, asking Buildbucket for the build status
[15:06:46.875] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:46.875] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:7:0) after 1m0s
[15:07:47.155] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:7:0)
[15:07:47.155] Timer tick, asking Buildbucket for the build status
[15:07:47.235] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:47.235] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:8:0) after 1m0s
[15:08:47.306] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:8:0)
[15:08:47.306] Timer tick, asking Buildbucket for the build status
[15:08:47.875] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:47.875] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:9:0) after 1m0s
[15:09:48.011] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:9:0)
[15:09:48.011] Timer tick, asking Buildbucket for the build status
[15:09:48.238] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:48.238] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:10:0) after 1m0s
[15:10:48.309] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:10:0)
[15:10:48.309] Timer tick, asking Buildbucket for the build status
[15:10:48.384] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:48.384] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:11:0) after 1m0s
[15:11:48.511] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:11:0)
[15:11:48.511] Timer tick, asking Buildbucket for the build status
[15:11:48.670] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:48.670] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:12:0) after 1m0s
[15:12:48.738] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:12:0)
[15:12:48.738] Timer tick, asking Buildbucket for the build status
[15:12:48.924] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:48.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:13:0) after 1m0s
[15:13:48.955] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:13:0)
[15:13:48.955] Timer tick, asking Buildbucket for the build status
[15:13:49.203] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:49.203] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:14:0) after 1m0s
[15:14:49.301] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:14:0)
[15:14:49.301] Timer tick, asking Buildbucket for the build status
[15:14:49.404] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:49.404] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:15:0) after 1m0s
[15:15:49.488] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:15:0)
[15:15:49.488] Timer tick, asking Buildbucket for the build status
[15:15:49.575] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:49.575] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:16:0) after 1m0s
[15:16:49.666] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:16:0)
[15:16:49.666] Timer tick, asking Buildbucket for the build status
[15:16:49.735] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:49.735] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:17:0) after 1m0s
[15:17:49.771] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:17:0)
[15:17:49.771] Timer tick, asking Buildbucket for the build status
[15:17:49.903] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:49.903] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:18:0) after 1m0s
[15:18:49.947] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:18:0)
[15:18:49.947] Timer tick, asking Buildbucket for the build status
[15:18:50.186] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:50.186] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:19:0) after 1m0s
[15:19:50.472] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:19:0)
[15:19:50.472] Timer tick, asking Buildbucket for the build status
[15:19:50.562] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:50.562] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:20:0) after 1m0s
[15:20:50.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:20:0)
[15:20:50.613] Timer tick, asking Buildbucket for the build status
[15:20:50.677] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:50.677] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:21:0) after 1m0s
[15:21:50.804] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:21:0)
[15:21:50.804] Timer tick, asking Buildbucket for the build status
[15:21:50.872] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:50.872] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:22:0) after 1m0s
[15:22:51.076] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:22:0)
[15:22:51.076] Timer tick, asking Buildbucket for the build status
[15:22:51.205] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:51.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:23:0) after 1m0s
[15:23:51.352] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:23:0)
[15:23:51.352] Timer tick, asking Buildbucket for the build status
[15:23:51.715] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:51.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:24:0) after 1m0s
[15:24:51.723] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:24:0)
[15:24:51.723] Timer tick, asking Buildbucket for the build status
[15:24:51.788] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:51.788] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:25:0) after 1m0s
[15:25:51.862] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:25:0)
[15:25:51.862] Timer tick, asking Buildbucket for the build status
[15:25:51.936] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:51.936] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:26:0) after 1m0s
[15:26:52.077] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:26:0)
[15:26:52.077] Timer tick, asking Buildbucket for the build status
[15:26:52.165] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:52.165] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:27:0) after 1m0s
[15:27:52.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:27:0)
[15:27:52.237] Timer tick, asking Buildbucket for the build status
[15:27:52.365] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:52.365] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:28:0) after 1m0s
[15:28:52.569] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:28:0)
[15:28:52.569] Timer tick, asking Buildbucket for the build status
[15:28:52.915] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:52.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:29:0) after 1m0s
[15:29:53.046] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:29:0)
[15:29:53.046] Timer tick, asking Buildbucket for the build status
[15:29:53.132] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:53.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:30:0) after 1m0s
[15:30:53.224] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:30:0)
[15:30:53.224] Timer tick, asking Buildbucket for the build status
[15:30:53.443] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:53.443] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:31:0) after 1m0s
[15:31:53.512] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:31:0)
[15:31:53.512] Timer tick, asking Buildbucket for the build status
[15:31:53.618] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:53.618] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:32:0) after 1m0s
[15:32:53.809] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:32:0)
[15:32:53.809] Timer tick, asking Buildbucket for the build status
[15:32:54.219] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:54.219] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:33:0) after 1m0s
[15:33:54.330] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:33:0)
[15:33:54.330] Timer tick, asking Buildbucket for the build status
[15:33:54.393] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:54.393] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:34:0) after 1m0s
[15:34:54.518] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:34:0)
[15:34:54.518] Timer tick, asking Buildbucket for the build status
[15:34:55.176] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:55.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:35:0) after 1m0s
[15:35:55.582] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:35:0)
[15:35:55.582] Timer tick, asking Buildbucket for the build status
[15:35:55.973] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:55.973] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:36:0) after 1m0s
[15:36:56.028] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:36:0)
[15:36:56.028] Timer tick, asking Buildbucket for the build status
[15:36:56.393] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:56.393] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:37:0) after 1m0s
[15:37:56.449] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:37:0)
[15:37:56.449] Timer tick, asking Buildbucket for the build status
[15:37:56.805] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:56.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:38:0) after 1m0s
[15:38:56.856] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:38:0)
[15:38:56.856] Timer tick, asking Buildbucket for the build status
[15:38:57.004] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:57.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:39:0) after 1m0s
[15:39:57.408] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:39:0)
[15:39:57.408] Timer tick, asking Buildbucket for the build status
[15:39:57.520] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:57.520] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:40:0) after 1m0s
[15:40:57.687] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:40:0)
[15:40:57.687] Timer tick, asking Buildbucket for the build status
[15:40:57.890] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:57.890] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:41:0) after 1m0s
[15:41:58.072] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:41:0)
[15:41:58.072] Timer tick, asking Buildbucket for the build status
[15:41:58.142] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:58.142] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:42:0) after 1m0s
[15:42:58.445] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:42:0)
[15:42:58.445] Timer tick, asking Buildbucket for the build status
[15:42:58.592] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:58.592] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:43:0) after 1m0s
[15:43:58.776] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:43:0)
[15:43:58.776] Timer tick, asking Buildbucket for the build status
[15:43:58.886] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:58.886] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:44:0) after 1m0s
[15:44:58.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:44:0)
[15:44:58.983] Timer tick, asking Buildbucket for the build status
[15:44:59.117] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:59.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:45:0) after 1m0s
[15:45:59.214] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:45:0)
[15:45:59.214] Timer tick, asking Buildbucket for the build status
[15:45:59.283] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:59.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:46:0) after 1m0s
[15:46:59.523] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:46:0)
[15:46:59.523] Timer tick, asking Buildbucket for the build status
[15:46:59.605] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:59.605] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:47:0) after 1m0s
[15:47:59.744] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:47:0)
[15:47:59.744] Timer tick, asking Buildbucket for the build status
[15:48:00.346] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:00.346] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:48:0) after 1m0s
[15:49:00.507] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:48:0)
[15:49:00.507] Timer tick, asking Buildbucket for the build status
[15:49:00.615] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:00.615] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:49:0) after 1m0s
[15:50:00.732] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:49:0)
[15:50:00.732] Timer tick, asking Buildbucket for the build status
[15:50:00.858] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:00.858] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:50:0) after 1m0s
[15:51:02.432] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:50:0)
[15:51:02.432] Timer tick, asking Buildbucket for the build status
[15:51:02.832] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:02.832] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:51:0) after 1m0s
[15:52:02.876] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:51:0)
[15:52:02.876] Timer tick, asking Buildbucket for the build status
[15:52:03.152] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:03.152] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:52:0) after 1m0s
[15:53:03.196] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:52:0)
[15:53:03.196] Timer tick, asking Buildbucket for the build status
[15:53:03.374] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:03.374] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:53:0) after 1m0s
[15:54:03.381] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:53:0)
[15:54:03.381] Timer tick, asking Buildbucket for the build status
[15:54:03.528] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:03.528] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:54:0) after 1m0s
[15:55:03.578] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:54:0)
[15:55:03.578] Timer tick, asking Buildbucket for the build status
[15:55:03.774] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:03.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:55:0) after 1m0s
[15:56:03.872] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:55:0)
[15:56:03.872] Timer tick, asking Buildbucket for the build status
[15:56:03.955] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:03.955] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:56:0) after 1m0s
[15:57:04.221] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:56:0)
[15:57:04.221] Timer tick, asking Buildbucket for the build status
[15:57:05.167] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:05.167] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:57:0) after 1m0s
[15:58:05.322] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:57:0)
[15:58:05.322] Timer tick, asking Buildbucket for the build status
[15:58:06.097] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:06.097] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:58:0) after 1m0s
[15:59:06.191] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:58:0)
[15:59:06.191] Timer tick, asking Buildbucket for the build status
[15:59:06.610] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:06.610] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:59:0) after 1m0s
[16:00:06.727] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:59:0)
[16:00:06.727] Timer tick, asking Buildbucket for the build status
[16:00:07.126] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:07.126] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:60:0) after 1m0s
[16:01:07.417] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:60:0)
[16:01:07.417] Timer tick, asking Buildbucket for the build status
[16:01:07.591] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:07.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:61:0) after 1m0s
[16:02:07.674] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:61:0)
[16:02:07.674] Timer tick, asking Buildbucket for the build status
[16:02:07.859] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:07.859] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:62:0) after 1m0s
[16:03:08.146] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:62:0)
[16:03:08.146] Timer tick, asking Buildbucket for the build status
[16:03:08.269] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:08.269] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:63:0) after 1m0s
[16:04:08.317] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:63:0)
[16:04:08.317] Timer tick, asking Buildbucket for the build status
[16:04:08.401] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:08.401] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:64:0) after 1m0s
[16:05:08.455] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:64:0)
[16:05:08.455] Timer tick, asking Buildbucket for the build status
[16:05:09.152] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:09.152] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:65:0) after 1m0s
[16:06:09.178] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:65:0)
[16:06:09.178] Timer tick, asking Buildbucket for the build status
[16:06:09.324] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:09.324] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:66:0) after 1m0s
[16:07:09.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:66:0)
[16:07:09.467] Timer tick, asking Buildbucket for the build status
[16:07:09.986] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:09.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:67:0) after 1m0s
[16:08:10.068] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:67:0)
[16:08:10.068] Timer tick, asking Buildbucket for the build status
[16:08:10.215] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:10.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:68:0) after 1m0s
[16:09:10.324] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:68:0)
[16:09:10.324] Timer tick, asking Buildbucket for the build status
[16:09:10.566] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:10.566] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:69:0) after 1m0s
[16:10:10.676] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:69:0)
[16:10:10.676] Timer tick, asking Buildbucket for the build status
[16:10:11.291] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:11.291] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:70:0) after 1m0s
[16:11:11.285] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:70:0)
[16:11:11.285] Timer tick, asking Buildbucket for the build status
[16:11:11.417] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:11.417] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:71:0) after 1m0s
[16:12:12.353] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:71:0)
[16:12:12.353] Timer tick, asking Buildbucket for the build status
[16:12:12.432] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:12.432] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:72:0) after 1m0s
[16:13:12.656] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:72:0)
[16:13:12.656] Timer tick, asking Buildbucket for the build status
[16:13:13.158] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:13.158] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:73:0) after 1m0s
[16:14:13.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:73:0)
[16:14:13.454] Timer tick, asking Buildbucket for the build status
[16:14:13.603] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:13.603] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:74:0) after 1m0s
[16:15:13.726] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:74:0)
[16:15:13.726] Timer tick, asking Buildbucket for the build status
[16:15:13.813] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:13.813] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:75:0) after 1m0s
[16:16:13.964] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:75:0)
[16:16:13.964] Timer tick, asking Buildbucket for the build status
[16:16:14.163] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:14.163] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:76:0) after 1m0s
[16:17:14.187] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:76:0)
[16:17:14.187] Timer tick, asking Buildbucket for the build status
[16:17:14.389] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:14.389] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:77:0) after 1m0s
[16:18:14.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:77:0)
[16:18:14.506] Timer tick, asking Buildbucket for the build status
[16:18:14.640] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:14.640] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:78:0) after 1m0s
[16:19:14.758] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:78:0)
[16:19:14.758] Timer tick, asking Buildbucket for the build status
[16:19:14.872] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:14.872] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:79:0) after 1m0s
[16:20:14.945] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:79:0)
[16:20:14.945] Timer tick, asking Buildbucket for the build status
[16:20:15.105] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:15.105] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:80:0) after 1m0s
[16:21:15.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:80:0)
[16:21:15.117] Timer tick, asking Buildbucket for the build status
[16:21:15.205] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:15.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:81:0) after 1m0s
[16:22:15.261] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:81:0)
[16:22:15.261] Timer tick, asking Buildbucket for the build status
[16:22:15.498] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:15.498] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:82:0) after 1m0s
[16:23:15.660] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:82:0)
[16:23:15.660] Timer tick, asking Buildbucket for the build status
[16:23:16.087] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:16.087] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:83:0) after 1m0s
[16:24:16.157] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:83:0)
[16:24:16.157] Timer tick, asking Buildbucket for the build status
[16:24:16.718] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:16.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:84:0) after 1m0s
[16:25:16.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:84:0)
[16:25:16.882] Timer tick, asking Buildbucket for the build status
[16:25:17.058] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:17.058] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:85:0) after 1m0s
[16:26:17.157] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:85:0)
[16:26:17.157] Timer tick, asking Buildbucket for the build status
[16:26:17.247] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:17.247] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:86:0) after 1m0s
[16:27:17.377] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:86:0)
[16:27:17.377] Timer tick, asking Buildbucket for the build status
[16:27:17.457] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:17.457] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:87:0) after 1m0s
[16:28:17.482] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:87:0)
[16:28:17.482] Timer tick, asking Buildbucket for the build status
[16:28:17.578] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:17.578] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:88:0) after 1m0s
[16:29:17.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:88:0)
[16:29:17.615] Timer tick, asking Buildbucket for the build status
[16:29:17.886] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:17.886] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:89:0) after 1m0s
[16:30:17.942] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:89:0)
[16:30:17.942] Timer tick, asking Buildbucket for the build status
[16:30:18.084] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:18.084] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:90:0) after 1m0s
[16:31:18.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:90:0)
[16:31:18.117] Timer tick, asking Buildbucket for the build status
[16:31:18.193] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:18.193] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:91:0) after 1m0s
[16:32:18.389] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:91:0)
[16:32:18.389] Timer tick, asking Buildbucket for the build status
[16:32:18.665] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:18.665] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:92:0) after 1m0s
[16:33:19.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:92:0)
[16:33:19.314] Timer tick, asking Buildbucket for the build status
[16:33:19.460] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:19.460] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:93:0) after 1m0s
[16:34:19.629] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:93:0)
[16:34:19.629] Timer tick, asking Buildbucket for the build status
[16:34:20.199] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:20.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:94:0) after 1m0s
[16:35:20.258] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:94:0)
[16:35:20.258] Timer tick, asking Buildbucket for the build status
[16:35:20.466] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:20.466] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:95:0) after 1m0s
[16:36:20.793] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:95:0)
[16:36:20.793] Timer tick, asking Buildbucket for the build status
[16:36:20.867] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:20.867] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:96:0) after 1m0s
[16:37:21.267] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:96:0)
[16:37:21.267] Timer tick, asking Buildbucket for the build status
[16:37:21.446] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:21.446] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:97:0) after 1m0s
[16:38:21.776] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:97:0)
[16:38:21.776] Timer tick, asking Buildbucket for the build status
[16:38:21.916] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:21.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:98:0) after 1m0s
[16:39:22.016] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:98:0)
[16:39:22.016] Timer tick, asking Buildbucket for the build status
[16:39:22.118] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:22.118] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:99:0) after 1m0s
[16:40:22.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:99:0)
[16:40:22.236] Timer tick, asking Buildbucket for the build status
[16:40:22.319] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:22.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:100:0) after 1m0s
[16:41:22.469] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:100:0)
[16:41:22.469] Timer tick, asking Buildbucket for the build status
[16:41:22.593] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:22.593] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:101:0) after 1m0s
[16:42:22.594] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:101:0)
[16:42:22.594] Timer tick, asking Buildbucket for the build status
[16:42:22.828] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:22.828] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:102:0) after 1m0s
[16:43:22.894] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:102:0)
[16:43:22.894] Timer tick, asking Buildbucket for the build status
[16:43:23.048] Build 8864370059869244560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:23.048] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9029800122209005696:103:0) after 1m0s
[16:44:08.989] Received PubSub notification, asking Buildbucket for the build status
[16:44:09.059] Build 8864370059869244560: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:44:09.059] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604681047519784",
"created_by": "project:chromium",
"created_ts": "1604674964990085",
"id": "8864370059869244560",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"42dafa576390d0bf2e52f60cafbb1fd61c8e6f3a\"}}",
"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\": \"42dafa576390d0bf2e52f60cafbb1fd61c8e6f3a\", \"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-203-bxm2\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21179, \"got_angle_revision\": \"0781b693fa2d29680c5620a4c73de158eab05f7b\", \"got_dawn_revision\": \"973d145df8656f81ee3c4f99a3e9a0222ec2c826\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"42dafa576390d0bf2e52f60cafbb1fd61c8e6f3a\", \"got_revision_cp\": \"refs/heads/master@{#824864}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"612ded0654a027d64922448f136d125a9dc17956\", \"got_v8_revision\": \"24c7b2d7fd1733d0bea46fdcc20f1b3d032c702b\", \"got_v8_revision_cp\": \"refs/heads/8.8.243@{#1}\", \"got_webrtc_revision\": \"42cafa5696f516712bbe6709fedeedffac61544c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32540}\", \"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\": \"42dafa576390d0bf2e52f60cafbb1fd61c8e6f3a\", \"swarm_hashes_refs/heads/master(at){#824864}_without_patch\": {\"absl_hardening_tests\": \"756fb21bb3727d3c363b2fa0476d448dcb42f7b7\", \"accessibility_unittests\": \"123c7eafb247a2dc8ed65914aef286f18b3d8a77\", \"angle_unittests\": \"b46532705904fe219c31b6ea8459c2755d0c0257\", \"app_list_unittests\": \"98bb22569a0a1344d816615d5c3398aac3a0fd3c\", \"app_shell_unittests\": \"71d9d738989248fe3597eec537da22f0cdbc9a70\", \"ash_unittests\": \"b63fd7bf7b69060fc228cb1e2bed9fab62e58c57\", \"aura_unittests\": \"82f01a626a2fb16dc0610818a4cd8e6351dc20e3\", \"base_unittests\": \"7ad249298b3cf7f0115fe7b8d40791eca5c59b10\", \"base_util_unittests\": \"e53b2e2b53000e81657fa0cda68c45503f3b953f\", \"blink_common_unittests\": \"80b9304d16a56c17d85263bd6efa05039bbcf6af\", \"blink_fuzzer_unittests\": \"36abe02a141c7fb0f2d290f6b7c4f1b1c199a6ae\", \"blink_heap_unittests\": \"60a134602206af5e208f5073778ab8db256193d0\", \"blink_platform_unittests\": \"2b1fb98ff47eef291b547ac984a8ba92dbf34075\", \"blink_unittests\": \"cb5faa1dff351ffc70ad4398bf645a8b94b5127e\", \"boringssl_crypto_tests\": \"7247674c6ddf95f2420cfccb0f38f60755d7c80f\", \"boringssl_ssl_tests\": \"8a4081eeb4c7032e11f03b55505bb6acf9cd40f4\", \"browser_tests\": \"314f511a6db96d3ccab112789075f168b7b9c15b\", \"capture_unittests\": \"7e8e2fcf8880a60d04ef152aeec193e46230daad\", \"cast_unittests\": \"bf37ff038da4a1acdacb59d8a0a234f5c7b4c065\", \"cc_unittests\": \"5ff13ea1a2e9a67334e2a9e46b2e8370ab05ecfb\", \"chrome_app_unittests\": \"3d6dfc66d9b99b9946453971f70d8a116099418b\", \"chromedriver_unittests\": \"a3b6f11d427c1aa4009fa29deb77f98874eed67f\", \"chromeos_components_unittests\": \"ef82624114ca6b284cfd08f73ee1334958c3bcfa\", \"chromeos_unittests\": \"112661b93db3ce544754b07d4db733aea4860079\", \"components_browsertests\": \"af9de3f7337ea79ba19b1a8759c693bfd001b7b7\", \"components_unittests\": \"86adb728c0a01add12a433eb7598736db64281b7\", \"compositor_unittests\": \"9f8e02688a5c86b10ec9d52ef2778fa124c19337\", \"content_browsertests\": \"22177c1619f3768c31b64cd2c93ed8309fe47fb1\", \"content_unittests\": \"05f1641cceed54e4013daf1721c6fbf389f3aeda\", \"crypto_unittests\": \"2d595273725c2785400dd51076aa220141fe23d4\", \"dbus_unittests\": \"f4d1b4ac7974f23c070e29fc76895e938364fc4d\", \"device_unittests\": \"018a443873753c9b2b13fe90d7598d92adf79739\", \"display_unittests\": \"1079e5d3da557439eb455309ce2b7491266a27a5\", \"events_unittests\": \"8e8db52fc0d52468ecc929212c26648aca02914e\", \"exo_unittests\": \"7ec8d8bc0be3a6a770fe8a27c7c26b3185f23d15\", \"extensions_browsertests\": \"b3439c999440d4d1a6739939de93e4789ff0ed8d\", \"extensions_unittests\": \"e923d6a7286032c8438ea5605a7c43ab0fefab48\", \"filesystem_service_unittests\": \"401ff1c17860ca5c5b8166bfc1cdf5242954405d\", \"gcm_unit_tests\": \"c83ba3b591c28e16a28a8afae14c47924a7a27ae\", \"gfx_unittests\": \"c0b126a5310a42e96a8ba28c3c091742ea272399\", \"gin_unittests\": \"24b12e8db51b83c3d884372b6e290e3c05556648\", \"gl_unittests_ozone\": \"7323b1743deec5c41c2b57a177619e35694f11eb\", \"google_apis_unittests\": \"706e17c57464c4e245dd3447ed4870680632dfaa\", \"gpu_unittests\": \"46d8d8b30b52b7c1c1ecc86232100521e00f66ab\", \"gwp_asan_unittests\": \"08bb7a47956822278ac337811ad7f5f578a41dda\", \"interactive_ui_tests\": \"64e374c2dc092f3e0743f2d91a42b8d40e707ee2\", \"ipc_tests\": \"cfd92406610b0843ec4e175d9e3aac91f6a9f717\", \"jingle_unittests\": \"023c2ce82a253e9c889e07c6a1717844498fd1f4\", \"keyboard_unittests\": \"4563b9d5f6ea1a4836a7d6b2c308716ca59e8500\", \"latency_unittests\": \"59a490f1561815f04cdf241606d052841164f6af\", \"libjingle_xmpp_unittests\": \"1e136500104d0e4edd7adbb5500e61ecb7c890e6\", \"liburlpattern_unittests\": \"e593ebb87d6b984f163c670d635379f6e93295a0\", \"media_blink_unittests\": \"2f72439b9a2367469ee75866d44cad985574adaf\", \"media_unittests\": \"2e3ac81dbb22dec22d128a1188125a88e1205bac\", \"message_center_unittests\": \"c4657477def9298bc1bd4a6c25130f9c5a8c4b0c\", \"midi_unittests\": \"cb0999d2121e8892fcaa79740abad4918e8202fe\", \"mojo_core_unittests\": \"f909ca35650dcbae98a9814b1dc0d68a8d619d06\", \"mojo_unittests\": \"7c7d11ca3b6585d5a4122f53ecc75502637cc362\", \"nacl_helper_nonsfi_unittests\": \"4139d4b5f73acb4187edbc2523f8eb60e95e959d\", \"nacl_loader_unittests\": \"a235d2bce7d93289461e4032231cf5984e0e6fbe\", \"native_theme_unittests\": \"c798b0f9e93e1ec681f86863959df04f21ef2e8f\", \"net_unittests\": \"3c30518d9329fd5a5590de5d0262968326be0d29\", \"ozone_gl_unittests\": \"73b3c6e5e92ddddee30c11df16c0c1c153198483\", \"ozone_unittests\": \"3811acbc7799450167cd9d58908747a170169cef\", \"ozone_x11_unittests\": \"18243d1389e38b6b248912785f1d698fe58bfe81\", \"pdf_unittests\": \"1be77333cfc89db6af8ba61815e7404413a8b5be\", \"perfetto_unittests\": \"b5d1a98aeb71402908cf70b68fc67926cdf7fec4\", \"ppapi_unittests\": \"029eeb8c3c6d9e18774f808390f32ccaf9eb9bd9\", \"printing_unittests\": \"a33102e75d55d0383a5fe556f47e50dfcf400e8e\", \"remoting_unittests\": \"7288b1f8a90e59da8fb197c4c3309a911b5d2917\", \"sandbox_linux_unittests\": \"61add97bb6b3b50b63ec6c3e81bf9fc6fc8596df\", \"service_manager_unittests\": \"3ebaa405dabdffd2cf132dc86a66cb7cd2450bab\", \"services_unittests\": \"5c0a91bd8b154e48d280b50ab79cdab04e1c9bbf\", \"shell_dialogs_unittests\": \"228d06566b8813da5ce1555be02883f65d91c7a5\", \"skia_unittests\": \"e4e49c4f10251473b635af478f05555723c81c99\", \"snapshot_unittests\": \"8525f991f90d2f17a1806f5772b029e361775e96\", \"sql_unittests\": \"485bc69bf5576233fb76b5f148d85bd79f5918db\", \"storage_unittests\": \"2e0e94d043dae7fe97203dcb348f8db0181611b3\", \"sync_integration_tests\": \"f96749cad7ae09913b4a99d7d91d29e98b897ed9\", \"traffic_annotation_auditor_unittests\": \"48dcc0d1332d9edff6017d5712da8f77cde0eecd\", \"ui_base_unittests\": \"84d2e3057a14389cc648f96c3238e87b73aeb6f8\", \"ui_chromeos_unittests\": \"c27197adbaf9cdc1e547161f03c7b989bb4ca08c\", \"ui_touch_selection_unittests\": \"119f9261393efe2027e6f2d1765962dbe32a52e2\", \"unit_tests\": \"9878ca96040824ed6abe0f305cef0c3c9f1f8eec\", \"url_unittests\": \"809cc1b2cb38fa8bc4336f86f38312949224654d\", \"usage_time_limit_unittests\": \"105291998a965161854db8e19f7a5f4c35e4b5c5\", \"views_unittests\": \"c76a7ac7ff51c78c8816d98f49bd762acb7f2aff\", \"viz_unittests\": \"487802df6d7f21cc29c6d667920384351921911f\", \"wm_unittests\": \"acda775a92d10bdc0e4c157c0954576d73116998\", \"wtf_unittests\": \"e9de6b9e1c40a8aed1e7bfb38590c7c003dd02a4\", \"zlib_unittests\": \"c85509e41b836b94c8b1564f51c86c828a66bcc9\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_4f0964162888fb5bae249a111360c6881d9714a6e065febf968887beea0fb93f_v2\", \"builder_7d75f6999c07e42a7f7fde2313383264fbd8ed871e2008bde33b278973c1f4c8_v2\", \"builder_84395cd86c4615c28c38755187d54d1bbe2dcea268d302d74191d04ce3a055d0_v2\", \"builder_8bff6729eb7a20b41fa723231755491227dfae6025a6d103df6a00cfb6cc22b8_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-203-bxm2\"], \"image\": [\"chrome-xenial-20102500-5da31bca5f9\"], \"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\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604674978819502",
"status": "COMPLETED",
"status_changed_ts": "1604681048133030",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21179",
"builder:linux-chromeos-dbg",
"buildset:commit/git/42dafa576390d0bf2e52f60cafbb1fd61c8e6f3a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/42dafa576390d0bf2e52f60cafbb1fd61c8e6f3a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029800122209005696",
"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/8864370059869244560/+/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:4fb6e65e2b11ed10",
"user_agent:luci-scheduler"
],
"updated_ts": "1604681048139767",
"url": "https://ci.chromium.org/b/8864370059869244560",
"utcnow_ts": "1604681049050514"
}
}
[16:44:09.059] Invocation finished in 1h41m25.684116301s with status SUCCEEDED