[11:04:53.035] New invocation is queued and will start shortly
[11:04:54.494] Starting the invocation (attempt 1)
[11:04:54.530] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:04:54.530] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:04:54.530] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9072576853903884880",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"2deca80506eccb1dce8166404ec8d9ee3a866a50\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9072576853903884880",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/2deca80506eccb1dce8166404ec8d9ee3a866a50",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2deca80506eccb1dce8166404ec8d9ee3a866a50",
"gitiles_ref:refs/heads/master"
]
}
[11:04:55.311] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1563879894731282",
"id": "8907146791460704960",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"2deca80506eccb1dce8166404ec8d9ee3a866a50\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1563879895165855",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/13529",
"builder:linux-chromeos-dbg",
"buildset:commit/git/2deca80506eccb1dce8166404ec8d9ee3a866a50",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2deca80506eccb1dce8166404ec8d9ee3a866a50",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9072576853903884880",
"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/8907146791460704960/+/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": "1563879895165949",
"url": "https://ci.chromium.org/b/8907146791460704960",
"utcnow_ts": "1563879895301871"
}
}
[11:04:55.311] Task URL: https://ci.chromium.org/b/8907146791460704960
[11:04:55.311] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:2:0) after 1m0s
[11:04:57.125] Received PubSub notification, asking Buildbucket for the build status
[11:04:57.319] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:55.343] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:2:0)
[11:05:55.343] Timer tick, asking Buildbucket for the build status
[11:05:55.501] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:55.501] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:4:0) after 1m0s
[11:06:55.497] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:4:0)
[11:06:55.497] Timer tick, asking Buildbucket for the build status
[11:06:56.065] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:56.065] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:5:0) after 1m0s
[11:07:56.109] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:5:0)
[11:07:56.109] Timer tick, asking Buildbucket for the build status
[11:07:56.618] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:56.618] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:6:0) after 1m0s
[11:08:56.676] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:6:0)
[11:08:56.676] Timer tick, asking Buildbucket for the build status
[11:08:57.352] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:57.352] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:7:0) after 1m0s
[11:09:57.437] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:7:0)
[11:09:57.437] Timer tick, asking Buildbucket for the build status
[11:09:58.717] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:58.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:8:0) after 1m0s
[11:10:58.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:8:0)
[11:10:58.748] Timer tick, asking Buildbucket for the build status
[11:10:59.006] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:59.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:9:0) after 1m0s
[11:11:59.036] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:9:0)
[11:11:59.036] Timer tick, asking Buildbucket for the build status
[11:11:59.581] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:59.581] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:10:0) after 1m0s
[11:12:59.631] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:10:0)
[11:12:59.631] Timer tick, asking Buildbucket for the build status
[11:12:59.856] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:59.856] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:11:0) after 1m0s
[11:13:59.962] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:11:0)
[11:13:59.962] Timer tick, asking Buildbucket for the build status
[11:14:00.119] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:00.119] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:12:0) after 1m0s
[11:15:00.154] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:12:0)
[11:15:00.154] Timer tick, asking Buildbucket for the build status
[11:15:00.505] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:00.505] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:13:0) after 1m0s
[11:16:00.542] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:13:0)
[11:16:00.542] Timer tick, asking Buildbucket for the build status
[11:16:00.726] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:00.726] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:14:0) after 1m0s
[11:17:00.805] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:14:0)
[11:17:00.805] Timer tick, asking Buildbucket for the build status
[11:17:02.030] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:02.030] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:15:0) after 1m0s
[11:18:02.151] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:15:0)
[11:18:02.151] Timer tick, asking Buildbucket for the build status
[11:18:02.374] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:02.374] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:16:0) after 1m0s
[11:19:02.594] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:16:0)
[11:19:02.594] Timer tick, asking Buildbucket for the build status
[11:19:03.086] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:03.086] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:17:0) after 1m0s
[11:20:03.246] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:17:0)
[11:20:03.246] Timer tick, asking Buildbucket for the build status
[11:20:04.483] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:04.483] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:18:0) after 1m0s
[11:21:04.548] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:18:0)
[11:21:04.548] Timer tick, asking Buildbucket for the build status
[11:21:04.749] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:04.749] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:19:0) after 1m0s
[11:22:04.904] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:19:0)
[11:22:04.904] Timer tick, asking Buildbucket for the build status
[11:22:05.125] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:05.125] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:20:0) after 1m0s
[11:23:05.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:20:0)
[11:23:05.236] Timer tick, asking Buildbucket for the build status
[11:23:05.412] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:05.412] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:21:0) after 1m0s
[11:24:05.499] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:21:0)
[11:24:05.499] Timer tick, asking Buildbucket for the build status
[11:24:05.692] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:05.692] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:22:0) after 1m0s
[11:25:05.718] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:22:0)
[11:25:05.718] Timer tick, asking Buildbucket for the build status
[11:25:05.899] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:05.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:23:0) after 1m0s
[11:26:05.921] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:23:0)
[11:26:05.921] Timer tick, asking Buildbucket for the build status
[11:26:06.092] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:06.092] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:24:0) after 1m0s
[11:27:06.146] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:24:0)
[11:27:06.146] Timer tick, asking Buildbucket for the build status
[11:27:06.743] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:06.743] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:25:0) after 1m0s
[11:28:06.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:25:0)
[11:28:06.878] Timer tick, asking Buildbucket for the build status
[11:28:07.068] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:07.068] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:26:0) after 1m0s
[11:29:07.161] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:26:0)
[11:29:07.161] Timer tick, asking Buildbucket for the build status
[11:29:07.496] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:07.496] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:27:0) after 1m0s
[11:30:07.518] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:27:0)
[11:30:07.518] Timer tick, asking Buildbucket for the build status
[11:30:08.705] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:08.705] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:28:0) after 1m0s
[11:31:08.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:28:0)
[11:31:08.820] Timer tick, asking Buildbucket for the build status
[11:31:09.544] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:09.544] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:29:0) after 1m0s
[11:32:09.566] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:29:0)
[11:32:09.566] Timer tick, asking Buildbucket for the build status
[11:32:09.750] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:09.750] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:30:0) after 1m0s
[11:33:09.978] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:30:0)
[11:33:09.978] Timer tick, asking Buildbucket for the build status
[11:33:10.369] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:10.369] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:31:0) after 1m0s
[11:34:10.585] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:31:0)
[11:34:10.585] Timer tick, asking Buildbucket for the build status
[11:34:11.378] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:11.378] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:32:0) after 1m0s
[11:35:11.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:32:0)
[11:35:11.558] Timer tick, asking Buildbucket for the build status
[11:35:11.816] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:11.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:33:0) after 1m0s
[11:36:11.865] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:33:0)
[11:36:11.865] Timer tick, asking Buildbucket for the build status
[11:36:12.047] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:12.047] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:34:0) after 1m0s
[11:37:12.196] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:34:0)
[11:37:12.196] Timer tick, asking Buildbucket for the build status
[11:37:12.867] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:12.867] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:35:0) after 1m0s
[11:38:12.999] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:35:0)
[11:38:12.999] Timer tick, asking Buildbucket for the build status
[11:38:13.385] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:13.385] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:36:0) after 1m0s
[11:39:13.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:36:0)
[11:39:13.513] Timer tick, asking Buildbucket for the build status
[11:39:13.640] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:13.640] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:37:0) after 1m0s
[11:40:13.766] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:37:0)
[11:40:13.766] Timer tick, asking Buildbucket for the build status
[11:40:14.138] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:14.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:38:0) after 1m0s
[11:41:14.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:38:0)
[11:41:14.236] Timer tick, asking Buildbucket for the build status
[11:41:14.422] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:14.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:39:0) after 1m0s
[11:42:14.536] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:39:0)
[11:42:14.536] Timer tick, asking Buildbucket for the build status
[11:42:15.052] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:15.052] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:40:0) after 1m0s
[11:43:15.058] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:40:0)
[11:43:15.058] Timer tick, asking Buildbucket for the build status
[11:43:15.270] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:15.270] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:41:0) after 1m0s
[11:44:15.315] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:41:0)
[11:44:15.315] Timer tick, asking Buildbucket for the build status
[11:44:16.022] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:16.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:42:0) after 1m0s
[11:45:16.090] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:42:0)
[11:45:16.090] Timer tick, asking Buildbucket for the build status
[11:45:16.316] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:16.316] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:43:0) after 1m0s
[11:46:16.423] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:43:0)
[11:46:16.423] Timer tick, asking Buildbucket for the build status
[11:46:16.734] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:16.734] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:44:0) after 1m0s
[11:47:16.819] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:44:0)
[11:47:16.819] Timer tick, asking Buildbucket for the build status
[11:47:17.045] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:17.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:45:0) after 1m0s
[11:48:17.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:45:0)
[11:48:17.067] Timer tick, asking Buildbucket for the build status
[11:48:17.643] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:17.643] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:46:0) after 1m0s
[11:49:17.666] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:46:0)
[11:49:17.666] Timer tick, asking Buildbucket for the build status
[11:49:18.262] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:18.262] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:47:0) after 1m0s
[11:50:18.332] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:47:0)
[11:50:18.333] Timer tick, asking Buildbucket for the build status
[11:50:18.667] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:18.667] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:48:0) after 1m0s
[11:51:18.725] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:48:0)
[11:51:18.725] Timer tick, asking Buildbucket for the build status
[11:51:18.983] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:18.983] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:49:0) after 1m0s
[11:52:19.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:49:0)
[11:52:19.007] Timer tick, asking Buildbucket for the build status
[11:52:19.502] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:19.502] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:50:0) after 1m0s
[11:53:19.573] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:50:0)
[11:53:19.573] Timer tick, asking Buildbucket for the build status
[11:53:19.764] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:19.764] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:51:0) after 1m0s
[11:54:19.851] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:51:0)
[11:54:19.851] Timer tick, asking Buildbucket for the build status
[11:54:20.498] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:20.498] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:52:0) after 1m0s
[11:55:20.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:52:0)
[11:55:20.983] Timer tick, asking Buildbucket for the build status
[11:55:21.284] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:21.284] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:53:0) after 1m0s
[11:56:21.459] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:53:0)
[11:56:21.459] Timer tick, asking Buildbucket for the build status
[11:56:21.616] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:21.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:54:0) after 1m0s
[11:57:21.751] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:54:0)
[11:57:21.751] Timer tick, asking Buildbucket for the build status
[11:57:22.105] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:22.107] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:55:0) after 1m0s
[11:58:22.283] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:55:0)
[11:58:22.283] Timer tick, asking Buildbucket for the build status
[11:58:23.445] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:23.445] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:56:0) after 1m0s
[11:59:23.505] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:56:0)
[11:59:23.505] Timer tick, asking Buildbucket for the build status
[11:59:25.090] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:25.090] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:57:0) after 1m0s
[12:00:25.199] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:57:0)
[12:00:25.199] Timer tick, asking Buildbucket for the build status
[12:00:26.316] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:26.316] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:58:0) after 1m0s
[12:01:26.381] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:58:0)
[12:01:26.381] Timer tick, asking Buildbucket for the build status
[12:01:26.765] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:26.765] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:59:0) after 1m0s
[12:02:27.293] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:59:0)
[12:02:27.293] Timer tick, asking Buildbucket for the build status
[12:02:27.733] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:27.733] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:60:0) after 1m0s
[12:03:27.808] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:60:0)
[12:03:27.808] Timer tick, asking Buildbucket for the build status
[12:03:28.268] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:28.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:61:0) after 1m0s
[12:04:28.448] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:61:0)
[12:04:28.448] Timer tick, asking Buildbucket for the build status
[12:04:28.624] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:28.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:62:0) after 1m0s
[12:05:28.750] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:62:0)
[12:05:28.750] Timer tick, asking Buildbucket for the build status
[12:05:29.763] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:29.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:63:0) after 1m0s
[12:06:29.889] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:63:0)
[12:06:29.889] Timer tick, asking Buildbucket for the build status
[12:06:30.178] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:30.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:64:0) after 1m0s
[12:07:30.271] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:64:0)
[12:07:30.271] Timer tick, asking Buildbucket for the build status
[12:07:30.868] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:30.868] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:65:0) after 1m0s
[12:08:30.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:65:0)
[12:08:30.970] Timer tick, asking Buildbucket for the build status
[12:08:31.123] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:31.123] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:66:0) after 1m0s
[12:09:31.226] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:66:0)
[12:09:31.226] Timer tick, asking Buildbucket for the build status
[12:09:31.495] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:31.495] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:67:0) after 1m0s
[12:10:31.576] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:67:0)
[12:10:31.576] Timer tick, asking Buildbucket for the build status
[12:10:31.906] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:31.906] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:68:0) after 1m0s
[12:11:31.932] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:68:0)
[12:11:31.932] Timer tick, asking Buildbucket for the build status
[12:11:32.123] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:32.123] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:69:0) after 1m0s
[12:12:32.178] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:69:0)
[12:12:32.178] Timer tick, asking Buildbucket for the build status
[12:12:32.354] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:32.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:70:0) after 1m0s
[12:13:32.376] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:70:0)
[12:13:32.376] Timer tick, asking Buildbucket for the build status
[12:13:32.572] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:32.572] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:71:0) after 1m0s
[12:14:32.657] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:71:0)
[12:14:32.657] Timer tick, asking Buildbucket for the build status
[12:14:34.781] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:34.781] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:72:0) after 1m0s
[12:15:34.807] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:72:0)
[12:15:34.807] Timer tick, asking Buildbucket for the build status
[12:15:36.048] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:36.048] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:73:0) after 1m0s
[12:16:36.079] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:73:0)
[12:16:36.079] Timer tick, asking Buildbucket for the build status
[12:16:36.278] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:36.278] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:74:0) after 1m0s
[12:17:36.297] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:74:0)
[12:17:36.297] Timer tick, asking Buildbucket for the build status
[12:17:36.560] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:36.561] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:75:0) after 1m0s
[12:18:36.592] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:75:0)
[12:18:36.592] Timer tick, asking Buildbucket for the build status
[12:18:37.124] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:37.124] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:76:0) after 1m0s
[12:19:37.162] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:76:0)
[12:19:37.162] Timer tick, asking Buildbucket for the build status
[12:19:38.353] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:38.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:77:0) after 1m0s
[12:20:38.374] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:77:0)
[12:20:38.374] Timer tick, asking Buildbucket for the build status
[12:20:39.074] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:39.074] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:78:0) after 1m0s
[12:21:39.098] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:78:0)
[12:21:39.098] Timer tick, asking Buildbucket for the build status
[12:21:39.323] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:39.323] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:79:0) after 1m0s
[12:22:39.425] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:79:0)
[12:22:39.425] Timer tick, asking Buildbucket for the build status
[12:22:39.910] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:39.910] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:80:0) after 1m0s
[12:23:40.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:80:0)
[12:23:40.067] Timer tick, asking Buildbucket for the build status
[12:23:40.335] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:40.335] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:81:0) after 1m0s
[12:24:40.396] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:81:0)
[12:24:40.396] Timer tick, asking Buildbucket for the build status
[12:24:40.783] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:40.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:82:0) after 1m0s
[12:25:40.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:82:0)
[12:25:40.925] Timer tick, asking Buildbucket for the build status
[12:25:42.291] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:42.291] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:83:0) after 1m0s
[12:26:42.344] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:83:0)
[12:26:42.344] Timer tick, asking Buildbucket for the build status
[12:26:42.947] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:42.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:84:0) after 1m0s
[12:27:43.035] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:84:0)
[12:27:43.035] Timer tick, asking Buildbucket for the build status
[12:27:43.328] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:43.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:85:0) after 1m0s
[12:28:43.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:85:0)
[12:28:43.351] Timer tick, asking Buildbucket for the build status
[12:28:43.535] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:43.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:86:0) after 1m0s
[12:29:43.563] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:86:0)
[12:29:43.563] Timer tick, asking Buildbucket for the build status
[12:29:43.966] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:43.966] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:87:0) after 1m0s
[12:30:44.090] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:87:0)
[12:30:44.090] Timer tick, asking Buildbucket for the build status
[12:30:44.453] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:44.453] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:88:0) after 1m0s
[12:31:44.470] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:88:0)
[12:31:44.470] Timer tick, asking Buildbucket for the build status
[12:31:45.640] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:45.640] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:89:0) after 1m0s
[12:32:45.697] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:89:0)
[12:32:45.697] Timer tick, asking Buildbucket for the build status
[12:32:45.870] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:45.870] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:90:0) after 1m0s
[12:33:45.901] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:90:0)
[12:33:45.901] Timer tick, asking Buildbucket for the build status
[12:33:46.053] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:46.053] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:91:0) after 1m0s
[12:34:46.085] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:91:0)
[12:34:46.085] Timer tick, asking Buildbucket for the build status
[12:34:46.551] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:46.551] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:92:0) after 1m0s
[12:35:46.652] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:92:0)
[12:35:46.652] Timer tick, asking Buildbucket for the build status
[12:35:46.890] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:46.890] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:93:0) after 1m0s
[12:36:46.893] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:93:0)
[12:36:46.893] Timer tick, asking Buildbucket for the build status
[12:36:47.171] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:47.172] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:94:0) after 1m0s
[12:37:47.196] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:94:0)
[12:37:47.196] Timer tick, asking Buildbucket for the build status
[12:37:48.344] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:48.344] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:95:0) after 1m0s
[12:38:48.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:95:0)
[12:38:48.371] Timer tick, asking Buildbucket for the build status
[12:38:49.528] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:49.528] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:96:0) after 1m0s
[12:39:49.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:96:0)
[12:39:49.558] Timer tick, asking Buildbucket for the build status
[12:39:49.770] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:49.770] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:97:0) after 1m0s
[12:40:49.827] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:97:0)
[12:40:49.827] Timer tick, asking Buildbucket for the build status
[12:40:50.457] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:50.457] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:98:0) after 1m0s
[12:41:50.550] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:98:0)
[12:41:50.550] Timer tick, asking Buildbucket for the build status
[12:41:50.968] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:50.969] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:99:0) after 1m0s
[12:42:51.073] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:99:0)
[12:42:51.073] Timer tick, asking Buildbucket for the build status
[12:42:51.279] Build 8907146791460704960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:51.279] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9072576853903884880:100:0) after 1m0s
[12:43:25.461] Received PubSub notification, asking Buildbucket for the build status
[12:43:25.594] Build 8907146791460704960: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[12:43:25.594] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1563885804496550",
"created_by": "project:chromium",
"created_ts": "1563879894731282",
"failure_reason": "BUILD_FAILURE",
"id": "8907146791460704960",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"2deca80506eccb1dce8166404ec8d9ee3a866a50\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"2 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- OSSettingsUIBrowserTest.All\\n\\n**non_viz_browser_tests** failed because of:\\n\\n- OSSettingsUIBrowserTest.All\"}, \"properties\": {\"$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-28-pl84\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 13529, \"got_angle_revision\": \"02407743bd7261c37abae0f7e4962ea324662122\", \"got_dawn_revision\": \"4e3b218e9695b1f7011ff80319e75e14a35cf466\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"2deca80506eccb1dce8166404ec8d9ee3a866a50\", \"got_revision_cp\": \"refs/heads/master@{#679930}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"12c0646785a3207f5cdd747038a9cf9910e2bab5\", \"got_v8_revision_cp\": \"refs/heads/7.7.295@{#1}\", \"got_webrtc_revision\": \"85ef3eab9407a75ce634ae213a2904be862ba542\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28643}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.chromiumos\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"2deca80506eccb1dce8166404ec8d9ee3a866a50\", \"swarm_hashes\": {\"accessibility_unittests\": \"47064490e4b8de083dd5bdcacac2a51e06066853\", \"angle_unittests\": \"7ce1c21babe052552c341b62de5f2b3c6bd9626d\", \"app_list_unittests\": \"3f4743bcead8fd18b45698bae41aecfdb6e57941\", \"app_shell_unittests\": \"0ae751d082f6c22c2588907b9c5cac44fb0245cd\", \"ash_unittests\": \"f861e9d29b8ac22dfb5bd546981949564d58f130\", \"aura_unittests\": \"ccf5c3d8dc3d132dc6722fd262c68f117b92059a\", \"base_unittests\": \"16048b7daef4d6255b818128573b7fc5d50645e1\", \"base_util_unittests\": \"e23e27f70b5dd9e096b239d1c02eeae333e6b686\", \"blink_common_unittests\": \"fa84f03a7fb24caf245272ec641658643ff1c77c\", \"blink_fuzzer_unittests\": \"2af7281ba8e2657cdecda1fbcfcc360b7dcf983d\", \"blink_heap_unittests\": \"a75fea658e6a1410ec90c3f2c0c5e460dec6e416\", \"blink_platform_unittests\": \"10f056950d62a308a626f3f2c4178b51577694c4\", \"blink_unittests\": \"dc497aeeffbca127d8a8a452798bd20d1b9ebfc4\", \"boringssl_crypto_tests\": \"63e6edbb86186133c767e7d944a280e9456bd09b\", \"boringssl_ssl_tests\": \"af2f3c0fa67b5c62b22eb1bfa3f1417dd9e6ba40\", \"browser_tests\": \"f1c0462e81e3874c1bf98466b7a0c9410df88555\", \"cacheinvalidation_unittests\": \"a4c38d7885256d4090b025a626974352868677ba\", \"capture_unittests\": \"1ed39f9d4127abf4ed1978e63c1947bacf393e58\", \"cast_unittests\": \"d2fa4d8bf11ebfe6bd90aff50ba8ee46511cf62c\", \"cc_unittests\": \"8990fcb9db2c74945e9857a77daa8a11ef5f7cf3\", \"chrome_app_unittests\": \"fb38bf125e6c0d8e3729f8fd40c3962a095aa900\", \"chromedriver_unittests\": \"d49ba1c3143d12a8916897487a6b0d65a54b370c\", \"chromeos_components_unittests\": \"7b3df3f01a89f3bd65ae3b66c17e1ca6b8d6939d\", \"chromeos_unittests\": \"91e9d62c81d2eaffb20395b0a7c6e0dc1a12302a\", \"components_browsertests\": \"726180e4c02a4103ae3e6ebde221eff772f9a0c6\", \"components_unittests\": \"1e866b15f170984815c71285c1424d0458b20fe8\", \"compositor_unittests\": \"bb5336fe93b79dca6adef4b614f61851fa1b6772\", \"content_browsertests\": \"f53c8949ed8fd370db2da6f8b49cd0cdf8dec5a8\", \"content_unittests\": \"4bad9424be54813824d58bff18ddf3c821db89e3\", \"crypto_unittests\": \"2297cc0364e3dad9294d369166944c1a96819d9d\", \"dbus_unittests\": \"c8b7261107c5c0f6e855b5ba2ca179194857dfd7\", \"device_unittests\": \"8d3eb65b090a361525b07e9ac27e79b554f0f058\", \"display_unittests\": \"b91e4aa5f344abaac462b8d5230b54972909cf34\", \"events_unittests\": \"566831de184f7799971d2a5cc1832e7832d55963\", \"exo_unittests\": \"459dc26fed542d586f96bc1872cb46e2af71b14f\", \"extensions_browsertests\": \"841f33a780120abd9ca53451d71352f4dc234fcd\", \"extensions_unittests\": \"3c13c3fa51ebdc3db6373427e9f7320c0c78a3a9\", \"filesystem_service_unittests\": \"9302f0aa0e81a271d53305d1186f4cc57dd2dd16\", \"gcm_unit_tests\": \"b6b61b19ab633f0bc7427700c38ad6f211614c29\", \"gfx_unittests\": \"b2b6dc2f4a4746b10bb1ebc41fc27b0ac7845d74\", \"gin_unittests\": \"7832e44debb88b015eec824e7f2f2f876c7d9841\", \"gl_unittests_ozone\": \"56f2f12d255426ffca584c65acfebc9cebe28be4\", \"google_apis_unittests\": \"b82f1fb8d9c080b6777ffcb40681184a5f1950b4\", \"gpu_unittests\": \"c445b934d7d2b87c0eb8e3967d5403eeddfd1e76\", \"interactive_ui_tests\": \"9bfb466dfd7b1d86c0b0b6377d114c590c3eb118\", \"ipc_tests\": \"9d6ca97d64c91191f5c482167a8117039207b5c9\", \"jingle_unittests\": \"18c2a335a2b7a1d096343a044a7dc86f0fcb2152\", \"keyboard_unittests\": \"de402679f3422362e7539be55b39e733ae6c4ffc\", \"latency_unittests\": \"24e0825ce762088cd907c2ec6ba9a611f0b527fa\", \"leveldb_service_unittests\": \"82a7c3036ab0c7216bff060a27c811c7db1c04e2\", \"libjingle_xmpp_unittests\": \"71bb6ed027c645868581620ae2913d96e255640f\", \"media_blink_unittests\": \"e6b4561bc94814a21610705090a3b9f396d2d73e\", \"media_service_unittests\": \"2421f82a99758f9be222ec50486421a95e836b1c\", \"media_unittests\": \"cd115eed9d8564b8a2bfc6c841a24b485af6cf3a\", \"message_center_unittests\": \"c94d30fba90284a6759df6726f434f57072f3b9f\", \"midi_unittests\": \"9e1456e2c9857df4cf8491d6a96992a7d4a0e851\", \"mojo_core_unittests\": \"c88fb762416beb594a18682dcb19ed3b24615920\", \"mojo_unittests\": \"9c491338bfbc17c62ab722bfeaf9b9fd27c97f3d\", \"nacl_helper_nonsfi_unittests\": \"f1fcb107a79e132399088fb6fb67e3b53eb639bc\", \"nacl_loader_unittests\": \"24ba6f914a699dc8aa79df7b8a85fa38c3348408\", \"native_theme_unittests\": \"94346a053c4bcb6407c918b59634e18173747498\", \"net_unittests\": \"185a5e64307fecf765a35700d64bbf128b227011\", \"ozone_gl_unittests\": \"0788142810427c020e7009b9cfc505e1f559650d\", \"ozone_unittests\": \"9fcad78e23a7421bcba6cd257260853bf9522f69\", \"ozone_x11_unittests\": \"58db301da5afed0a5a20c30abe0c1c485c55660f\", \"pdf_unittests\": \"803347cac0d974b2521aa0575ce194a081275dd0\", \"perfetto_unittests\": \"44a75ba11364cd16950cd05af94a8bf33850cb9a\", \"ppapi_unittests\": \"7cab9fe9866b285f2350abb0f01ab480f41385c1\", \"printing_unittests\": \"d865089ae41e92d528b52c67bd2c79d0a076d0f8\", \"remoting_unittests\": \"ff7837424cd685e65c65e84e87ed476f800773e7\", \"sandbox_linux_unittests\": \"87ed6355af9285b2758a9ebdf2293d84d7010a2b\", \"service_manager_unittests\": \"0ea549ce05a0b503442c244d593670cb16029b14\", \"services_unittests\": \"e34deff6a8d10df3ea6f17173271020a58342d6b\", \"shell_dialogs_unittests\": \"6c524d9d38d4738d612afa63733bc2df309d5ca3\", \"skia_unittests\": \"b7368de50e0b6f6c3f9e195c70d41b958da74b1f\", \"snapshot_unittests\": \"a1a4af8beb924122ead98a9b3621351625aa4d2a\", \"sql_unittests\": \"3551178243be355007cfb9f50e1638379057dbf4\", \"storage_unittests\": \"e0455042e909e1739c71fe4c99d3d52762ea2841\", \"sync_integration_tests\": \"6f6b0cf54c5a784f0f375a85868085995b9c8896\", \"traffic_annotation_auditor_unittests\": \"7c490f9a82ddef458720edf4c55c992042af4d35\", \"ui_base_unittests\": \"1b6c8f5399be0baeffe8bf2ddd166348291a02ba\", \"ui_chromeos_unittests\": \"504cc3d3fc4ed923486f00a44019042397ad7be0\", \"ui_touch_selection_unittests\": \"41b9315ffeabeca93a85eb240236247e365f69bb\", \"unit_tests\": \"8bdf409564f7308f9ca4093aa61cc51897b82537\", \"url_unittests\": \"48807b786319835154f29f6a1668aa216c676183\", \"usage_time_limit_unittests\": \"9cbec0d7e67928eb51290b3d0e58ebbb11d4a9e0\", \"views_unittests\": \"96204dbee42fa3c8063df93f5f381ad3525fb099\", \"viz_unittests\": \"b9a895849915a5012bf4822c58a5ec3a901ed22b\", \"wm_unittests\": \"44a33fea2e22adbce72ccfdabcc054d475754883\", \"wtf_unittests\": \"9dd758ebcc832e7ecbfb3ab00958d147f6e03145\"}, \"swarm_hashes_refs/heads/master(at){#679930}_without_patch\": {\"accessibility_unittests\": \"47064490e4b8de083dd5bdcacac2a51e06066853\", \"angle_unittests\": \"7ce1c21babe052552c341b62de5f2b3c6bd9626d\", \"app_list_unittests\": \"3f4743bcead8fd18b45698bae41aecfdb6e57941\", \"app_shell_unittests\": \"0ae751d082f6c22c2588907b9c5cac44fb0245cd\", \"ash_unittests\": \"f861e9d29b8ac22dfb5bd546981949564d58f130\", \"aura_unittests\": \"ccf5c3d8dc3d132dc6722fd262c68f117b92059a\", \"base_unittests\": \"16048b7daef4d6255b818128573b7fc5d50645e1\", \"base_util_unittests\": \"e23e27f70b5dd9e096b239d1c02eeae333e6b686\", \"blink_common_unittests\": \"fa84f03a7fb24caf245272ec641658643ff1c77c\", \"blink_fuzzer_unittests\": \"2af7281ba8e2657cdecda1fbcfcc360b7dcf983d\", \"blink_heap_unittests\": \"a75fea658e6a1410ec90c3f2c0c5e460dec6e416\", \"blink_platform_unittests\": \"10f056950d62a308a626f3f2c4178b51577694c4\", \"blink_unittests\": \"dc497aeeffbca127d8a8a452798bd20d1b9ebfc4\", \"boringssl_crypto_tests\": \"63e6edbb86186133c767e7d944a280e9456bd09b\", \"boringssl_ssl_tests\": \"af2f3c0fa67b5c62b22eb1bfa3f1417dd9e6ba40\", \"browser_tests\": \"f1c0462e81e3874c1bf98466b7a0c9410df88555\", \"cacheinvalidation_unittests\": \"a4c38d7885256d4090b025a626974352868677ba\", \"capture_unittests\": \"1ed39f9d4127abf4ed1978e63c1947bacf393e58\", \"cast_unittests\": \"d2fa4d8bf11ebfe6bd90aff50ba8ee46511cf62c\", \"cc_unittests\": \"8990fcb9db2c74945e9857a77daa8a11ef5f7cf3\", \"chrome_app_unittests\": \"fb38bf125e6c0d8e3729f8fd40c3962a095aa900\", \"chromedriver_unittests\": \"d49ba1c3143d12a8916897487a6b0d65a54b370c\", \"chromeos_components_unittests\": \"7b3df3f01a89f3bd65ae3b66c17e1ca6b8d6939d\", \"chromeos_unittests\": \"91e9d62c81d2eaffb20395b0a7c6e0dc1a12302a\", \"components_browsertests\": \"726180e4c02a4103ae3e6ebde221eff772f9a0c6\", \"components_unittests\": \"1e866b15f170984815c71285c1424d0458b20fe8\", \"compositor_unittests\": \"bb5336fe93b79dca6adef4b614f61851fa1b6772\", \"content_browsertests\": \"f53c8949ed8fd370db2da6f8b49cd0cdf8dec5a8\", \"content_unittests\": \"4bad9424be54813824d58bff18ddf3c821db89e3\", \"crypto_unittests\": \"2297cc0364e3dad9294d369166944c1a96819d9d\", \"dbus_unittests\": \"c8b7261107c5c0f6e855b5ba2ca179194857dfd7\", \"device_unittests\": \"8d3eb65b090a361525b07e9ac27e79b554f0f058\", \"display_unittests\": \"b91e4aa5f344abaac462b8d5230b54972909cf34\", \"events_unittests\": \"566831de184f7799971d2a5cc1832e7832d55963\", \"exo_unittests\": \"459dc26fed542d586f96bc1872cb46e2af71b14f\", \"extensions_browsertests\": \"841f33a780120abd9ca53451d71352f4dc234fcd\", \"extensions_unittests\": \"3c13c3fa51ebdc3db6373427e9f7320c0c78a3a9\", \"filesystem_service_unittests\": \"9302f0aa0e81a271d53305d1186f4cc57dd2dd16\", \"gcm_unit_tests\": \"b6b61b19ab633f0bc7427700c38ad6f211614c29\", \"gfx_unittests\": \"b2b6dc2f4a4746b10bb1ebc41fc27b0ac7845d74\", \"gin_unittests\": \"7832e44debb88b015eec824e7f2f2f876c7d9841\", \"gl_unittests_ozone\": \"56f2f12d255426ffca584c65acfebc9cebe28be4\", \"google_apis_unittests\": \"b82f1fb8d9c080b6777ffcb40681184a5f1950b4\", \"gpu_unittests\": \"c445b934d7d2b87c0eb8e3967d5403eeddfd1e76\", \"interactive_ui_tests\": \"9bfb466dfd7b1d86c0b0b6377d114c590c3eb118\", \"ipc_tests\": \"9d6ca97d64c91191f5c482167a8117039207b5c9\", \"jingle_unittests\": \"18c2a335a2b7a1d096343a044a7dc86f0fcb2152\", \"keyboard_unittests\": \"de402679f3422362e7539be55b39e733ae6c4ffc\", \"latency_unittests\": \"24e0825ce762088cd907c2ec6ba9a611f0b527fa\", \"leveldb_service_unittests\": \"82a7c3036ab0c7216bff060a27c811c7db1c04e2\", \"libjingle_xmpp_unittests\": \"71bb6ed027c645868581620ae2913d96e255640f\", \"media_blink_unittests\": \"e6b4561bc94814a21610705090a3b9f396d2d73e\", \"media_service_unittests\": \"2421f82a99758f9be222ec50486421a95e836b1c\", \"media_unittests\": \"cd115eed9d8564b8a2bfc6c841a24b485af6cf3a\", \"message_center_unittests\": \"c94d30fba90284a6759df6726f434f57072f3b9f\", \"midi_unittests\": \"9e1456e2c9857df4cf8491d6a96992a7d4a0e851\", \"mojo_core_unittests\": \"c88fb762416beb594a18682dcb19ed3b24615920\", \"mojo_unittests\": \"9c491338bfbc17c62ab722bfeaf9b9fd27c97f3d\", \"nacl_helper_nonsfi_unittests\": \"f1fcb107a79e132399088fb6fb67e3b53eb639bc\", \"nacl_loader_unittests\": \"24ba6f914a699dc8aa79df7b8a85fa38c3348408\", \"native_theme_unittests\": \"94346a053c4bcb6407c918b59634e18173747498\", \"net_unittests\": \"185a5e64307fecf765a35700d64bbf128b227011\", \"ozone_gl_unittests\": \"0788142810427c020e7009b9cfc505e1f559650d\", \"ozone_unittests\": \"9fcad78e23a7421bcba6cd257260853bf9522f69\", \"ozone_x11_unittests\": \"58db301da5afed0a5a20c30abe0c1c485c55660f\", \"pdf_unittests\": \"803347cac0d974b2521aa0575ce194a081275dd0\", \"perfetto_unittests\": \"44a75ba11364cd16950cd05af94a8bf33850cb9a\", \"ppapi_unittests\": \"7cab9fe9866b285f2350abb0f01ab480f41385c1\", \"printing_unittests\": \"d865089ae41e92d528b52c67bd2c79d0a076d0f8\", \"remoting_unittests\": \"ff7837424cd685e65c65e84e87ed476f800773e7\", \"sandbox_linux_unittests\": \"87ed6355af9285b2758a9ebdf2293d84d7010a2b\", \"service_manager_unittests\": \"0ea549ce05a0b503442c244d593670cb16029b14\", \"services_unittests\": \"e34deff6a8d10df3ea6f17173271020a58342d6b\", \"shell_dialogs_unittests\": \"6c524d9d38d4738d612afa63733bc2df309d5ca3\", \"skia_unittests\": \"b7368de50e0b6f6c3f9e195c70d41b958da74b1f\", \"snapshot_unittests\": \"a1a4af8beb924122ead98a9b3621351625aa4d2a\", \"sql_unittests\": \"3551178243be355007cfb9f50e1638379057dbf4\", \"storage_unittests\": \"e0455042e909e1739c71fe4c99d3d52762ea2841\", \"sync_integration_tests\": \"6f6b0cf54c5a784f0f375a85868085995b9c8896\", \"traffic_annotation_auditor_unittests\": \"7c490f9a82ddef458720edf4c55c992042af4d35\", \"ui_base_unittests\": \"1b6c8f5399be0baeffe8bf2ddd166348291a02ba\", \"ui_chromeos_unittests\": \"504cc3d3fc4ed923486f00a44019042397ad7be0\", \"ui_touch_selection_unittests\": \"41b9315ffeabeca93a85eb240236247e365f69bb\", \"unit_tests\": \"8bdf409564f7308f9ca4093aa61cc51897b82537\", \"url_unittests\": \"48807b786319835154f29f6a1668aa216c676183\", \"usage_time_limit_unittests\": \"9cbec0d7e67928eb51290b3d0e58ebbb11d4a9e0\", \"views_unittests\": \"96204dbee42fa3c8063df93f5f381ad3525fb099\", \"viz_unittests\": \"b9a895849915a5012bf4822c58a5ec3a901ed22b\", \"wm_unittests\": \"44a33fea2e22adbce72ccfdabcc054d475754883\", \"wtf_unittests\": \"9dd758ebcc832e7ecbfb3ab00958d147f6e03145\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-28-pl84\"], \"image\": [\"chrome-xenial-19052201-9cb74617499\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4381-7c1a68d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"2 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- OSSettingsUIBrowserTest.All\\n\\n**non_viz_browser_tests** failed because of:\\n\\n- OSSettingsUIBrowserTest.All\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1563879896523032",
"status": "COMPLETED",
"status_changed_ts": "1563879896853441",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/13529",
"builder:linux-chromeos-dbg",
"buildset:commit/git/2deca80506eccb1dce8166404ec8d9ee3a866a50",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2deca80506eccb1dce8166404ec8d9ee3a866a50",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9072576853903884880",
"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/8907146791460704960/+/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:463752f981cf4610",
"user_agent:luci-scheduler"
],
"updated_ts": "1563885804835511",
"url": "https://ci.chromium.org/b/8907146791460704960",
"utcnow_ts": "1563885805585119"
}
}
[12:43:25.594] Invocation finished in 1h38m32.575771204s with status FAILED