[19:00:36.405] New invocation is queued and will start shortly
[19:00:37.512] Starting the invocation (attempt 1)
[19:00:37.557] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:00:37.557] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:00:37.557] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9076895578399096768",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"a1c5c417186fb3739ac0c0706f17f554a842aec6\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9076895578399096768",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/a1c5c417186fb3739ac0c0706f17f554a842aec6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a1c5c417186fb3739ac0c0706f17f554a842aec6",
"gitiles_ref:refs/heads/master"
]
}
[19:00:46.988] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1559761240742731",
"id": "8911465513185927296",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"a1c5c417186fb3739ac0c0706f17f554a842aec6\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1559761245606910",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/12742",
"builder:linux-chromeos-dbg",
"buildset:commit/git/a1c5c417186fb3739ac0c0706f17f554a842aec6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a1c5c417186fb3739ac0c0706f17f554a842aec6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9076895578399096768",
"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/8911465513185927296/+/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": "1559761245668860",
"url": "https://ci.chromium.org/b/8911465513185927296",
"utcnow_ts": "1559761246861894"
}
}
[19:00:46.988] Task URL: https://ci.chromium.org/b/8911465513185927296
[19:00:46.988] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:2:0) after 1m0s
[19:01:47.129] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:2:0)
[19:01:47.129] Timer tick, asking Buildbucket for the build status
[19:01:47.419] Build 8911465513185927296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:01:47.419] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:3:0) after 1m0s
[19:02:47.599] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:3:0)
[19:02:47.599] Timer tick, asking Buildbucket for the build status
[19:02:48.418] Build 8911465513185927296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:02:48.418] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:4:0) after 1m0s
[19:03:48.453] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:4:0)
[19:03:48.453] Timer tick, asking Buildbucket for the build status
[19:03:48.884] Build 8911465513185927296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:03:48.884] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:5:0) after 1m0s
[19:04:41.093] Received PubSub notification, asking Buildbucket for the build status
[19:04:42.589] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:48.911] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:5:0)
[19:04:48.911] Timer tick, asking Buildbucket for the build status
[19:04:49.025] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:49.025] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:7:0) after 1m0s
[19:05:49.075] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:7:0)
[19:05:49.075] Timer tick, asking Buildbucket for the build status
[19:05:50.262] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:50.262] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:8:0) after 1m0s
[19:06:50.666] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:8:0)
[19:06:50.666] Timer tick, asking Buildbucket for the build status
[19:06:52.163] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:52.163] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:9:0) after 1m0s
[19:07:52.179] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:9:0)
[19:07:52.179] Timer tick, asking Buildbucket for the build status
[19:07:52.893] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:52.893] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:10:0) after 1m0s
[19:08:53.042] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:10:0)
[19:08:53.042] Timer tick, asking Buildbucket for the build status
[19:08:53.401] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:53.401] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:11:0) after 1m0s
[19:09:53.473] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:11:0)
[19:09:53.473] Timer tick, asking Buildbucket for the build status
[19:09:57.823] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:57.823] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:12:0) after 1m0s
[19:10:57.841] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:12:0)
[19:10:57.841] Timer tick, asking Buildbucket for the build status
[19:11:01.067] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:01.067] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:13:0) after 1m0s
[19:12:01.098] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:13:0)
[19:12:01.098] Timer tick, asking Buildbucket for the build status
[19:12:01.217] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:01.217] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:14:0) after 1m0s
[19:13:01.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:14:0)
[19:13:01.237] Timer tick, asking Buildbucket for the build status
[19:13:03.344] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:03.344] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:15:0) after 1m0s
[19:14:03.374] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:15:0)
[19:14:03.374] Timer tick, asking Buildbucket for the build status
[19:14:04.152] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:04.152] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:16:0) after 1m0s
[19:15:04.189] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:16:0)
[19:15:04.189] Timer tick, asking Buildbucket for the build status
[19:15:04.330] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:04.330] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:17:0) after 1m0s
[19:16:04.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:17:0)
[19:16:04.349] Timer tick, asking Buildbucket for the build status
[19:16:05.856] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:05.856] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:18:0) after 1m0s
[19:17:05.880] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:18:0)
[19:17:05.880] Timer tick, asking Buildbucket for the build status
[19:17:06.062] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:06.063] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:19:0) after 1m0s
[19:18:06.081] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:19:0)
[19:18:06.081] Timer tick, asking Buildbucket for the build status
[19:18:06.254] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:06.254] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:20:0) after 1m0s
[19:19:06.298] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:20:0)
[19:19:06.298] Timer tick, asking Buildbucket for the build status
[19:19:07.859] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:07.859] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:21:0) after 1m0s
[19:20:07.906] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:21:0)
[19:20:07.906] Timer tick, asking Buildbucket for the build status
[19:20:10.087] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:10.087] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:22:0) after 1m0s
[19:21:10.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:22:0)
[19:21:10.216] Timer tick, asking Buildbucket for the build status
[19:21:12.964] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:12.964] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:23:0) after 1m0s
[19:22:13.051] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:23:0)
[19:22:13.051] Timer tick, asking Buildbucket for the build status
[19:22:13.231] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:13.231] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:24:0) after 1m0s
[19:23:13.399] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:24:0)
[19:23:13.399] Timer tick, asking Buildbucket for the build status
[19:23:13.564] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:13.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:25:0) after 1m0s
[19:24:13.597] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:25:0)
[19:24:13.597] Timer tick, asking Buildbucket for the build status
[19:24:13.708] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:13.708] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:26:0) after 1m0s
[19:25:13.803] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:26:0)
[19:25:13.803] Timer tick, asking Buildbucket for the build status
[19:25:15.496] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:15.496] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:27:0) after 1m0s
[19:26:15.551] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:27:0)
[19:26:15.551] Timer tick, asking Buildbucket for the build status
[19:26:15.879] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:15.879] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:28:0) after 1m0s
[19:27:15.944] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:28:0)
[19:27:15.944] Timer tick, asking Buildbucket for the build status
[19:27:16.263] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:16.263] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:29:0) after 1m0s
[19:28:16.353] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:29:0)
[19:28:16.353] Timer tick, asking Buildbucket for the build status
[19:28:16.786] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:16.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:30:0) after 1m0s
[19:29:16.861] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:30:0)
[19:29:16.861] Timer tick, asking Buildbucket for the build status
[19:29:19.534] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:19.534] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:31:0) after 1m0s
[19:30:19.578] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:31:0)
[19:30:19.578] Timer tick, asking Buildbucket for the build status
[19:30:19.813] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:19.813] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:32:0) after 1m0s
[19:31:19.866] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:32:0)
[19:31:19.866] Timer tick, asking Buildbucket for the build status
[19:31:20.402] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:20.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:33:0) after 1m0s
[19:32:20.446] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:33:0)
[19:32:20.446] Timer tick, asking Buildbucket for the build status
[19:32:20.737] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:20.737] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:34:0) after 1m0s
[19:33:20.913] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:34:0)
[19:33:20.913] Timer tick, asking Buildbucket for the build status
[19:33:21.483] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:21.483] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:35:0) after 1m0s
[19:34:21.540] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:35:0)
[19:34:21.540] Timer tick, asking Buildbucket for the build status
[19:34:22.125] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:22.125] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:36:0) after 1m0s
[19:35:22.336] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:36:0)
[19:35:22.336] Timer tick, asking Buildbucket for the build status
[19:35:23.229] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:23.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:37:0) after 1m0s
[19:36:23.246] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:37:0)
[19:36:23.246] Timer tick, asking Buildbucket for the build status
[19:36:23.492] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:23.492] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:38:0) after 1m0s
[19:37:23.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:38:0)
[19:37:23.514] Timer tick, asking Buildbucket for the build status
[19:37:25.824] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:25.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:39:0) after 1m0s
[19:38:25.879] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:39:0)
[19:38:25.879] Timer tick, asking Buildbucket for the build status
[19:38:26.710] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:26.710] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:40:0) after 1m0s
[19:39:26.767] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:40:0)
[19:39:26.767] Timer tick, asking Buildbucket for the build status
[19:39:28.339] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:28.339] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:41:0) after 1m0s
[19:40:28.390] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:41:0)
[19:40:28.390] Timer tick, asking Buildbucket for the build status
[19:40:28.753] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:28.753] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:42:0) after 1m0s
[19:41:28.747] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:42:0)
[19:41:28.747] Timer tick, asking Buildbucket for the build status
[19:41:29.074] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:29.074] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:43:0) after 1m0s
[19:42:29.115] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:43:0)
[19:42:29.115] Timer tick, asking Buildbucket for the build status
[19:42:29.744] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:29.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:44:0) after 1m0s
[19:43:29.793] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:44:0)
[19:43:29.793] Timer tick, asking Buildbucket for the build status
[19:43:32.797] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:32.797] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:45:0) after 1m0s
[19:44:32.930] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:45:0)
[19:44:32.931] Timer tick, asking Buildbucket for the build status
[19:44:33.211] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:33.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:46:0) after 1m0s
[19:45:33.261] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:46:0)
[19:45:33.261] Timer tick, asking Buildbucket for the build status
[19:45:33.727] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:33.727] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:47:0) after 1m0s
[19:46:33.782] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:47:0)
[19:46:33.782] Timer tick, asking Buildbucket for the build status
[19:46:34.735] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:34.735] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:48:0) after 1m0s
[19:47:34.835] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:48:0)
[19:47:34.835] Timer tick, asking Buildbucket for the build status
[19:47:35.044] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:35.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:49:0) after 1m0s
[19:48:35.573] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:49:0)
[19:48:35.573] Timer tick, asking Buildbucket for the build status
[19:48:38.571] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:38.571] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:50:0) after 1m0s
[19:49:38.704] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:50:0)
[19:49:38.704] Timer tick, asking Buildbucket for the build status
[19:49:39.187] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:39.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:51:0) after 1m0s
[19:50:39.227] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:51:0)
[19:50:39.227] Timer tick, asking Buildbucket for the build status
[19:50:41.316] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:41.316] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:52:0) after 1m0s
[19:51:41.385] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:52:0)
[19:51:41.385] Timer tick, asking Buildbucket for the build status
[19:51:41.507] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:41.507] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:53:0) after 1m0s
[19:52:41.669] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:53:0)
[19:52:41.669] Timer tick, asking Buildbucket for the build status
[19:52:43.674] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:43.674] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:54:0) after 1m0s
[19:53:43.751] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:54:0)
[19:53:43.751] Timer tick, asking Buildbucket for the build status
[19:53:44.503] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:44.503] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:55:0) after 1m0s
[19:54:44.655] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:55:0)
[19:54:44.655] Timer tick, asking Buildbucket for the build status
[19:54:47.344] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:47.344] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:56:0) after 1m0s
[19:55:47.323] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:56:0)
[19:55:47.323] Timer tick, asking Buildbucket for the build status
[19:55:47.530] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:47.530] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:57:0) after 1m0s
[19:56:47.572] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:57:0)
[19:56:47.572] Timer tick, asking Buildbucket for the build status
[19:56:50.887] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:50.887] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:58:0) after 1m0s
[19:57:50.921] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:58:0)
[19:57:50.921] Timer tick, asking Buildbucket for the build status
[19:57:51.108] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:51.108] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:59:0) after 1m0s
[19:58:51.489] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:59:0)
[19:58:51.489] Timer tick, asking Buildbucket for the build status
[19:58:54.029] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:54.029] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:60:0) after 1m0s
[19:59:54.111] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:60:0)
[19:59:54.111] Timer tick, asking Buildbucket for the build status
[19:59:54.709] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:54.709] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:61:0) after 1m0s
[20:00:54.766] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:61:0)
[20:00:54.766] Timer tick, asking Buildbucket for the build status
[20:00:54.938] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:54.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:62:0) after 1m0s
[20:01:55.193] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:62:0)
[20:01:55.193] Timer tick, asking Buildbucket for the build status
[20:01:55.352] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:55.352] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:63:0) after 1m0s
[20:02:56.403] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:63:0)
[20:02:56.403] Timer tick, asking Buildbucket for the build status
[20:02:56.675] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:56.675] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:64:0) after 1m0s
[20:03:56.973] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:64:0)
[20:03:56.973] Timer tick, asking Buildbucket for the build status
[20:03:57.123] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:57.123] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:65:0) after 1m0s
[20:04:57.362] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:65:0)
[20:04:57.362] Timer tick, asking Buildbucket for the build status
[20:04:57.480] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:57.480] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:66:0) after 1m0s
[20:05:57.818] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:66:0)
[20:05:57.818] Timer tick, asking Buildbucket for the build status
[20:05:59.719] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:59.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:67:0) after 1m0s
[20:07:00.261] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:67:0)
[20:07:00.261] Timer tick, asking Buildbucket for the build status
[20:07:00.767] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:00.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:68:0) after 1m0s
[20:08:00.871] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:68:0)
[20:08:00.871] Timer tick, asking Buildbucket for the build status
[20:08:04.124] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:04.124] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:69:0) after 1m0s
[20:09:04.225] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:69:0)
[20:09:04.225] Timer tick, asking Buildbucket for the build status
[20:09:06.174] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:06.174] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:70:0) after 1m0s
[20:10:06.280] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:70:0)
[20:10:06.280] Timer tick, asking Buildbucket for the build status
[20:10:07.922] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:07.922] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:71:0) after 1m0s
[20:11:08.010] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:71:0)
[20:11:08.010] Timer tick, asking Buildbucket for the build status
[20:11:08.786] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:08.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:72:0) after 1m0s
[20:12:08.828] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:72:0)
[20:12:08.828] Timer tick, asking Buildbucket for the build status
[20:12:09.376] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:09.376] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:73:0) after 1m0s
[20:13:09.411] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:73:0)
[20:13:09.411] Timer tick, asking Buildbucket for the build status
[20:13:09.792] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:09.792] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:74:0) after 1m0s
[20:14:10.101] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:74:0)
[20:14:10.102] Timer tick, asking Buildbucket for the build status
[20:14:10.667] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:10.667] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:75:0) after 1m0s
[20:15:10.688] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:75:0)
[20:15:10.688] Timer tick, asking Buildbucket for the build status
[20:15:12.311] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:12.311] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:76:0) after 1m0s
[20:16:12.348] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:76:0)
[20:16:12.348] Timer tick, asking Buildbucket for the build status
[20:16:14.808] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:14.808] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:77:0) after 1m0s
[20:17:14.898] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:77:0)
[20:17:14.899] Timer tick, asking Buildbucket for the build status
[20:17:17.267] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:17.267] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:78:0) after 1m0s
[20:18:17.295] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:78:0)
[20:18:17.296] Timer tick, asking Buildbucket for the build status
[20:18:17.408] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:17.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:79:0) after 1m0s
[20:19:17.477] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:79:0)
[20:19:17.477] Timer tick, asking Buildbucket for the build status
[20:19:18.152] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:18.152] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:80:0) after 1m0s
[20:20:18.263] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:80:0)
[20:20:18.263] Timer tick, asking Buildbucket for the build status
[20:20:21.186] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:21.186] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:81:0) after 1m0s
[20:21:21.243] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:81:0)
[20:21:21.243] Timer tick, asking Buildbucket for the build status
[20:21:21.363] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:21.363] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:82:0) after 1m0s
[20:22:21.415] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:82:0)
[20:22:21.415] Timer tick, asking Buildbucket for the build status
[20:22:24.007] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:24.007] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:83:0) after 1m0s
[20:23:24.053] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:83:0)
[20:23:24.053] Timer tick, asking Buildbucket for the build status
[20:23:25.072] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:25.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:84:0) after 1m0s
[20:24:25.152] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:84:0)
[20:24:25.152] Timer tick, asking Buildbucket for the build status
[20:24:25.737] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:25.737] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:85:0) after 1m0s
[20:25:25.729] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:85:0)
[20:25:25.729] Timer tick, asking Buildbucket for the build status
[20:25:26.628] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:26.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:86:0) after 1m0s
[20:26:26.712] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:86:0)
[20:26:26.712] Timer tick, asking Buildbucket for the build status
[20:26:27.046] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:27.046] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:87:0) after 1m0s
[20:27:27.135] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:87:0)
[20:27:27.135] Timer tick, asking Buildbucket for the build status
[20:27:27.617] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:27.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:88:0) after 1m0s
[20:28:27.649] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:88:0)
[20:28:27.649] Timer tick, asking Buildbucket for the build status
[20:28:28.429] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:28.429] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:89:0) after 1m0s
[20:29:28.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:89:0)
[20:29:28.495] Timer tick, asking Buildbucket for the build status
[20:29:29.004] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:29.005] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:90:0) after 1m0s
[20:30:29.076] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:90:0)
[20:30:29.076] Timer tick, asking Buildbucket for the build status
[20:30:29.744] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:29.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:91:0) after 1m0s
[20:31:29.765] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:91:0)
[20:31:29.765] Timer tick, asking Buildbucket for the build status
[20:31:30.103] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:30.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:92:0) after 1m0s
[20:32:30.126] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:92:0)
[20:32:30.126] Timer tick, asking Buildbucket for the build status
[20:32:30.583] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:30.583] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:93:0) after 1m0s
[20:33:30.626] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:93:0)
[20:33:30.626] Timer tick, asking Buildbucket for the build status
[20:33:34.847] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:34.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:94:0) after 1m0s
[20:34:34.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:94:0)
[20:34:34.925] Timer tick, asking Buildbucket for the build status
[20:34:36.046] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:36.046] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:95:0) after 1m0s
[20:35:36.103] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:95:0)
[20:35:36.103] Timer tick, asking Buildbucket for the build status
[20:35:36.506] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:36.506] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:96:0) after 1m0s
[20:36:36.592] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:96:0)
[20:36:36.592] Timer tick, asking Buildbucket for the build status
[20:36:36.739] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:36.739] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:97:0) after 1m0s
[20:37:36.754] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:97:0)
[20:37:36.754] Timer tick, asking Buildbucket for the build status
[20:37:36.931] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:36.931] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:98:0) after 1m0s
[20:38:36.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:98:0)
[20:38:36.983] Timer tick, asking Buildbucket for the build status
[20:38:39.707] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:39.707] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:99:0) after 1m0s
[20:39:39.800] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:99:0)
[20:39:39.800] Timer tick, asking Buildbucket for the build status
[20:39:39.962] Build 8911465513185927296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:39.962] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9076895578399096768:100:0) after 1m0s
[20:39:51.952] Received PubSub notification, asking Buildbucket for the build status
[20:39:53.866] Build 8911465513185927296: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[20:39:53.866] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1559767189189852",
"created_by": "project:chromium",
"created_ts": "1559761240742731",
"failure_reason": "BUILD_FAILURE",
"id": "8911465513185927296",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"a1c5c417186fb3739ac0c0706f17f554a842aec6\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"2 tests failed: ['viz_browser_tests', 'unit_tests']\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"swarm1567-c4\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 12742, \"got_angle_revision\": \"4a75741655d330e257b2f20d7404cce1e51ef72e\", \"got_dawn_revision\": \"b632bc58ed373eb2020af65e0fdeaf07d46d1a9c\", \"got_nacl_revision\": \"0ddc033406886a709b901e0c312872529f9705e8\", \"got_revision\": \"a1c5c417186fb3739ac0c0706f17f554a842aec6\", \"got_revision_cp\": \"refs/heads/master@{#666390}\", \"got_swarming_client_revision\": \"9b1b0ed1f31dd42b128ae88ce50c2ab1f87ebaeb\", \"got_v8_revision\": \"13da560bef16ab254fe91e85541f8dd4db6c337a\", \"got_v8_revision_cp\": \"refs/heads/7.7.18@{#1}\", \"got_webrtc_revision\": \"479a3c0f92b957a9ba1c242e7fe6e4d37b49ce32\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28154}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.chromiumos\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"a1c5c417186fb3739ac0c0706f17f554a842aec6\", \"swarm_hashes\": {\"accessibility_unittests\": \"ac9be63c69aa63a7ce61636e6f155bfb739c5934\", \"angle_unittests\": \"b5f78180cba94e91a75f0673bc5079169d78ee4a\", \"app_list_unittests\": \"844fdd1cfd9e9805b5ec65dfa224717d7e3a3b30\", \"app_shell_unittests\": \"4223dc2fac903ba16bbdc6288c46aa0c6b6aa681\", \"ash_unittests\": \"a17c8d55448ce7ce2ee66da541aa55027a7413a6\", \"aura_unittests\": \"0a56715feea369fdb1f586301793d39fe3b82642\", \"base_unittests\": \"8b12b7c9f2fb8d4d407b35e6c320b37f83d649b6\", \"base_util_unittests\": \"54659f15574522e68da5684bacd3b0f300555ac2\", \"blink_common_unittests\": \"abdd824b9d4247f40e3ada7c0c4994bc9bb0ed46\", \"blink_fuzzer_unittests\": \"27b09e2a200762330d1ed4e3469bccf364835585\", \"blink_heap_unittests\": \"5106d49362a81876b1e63c62e39114ddd2365245\", \"blink_platform_unittests\": \"e94ef6a4300b6e9b2c26bc08eb330740b1d27bf1\", \"blink_unittests\": \"176be3709d272e5469a62b911e22edc8bee8f778\", \"boringssl_crypto_tests\": \"c13a40e5370633c86bdde049ae42cd3129a0dbb6\", \"boringssl_ssl_tests\": \"e2793df2a560a70f6536530dd0ab9266b7806de7\", \"browser_tests\": \"a4ae2c14e26346473f9977923652ea0c385f14ea\", \"cacheinvalidation_unittests\": \"49303066b120078df6c73ec34f51c7a72ad8fb28\", \"capture_unittests\": \"fbfa098d8779c0e08a0eef8fee77cadf35331299\", \"cast_unittests\": \"2347c29a9e78a4db68a135710a381ae528e4f092\", \"cc_unittests\": \"ca72433b59d7d23ff8639861b85a2a3aa456717e\", \"chrome_app_unittests\": \"d01f5d1bc13199c6b4e93ff0973357cc13483f4b\", \"chromedriver_unittests\": \"bcc53bd7ecbbae42d680da5ebcaa1b572b392a43\", \"chromeos_components_unittests\": \"c74e66e85416c51ea34c2e8679c2437bbe872cef\", \"chromeos_unittests\": \"5e2a78294794e1115c4e5e90bd19e75ece0bcc74\", \"components_browsertests\": \"b43c6aa9a339bb52776a7cb24936021520ebf01a\", \"components_unittests\": \"a3695a3f63ba438599abb9a5025e3f7f8dfb6df4\", \"compositor_unittests\": \"19950d19a4979a5c3903a6ce0ad4965fb581aff1\", \"content_browsertests\": \"36eb725cc0fe663db1a4c3d3e41ffd5b1630bb38\", \"content_unittests\": \"d9ac53a3ab4b464fab8a27193de81b9a096f73c9\", \"crypto_unittests\": \"08c8dad4c434d705051306c233fe37ad63997416\", \"dbus_unittests\": \"c602b50a57c37fd030f85656352056d2d777bd01\", \"device_unittests\": \"c2833ac8e4164e04eabef32a2cc05df76d5cdcde\", \"display_unittests\": \"796bc7a4ff306ee762481eb072ba67860c3443a7\", \"events_unittests\": \"0ebf1344fa25c731eb6ebae0871e4428bed4971b\", \"exo_unittests\": \"631fdcd75b723d661aa3830c1379cc360a2db90d\", \"extensions_browsertests\": \"39be2a9fc26a68180a4e5ba5d9d9724dabfa7b08\", \"extensions_unittests\": \"c6c67a62114449b5c1d0da87898eca758afb74ec\", \"filesystem_service_unittests\": \"f0c60a67d6c75da4e6c649b539200c5ffa33905f\", \"gcm_unit_tests\": \"eb9ac45dd2e709ac972703277c3f53206efcf1d8\", \"gfx_unittests\": \"0f92fd96295d0d6f745a198117a6e8ffb69cbecc\", \"gin_unittests\": \"60cb99d4c0f09a665dc10d8432afd150e0cf4d11\", \"gl_unittests_ozone\": \"34d7f0c79b963e206e68d5376cb9e0fe826067cf\", \"google_apis_unittests\": \"55fd259ceed592ef05bc41d52d972f0ec2cccf90\", \"gpu_unittests\": \"9d87bf0076d7091deb8fb9eb66f9b79a3b4e8023\", \"interactive_ui_tests\": \"cbba1b1b69b26d12e0b3038cb7d07589c63e9ed0\", \"ipc_tests\": \"e1f0960d1039a2935ead0a075638943be0865a43\", \"jingle_unittests\": \"6e15293bdd845322bc7ed92cfde5a4c9dc1fcc9c\", \"keyboard_unittests\": \"a3066338ba42ac45d585a7b16d19e81fa317f7c0\", \"latency_unittests\": \"e0a42a3d9e442aaf9874afb88338624e9c58265b\", \"leveldb_service_unittests\": \"bb16028a4e5eaa08bb09ffa2d543f049617f543a\", \"libjingle_xmpp_unittests\": \"3e95892e9b05f93a6c7b52e1afb421835ed6a8ce\", \"media_blink_unittests\": \"a269c535ec58f5e7ae2783dd59f7cc1b49d9cc1e\", \"media_service_unittests\": \"be104da5eb2aeb483ff3b859505826c532d50a88\", \"media_unittests\": \"75a2167689006841de143f21a8c2f4752b00e77e\", \"message_center_unittests\": \"66c0ef285cf8b247c171776b484a557c1d72d1ad\", \"midi_unittests\": \"58e6a7f86dda6c27faa1211747c32310b82c88ce\", \"mojo_core_unittests\": \"a77060c4a3c2ff6cbd2a2fd4f2d855e265841fcb\", \"mojo_unittests\": \"ac61362dc3662f1c4458f4ff56584d3b9f230499\", \"nacl_helper_nonsfi_unittests\": \"80c064ac68795e2ffb6d8ad76c034d98e9687cf5\", \"nacl_loader_unittests\": \"f18f54212c332e6747e896883885c791a62da6c0\", \"native_theme_unittests\": \"bc2696f5f160662ba63cb4dd8f90e7a452dd96a2\", \"net_unittests\": \"8a135296726575e395ee95d27d623f5b1c952cbb\", \"ozone_gl_unittests\": \"2324d03d5803bf490c653fda348833b7b0bc580e\", \"ozone_unittests\": \"d0e63fd12ecd68909dcd36f31435ad27ab6c1822\", \"ozone_x11_unittests\": \"e5dac1b2b3e9c921c91669fef45d00dc376df67a\", \"pdf_unittests\": \"aff9c650af750558f72f9fcf71e63b791a80fbe6\", \"perfetto_unittests\": \"0b95bc94d40e86ffb92dd546f67b8d9d9d0f19c3\", \"ppapi_unittests\": \"0d5b2647fbcddac84971816b0e199a28ba982938\", \"printing_unittests\": \"d800b38990a42efcc5ce8b3f18e77f0ce4e9517c\", \"remoting_unittests\": \"4d8f86ff6f55ea37717e2210c9337df5c60354e2\", \"sandbox_linux_unittests\": \"5a480b4584122fa917a3877379e9ed11da815084\", \"service_manager_unittests\": \"9ded2abf82a44af3c1c6afa8f16f03ce4dda9329\", \"services_unittests\": \"19b4fe940163107f8d088fef25c0ca60d5418bc8\", \"shell_dialogs_unittests\": \"338c4968ddfa67aae507f511d777cb0b25917e67\", \"skia_unittests\": \"fe9abe6ef0d22f0ca4a62c3bce120162ec4be63d\", \"snapshot_unittests\": \"0f94a3dba5382c46e410de8003ed196cfd6b3b62\", \"sql_unittests\": \"844d8a13f5221c26b757fc8a7d0f565e9966b7e0\", \"storage_unittests\": \"6f0fbed734a5116273e78c16e24ef2ab3c944ce7\", \"sync_integration_tests\": \"832d69003d675b5ea60234f38d17c95c42ae4776\", \"traffic_annotation_auditor_unittests\": \"0999281916a541e2f83223f267aa74e7f4a19a42\", \"ui_base_unittests\": \"e54502ac856a981374e787cc3de39e108e671a28\", \"ui_chromeos_unittests\": \"0fc84907407f167b2fb6415fd73e9bdb194754f6\", \"ui_touch_selection_unittests\": \"c9bcd9698878333a3fd834af95e4759e0320de81\", \"unit_tests\": \"0e8ef9dc64a866f01c1d44861b2460d68267b8cd\", \"url_unittests\": \"98f98fe38ad9d3efa72009274d3019eb656e47e0\", \"usage_time_limit_unittests\": \"499ac76cb6391dacc624c131973c40618b316e4a\", \"views_unittests\": \"34cdd64ff618518cad79966b753247e02f496063\", \"viz_unittests\": \"0d6c0db597028af979e71a058bc35a7f8900c2a2\", \"wm_unittests\": \"18499d00bbb05ff5875f85f60f80a14051d7e115\", \"wtf_unittests\": \"8ef9a5cd71256b42d6f9e35c3aebc64c1a9e7bd9\"}, \"swarm_hashes_refs/heads/master(at){#666390}_without_patch\": {\"accessibility_unittests\": \"ac9be63c69aa63a7ce61636e6f155bfb739c5934\", \"angle_unittests\": \"b5f78180cba94e91a75f0673bc5079169d78ee4a\", \"app_list_unittests\": \"844fdd1cfd9e9805b5ec65dfa224717d7e3a3b30\", \"app_shell_unittests\": \"4223dc2fac903ba16bbdc6288c46aa0c6b6aa681\", \"ash_unittests\": \"a17c8d55448ce7ce2ee66da541aa55027a7413a6\", \"aura_unittests\": \"0a56715feea369fdb1f586301793d39fe3b82642\", \"base_unittests\": \"8b12b7c9f2fb8d4d407b35e6c320b37f83d649b6\", \"base_util_unittests\": \"54659f15574522e68da5684bacd3b0f300555ac2\", \"blink_common_unittests\": \"abdd824b9d4247f40e3ada7c0c4994bc9bb0ed46\", \"blink_fuzzer_unittests\": \"27b09e2a200762330d1ed4e3469bccf364835585\", \"blink_heap_unittests\": \"5106d49362a81876b1e63c62e39114ddd2365245\", \"blink_platform_unittests\": \"e94ef6a4300b6e9b2c26bc08eb330740b1d27bf1\", \"blink_unittests\": \"176be3709d272e5469a62b911e22edc8bee8f778\", \"boringssl_crypto_tests\": \"c13a40e5370633c86bdde049ae42cd3129a0dbb6\", \"boringssl_ssl_tests\": \"e2793df2a560a70f6536530dd0ab9266b7806de7\", \"browser_tests\": \"a4ae2c14e26346473f9977923652ea0c385f14ea\", \"cacheinvalidation_unittests\": \"49303066b120078df6c73ec34f51c7a72ad8fb28\", \"capture_unittests\": \"fbfa098d8779c0e08a0eef8fee77cadf35331299\", \"cast_unittests\": \"2347c29a9e78a4db68a135710a381ae528e4f092\", \"cc_unittests\": \"ca72433b59d7d23ff8639861b85a2a3aa456717e\", \"chrome_app_unittests\": \"d01f5d1bc13199c6b4e93ff0973357cc13483f4b\", \"chromedriver_unittests\": \"bcc53bd7ecbbae42d680da5ebcaa1b572b392a43\", \"chromeos_components_unittests\": \"c74e66e85416c51ea34c2e8679c2437bbe872cef\", \"chromeos_unittests\": \"5e2a78294794e1115c4e5e90bd19e75ece0bcc74\", \"components_browsertests\": \"b43c6aa9a339bb52776a7cb24936021520ebf01a\", \"components_unittests\": \"a3695a3f63ba438599abb9a5025e3f7f8dfb6df4\", \"compositor_unittests\": \"19950d19a4979a5c3903a6ce0ad4965fb581aff1\", \"content_browsertests\": \"36eb725cc0fe663db1a4c3d3e41ffd5b1630bb38\", \"content_unittests\": \"d9ac53a3ab4b464fab8a27193de81b9a096f73c9\", \"crypto_unittests\": \"08c8dad4c434d705051306c233fe37ad63997416\", \"dbus_unittests\": \"c602b50a57c37fd030f85656352056d2d777bd01\", \"device_unittests\": \"c2833ac8e4164e04eabef32a2cc05df76d5cdcde\", \"display_unittests\": \"796bc7a4ff306ee762481eb072ba67860c3443a7\", \"events_unittests\": \"0ebf1344fa25c731eb6ebae0871e4428bed4971b\", \"exo_unittests\": \"631fdcd75b723d661aa3830c1379cc360a2db90d\", \"extensions_browsertests\": \"39be2a9fc26a68180a4e5ba5d9d9724dabfa7b08\", \"extensions_unittests\": \"c6c67a62114449b5c1d0da87898eca758afb74ec\", \"filesystem_service_unittests\": \"f0c60a67d6c75da4e6c649b539200c5ffa33905f\", \"gcm_unit_tests\": \"eb9ac45dd2e709ac972703277c3f53206efcf1d8\", \"gfx_unittests\": \"0f92fd96295d0d6f745a198117a6e8ffb69cbecc\", \"gin_unittests\": \"60cb99d4c0f09a665dc10d8432afd150e0cf4d11\", \"gl_unittests_ozone\": \"34d7f0c79b963e206e68d5376cb9e0fe826067cf\", \"google_apis_unittests\": \"55fd259ceed592ef05bc41d52d972f0ec2cccf90\", \"gpu_unittests\": \"9d87bf0076d7091deb8fb9eb66f9b79a3b4e8023\", \"interactive_ui_tests\": \"cbba1b1b69b26d12e0b3038cb7d07589c63e9ed0\", \"ipc_tests\": \"e1f0960d1039a2935ead0a075638943be0865a43\", \"jingle_unittests\": \"6e15293bdd845322bc7ed92cfde5a4c9dc1fcc9c\", \"keyboard_unittests\": \"a3066338ba42ac45d585a7b16d19e81fa317f7c0\", \"latency_unittests\": \"e0a42a3d9e442aaf9874afb88338624e9c58265b\", \"leveldb_service_unittests\": \"bb16028a4e5eaa08bb09ffa2d543f049617f543a\", \"libjingle_xmpp_unittests\": \"3e95892e9b05f93a6c7b52e1afb421835ed6a8ce\", \"media_blink_unittests\": \"a269c535ec58f5e7ae2783dd59f7cc1b49d9cc1e\", \"media_service_unittests\": \"be104da5eb2aeb483ff3b859505826c532d50a88\", \"media_unittests\": \"75a2167689006841de143f21a8c2f4752b00e77e\", \"message_center_unittests\": \"66c0ef285cf8b247c171776b484a557c1d72d1ad\", \"midi_unittests\": \"58e6a7f86dda6c27faa1211747c32310b82c88ce\", \"mojo_core_unittests\": \"a77060c4a3c2ff6cbd2a2fd4f2d855e265841fcb\", \"mojo_unittests\": \"ac61362dc3662f1c4458f4ff56584d3b9f230499\", \"nacl_helper_nonsfi_unittests\": \"80c064ac68795e2ffb6d8ad76c034d98e9687cf5\", \"nacl_loader_unittests\": \"f18f54212c332e6747e896883885c791a62da6c0\", \"native_theme_unittests\": \"bc2696f5f160662ba63cb4dd8f90e7a452dd96a2\", \"net_unittests\": \"8a135296726575e395ee95d27d623f5b1c952cbb\", \"ozone_gl_unittests\": \"2324d03d5803bf490c653fda348833b7b0bc580e\", \"ozone_unittests\": \"d0e63fd12ecd68909dcd36f31435ad27ab6c1822\", \"ozone_x11_unittests\": \"e5dac1b2b3e9c921c91669fef45d00dc376df67a\", \"pdf_unittests\": \"aff9c650af750558f72f9fcf71e63b791a80fbe6\", \"perfetto_unittests\": \"0b95bc94d40e86ffb92dd546f67b8d9d9d0f19c3\", \"ppapi_unittests\": \"0d5b2647fbcddac84971816b0e199a28ba982938\", \"printing_unittests\": \"d800b38990a42efcc5ce8b3f18e77f0ce4e9517c\", \"remoting_unittests\": \"4d8f86ff6f55ea37717e2210c9337df5c60354e2\", \"sandbox_linux_unittests\": \"5a480b4584122fa917a3877379e9ed11da815084\", \"service_manager_unittests\": \"9ded2abf82a44af3c1c6afa8f16f03ce4dda9329\", \"services_unittests\": \"19b4fe940163107f8d088fef25c0ca60d5418bc8\", \"shell_dialogs_unittests\": \"338c4968ddfa67aae507f511d777cb0b25917e67\", \"skia_unittests\": \"fe9abe6ef0d22f0ca4a62c3bce120162ec4be63d\", \"snapshot_unittests\": \"0f94a3dba5382c46e410de8003ed196cfd6b3b62\", \"sql_unittests\": \"844d8a13f5221c26b757fc8a7d0f565e9966b7e0\", \"storage_unittests\": \"6f0fbed734a5116273e78c16e24ef2ab3c944ce7\", \"sync_integration_tests\": \"832d69003d675b5ea60234f38d17c95c42ae4776\", \"traffic_annotation_auditor_unittests\": \"0999281916a541e2f83223f267aa74e7f4a19a42\", \"ui_base_unittests\": \"e54502ac856a981374e787cc3de39e108e671a28\", \"ui_chromeos_unittests\": \"0fc84907407f167b2fb6415fd73e9bdb194754f6\", \"ui_touch_selection_unittests\": \"c9bcd9698878333a3fd834af95e4759e0320de81\", \"unit_tests\": \"0e8ef9dc64a866f01c1d44861b2460d68267b8cd\", \"url_unittests\": \"98f98fe38ad9d3efa72009274d3019eb656e47e0\", \"usage_time_limit_unittests\": \"499ac76cb6391dacc624c131973c40618b316e4a\", \"views_unittests\": \"34cdd64ff618518cad79966b753247e02f496063\", \"viz_unittests\": \"0d6c0db597028af979e71a058bc35a7f8900c2a2\", \"wm_unittests\": \"18499d00bbb05ff5875f85f60f80a14051d7e115\", \"wtf_unittests\": \"8ef9a5cd71256b42d6f9e35c3aebc64c1a9e7bd9\"}}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"linux-chromeos-dbg\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"swarm1567-c4\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4316-effbcfc\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"2 tests failed: ['viz_browser_tests', 'unit_tests']\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1559761478761567",
"status": "COMPLETED",
"status_changed_ts": "1559761480192186",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/12742",
"builder:linux-chromeos-dbg",
"buildset:commit/git/a1c5c417186fb3739ac0c0706f17f554a842aec6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a1c5c417186fb3739ac0c0706f17f554a842aec6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9076895578399096768",
"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/8911465513185927296/+/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:4541d5a168117110",
"user_agent:luci-scheduler"
],
"updated_ts": "1559767191557653",
"url": "https://ci.chromium.org/b/8911465513185927296",
"utcnow_ts": "1559767193818562"
}
}
[20:39:53.866] Invocation finished in 1h39m17.47904854s with status FAILED