[16:17:56.118] New invocation is queued and will start shortly
[16:17:57.304] Starting the invocation (attempt 1)
[16:17:57.351] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:17:57.357] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:17:57.357] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9083609988318600480",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"bb9a0ad50c8ef3ab2b4498c265f0ddf2b1f5d0cb\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9083609988318600480",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/bb9a0ad50c8ef3ab2b4498c265f0ddf2b1f5d0cb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bb9a0ad50c8ef3ab2b4498c265f0ddf2b1f5d0cb",
"gitiles_ref:refs/heads/master"
]
}
[16:17:58.551] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "project:chromium",
"created_ts": "1553357877499512",
"id": "8918179926202335456",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"bb9a0ad50c8ef3ab2b4498c265f0ddf2b1f5d0cb\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1553357878441515",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/11514",
"builder:linux-chromeos-dbg",
"buildset:commit/git/bb9a0ad50c8ef3ab2b4498c265f0ddf2b1f5d0cb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bb9a0ad50c8ef3ab2b4498c265f0ddf2b1f5d0cb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9083609988318600480",
"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/8918179926202335456/+/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:43c429ba7890b010",
"user_agent:luci-scheduler"
],
"updated_ts": "1553357878441595",
"url": "https://ci.chromium.org/b/8918179926202335456",
"utcnow_ts": "1553357878538504"
}
}
[16:17:58.551] Task URL: https://ci.chromium.org/b/8918179926202335456
[16:17:58.551] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:2:0) after 1m0s
[16:18:58.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:2:0)
[16:18:58.527] Timer tick, asking Buildbucket for the build status
[16:18:58.922] Build 8918179926202335456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:18:58.922] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:3:0) after 1m0s
[16:19:52.323] Received PubSub notification, asking Buildbucket for the build status
[16:19:52.440] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:58.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:3:0)
[16:19:58.941] Timer tick, asking Buildbucket for the build status
[16:19:59.150] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:59.150] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:5:0) after 1m0s
[16:20:59.156] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:5:0)
[16:20:59.156] Timer tick, asking Buildbucket for the build status
[16:20:59.260] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:59.260] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:6:0) after 1m0s
[16:21:59.259] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:6:0)
[16:21:59.259] Timer tick, asking Buildbucket for the build status
[16:21:59.828] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:59.828] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:7:0) after 1m0s
[16:22:59.803] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:7:0)
[16:22:59.803] Timer tick, asking Buildbucket for the build status
[16:23:00.375] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:00.375] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:8:0) after 1m0s
[16:24:00.383] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:8:0)
[16:24:00.383] Timer tick, asking Buildbucket for the build status
[16:24:00.656] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:00.656] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:9:0) after 1m0s
[16:25:00.676] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:9:0)
[16:25:00.676] Timer tick, asking Buildbucket for the build status
[16:25:01.034] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:01.034] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:10:0) after 1m0s
[16:26:01.048] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:10:0)
[16:26:01.048] Timer tick, asking Buildbucket for the build status
[16:26:01.609] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:01.609] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:11:0) after 1m0s
[16:27:01.601] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:11:0)
[16:27:01.601] Timer tick, asking Buildbucket for the build status
[16:27:01.769] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:01.769] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:12:0) after 1m0s
[16:28:01.791] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:12:0)
[16:28:01.791] Timer tick, asking Buildbucket for the build status
[16:28:02.231] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:02.231] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:13:0) after 1m0s
[16:29:02.259] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:13:0)
[16:29:02.259] Timer tick, asking Buildbucket for the build status
[16:29:02.510] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:02.510] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:14:0) after 1m0s
[16:30:02.499] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:14:0)
[16:30:02.499] Timer tick, asking Buildbucket for the build status
[16:30:02.633] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:02.633] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:15:0) after 1m0s
[16:31:02.640] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:15:0)
[16:31:02.640] Timer tick, asking Buildbucket for the build status
[16:31:02.763] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:02.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:16:0) after 1m0s
[16:32:02.733] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:16:0)
[16:32:02.733] Timer tick, asking Buildbucket for the build status
[16:32:02.957] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:02.957] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:17:0) after 1m0s
[16:33:02.979] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:17:0)
[16:33:02.979] Timer tick, asking Buildbucket for the build status
[16:33:03.071] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:03.071] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:18:0) after 1m0s
[16:34:03.064] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:18:0)
[16:34:03.064] Timer tick, asking Buildbucket for the build status
[16:34:05.038] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:05.038] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:19:0) after 1m0s
[16:35:05.029] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:19:0)
[16:35:05.029] Timer tick, asking Buildbucket for the build status
[16:35:05.143] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:05.143] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:20:0) after 1m0s
[16:36:05.125] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:20:0)
[16:36:05.125] Timer tick, asking Buildbucket for the build status
[16:36:05.272] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:05.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:21:0) after 1m0s
[16:37:05.293] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:21:0)
[16:37:05.293] Timer tick, asking Buildbucket for the build status
[16:37:05.475] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:05.475] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:22:0) after 1m0s
[16:38:05.476] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:22:0)
[16:38:05.476] Timer tick, asking Buildbucket for the build status
[16:38:06.127] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:06.127] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:23:0) after 1m0s
[16:39:06.148] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:23:0)
[16:39:06.148] Timer tick, asking Buildbucket for the build status
[16:39:06.707] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:06.707] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:24:0) after 1m0s
[16:40:06.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:24:0)
[16:40:06.730] Timer tick, asking Buildbucket for the build status
[16:40:06.839] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:06.839] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:25:0) after 1m0s
[16:41:06.858] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:25:0)
[16:41:06.858] Timer tick, asking Buildbucket for the build status
[16:41:06.937] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:06.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:26:0) after 1m0s
[16:42:06.947] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:26:0)
[16:42:06.947] Timer tick, asking Buildbucket for the build status
[16:42:07.068] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:07.068] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:27:0) after 1m0s
[16:43:07.062] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:27:0)
[16:43:07.062] Timer tick, asking Buildbucket for the build status
[16:43:07.680] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:07.680] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:28:0) after 1m0s
[16:44:07.698] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:28:0)
[16:44:07.698] Timer tick, asking Buildbucket for the build status
[16:44:07.884] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:07.884] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:29:0) after 1m0s
[16:45:07.900] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:29:0)
[16:45:07.900] Timer tick, asking Buildbucket for the build status
[16:45:08.054] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:08.054] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:30:0) after 1m0s
[16:46:08.108] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:30:0)
[16:46:08.108] Timer tick, asking Buildbucket for the build status
[16:46:08.227] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:08.227] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:31:0) after 1m0s
[16:47:08.255] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:31:0)
[16:47:08.255] Timer tick, asking Buildbucket for the build status
[16:47:08.677] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:08.677] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:32:0) after 1m0s
[16:48:08.694] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:32:0)
[16:48:08.694] Timer tick, asking Buildbucket for the build status
[16:48:09.003] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:09.003] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:33:0) after 1m0s
[16:49:09.014] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:33:0)
[16:49:09.014] Timer tick, asking Buildbucket for the build status
[16:49:09.406] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:09.406] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:34:0) after 1m0s
[16:50:09.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:34:0)
[16:50:09.402] Timer tick, asking Buildbucket for the build status
[16:50:09.524] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:09.524] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:35:0) after 1m0s
[16:51:09.546] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:35:0)
[16:51:09.546] Timer tick, asking Buildbucket for the build status
[16:51:09.902] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:09.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:36:0) after 1m0s
[16:52:09.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:36:0)
[16:52:09.920] Timer tick, asking Buildbucket for the build status
[16:52:10.892] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:10.892] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:37:0) after 1m0s
[16:53:10.867] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:37:0)
[16:53:10.867] Timer tick, asking Buildbucket for the build status
[16:53:13.904] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:13.904] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:38:0) after 1m0s
[16:54:13.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:38:0)
[16:54:13.934] Timer tick, asking Buildbucket for the build status
[16:54:14.386] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:14.386] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:39:0) after 1m0s
[16:55:14.456] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:39:0)
[16:55:14.456] Timer tick, asking Buildbucket for the build status
[16:55:14.666] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:14.666] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:40:0) after 1m0s
[16:56:14.686] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:40:0)
[16:56:14.686] Timer tick, asking Buildbucket for the build status
[16:56:14.851] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:14.851] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:41:0) after 1m0s
[16:57:14.884] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:41:0)
[16:57:14.884] Timer tick, asking Buildbucket for the build status
[16:57:15.264] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:15.264] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:42:0) after 1m0s
[16:58:15.271] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:42:0)
[16:58:15.271] Timer tick, asking Buildbucket for the build status
[16:58:15.447] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:15.447] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:43:0) after 1m0s
[16:59:15.450] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:43:0)
[16:59:15.450] Timer tick, asking Buildbucket for the build status
[16:59:15.737] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:15.737] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:44:0) after 1m0s
[17:00:15.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:44:0)
[17:00:15.762] Timer tick, asking Buildbucket for the build status
[17:00:15.882] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:15.882] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:45:0) after 1m0s
[17:01:15.899] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:45:0)
[17:01:15.899] Timer tick, asking Buildbucket for the build status
[17:01:16.253] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:16.253] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:46:0) after 1m0s
[17:02:16.244] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:46:0)
[17:02:16.244] Timer tick, asking Buildbucket for the build status
[17:02:16.479] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:16.479] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:47:0) after 1m0s
[17:03:16.516] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:47:0)
[17:03:16.516] Timer tick, asking Buildbucket for the build status
[17:03:17.212] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:17.212] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:48:0) after 1m0s
[17:04:17.225] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:48:0)
[17:04:17.225] Timer tick, asking Buildbucket for the build status
[17:04:17.327] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:17.327] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:49:0) after 1m0s
[17:05:17.324] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:49:0)
[17:05:17.324] Timer tick, asking Buildbucket for the build status
[17:05:17.494] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:17.494] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:50:0) after 1m0s
[17:06:17.480] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:50:0)
[17:06:17.480] Timer tick, asking Buildbucket for the build status
[17:06:18.773] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:18.773] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:51:0) after 1m0s
[17:07:18.768] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:51:0)
[17:07:18.768] Timer tick, asking Buildbucket for the build status
[17:07:19.389] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:19.389] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:52:0) after 1m0s
[17:08:19.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:52:0)
[17:08:19.421] Timer tick, asking Buildbucket for the build status
[17:08:19.525] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:19.525] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:53:0) after 1m0s
[17:09:19.507] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:53:0)
[17:09:19.507] Timer tick, asking Buildbucket for the build status
[17:09:19.660] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:19.660] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:54:0) after 1m0s
[17:10:19.660] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:54:0)
[17:10:19.660] Timer tick, asking Buildbucket for the build status
[17:10:20.181] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:20.181] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:55:0) after 1m0s
[17:11:20.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:55:0)
[17:11:20.206] Timer tick, asking Buildbucket for the build status
[17:11:20.350] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:20.350] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:56:0) after 1m0s
[17:12:20.386] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:56:0)
[17:12:20.386] Timer tick, asking Buildbucket for the build status
[17:12:20.519] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:20.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:57:0) after 1m0s
[17:13:20.547] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:57:0)
[17:13:20.547] Timer tick, asking Buildbucket for the build status
[17:13:20.986] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:20.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:58:0) after 1m0s
[17:14:21.001] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:58:0)
[17:14:21.001] Timer tick, asking Buildbucket for the build status
[17:14:21.193] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:21.193] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:59:0) after 1m0s
[17:15:21.166] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:59:0)
[17:15:21.166] Timer tick, asking Buildbucket for the build status
[17:15:21.331] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:21.331] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:60:0) after 1m0s
[17:16:21.324] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:60:0)
[17:16:21.324] Timer tick, asking Buildbucket for the build status
[17:16:21.700] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:21.700] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:61:0) after 1m0s
[17:17:21.709] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:61:0)
[17:17:21.709] Timer tick, asking Buildbucket for the build status
[17:17:21.808] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:21.808] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:62:0) after 1m0s
[17:18:21.889] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:62:0)
[17:18:21.889] Timer tick, asking Buildbucket for the build status
[17:18:22.046] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:22.046] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:63:0) after 1m0s
[17:19:22.025] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:63:0)
[17:19:22.025] Timer tick, asking Buildbucket for the build status
[17:19:22.178] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:22.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:64:0) after 1m0s
[17:20:22.163] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:64:0)
[17:20:22.163] Timer tick, asking Buildbucket for the build status
[17:20:22.677] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:22.677] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:65:0) after 1m0s
[17:21:22.685] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:65:0)
[17:21:22.685] Timer tick, asking Buildbucket for the build status
[17:21:23.312] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:23.312] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:66:0) after 1m0s
[17:22:23.332] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:66:0)
[17:22:23.332] Timer tick, asking Buildbucket for the build status
[17:22:23.448] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:23.448] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:67:0) after 1m0s
[17:23:23.438] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:67:0)
[17:23:23.438] Timer tick, asking Buildbucket for the build status
[17:23:23.611] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:23.611] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:68:0) after 1m0s
[17:24:23.633] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:68:0)
[17:24:23.633] Timer tick, asking Buildbucket for the build status
[17:24:23.764] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:23.764] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:69:0) after 1m0s
[17:25:23.786] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:69:0)
[17:25:23.786] Timer tick, asking Buildbucket for the build status
[17:25:24.054] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:24.054] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:70:0) after 1m0s
[17:26:24.069] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:70:0)
[17:26:24.069] Timer tick, asking Buildbucket for the build status
[17:26:24.372] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:24.372] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:71:0) after 1m0s
[17:27:24.381] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:71:0)
[17:27:24.381] Timer tick, asking Buildbucket for the build status
[17:27:24.571] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:24.571] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:72:0) after 1m0s
[17:28:24.572] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:72:0)
[17:28:24.572] Timer tick, asking Buildbucket for the build status
[17:28:25.481] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:25.481] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:73:0) after 1m0s
[17:29:25.493] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:73:0)
[17:29:25.493] Timer tick, asking Buildbucket for the build status
[17:29:26.715] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:26.716] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:74:0) after 1m0s
[17:30:26.696] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:74:0)
[17:30:26.696] Timer tick, asking Buildbucket for the build status
[17:30:28.324] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:28.324] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:75:0) after 1m0s
[17:31:28.365] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:75:0)
[17:31:28.365] Timer tick, asking Buildbucket for the build status
[17:31:28.711] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:28.711] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:76:0) after 1m0s
[17:32:28.738] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:76:0)
[17:32:28.738] Timer tick, asking Buildbucket for the build status
[17:32:29.097] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:29.097] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:77:0) after 1m0s
[17:33:29.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:77:0)
[17:33:29.119] Timer tick, asking Buildbucket for the build status
[17:33:29.495] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:29.495] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:78:0) after 1m0s
[17:34:29.519] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:78:0)
[17:34:29.519] Timer tick, asking Buildbucket for the build status
[17:34:29.660] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:29.660] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:79:0) after 1m0s
[17:35:29.673] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:79:0)
[17:35:29.673] Timer tick, asking Buildbucket for the build status
[17:35:29.812] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:29.812] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:80:0) after 1m0s
[17:36:29.829] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:80:0)
[17:36:29.829] Timer tick, asking Buildbucket for the build status
[17:36:30.177] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:30.177] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:81:0) after 1m0s
[17:37:30.203] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:81:0)
[17:37:30.203] Timer tick, asking Buildbucket for the build status
[17:37:30.985] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:30.985] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:82:0) after 1m0s
[17:38:30.968] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:82:0)
[17:38:30.968] Timer tick, asking Buildbucket for the build status
[17:38:31.498] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:31.498] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:83:0) after 1m0s
[17:39:31.519] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:83:0)
[17:39:31.519] Timer tick, asking Buildbucket for the build status
[17:39:31.717] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:31.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:84:0) after 1m0s
[17:40:31.707] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:84:0)
[17:40:31.707] Timer tick, asking Buildbucket for the build status
[17:40:32.188] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:32.188] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:85:0) after 1m0s
[17:41:32.246] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:85:0)
[17:41:32.246] Timer tick, asking Buildbucket for the build status
[17:41:33.701] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:33.701] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:86:0) after 1m0s
[17:42:33.745] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:86:0)
[17:42:33.745] Timer tick, asking Buildbucket for the build status
[17:42:33.915] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:33.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:87:0) after 1m0s
[17:43:33.933] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:87:0)
[17:43:33.933] Timer tick, asking Buildbucket for the build status
[17:43:34.066] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:34.066] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:88:0) after 1m0s
[17:44:34.094] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:88:0)
[17:44:34.094] Timer tick, asking Buildbucket for the build status
[17:44:34.388] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:34.388] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:89:0) after 1m0s
[17:45:34.393] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:89:0)
[17:45:34.393] Timer tick, asking Buildbucket for the build status
[17:45:34.666] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:34.666] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:90:0) after 1m0s
[17:46:34.688] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:90:0)
[17:46:34.688] Timer tick, asking Buildbucket for the build status
[17:46:34.882] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:34.882] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:91:0) after 1m0s
[17:47:34.873] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:91:0)
[17:47:34.873] Timer tick, asking Buildbucket for the build status
[17:47:35.001] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:35.001] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:92:0) after 1m0s
[17:48:35.009] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:92:0)
[17:48:35.009] Timer tick, asking Buildbucket for the build status
[17:48:35.116] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:35.116] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:93:0) after 1m0s
[17:49:35.160] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:93:0)
[17:49:35.160] Timer tick, asking Buildbucket for the build status
[17:49:36.103] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:36.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:94:0) after 1m0s
[17:50:36.125] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:94:0)
[17:50:36.125] Timer tick, asking Buildbucket for the build status
[17:50:36.282] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:36.282] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:95:0) after 1m0s
[17:51:36.302] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:95:0)
[17:51:36.302] Timer tick, asking Buildbucket for the build status
[17:51:36.495] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:36.495] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:96:0) after 1m0s
[17:52:36.524] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:96:0)
[17:52:36.524] Timer tick, asking Buildbucket for the build status
[17:52:36.667] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:36.667] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:97:0) after 1m0s
[17:53:36.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:97:0)
[17:53:36.667] Timer tick, asking Buildbucket for the build status
[17:53:37.042] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:37.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:98:0) after 1m0s
[17:54:37.064] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:98:0)
[17:54:37.064] Timer tick, asking Buildbucket for the build status
[17:54:37.465] Build 8918179926202335456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:37.465] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083609988318600480:99:0) after 1m0s
[17:54:39.598] Received PubSub notification, asking Buildbucket for the build status
[17:54:39.928] Build 8918179926202335456: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[17:54:39.928] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1553363679082386",
"created_by": "project:chromium",
"created_ts": "1553357877499512",
"failure_reason": "BUILD_FAILURE",
"id": "8918179926202335456",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"bb9a0ad50c8ef3ab2b4498c265f0ddf2b1f5d0cb\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"3 tests failed: ['non_network_service_browser_tests', 'non_single_process_mash_browser_tests', 'non_network_service_interactive_ui_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\": 11514, \"got_angle_revision\": \"2660b5031f1141534e8969a8bb93b3401fa870cd\", \"got_dawn_revision\": \"07950e80fe36028ed9cca0a4a99a8b08e9bb4fdf\", \"got_nacl_revision\": \"7d24fb15d81f95ed30dde0c04b68584749709657\", \"got_revision\": \"bb9a0ad50c8ef3ab2b4498c265f0ddf2b1f5d0cb\", \"got_revision_cp\": \"refs/heads/master@{#643687}\", \"got_swarming_client_revision\": \"aa60736aded9fc32a0e21a81f5fc51f6009d01f3\", \"got_v8_revision\": \"b346546b7795350b8c910ff06f9520e7f03224f0\", \"got_v8_revision_cp\": \"refs/heads/7.5.100@{#1}\", \"got_webrtc_revision\": \"85a4a93e77b163098e91f41d8e7415181f23d02c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#27257}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.chromiumos\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"bb9a0ad50c8ef3ab2b4498c265f0ddf2b1f5d0cb\", \"swarm_hashes\": {\"accessibility_unittests\": \"3e50893727885c556d386e4c4f8d420ab6aa587f\", \"angle_unittests\": \"ebd234b198dd1658dbc2123aa085115ef69f00b8\", \"app_list_unittests\": \"4acb795655c791ab71c74d0c955f8f2c784cdfa4\", \"app_shell_unittests\": \"36367204a7cc82c14ee29652bbe457216ef520a5\", \"ash_unittests\": \"35e66b86ba861186aca9288110b50242cb9b49a0\", \"aura_unittests\": \"cc93862d0cdfc7491f437772c2fd54754b23622f\", \"base_unittests\": \"71f6d576b70c5a85d52721dcddeceac05f801608\", \"blink_common_unittests\": \"f66851dc0ca36d4207c19c2714c342277eddfe5a\", \"blink_fuzzer_unittests\": \"c5a4dc682abab5e4ffbe1ced53fe872587227b82\", \"blink_heap_unittests\": \"bcadb1f11fe1c00d394f608d180f92b9215b546c\", \"blink_platform_unittests\": \"f7460a4370c41f4f76fc54c64404cbd82b97403c\", \"blink_unittests\": \"edee7de33aec4c85e9d6dc28c0ac73df58d698b8\", \"boringssl_crypto_tests\": \"abed17b6653a9530b95701eeffe7d0114cfa37ed\", \"boringssl_ssl_tests\": \"eba6750d83be4a7859d37c4573fd0dba0797b831\", \"browser_tests\": \"6446f85fedddb7dc6a52f2a37d82ad7f693b7739\", \"cacheinvalidation_unittests\": \"d1fc570d1da9dd32a5c16b32bf0b4fd635253670\", \"capture_unittests\": \"ba29ce86e2817d7e6aa08cec4b6131f117a67f6a\", \"cast_unittests\": \"f17ea235910cfdc5c36aab1a34fb98ddb1456615\", \"cc_unittests\": \"a1399f72bc9d792b2abcac1b00f80e7e1a04b71d\", \"chrome_app_unittests\": \"d2f33af6497b21560d4fdaaeb1d05e5c6ec6f321\", \"chromedriver_unittests\": \"58fa14fa1f9a56106b65205083806cfffdbedcad\", \"chromeos_components_unittests\": \"44314d739981fbec553eab62b444ad22f2a2011a\", \"chromeos_unittests\": \"17616ea2e476d141133116293cb7bf4715b6794b\", \"components_browsertests\": \"c4ee1a65669a67698324900a748a79d9717e0d1d\", \"components_unittests\": \"b8861901702c34229446f659f48136bbc938a23e\", \"compositor_unittests\": \"f6f2a53806219564bd18522e73caf11e846e2f26\", \"content_browsertests\": \"5f0bb15f4a9983758895a90511d1ea4ba9298be6\", \"content_unittests\": \"ce3dd6e5e180f7e4acb86c1696fa1892a37b81cf\", \"crypto_unittests\": \"c77338c2253576fb7242b52443937031dcae434c\", \"dbus_unittests\": \"aa0c76fbcafbac7e301caffab28543f7fcfaf6a4\", \"device_unittests\": \"b4457ede8d4f708a0d711d102c182c8af3f7b100\", \"display_unittests\": \"399cd163ec830598155a650e2de88bfbcdb6abf2\", \"events_unittests\": \"7cbbbefe0ed384e24b79565d05ad5a684114c4c7\", \"exo_unittests\": \"40047165a85a90e6abdcfd32a0f695d5b4b201f4\", \"extensions_browsertests\": \"8f1d4265399bd23bc6d4d6fb9eef542d86a95697\", \"extensions_unittests\": \"1d39673e68a8030ddee5e232dc64dbf842fa0976\", \"filesystem_service_unittests\": \"b3da6fc219c5f5f484cd31b1ba692c17d35694ab\", \"gcm_unit_tests\": \"54aa3ed149b57459d5f64f762a34b2d776124ab3\", \"gfx_unittests\": \"802012e35d1c5d8f770c950db8693fa22330047a\", \"gin_unittests\": \"ad78787580626085bd12fbf2c749d7fa1fc55f71\", \"gl_unittests_ozone\": \"9d15a8553e60c194735c4b10c537f31fc020d8ad\", \"google_apis_unittests\": \"d11c48c47e3d47cd553e07dd63e98b6a71a60454\", \"gpu_unittests\": \"4a7c55d544d0353301f3aa6830572bd152a371ac\", \"interactive_ui_tests\": \"f1c063287cc8117d36fe044718ec50134d75bdb2\", \"ipc_tests\": \"a2d894b50c532c66875c909a9c2616fd2ffb24d5\", \"jingle_unittests\": \"dbf0c889b74d3f1bc201024b34ef68348345b834\", \"keyboard_unittests\": \"2330fd29fdeb99cd68e391eb4e77511f1b0a5660\", \"latency_unittests\": \"98d6782b1d54bef48b16a79293164191363ecbd2\", \"leveldb_service_unittests\": \"b797059789e5b6bd5715f86456369c22ee4cbed4\", \"libjingle_xmpp_unittests\": \"a90a78ce26d856a2a9cef5d44081551a9e558ae4\", \"media_blink_unittests\": \"9938234b2f53d99f7504b66022a18a845d976bde\", \"media_service_unittests\": \"3f4ce1c79f0974182e31e16999dd01f03c1c3610\", \"media_unittests\": \"0c04a17aba1fa5faf7e227ab0ff0afc084f218a8\", \"message_center_unittests\": \"a1a30186c6beeb0d1932cd8f65e4c374256980a5\", \"midi_unittests\": \"f8e05cc2a583a6229c9a2af5f452009cce20891d\", \"mojo_core_unittests\": \"9fa2b679a4347045e7f95863e5c3efba4044a2e7\", \"mojo_unittests\": \"7f1615259ce0f762ff1e8d146a977eccd2ff2efe\", \"nacl_helper_nonsfi_unittests\": \"10fc7009dd503a3df3570e00873f3235fcc72a9d\", \"nacl_loader_unittests\": \"8cb44c37572f3464e3b6cd2420112b596f3eacb2\", \"native_theme_unittests\": \"301e3f7d8913c40851102ff6568387ecdfbc57f8\", \"net_unittests\": \"ad7163d74ea75b6ef8ffaa531479c3074b892108\", \"ozone_gl_unittests\": \"d9e84ada4d7cfa39498e7e8718b8cd0008e92d61\", \"ozone_unittests\": \"c148dae41a56c117b9d0abe59a305b6507a3c204\", \"ozone_x11_unittests\": \"00e9d556d4910d7250c85da1fd00f3d184ff883d\", \"pdf_unittests\": \"a7b1e73979e1d3279dfd8526233b889e3c22bb7d\", \"perfetto_unittests\": \"4db8fdbc4e3c9d1a69adb21141ee7b6fba008e7e\", \"ppapi_unittests\": \"2c385b1b179e04cff2123c685ac3dec9ac9892fa\", \"printing_unittests\": \"720ccd6248a542ad9950c95b281442d7db8f2218\", \"remoting_unittests\": \"0073b3b60a3d5384e03deca1796a6817f940b402\", \"sandbox_linux_unittests\": \"b6cf1111763b37f5c1c66bb72a6aad2097af1b1b\", \"service_manager_unittests\": \"d41ddf0e93be81f8e39edaf32d860b0418013d9b\", \"services_unittests\": \"95dc9d171657e9f2adc71e5b7aee05e00bdb8de1\", \"shell_dialogs_unittests\": \"249262e7027165e07dd155297d42517094f19c69\", \"skia_unittests\": \"c5dae757f81108b60e75fef167882969bbe89299\", \"snapshot_unittests\": \"1b253a738f5430478bd40450165a446c0e5cce34\", \"sql_unittests\": \"c1a10770b117de6ac55c26b7a5398a11446cc972\", \"storage_unittests\": \"1aeefe82cd428dbc11bf198ceb728b29dae97d22\", \"sync_integration_tests\": \"b814b2cf297cfed411add9fd93b3e899e476dba6\", \"traffic_annotation_auditor_unittests\": \"a4db745aad0bc84c99277bb0f0794276e4d49d93\", \"ui_base_unittests\": \"fa85a21f56c878bc9573285dc784b95023f41200\", \"ui_chromeos_unittests\": \"86ca1d4c85d12962553c1a59ac70b1c1adc1d49a\", \"ui_touch_selection_unittests\": \"bb851617bec46753048ed1a85c737d15c5cb97ed\", \"unit_tests\": \"79b25d33e54d24ab866588e11ffc02390d666409\", \"url_unittests\": \"7cd69acfff4bf78a4dbc304994c9dc56b8d7b7aa\", \"usage_time_limit_unittests\": \"ae2c38a5270cd32adcca05ba033b08be3308126b\", \"views_unittests\": \"6e6cfd66a4b4163b4b1b420babce52fff67c40b1\", \"viz_unittests\": \"71b93c3fae8ce1a85dda185708fed3dd74baf28b\", \"wm_unittests\": \"f38806bf53af372864d2f12306153ffc72f88b73\", \"wtf_unittests\": \"09dd4f2aacdec52055bf9dfb9b47ce2a57c8cadb\"}, \"swarm_hashes_refs/heads/master(at){#643687}_without_patch\": {\"accessibility_unittests\": \"3e50893727885c556d386e4c4f8d420ab6aa587f\", \"angle_unittests\": \"ebd234b198dd1658dbc2123aa085115ef69f00b8\", \"app_list_unittests\": \"4acb795655c791ab71c74d0c955f8f2c784cdfa4\", \"app_shell_unittests\": \"36367204a7cc82c14ee29652bbe457216ef520a5\", \"ash_unittests\": \"35e66b86ba861186aca9288110b50242cb9b49a0\", \"aura_unittests\": \"cc93862d0cdfc7491f437772c2fd54754b23622f\", \"base_unittests\": \"71f6d576b70c5a85d52721dcddeceac05f801608\", \"blink_common_unittests\": \"f66851dc0ca36d4207c19c2714c342277eddfe5a\", \"blink_fuzzer_unittests\": \"c5a4dc682abab5e4ffbe1ced53fe872587227b82\", \"blink_heap_unittests\": \"bcadb1f11fe1c00d394f608d180f92b9215b546c\", \"blink_platform_unittests\": \"f7460a4370c41f4f76fc54c64404cbd82b97403c\", \"blink_unittests\": \"edee7de33aec4c85e9d6dc28c0ac73df58d698b8\", \"boringssl_crypto_tests\": \"abed17b6653a9530b95701eeffe7d0114cfa37ed\", \"boringssl_ssl_tests\": \"eba6750d83be4a7859d37c4573fd0dba0797b831\", \"browser_tests\": \"6446f85fedddb7dc6a52f2a37d82ad7f693b7739\", \"cacheinvalidation_unittests\": \"d1fc570d1da9dd32a5c16b32bf0b4fd635253670\", \"capture_unittests\": \"ba29ce86e2817d7e6aa08cec4b6131f117a67f6a\", \"cast_unittests\": \"f17ea235910cfdc5c36aab1a34fb98ddb1456615\", \"cc_unittests\": \"a1399f72bc9d792b2abcac1b00f80e7e1a04b71d\", \"chrome_app_unittests\": \"d2f33af6497b21560d4fdaaeb1d05e5c6ec6f321\", \"chromedriver_unittests\": \"58fa14fa1f9a56106b65205083806cfffdbedcad\", \"chromeos_components_unittests\": \"44314d739981fbec553eab62b444ad22f2a2011a\", \"chromeos_unittests\": \"17616ea2e476d141133116293cb7bf4715b6794b\", \"components_browsertests\": \"c4ee1a65669a67698324900a748a79d9717e0d1d\", \"components_unittests\": \"b8861901702c34229446f659f48136bbc938a23e\", \"compositor_unittests\": \"f6f2a53806219564bd18522e73caf11e846e2f26\", \"content_browsertests\": \"5f0bb15f4a9983758895a90511d1ea4ba9298be6\", \"content_unittests\": \"ce3dd6e5e180f7e4acb86c1696fa1892a37b81cf\", \"crypto_unittests\": \"c77338c2253576fb7242b52443937031dcae434c\", \"dbus_unittests\": \"aa0c76fbcafbac7e301caffab28543f7fcfaf6a4\", \"device_unittests\": \"b4457ede8d4f708a0d711d102c182c8af3f7b100\", \"display_unittests\": \"399cd163ec830598155a650e2de88bfbcdb6abf2\", \"events_unittests\": \"7cbbbefe0ed384e24b79565d05ad5a684114c4c7\", \"exo_unittests\": \"40047165a85a90e6abdcfd32a0f695d5b4b201f4\", \"extensions_browsertests\": \"8f1d4265399bd23bc6d4d6fb9eef542d86a95697\", \"extensions_unittests\": \"1d39673e68a8030ddee5e232dc64dbf842fa0976\", \"filesystem_service_unittests\": \"b3da6fc219c5f5f484cd31b1ba692c17d35694ab\", \"gcm_unit_tests\": \"54aa3ed149b57459d5f64f762a34b2d776124ab3\", \"gfx_unittests\": \"802012e35d1c5d8f770c950db8693fa22330047a\", \"gin_unittests\": \"ad78787580626085bd12fbf2c749d7fa1fc55f71\", \"gl_unittests_ozone\": \"9d15a8553e60c194735c4b10c537f31fc020d8ad\", \"google_apis_unittests\": \"d11c48c47e3d47cd553e07dd63e98b6a71a60454\", \"gpu_unittests\": \"4a7c55d544d0353301f3aa6830572bd152a371ac\", \"interactive_ui_tests\": \"f1c063287cc8117d36fe044718ec50134d75bdb2\", \"ipc_tests\": \"a2d894b50c532c66875c909a9c2616fd2ffb24d5\", \"jingle_unittests\": \"dbf0c889b74d3f1bc201024b34ef68348345b834\", \"keyboard_unittests\": \"2330fd29fdeb99cd68e391eb4e77511f1b0a5660\", \"latency_unittests\": \"98d6782b1d54bef48b16a79293164191363ecbd2\", \"leveldb_service_unittests\": \"b797059789e5b6bd5715f86456369c22ee4cbed4\", \"libjingle_xmpp_unittests\": \"a90a78ce26d856a2a9cef5d44081551a9e558ae4\", \"media_blink_unittests\": \"9938234b2f53d99f7504b66022a18a845d976bde\", \"media_service_unittests\": \"3f4ce1c79f0974182e31e16999dd01f03c1c3610\", \"media_unittests\": \"0c04a17aba1fa5faf7e227ab0ff0afc084f218a8\", \"message_center_unittests\": \"a1a30186c6beeb0d1932cd8f65e4c374256980a5\", \"midi_unittests\": \"f8e05cc2a583a6229c9a2af5f452009cce20891d\", \"mojo_core_unittests\": \"9fa2b679a4347045e7f95863e5c3efba4044a2e7\", \"mojo_unittests\": \"7f1615259ce0f762ff1e8d146a977eccd2ff2efe\", \"nacl_helper_nonsfi_unittests\": \"10fc7009dd503a3df3570e00873f3235fcc72a9d\", \"nacl_loader_unittests\": \"8cb44c37572f3464e3b6cd2420112b596f3eacb2\", \"native_theme_unittests\": \"301e3f7d8913c40851102ff6568387ecdfbc57f8\", \"net_unittests\": \"ad7163d74ea75b6ef8ffaa531479c3074b892108\", \"ozone_gl_unittests\": \"d9e84ada4d7cfa39498e7e8718b8cd0008e92d61\", \"ozone_unittests\": \"c148dae41a56c117b9d0abe59a305b6507a3c204\", \"ozone_x11_unittests\": \"00e9d556d4910d7250c85da1fd00f3d184ff883d\", \"pdf_unittests\": \"a7b1e73979e1d3279dfd8526233b889e3c22bb7d\", \"perfetto_unittests\": \"4db8fdbc4e3c9d1a69adb21141ee7b6fba008e7e\", \"ppapi_unittests\": \"2c385b1b179e04cff2123c685ac3dec9ac9892fa\", \"printing_unittests\": \"720ccd6248a542ad9950c95b281442d7db8f2218\", \"remoting_unittests\": \"0073b3b60a3d5384e03deca1796a6817f940b402\", \"sandbox_linux_unittests\": \"b6cf1111763b37f5c1c66bb72a6aad2097af1b1b\", \"service_manager_unittests\": \"d41ddf0e93be81f8e39edaf32d860b0418013d9b\", \"services_unittests\": \"95dc9d171657e9f2adc71e5b7aee05e00bdb8de1\", \"shell_dialogs_unittests\": \"249262e7027165e07dd155297d42517094f19c69\", \"skia_unittests\": \"c5dae757f81108b60e75fef167882969bbe89299\", \"snapshot_unittests\": \"1b253a738f5430478bd40450165a446c0e5cce34\", \"sql_unittests\": \"c1a10770b117de6ac55c26b7a5398a11446cc972\", \"storage_unittests\": \"1aeefe82cd428dbc11bf198ceb728b29dae97d22\", \"sync_integration_tests\": \"b814b2cf297cfed411add9fd93b3e899e476dba6\", \"traffic_annotation_auditor_unittests\": \"a4db745aad0bc84c99277bb0f0794276e4d49d93\", \"ui_base_unittests\": \"fa85a21f56c878bc9573285dc784b95023f41200\", \"ui_chromeos_unittests\": \"86ca1d4c85d12962553c1a59ac70b1c1adc1d49a\", \"ui_touch_selection_unittests\": \"bb851617bec46753048ed1a85c737d15c5cb97ed\", \"unit_tests\": \"79b25d33e54d24ab866588e11ffc02390d666409\", \"url_unittests\": \"7cd69acfff4bf78a4dbc304994c9dc56b8d7b7aa\", \"usage_time_limit_unittests\": \"ae2c38a5270cd32adcca05ba033b08be3308126b\", \"views_unittests\": \"6e6cfd66a4b4163b4b1b420babce52fff67c40b1\", \"viz_unittests\": \"71b93c3fae8ce1a85dda185708fed3dd74baf28b\", \"wm_unittests\": \"f38806bf53af372864d2f12306153ffc72f88b73\", \"wtf_unittests\": \"09dd4f2aacdec52055bf9dfb9b47ce2a57c8cadb\"}}, \"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\"], \"image\": [\"chrome-trusty-18042300-b7223b463e3\"], \"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\": [\"4216-cf4a3cd\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"3 tests failed: ['non_network_service_browser_tests', 'non_single_process_mash_browser_tests', 'non_network_service_interactive_ui_tests']\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1553357991603865",
"status": "COMPLETED",
"status_changed_ts": "1553357991872839",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/11514",
"builder:linux-chromeos-dbg",
"buildset:commit/git/bb9a0ad50c8ef3ab2b4498c265f0ddf2b1f5d0cb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bb9a0ad50c8ef3ab2b4498c265f0ddf2b1f5d0cb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9083609988318600480",
"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/8918179926202335456/+/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:43c429ba7890b010",
"user_agent:luci-scheduler"
],
"updated_ts": "1553363679306116",
"url": "https://ci.chromium.org/b/8918179926202335456",
"utcnow_ts": "1553363679850506"
}
}
[17:54:39.928] Invocation finished in 1h36m43.831108626s with status FAILED