[05:51:56.447] New invocation is queued and will start shortly
[05:51:57.616] Starting the invocation (attempt 1)
[05:51:57.646] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:51:57.646] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:51:57.646] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022677614095173168",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"640bca0da5444218efce5a4416463afc6a97f131\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9022677614095173168",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/640bca0da5444218efce5a4416463afc6a97f131",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/640bca0da5444218efce5a4416463afc6a97f131",
"gitiles_ref:refs/heads/master"
]
}
[05:51:58.319] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611467517727194",
"id": "8857247552089826432",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"640bca0da5444218efce5a4416463afc6a97f131\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611467518106778",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22321",
"builder:linux-chromeos-dbg",
"buildset:commit/git/640bca0da5444218efce5a4416463afc6a97f131",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/640bca0da5444218efce5a4416463afc6a97f131",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022677614095173168",
"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/8857247552089826432/+/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": "1611467518106964",
"url": "https://ci.chromium.org/b/8857247552089826432",
"utcnow_ts": "1611467518310944"
}
}
[05:51:58.319] Task URL: https://ci.chromium.org/b/8857247552089826432
[05:51:58.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:2:0) after 1m0s
[05:52:58.385] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:2:0)
[05:52:58.389] Timer tick, asking Buildbucket for the build status
[05:52:58.489] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:52:58.489] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:3:0) after 1m0s
[05:53:58.518] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:3:0)
[05:53:58.518] Timer tick, asking Buildbucket for the build status
[05:53:58.596] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:53:58.596] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:4:0) after 1m0s
[05:54:58.633] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:4:0)
[05:54:58.633] Timer tick, asking Buildbucket for the build status
[05:54:58.841] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:54:58.841] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:5:0) after 1m0s
[05:55:58.849] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:5:0)
[05:55:58.849] Timer tick, asking Buildbucket for the build status
[05:55:58.922] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:55:58.922] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:6:0) after 1m0s
[05:56:58.928] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:6:0)
[05:56:58.928] Timer tick, asking Buildbucket for the build status
[05:56:59.013] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:56:59.013] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:7:0) after 1m0s
[05:57:59.029] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:7:0)
[05:57:59.029] Timer tick, asking Buildbucket for the build status
[05:57:59.133] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:57:59.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:8:0) after 1m0s
[05:58:59.153] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:8:0)
[05:58:59.153] Timer tick, asking Buildbucket for the build status
[05:58:59.841] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:58:59.841] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:9:0) after 1m0s
[05:59:59.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:9:0)
[05:59:59.857] Timer tick, asking Buildbucket for the build status
[05:59:59.980] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:59:59.980] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:10:0) after 1m0s
[06:01:00.003] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:10:0)
[06:01:00.003] Timer tick, asking Buildbucket for the build status
[06:01:00.103] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:01:00.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:11:0) after 1m0s
[06:02:00.123] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:11:0)
[06:02:00.123] Timer tick, asking Buildbucket for the build status
[06:02:00.255] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:02:00.255] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:12:0) after 1m0s
[06:03:00.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:12:0)
[06:03:00.304] Timer tick, asking Buildbucket for the build status
[06:03:00.379] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:03:00.379] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:13:0) after 1m0s
[06:04:00.445] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:13:0)
[06:04:00.445] Timer tick, asking Buildbucket for the build status
[06:04:00.512] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:04:00.512] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:14:0) after 1m0s
[06:05:00.549] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:14:0)
[06:05:00.549] Timer tick, asking Buildbucket for the build status
[06:05:00.634] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:05:00.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:15:0) after 1m0s
[06:06:00.651] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:15:0)
[06:06:00.651] Timer tick, asking Buildbucket for the build status
[06:06:00.901] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:06:00.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:16:0) after 1m0s
[06:07:00.969] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:16:0)
[06:07:00.969] Timer tick, asking Buildbucket for the build status
[06:07:01.319] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:07:01.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:17:0) after 1m0s
[06:08:01.292] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:17:0)
[06:08:01.292] Timer tick, asking Buildbucket for the build status
[06:08:01.421] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:08:01.421] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:18:0) after 1m0s
[06:09:01.474] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:18:0)
[06:09:01.474] Timer tick, asking Buildbucket for the build status
[06:09:01.539] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:09:01.539] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:19:0) after 1m0s
[06:10:01.562] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:19:0)
[06:10:01.562] Timer tick, asking Buildbucket for the build status
[06:10:01.654] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:10:01.654] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:20:0) after 1m0s
[06:11:01.705] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:20:0)
[06:11:01.705] Timer tick, asking Buildbucket for the build status
[06:11:01.771] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:11:01.771] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:21:0) after 1m0s
[06:12:01.803] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:21:0)
[06:12:01.803] Timer tick, asking Buildbucket for the build status
[06:12:01.895] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:12:01.895] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:22:0) after 1m0s
[06:13:01.963] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:22:0)
[06:13:01.963] Timer tick, asking Buildbucket for the build status
[06:13:02.185] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:13:02.185] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:23:0) after 1m0s
[06:14:02.202] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:23:0)
[06:14:02.202] Timer tick, asking Buildbucket for the build status
[06:14:02.279] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:14:02.279] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:24:0) after 1m0s
[06:15:02.319] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:24:0)
[06:15:02.319] Timer tick, asking Buildbucket for the build status
[06:15:02.386] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:15:02.386] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:25:0) after 1m0s
[06:16:02.366] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:25:0)
[06:16:02.366] Timer tick, asking Buildbucket for the build status
[06:16:02.466] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:16:02.466] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:26:0) after 1m0s
[06:17:02.487] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:26:0)
[06:17:02.487] Timer tick, asking Buildbucket for the build status
[06:17:02.656] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:17:02.656] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:27:0) after 1m0s
[06:18:02.732] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:27:0)
[06:18:02.732] Timer tick, asking Buildbucket for the build status
[06:18:02.801] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:18:02.801] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:28:0) after 1m0s
[06:19:02.828] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:28:0)
[06:19:02.828] Timer tick, asking Buildbucket for the build status
[06:19:02.892] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:19:02.892] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:29:0) after 1m0s
[06:20:02.944] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:29:0)
[06:20:02.944] Timer tick, asking Buildbucket for the build status
[06:20:03.066] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:20:03.066] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:30:0) after 1m0s
[06:21:03.046] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:30:0)
[06:21:03.046] Timer tick, asking Buildbucket for the build status
[06:21:03.106] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:21:03.106] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:31:0) after 1m0s
[06:22:03.134] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:31:0)
[06:22:03.134] Timer tick, asking Buildbucket for the build status
[06:22:03.589] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:22:03.589] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:32:0) after 1m0s
[06:23:03.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:32:0)
[06:23:03.613] Timer tick, asking Buildbucket for the build status
[06:23:03.818] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:23:03.818] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:33:0) after 1m0s
[06:24:03.924] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:33:0)
[06:24:03.924] Timer tick, asking Buildbucket for the build status
[06:24:04.050] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:24:04.050] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:34:0) after 1m0s
[06:25:04.082] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:34:0)
[06:25:04.082] Timer tick, asking Buildbucket for the build status
[06:25:04.228] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:25:04.228] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:35:0) after 1m0s
[06:26:04.322] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:35:0)
[06:26:04.322] Timer tick, asking Buildbucket for the build status
[06:26:04.438] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:26:04.438] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:36:0) after 1m0s
[06:27:04.509] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:36:0)
[06:27:04.509] Timer tick, asking Buildbucket for the build status
[06:27:04.622] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:27:04.622] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:37:0) after 1m0s
[06:28:04.675] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:37:0)
[06:28:04.675] Timer tick, asking Buildbucket for the build status
[06:28:04.897] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:28:04.897] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:38:0) after 1m0s
[06:29:04.957] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:38:0)
[06:29:04.957] Timer tick, asking Buildbucket for the build status
[06:29:05.032] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:29:05.032] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:39:0) after 1m0s
[06:30:05.059] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:39:0)
[06:30:05.059] Timer tick, asking Buildbucket for the build status
[06:30:05.212] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:30:05.212] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:40:0) after 1m0s
[06:31:05.830] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:40:0)
[06:31:05.830] Timer tick, asking Buildbucket for the build status
[06:31:05.949] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:31:05.950] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:41:0) after 1m0s
[06:32:05.969] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:41:0)
[06:32:05.969] Timer tick, asking Buildbucket for the build status
[06:32:06.070] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:32:06.070] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:42:0) after 1m0s
[06:33:06.134] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:42:0)
[06:33:06.134] Timer tick, asking Buildbucket for the build status
[06:33:06.304] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:33:06.304] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:43:0) after 1m0s
[06:34:06.377] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:43:0)
[06:34:06.377] Timer tick, asking Buildbucket for the build status
[06:34:06.607] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:34:06.607] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:44:0) after 1m0s
[06:35:06.731] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:44:0)
[06:35:06.731] Timer tick, asking Buildbucket for the build status
[06:35:06.920] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:35:06.920] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:45:0) after 1m0s
[06:36:07.083] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:45:0)
[06:36:07.083] Timer tick, asking Buildbucket for the build status
[06:36:07.161] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:36:07.161] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:46:0) after 1m0s
[06:37:07.207] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:46:0)
[06:37:07.207] Timer tick, asking Buildbucket for the build status
[06:37:07.292] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:37:07.292] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:47:0) after 1m0s
[06:38:07.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:47:0)
[06:38:07.314] Timer tick, asking Buildbucket for the build status
[06:38:07.386] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:38:07.386] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:48:0) after 1m0s
[06:39:07.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:48:0)
[06:39:07.514] Timer tick, asking Buildbucket for the build status
[06:39:07.807] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:39:07.807] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:49:0) after 1m0s
[06:40:07.847] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:49:0)
[06:40:07.847] Timer tick, asking Buildbucket for the build status
[06:40:08.246] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:40:08.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:50:0) after 1m0s
[06:41:08.383] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:50:0)
[06:41:08.383] Timer tick, asking Buildbucket for the build status
[06:41:08.538] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:41:08.538] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:51:0) after 1m0s
[06:42:08.565] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:51:0)
[06:42:08.565] Timer tick, asking Buildbucket for the build status
[06:42:08.748] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:42:08.748] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:52:0) after 1m0s
[06:43:08.900] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:52:0)
[06:43:08.900] Timer tick, asking Buildbucket for the build status
[06:43:09.177] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:43:09.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:53:0) after 1m0s
[06:44:09.182] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:53:0)
[06:44:09.182] Timer tick, asking Buildbucket for the build status
[06:44:09.261] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:44:09.261] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:54:0) after 1m0s
[06:45:09.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:54:0)
[06:45:09.252] Timer tick, asking Buildbucket for the build status
[06:45:09.328] Build 8857247552089826432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:45:09.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:55:0) after 1m0s
[06:45:57.794] Received PubSub notification, asking Buildbucket for the build status
[06:45:57.939] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:09.350] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:55:0)
[06:46:09.350] Timer tick, asking Buildbucket for the build status
[06:46:09.412] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:09.412] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:57:0) after 1m0s
[06:47:09.419] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:57:0)
[06:47:09.419] Timer tick, asking Buildbucket for the build status
[06:47:09.511] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:09.511] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:58:0) after 1m0s
[06:48:09.590] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:58:0)
[06:48:09.590] Timer tick, asking Buildbucket for the build status
[06:48:09.668] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:09.668] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:59:0) after 1m0s
[06:49:09.725] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:59:0)
[06:49:09.725] Timer tick, asking Buildbucket for the build status
[06:49:09.804] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:09.804] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:60:0) after 1m0s
[06:50:09.881] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:60:0)
[06:50:09.881] Timer tick, asking Buildbucket for the build status
[06:50:10.227] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:10.227] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:61:0) after 1m0s
[06:51:10.272] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:61:0)
[06:51:10.272] Timer tick, asking Buildbucket for the build status
[06:51:10.393] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:10.393] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:62:0) after 1m0s
[06:52:10.493] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:62:0)
[06:52:10.493] Timer tick, asking Buildbucket for the build status
[06:52:10.602] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:10.602] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:63:0) after 1m0s
[06:53:10.734] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:63:0)
[06:53:10.734] Timer tick, asking Buildbucket for the build status
[06:53:10.795] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:10.795] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:64:0) after 1m0s
[06:54:10.895] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:64:0)
[06:54:10.895] Timer tick, asking Buildbucket for the build status
[06:54:10.943] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:10.943] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:65:0) after 1m0s
[06:55:11.352] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:65:0)
[06:55:11.352] Timer tick, asking Buildbucket for the build status
[06:55:11.422] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:11.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:66:0) after 1m0s
[06:56:11.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:66:0)
[06:56:11.792] Timer tick, asking Buildbucket for the build status
[06:56:11.874] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:11.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:67:0) after 1m0s
[06:57:12.081] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:67:0)
[06:57:12.081] Timer tick, asking Buildbucket for the build status
[06:57:12.446] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:12.446] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:68:0) after 1m0s
[06:58:12.551] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:68:0)
[06:58:12.551] Timer tick, asking Buildbucket for the build status
[06:58:12.612] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:12.612] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:69:0) after 1m0s
[06:59:12.808] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:69:0)
[06:59:12.808] Timer tick, asking Buildbucket for the build status
[06:59:12.878] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:12.878] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:70:0) after 1m0s
[07:00:13.029] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:70:0)
[07:00:13.029] Timer tick, asking Buildbucket for the build status
[07:00:13.089] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:13.089] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:71:0) after 1m0s
[07:01:13.332] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:71:0)
[07:01:13.333] Timer tick, asking Buildbucket for the build status
[07:01:13.427] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:13.427] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:72:0) after 1m0s
[07:02:13.555] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:72:0)
[07:02:13.556] Timer tick, asking Buildbucket for the build status
[07:02:13.657] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:13.657] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:73:0) after 1m0s
[07:03:13.889] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:73:0)
[07:03:13.889] Timer tick, asking Buildbucket for the build status
[07:03:13.988] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:13.988] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:74:0) after 1m0s
[07:04:14.053] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:74:0)
[07:04:14.053] Timer tick, asking Buildbucket for the build status
[07:04:14.152] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:14.152] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:75:0) after 1m0s
[07:05:14.585] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:75:0)
[07:05:14.585] Timer tick, asking Buildbucket for the build status
[07:05:14.640] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:14.640] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:76:0) after 1m0s
[07:06:14.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:76:0)
[07:06:14.784] Timer tick, asking Buildbucket for the build status
[07:06:14.853] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:14.854] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:77:0) after 1m0s
[07:07:15.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:77:0)
[07:07:15.177] Timer tick, asking Buildbucket for the build status
[07:07:15.309] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:15.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:78:0) after 1m0s
[07:08:15.374] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:78:0)
[07:08:15.374] Timer tick, asking Buildbucket for the build status
[07:08:15.435] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:15.435] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:79:0) after 1m0s
[07:09:15.524] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:79:0)
[07:09:15.524] Timer tick, asking Buildbucket for the build status
[07:09:15.592] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:15.592] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:80:0) after 1m0s
[07:10:15.656] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:80:0)
[07:10:15.656] Timer tick, asking Buildbucket for the build status
[07:10:15.716] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:15.716] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:81:0) after 1m0s
[07:11:15.848] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:81:0)
[07:11:15.848] Timer tick, asking Buildbucket for the build status
[07:11:15.912] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:15.912] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:82:0) after 1m0s
[07:12:16.021] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:82:0)
[07:12:16.021] Timer tick, asking Buildbucket for the build status
[07:12:16.132] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:16.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:83:0) after 1m0s
[07:13:16.319] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:83:0)
[07:13:16.319] Timer tick, asking Buildbucket for the build status
[07:13:16.395] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:16.395] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:84:0) after 1m0s
[07:14:16.665] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:84:0)
[07:14:16.665] Timer tick, asking Buildbucket for the build status
[07:14:16.723] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:16.723] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:85:0) after 1m0s
[07:15:16.777] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:85:0)
[07:15:16.777] Timer tick, asking Buildbucket for the build status
[07:15:16.842] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:16.842] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:86:0) after 1m0s
[07:16:16.964] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:86:0)
[07:16:16.964] Timer tick, asking Buildbucket for the build status
[07:16:17.028] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:17.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:87:0) after 1m0s
[07:17:17.123] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:87:0)
[07:17:17.123] Timer tick, asking Buildbucket for the build status
[07:17:17.213] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:17.213] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:88:0) after 1m0s
[07:18:17.301] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:88:0)
[07:18:17.301] Timer tick, asking Buildbucket for the build status
[07:18:17.362] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:17.362] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:89:0) after 1m0s
[07:19:17.401] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:89:0)
[07:19:17.401] Timer tick, asking Buildbucket for the build status
[07:19:17.458] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:17.458] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:90:0) after 1m0s
[07:20:17.505] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:90:0)
[07:20:17.505] Timer tick, asking Buildbucket for the build status
[07:20:17.567] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:17.567] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:91:0) after 1m0s
[07:21:17.592] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:91:0)
[07:21:17.592] Timer tick, asking Buildbucket for the build status
[07:21:17.648] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:17.648] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:92:0) after 1m0s
[07:22:17.690] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:92:0)
[07:22:17.690] Timer tick, asking Buildbucket for the build status
[07:22:17.845] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:17.845] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:93:0) after 1m0s
[07:23:17.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:93:0)
[07:23:17.845] Timer tick, asking Buildbucket for the build status
[07:23:17.907] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:17.907] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:94:0) after 1m0s
[07:24:17.997] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:94:0)
[07:24:17.997] Timer tick, asking Buildbucket for the build status
[07:24:18.292] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:18.292] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:95:0) after 1m0s
[07:25:18.458] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:95:0)
[07:25:18.458] Timer tick, asking Buildbucket for the build status
[07:25:18.530] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:18.530] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:96:0) after 1m0s
[07:26:18.551] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:96:0)
[07:26:18.551] Timer tick, asking Buildbucket for the build status
[07:26:18.610] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:18.610] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:97:0) after 1m0s
[07:27:18.621] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:97:0)
[07:27:18.621] Timer tick, asking Buildbucket for the build status
[07:27:18.704] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:18.704] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:98:0) after 1m0s
[07:28:18.728] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:98:0)
[07:28:18.728] Timer tick, asking Buildbucket for the build status
[07:28:18.807] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:18.807] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:99:0) after 1m0s
[07:29:18.890] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:99:0)
[07:29:18.890] Timer tick, asking Buildbucket for the build status
[07:29:18.937] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:18.937] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:100:0) after 1m0s
[07:30:18.999] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:100:0)
[07:30:18.999] Timer tick, asking Buildbucket for the build status
[07:30:19.088] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:19.088] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:101:0) after 1m0s
[07:31:19.099] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:101:0)
[07:31:19.099] Timer tick, asking Buildbucket for the build status
[07:31:19.164] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:19.164] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:102:0) after 1m0s
[07:32:19.183] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:102:0)
[07:32:19.183] Timer tick, asking Buildbucket for the build status
[07:32:19.286] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:19.286] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:103:0) after 1m0s
[07:33:19.340] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:103:0)
[07:33:19.340] Timer tick, asking Buildbucket for the build status
[07:33:19.397] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:19.397] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:104:0) after 1m0s
[07:34:19.485] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:104:0)
[07:34:19.485] Timer tick, asking Buildbucket for the build status
[07:34:19.545] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:19.545] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:105:0) after 1m0s
[07:35:19.620] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:105:0)
[07:35:19.620] Timer tick, asking Buildbucket for the build status
[07:35:19.720] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:19.720] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:106:0) after 1m0s
[07:36:19.744] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:106:0)
[07:36:19.744] Timer tick, asking Buildbucket for the build status
[07:36:19.861] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:19.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:107:0) after 1m0s
[07:37:19.883] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:107:0)
[07:37:19.883] Timer tick, asking Buildbucket for the build status
[07:37:20.108] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:20.108] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:108:0) after 1m0s
[07:38:20.133] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:108:0)
[07:38:20.134] Timer tick, asking Buildbucket for the build status
[07:38:20.451] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:20.451] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:109:0) after 1m0s
[07:39:20.536] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:109:0)
[07:39:20.536] Timer tick, asking Buildbucket for the build status
[07:39:20.842] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:20.842] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:110:0) after 1m0s
[07:40:20.929] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:110:0)
[07:40:20.930] Timer tick, asking Buildbucket for the build status
[07:40:21.003] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:21.003] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:111:0) after 1m0s
[07:41:21.054] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:111:0)
[07:41:21.054] Timer tick, asking Buildbucket for the build status
[07:41:21.132] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:21.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:112:0) after 1m0s
[07:42:21.280] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:112:0)
[07:42:21.280] Timer tick, asking Buildbucket for the build status
[07:42:21.384] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:21.384] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:113:0) after 1m0s
[07:43:21.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:113:0)
[07:43:21.495] Timer tick, asking Buildbucket for the build status
[07:43:21.651] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:21.651] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:114:0) after 1m0s
[07:44:21.805] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:114:0)
[07:44:21.805] Timer tick, asking Buildbucket for the build status
[07:44:21.955] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:21.955] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:115:0) after 1m0s
[07:45:21.957] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:115:0)
[07:45:21.957] Timer tick, asking Buildbucket for the build status
[07:45:22.072] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:22.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:116:0) after 1m0s
[07:46:22.113] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:116:0)
[07:46:22.113] Timer tick, asking Buildbucket for the build status
[07:46:22.213] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:22.213] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:117:0) after 1m0s
[07:47:22.218] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:117:0)
[07:47:22.218] Timer tick, asking Buildbucket for the build status
[07:47:22.310] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:22.311] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:118:0) after 1m0s
[07:48:22.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:118:0)
[07:48:22.371] Timer tick, asking Buildbucket for the build status
[07:48:22.462] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:22.462] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:119:0) after 1m0s
[07:49:22.474] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:119:0)
[07:49:22.474] Timer tick, asking Buildbucket for the build status
[07:49:22.923] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:22.923] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:120:0) after 1m0s
[07:50:22.976] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:120:0)
[07:50:22.976] Timer tick, asking Buildbucket for the build status
[07:50:23.125] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:23.125] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:121:0) after 1m0s
[07:51:23.156] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:121:0)
[07:51:23.157] Timer tick, asking Buildbucket for the build status
[07:51:23.356] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:23.356] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:122:0) after 1m0s
[07:52:23.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:122:0)
[07:52:23.527] Timer tick, asking Buildbucket for the build status
[07:52:23.634] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:23.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:123:0) after 1m0s
[07:53:23.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:123:0)
[07:53:23.638] Timer tick, asking Buildbucket for the build status
[07:53:23.732] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:23.732] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:124:0) after 1m0s
[07:54:23.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:124:0)
[07:54:23.846] Timer tick, asking Buildbucket for the build status
[07:54:24.144] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:24.144] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:125:0) after 1m0s
[07:55:24.266] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:125:0)
[07:55:24.266] Timer tick, asking Buildbucket for the build status
[07:55:24.348] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:24.348] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:126:0) after 1m0s
[07:56:24.420] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:126:0)
[07:56:24.420] Timer tick, asking Buildbucket for the build status
[07:56:24.490] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:24.490] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:127:0) after 1m0s
[07:57:24.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:127:0)
[07:57:24.571] Timer tick, asking Buildbucket for the build status
[07:57:24.669] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:24.669] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:128:0) after 1m0s
[07:58:24.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:128:0)
[07:58:24.761] Timer tick, asking Buildbucket for the build status
[07:58:25.002] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:25.002] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:129:0) after 1m0s
[07:59:25.069] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:129:0)
[07:59:25.069] Timer tick, asking Buildbucket for the build status
[07:59:25.221] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:25.221] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:130:0) after 1m0s
[08:00:25.294] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:130:0)
[08:00:25.294] Timer tick, asking Buildbucket for the build status
[08:00:25.368] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:25.368] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:131:0) after 1m0s
[08:01:25.414] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:131:0)
[08:01:25.414] Timer tick, asking Buildbucket for the build status
[08:01:25.543] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:25.543] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:132:0) after 1m0s
[08:02:25.644] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:132:0)
[08:02:25.644] Timer tick, asking Buildbucket for the build status
[08:02:25.751] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:25.751] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:133:0) after 1m0s
[08:03:25.810] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:133:0)
[08:03:25.810] Timer tick, asking Buildbucket for the build status
[08:03:26.043] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:26.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:134:0) after 1m0s
[08:04:26.078] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:134:0)
[08:04:26.078] Timer tick, asking Buildbucket for the build status
[08:04:26.357] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:26.357] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:135:0) after 1m0s
[08:05:26.407] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:135:0)
[08:05:26.407] Timer tick, asking Buildbucket for the build status
[08:05:26.483] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:26.483] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:136:0) after 1m0s
[08:06:26.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:136:0)
[08:06:26.514] Timer tick, asking Buildbucket for the build status
[08:06:26.613] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:26.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:137:0) after 1m0s
[08:07:26.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:137:0)
[08:07:26.668] Timer tick, asking Buildbucket for the build status
[08:07:26.761] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:26.761] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:138:0) after 1m0s
[08:08:26.796] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:138:0)
[08:08:26.796] Timer tick, asking Buildbucket for the build status
[08:08:26.903] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:26.903] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:139:0) after 1m0s
[08:09:26.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:139:0)
[08:09:26.960] Timer tick, asking Buildbucket for the build status
[08:09:27.046] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:27.046] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:140:0) after 1m0s
[08:10:27.060] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:140:0)
[08:10:27.060] Timer tick, asking Buildbucket for the build status
[08:10:27.126] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:27.126] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:141:0) after 1m0s
[08:11:27.154] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:141:0)
[08:11:27.154] Timer tick, asking Buildbucket for the build status
[08:11:27.244] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:27.244] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:142:0) after 1m0s
[08:12:27.269] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:142:0)
[08:12:27.269] Timer tick, asking Buildbucket for the build status
[08:12:27.605] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:27.605] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:143:0) after 1m0s
[08:13:27.694] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:143:0)
[08:13:27.694] Timer tick, asking Buildbucket for the build status
[08:13:27.770] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:27.770] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:144:0) after 1m0s
[08:14:27.849] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:144:0)
[08:14:27.849] Timer tick, asking Buildbucket for the build status
[08:14:28.085] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:28.085] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:145:0) after 1m0s
[08:15:31.105] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:145:0)
[08:15:31.105] Timer tick, asking Buildbucket for the build status
[08:15:31.181] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:31.181] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:146:0) after 1m0s
[08:16:31.215] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:146:0)
[08:16:31.215] Timer tick, asking Buildbucket for the build status
[08:16:31.282] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:31.282] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:147:0) after 1m0s
[08:17:31.380] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:147:0)
[08:17:31.380] Timer tick, asking Buildbucket for the build status
[08:17:31.596] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:31.596] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:148:0) after 1m0s
[08:18:31.720] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:148:0)
[08:18:31.720] Timer tick, asking Buildbucket for the build status
[08:18:32.201] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:32.201] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:149:0) after 1m0s
[08:19:32.407] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:149:0)
[08:19:32.407] Timer tick, asking Buildbucket for the build status
[08:19:32.624] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:32.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:150:0) after 1m0s
[08:20:32.660] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:150:0)
[08:20:32.660] Timer tick, asking Buildbucket for the build status
[08:20:32.719] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:32.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:151:0) after 1m0s
[08:21:32.769] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:151:0)
[08:21:32.769] Timer tick, asking Buildbucket for the build status
[08:21:32.875] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:32.875] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:152:0) after 1m0s
[08:22:32.891] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:152:0)
[08:22:32.891] Timer tick, asking Buildbucket for the build status
[08:22:33.256] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:33.256] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:153:0) after 1m0s
[08:23:33.311] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:153:0)
[08:23:33.311] Timer tick, asking Buildbucket for the build status
[08:23:33.767] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:33.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:154:0) after 1m0s
[08:24:33.825] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:154:0)
[08:24:33.825] Timer tick, asking Buildbucket for the build status
[08:24:33.891] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:33.891] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:155:0) after 1m0s
[08:25:33.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:155:0)
[08:25:33.922] Timer tick, asking Buildbucket for the build status
[08:25:34.221] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:34.221] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:156:0) after 1m0s
[08:26:34.197] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:156:0)
[08:26:34.197] Timer tick, asking Buildbucket for the build status
[08:26:34.506] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:34.506] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:157:0) after 1m0s
[08:27:34.550] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:157:0)
[08:27:34.550] Timer tick, asking Buildbucket for the build status
[08:27:34.668] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:34.668] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:158:0) after 1m0s
[08:28:34.725] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:158:0)
[08:28:34.725] Timer tick, asking Buildbucket for the build status
[08:28:34.783] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:34.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:159:0) after 1m0s
[08:29:34.873] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:159:0)
[08:29:34.873] Timer tick, asking Buildbucket for the build status
[08:29:34.939] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:34.939] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:160:0) after 1m0s
[08:30:35.004] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:160:0)
[08:30:35.004] Timer tick, asking Buildbucket for the build status
[08:30:35.084] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:35.084] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:161:0) after 1m0s
[08:31:35.153] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:161:0)
[08:31:35.153] Timer tick, asking Buildbucket for the build status
[08:31:35.428] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:35.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:162:0) after 1m0s
[08:32:35.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:162:0)
[08:32:35.467] Timer tick, asking Buildbucket for the build status
[08:32:35.585] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:35.585] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:163:0) after 1m0s
[08:33:35.618] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:163:0)
[08:33:35.618] Timer tick, asking Buildbucket for the build status
[08:33:35.687] Build 8857247552089826432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:35.687] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:164:0) after 1m0s
[08:34:35.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022677614095173168:164:0)
[08:34:35.711] Timer tick, asking Buildbucket for the build status
[08:34:35.944] Build 8857247552089826432: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[08:34:35.945] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611477275212278",
"created_by": "project:chromium",
"created_ts": "1611467517727194",
"failure_reason": "BUILD_FAILURE",
"id": "8857247552089826432",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"640bca0da5444218efce5a4416463afc6a97f131\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- ChromeVoxOptionsTest.PunctuationEchoSelect\"}, \"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\": \"640bca0da5444218efce5a4416463afc6a97f131\", \"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-east1-d-8-23-nkom\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22321, \"got_angle_revision\": \"3c3b82abcf0a5c18b4d97ae49726045ce6d3b832\", \"got_dawn_revision\": \"f1f8394de04ea9532de763dfb2f968fc9610683b\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"640bca0da5444218efce5a4416463afc6a97f131\", \"got_revision_cp\": \"refs/heads/master@{#846564}\", \"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\": \"640bca0da5444218efce5a4416463afc6a97f131\", \"swarm_hashes_refs/heads/master(at){#846564}_without_patch\": {\"absl_hardening_tests\": \"a3bd4b078a9f594562a4f2c6252dbdce7dbaf521\", \"accessibility_unittests\": \"853e05ce257ee819e40f8e45497260fe83ad0b5f\", \"angle_unittests\": \"b115aa65c3d018216f882663c23552155eaa230a\", \"app_list_unittests\": \"d50f6502a8619a33a28bda03925bb7f0239caf9b\", \"app_shell_unittests\": \"8cdd49d34b31239e748ce7ed45ad8037ee9a56c0\", \"ash_unittests\": \"807278740813948869a1822897cdb8e6faeb521e\", \"aura_unittests\": \"90beaa0d71cfc0f6d14463f8bf8d97eff2051111\", \"base_unittests\": \"5d89cf795c3193c3368e1bab3719cfe8f5928140\", \"base_util_unittests\": \"12dae3edfad4eb2a751d11c33684e3f9711ddca6\", \"blink_common_unittests\": \"339cb96583029f3e8709da95e88666ad7a5ed434\", \"blink_fuzzer_unittests\": \"fd77a8d590896fb82809fd82bb227f8974a7e421\", \"blink_heap_unittests\": \"e464bd1ba7428287b50e99bd7f83a60a221d59a9\", \"blink_platform_unittests\": \"46e67268e4e4fe9e3e9a772dfd7444e921edd281\", \"blink_unittests\": \"a2b6f1df9707aca2f3c2c4b6c53023db91f7dc43\", \"boringssl_crypto_tests\": \"d18498d5161a89821f60049f177d17a189f1ac1c\", \"boringssl_ssl_tests\": \"203b25c35171c125cfbc18c61936df84ba20b908\", \"browser_tests\": \"fb7cc06c1c305cd2b92c96664f62b2d7ad9f334d\", \"capture_unittests\": \"0eb0c117771a8072afe0ae7150f38902066e81af\", \"cast_unittests\": \"eefc28683b52a52eac07dca12eae96b448f775b5\", \"cc_unittests\": \"74fa071c3811ca62b5e890cf6f506f87b340fe5d\", \"chrome_app_unittests\": \"40ef943608d89da3b4663dd126e5c1fa530b8283\", \"chromedriver_unittests\": \"4bbe41e96d9df3e8db5c6483d78d0202ff49537e\", \"chromeos_components_unittests\": \"5a3bce0e8d2794b5e11f7eeb23238df1cb205111\", \"chromeos_unittests\": \"16cfcdb0aa3bc6963daa3ec071231f0df4b7aa7c\", \"components_browsertests\": \"2ae014f81117814e79ca2af72e2c41f4787fbc62\", \"components_unittests\": \"5fac6de29b3352058ed21ac37399c3fa471c908b\", \"compositor_unittests\": \"ddef75e8365e9c4c289cf7da2c88ea625d48a35c\", \"content_browsertests\": \"f009f1cb16d52424a5e4da3fafdc1cdb435bea61\", \"content_unittests\": \"e532a607b8b012bff7b1b5e5c1b21dceaf903f5b\", \"crashpad_tests\": \"d0420808fbffdfeaec058facb56adb0daebf6a3f\", \"crypto_unittests\": \"23e9e54a086c15aaea103dc19c18ac00db0795cb\", \"dbus_unittests\": \"cf80aaaa41d01df8af2b134e3cebe1d3d0d980e8\", \"device_unittests\": \"0140ef809b6e7cdee44cedabb3c0d44dde27f496\", \"display_unittests\": \"1fe791f83ef4ada65023dc7894f01d0b962089b0\", \"events_unittests\": \"1f7e162967afe62b5d8bbbded57f4cc7c671f347\", \"exo_unittests\": \"019bd2943a8b5e0698a9547f1fbdad652c6d057e\", \"extensions_browsertests\": \"e3b5f74f7b68a5f51af412d9a2fe69dd563bd10d\", \"extensions_unittests\": \"9d2711147c9b5cc602b0e100b11ff8e67f1d56cc\", \"filesystem_service_unittests\": \"b80a984bfcfa470cfc45932e3bc7de9b284172d9\", \"gcm_unit_tests\": \"3e47c71a9636745efee3225436904a825f63b781\", \"gfx_unittests\": \"ffc254b8a688e021aac1a28da364b23a8151bb97\", \"gin_unittests\": \"c22309d9e0f76160b07aeaa4877cc90b9f9c4869\", \"gl_unittests_ozone\": \"756cdb9d6883361eb42cf11eabd9e9279240c491\", \"google_apis_unittests\": \"0e1199fad4a3f43ab130116b07b3106536fddc2c\", \"gpu_unittests\": \"a634bcadff50a2bec662f4590cab56deb4c11409\", \"gwp_asan_unittests\": \"33e5463c96ba9d12d5050976a9bde30f38bf0c2f\", \"interactive_ui_tests\": \"c0442e688c62185436e47f1691d6b4853c184bfa\", \"ipc_tests\": \"caace76828c07d0cfa8ce7c06a9f6265b9d49331\", \"jingle_unittests\": \"b0a1a1c05ce5559a1230b63709c6561b8eaac84c\", \"keyboard_unittests\": \"35e3b39d2dc6b512ecb1c4d3a388b64042fc41b9\", \"latency_unittests\": \"cabb90f00b6fb4455c7485105c5d605bc5b5215f\", \"libjingle_xmpp_unittests\": \"2d44f5307d33f186cea3c89c81ee41955c2fc47a\", \"liburlpattern_unittests\": \"4dcc14172e32b2470af3c1ef92fe8b928f005a83\", \"media_blink_unittests\": \"46a87ad829d1c732ab5daf2b0491b6656c45e67d\", \"media_unittests\": \"a00c09936210eac512212305cfe37adac465bc8f\", \"message_center_unittests\": \"5d2e5caa57572f377057d302c221ddfa79c71606\", \"midi_unittests\": \"59d9d04e01f4d13e9818b0e35df99fc1206e73ab\", \"mojo_core_unittests\": \"2d6068938942d1043c61d8a2c1068497a12419ff\", \"mojo_unittests\": \"c4a295927a1aeef324e2edb257f21317ef9a2591\", \"nacl_helper_nonsfi_unittests\": \"f3c7be4dfb040885b8dedaf44399517a302df467\", \"nacl_loader_unittests\": \"9f223716c0ace3b26d88dff8b98de7ad68cc05fe\", \"native_theme_unittests\": \"5eb595b2e87b604d9e99ffe488db032ed762b4df\", \"net_unittests\": \"f47422dde97533466d11614ce253206571a433b5\", \"ozone_gl_unittests\": \"570c7376936befc035eb2cec451634e2748406d8\", \"ozone_unittests\": \"aebc027e04f22f051747bde76931f2cf02597c21\", \"ozone_x11_unittests\": \"38599bda73c02e03a41bf7343ab0a43e0b092d05\", \"pdf_unittests\": \"77c8c3ac24b45d82f4f0e12919f4db1b1ae28b8b\", \"perfetto_unittests\": \"51f87dd4922912657977133b98ecff9edb228492\", \"ppapi_unittests\": \"7e121d24ba9d5bd2d1945abe664f9d4d16f3fb13\", \"printing_unittests\": \"ef55cd3e9bf05b9c421455241e772a50c04a308b\", \"remoting_unittests\": \"339c8b48b9b5a23ae25081bac97e7c1eef71e2d4\", \"sandbox_linux_unittests\": \"87fddbcf7184b9e45062242efdf5a1d185f7d271\", \"service_manager_unittests\": \"f97ea74b4fb3807b652a8a38ff80136e73cae716\", \"services_unittests\": \"aefa798d5e24d3a5b3e7e991c8cc69584f19c85c\", \"shell_dialogs_unittests\": \"dc1efeb121ff9882e63463d11b32ff4f6e207f63\", \"shell_encryption_unittests\": \"97f72235aaeab1f242ae8785ba54f60e6f683d86\", \"skia_unittests\": \"8075dccc5f28e98a03392015b229cc86d8111220\", \"snapshot_unittests\": \"fbe8b7daa43eca808130936046c1a23c2baf782c\", \"sql_unittests\": \"e9b8134b70cb790b78419755f5741a9f15c1e5fa\", \"storage_unittests\": \"10968c14854674bd7e47c8725fa7bc878d6f5117\", \"sync_integration_tests\": \"505941caadea3b5acb05a3aa9f70c10b845a54e2\", \"traffic_annotation_auditor_unittests\": \"b1583a5cd46900bdd6eb56d6dd3a70e1bbff888d\", \"ui_base_unittests\": \"8e2cf022e6b916b0e95564d9c475a440165eaf86\", \"ui_chromeos_unittests\": \"d72384ead591695be7f2b4d3e527262c868eec7e\", \"ui_touch_selection_unittests\": \"3b583ce3d59aa95e946499bbb20d0016107c5b00\", \"unit_tests\": \"8009fb5d0028890a403c90a94dc2949ba323c6dd\", \"url_unittests\": \"57d1481c20b737ba4027526b833052f0c84c3aa9\", \"usage_time_limit_unittests\": \"ac2a9500c9568098f93af80e23a5a29ad935706c\", \"views_unittests\": \"609a275b145e54a0eaf0bcb0fab72bc48797034e\", \"viz_unittests\": \"c8d0af0be449724d17a01ddc99de7acdb95ed7fc\", \"wm_unittests\": \"687b282a9d18ff163ca3fff9000daddb126ceeff\", \"wtf_unittests\": \"196b890fb786fb66e36237c32aab85f58895992d\", \"zlib_unittests\": \"3a4b441cf295279b23fd9b4be9dec5a39012eb65\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2295bac873f7edd8c9763e89419d85b38a875955550d968c436d775d3f06377b_v2\", \"builder_61faa0d0c1c079ecf670d8cfa4f78ad3b1687a5534233c7377462c3ee6819708_v2\", \"builder_81975214af25fe3c157931ccf4182e1c4ae2635ce20b925a941b30b87e2fcb1d_v2\", \"builder_83d41522ef30b186d170824fe4af0f819b6d8e33bbc59ab4098fd9fd1af4e43b_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-east1-d-8-23-nkom\"], \"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-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- ChromeVoxOptionsTest.PunctuationEchoSelect\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611470754910962",
"status": "COMPLETED",
"status_changed_ts": "1611470755903111",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22321",
"builder:linux-chromeos-dbg",
"buildset:commit/git/640bca0da5444218efce5a4416463afc6a97f131",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/640bca0da5444218efce5a4416463afc6a97f131",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022677614095173168",
"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/8857247552089826432/+/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:514bc47b2d244d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1611477275628666",
"url": "https://ci.chromium.org/b/8857247552089826432",
"utcnow_ts": "1611477275933269"
}
}
[08:34:35.947] Invocation finished in 2h42m39.515310683s with status FAILED