[16:47:29.628] New invocation is queued and will start shortly
[16:47:30.902] Starting the invocation (attempt 1)
[16:47:31.029] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:47:31.030] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:47:31.030] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9083336337756101088",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"321d70a0ca6f17ad8984430c5332166868053e99\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9083336337756101088",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/321d70a0ca6f17ad8984430c5332166868053e99",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/321d70a0ca6f17ad8984430c5332166868053e99",
"gitiles_ref:refs/heads/master"
]
}
[16:47:31.907] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "project:chromium",
"created_ts": "1553618851216005",
"id": "8917906275425373376",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"321d70a0ca6f17ad8984430c5332166868053e99\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1553618851734779",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/11556",
"builder:linux-chromeos-dbg",
"buildset:commit/git/321d70a0ca6f17ad8984430c5332166868053e99",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/321d70a0ca6f17ad8984430c5332166868053e99",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9083336337756101088",
"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/8917906275425373376/+/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": "1553618851734896",
"url": "https://ci.chromium.org/b/8917906275425373376",
"utcnow_ts": "1553618851882901"
}
}
[16:47:31.907] Task URL: https://ci.chromium.org/b/8917906275425373376
[16:47:31.907] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:2:0) after 1m0s
[16:48:31.924] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:2:0)
[16:48:31.924] Timer tick, asking Buildbucket for the build status
[16:48:32.050] Build 8917906275425373376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:48:32.050] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:3:0) after 1m0s
[16:49:32.069] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:3:0)
[16:49:32.069] Timer tick, asking Buildbucket for the build status
[16:49:32.670] Build 8917906275425373376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:49:32.671] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:4:0) after 1m0s
[16:50:32.683] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:4:0)
[16:50:32.683] Timer tick, asking Buildbucket for the build status
[16:50:33.160] Build 8917906275425373376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:50:33.160] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:5:0) after 1m0s
[16:51:33.185] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:5:0)
[16:51:33.185] Timer tick, asking Buildbucket for the build status
[16:51:33.360] Build 8917906275425373376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:51:33.360] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:6:0) after 1m0s
[16:52:33.381] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:6:0)
[16:52:33.381] Timer tick, asking Buildbucket for the build status
[16:52:33.482] Build 8917906275425373376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:52:33.482] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:7:0) after 1m0s
[16:53:33.507] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:7:0)
[16:53:33.507] Timer tick, asking Buildbucket for the build status
[16:53:33.629] Build 8917906275425373376: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:53:33.630] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:8:0) after 1m0s
[16:54:21.722] Received PubSub notification, asking Buildbucket for the build status
[16:54:22.825] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:33.649] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:8:0)
[16:54:33.649] Timer tick, asking Buildbucket for the build status
[16:54:34.005] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:34.005] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:10:0) after 1m0s
[16:55:34.008] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:10:0)
[16:55:34.008] Timer tick, asking Buildbucket for the build status
[16:55:34.137] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:34.137] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:11:0) after 1m0s
[16:56:35.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:11:0)
[16:56:35.363] Timer tick, asking Buildbucket for the build status
[16:56:35.619] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:35.619] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:12:0) after 1m0s
[16:57:35.597] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:12:0)
[16:57:35.597] Timer tick, asking Buildbucket for the build status
[16:57:35.696] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:35.696] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:13:0) after 1m0s
[16:58:35.714] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:13:0)
[16:58:35.714] Timer tick, asking Buildbucket for the build status
[16:58:35.805] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:35.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:14:0) after 1m0s
[16:59:35.789] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:14:0)
[16:59:35.789] Timer tick, asking Buildbucket for the build status
[16:59:36.721] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:36.721] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:15:0) after 1m0s
[17:00:36.749] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:15:0)
[17:00:36.749] Timer tick, asking Buildbucket for the build status
[17:00:37.689] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:37.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:16:0) after 1m0s
[17:01:37.721] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:16:0)
[17:01:37.721] Timer tick, asking Buildbucket for the build status
[17:01:37.823] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:37.823] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:17:0) after 1m0s
[17:02:37.842] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:17:0)
[17:02:37.842] Timer tick, asking Buildbucket for the build status
[17:02:38.171] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:38.171] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:18:0) after 1m0s
[17:03:38.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:18:0)
[17:03:38.216] Timer tick, asking Buildbucket for the build status
[17:03:38.497] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:38.497] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:19:0) after 1m0s
[17:04:38.545] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:19:0)
[17:04:38.545] Timer tick, asking Buildbucket for the build status
[17:04:39.145] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:39.145] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:20:0) after 1m0s
[17:05:39.166] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:20:0)
[17:05:39.166] Timer tick, asking Buildbucket for the build status
[17:05:39.479] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:39.479] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:21:0) after 1m0s
[17:06:39.474] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:21:0)
[17:06:39.474] Timer tick, asking Buildbucket for the build status
[17:06:39.604] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:39.604] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:22:0) after 1m0s
[17:07:39.634] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:22:0)
[17:07:39.634] Timer tick, asking Buildbucket for the build status
[17:07:40.190] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:40.190] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:23:0) after 1m0s
[17:08:40.212] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:23:0)
[17:08:40.212] Timer tick, asking Buildbucket for the build status
[17:08:40.295] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:40.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:24:0) after 1m0s
[17:09:40.352] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:24:0)
[17:09:40.352] Timer tick, asking Buildbucket for the build status
[17:09:40.797] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:40.797] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:25:0) after 1m0s
[17:10:40.774] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:25:0)
[17:10:40.774] Timer tick, asking Buildbucket for the build status
[17:10:41.591] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:41.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:26:0) after 1m0s
[17:11:41.582] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:26:0)
[17:11:41.582] Timer tick, asking Buildbucket for the build status
[17:11:42.075] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:42.075] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:27:0) after 1m0s
[17:12:42.109] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:27:0)
[17:12:42.109] Timer tick, asking Buildbucket for the build status
[17:12:42.217] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:42.217] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:28:0) after 1m0s
[17:13:42.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:28:0)
[17:13:42.198] Timer tick, asking Buildbucket for the build status
[17:13:42.962] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:42.962] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:29:0) after 1m0s
[17:14:43.271] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:29:0)
[17:14:43.271] Timer tick, asking Buildbucket for the build status
[17:14:43.765] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:43.765] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:30:0) after 1m0s
[17:15:43.790] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:30:0)
[17:15:43.790] Timer tick, asking Buildbucket for the build status
[17:15:43.892] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:43.892] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:31:0) after 1m0s
[17:16:43.915] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:31:0)
[17:16:43.915] Timer tick, asking Buildbucket for the build status
[17:16:44.151] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:44.151] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:32:0) after 1m0s
[17:17:44.195] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:32:0)
[17:17:44.195] Timer tick, asking Buildbucket for the build status
[17:17:44.658] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:44.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:33:0) after 1m0s
[17:18:44.660] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:33:0)
[17:18:44.660] Timer tick, asking Buildbucket for the build status
[17:18:44.747] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:44.747] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:34:0) after 1m0s
[17:19:44.785] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:34:0)
[17:19:44.785] Timer tick, asking Buildbucket for the build status
[17:19:45.185] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:45.185] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:35:0) after 1m0s
[17:20:45.207] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:35:0)
[17:20:45.207] Timer tick, asking Buildbucket for the build status
[17:20:45.776] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:45.776] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:36:0) after 1m0s
[17:21:45.811] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:36:0)
[17:21:45.811] Timer tick, asking Buildbucket for the build status
[17:21:46.114] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:46.114] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:37:0) after 1m0s
[17:22:46.139] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:37:0)
[17:22:46.139] Timer tick, asking Buildbucket for the build status
[17:22:46.238] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:46.238] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:38:0) after 1m0s
[17:23:46.257] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:38:0)
[17:23:46.257] Timer tick, asking Buildbucket for the build status
[17:23:46.866] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:46.866] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:39:0) after 1m0s
[17:24:46.855] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:39:0)
[17:24:46.855] Timer tick, asking Buildbucket for the build status
[17:24:47.701] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:47.701] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:40:0) after 1m0s
[17:25:47.700] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:40:0)
[17:25:47.700] Timer tick, asking Buildbucket for the build status
[17:25:47.957] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:47.957] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:41:0) after 1m0s
[17:26:47.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:41:0)
[17:26:47.983] Timer tick, asking Buildbucket for the build status
[17:26:48.682] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:48.682] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:42:0) after 1m0s
[17:27:48.695] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:42:0)
[17:27:48.695] Timer tick, asking Buildbucket for the build status
[17:27:48.845] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:48.845] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:43:0) after 1m0s
[17:28:48.866] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:43:0)
[17:28:48.866] Timer tick, asking Buildbucket for the build status
[17:28:49.041] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:49.041] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:44:0) after 1m0s
[17:29:49.040] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:44:0)
[17:29:49.040] Timer tick, asking Buildbucket for the build status
[17:29:49.289] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:49.289] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:45:0) after 1m0s
[17:30:49.310] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:45:0)
[17:30:49.310] Timer tick, asking Buildbucket for the build status
[17:30:49.574] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:49.574] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:46:0) after 1m0s
[17:31:49.618] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:46:0)
[17:31:49.618] Timer tick, asking Buildbucket for the build status
[17:31:49.879] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:49.879] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:47:0) after 1m0s
[17:32:49.901] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:47:0)
[17:32:49.901] Timer tick, asking Buildbucket for the build status
[17:32:50.406] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:50.406] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:48:0) after 1m0s
[17:33:50.379] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:48:0)
[17:33:50.379] Timer tick, asking Buildbucket for the build status
[17:33:50.516] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:50.516] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:49:0) after 1m0s
[17:34:50.542] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:49:0)
[17:34:50.542] Timer tick, asking Buildbucket for the build status
[17:34:50.723] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:50.723] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:50:0) after 1m0s
[17:35:50.738] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:50:0)
[17:35:50.738] Timer tick, asking Buildbucket for the build status
[17:35:51.241] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:51.241] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:51:0) after 1m0s
[17:36:51.263] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:51:0)
[17:36:51.263] Timer tick, asking Buildbucket for the build status
[17:36:52.318] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:52.318] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:52:0) after 1m0s
[17:37:52.338] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:52:0)
[17:37:52.338] Timer tick, asking Buildbucket for the build status
[17:37:53.485] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:53.485] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:53:0) after 1m0s
[17:38:53.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:53:0)
[17:38:53.508] Timer tick, asking Buildbucket for the build status
[17:38:54.205] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:54.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:54:0) after 1m0s
[17:39:54.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:54:0)
[17:39:54.237] Timer tick, asking Buildbucket for the build status
[17:39:55.572] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:55.572] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:55:0) after 1m0s
[17:40:55.593] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:55:0)
[17:40:55.593] Timer tick, asking Buildbucket for the build status
[17:40:55.719] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:55.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:56:0) after 1m0s
[17:41:55.742] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:56:0)
[17:41:55.742] Timer tick, asking Buildbucket for the build status
[17:41:55.935] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:55.935] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:57:0) after 1m0s
[17:42:55.951] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:57:0)
[17:42:55.951] Timer tick, asking Buildbucket for the build status
[17:42:56.272] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:56.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:58:0) after 1m0s
[17:43:56.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:58:0)
[17:43:56.327] Timer tick, asking Buildbucket for the build status
[17:43:56.791] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:56.792] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:59:0) after 1m0s
[17:44:56.815] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:59:0)
[17:44:56.815] Timer tick, asking Buildbucket for the build status
[17:44:57.511] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:57.511] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:60:0) after 1m0s
[17:45:57.603] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:60:0)
[17:45:57.603] Timer tick, asking Buildbucket for the build status
[17:45:57.704] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:57.704] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:61:0) after 1m0s
[17:46:57.729] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:61:0)
[17:46:57.729] Timer tick, asking Buildbucket for the build status
[17:46:58.095] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:58.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:62:0) after 1m0s
[17:47:58.070] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:62:0)
[17:47:58.070] Timer tick, asking Buildbucket for the build status
[17:47:58.200] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:58.200] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:63:0) after 1m0s
[17:48:58.204] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:63:0)
[17:48:58.204] Timer tick, asking Buildbucket for the build status
[17:48:58.437] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:58.437] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:64:0) after 1m0s
[17:49:58.444] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:64:0)
[17:49:58.444] Timer tick, asking Buildbucket for the build status
[17:49:59.266] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:59.266] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:65:0) after 1m0s
[17:50:59.290] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:65:0)
[17:50:59.290] Timer tick, asking Buildbucket for the build status
[17:51:00.213] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:00.213] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:66:0) after 1m0s
[17:52:00.250] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:66:0)
[17:52:00.250] Timer tick, asking Buildbucket for the build status
[17:52:00.488] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:00.488] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:67:0) after 1m0s
[17:53:00.480] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:67:0)
[17:53:00.480] Timer tick, asking Buildbucket for the build status
[17:53:01.169] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:01.169] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:68:0) after 1m0s
[17:54:01.203] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:68:0)
[17:54:01.203] Timer tick, asking Buildbucket for the build status
[17:54:01.456] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:01.456] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:69:0) after 1m0s
[17:55:01.487] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:69:0)
[17:55:01.487] Timer tick, asking Buildbucket for the build status
[17:55:01.979] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:01.979] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:70:0) after 1m0s
[17:56:02.003] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:70:0)
[17:56:02.003] Timer tick, asking Buildbucket for the build status
[17:56:02.105] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:02.105] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:71:0) after 1m0s
[17:57:02.129] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:71:0)
[17:57:02.129] Timer tick, asking Buildbucket for the build status
[17:57:02.319] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:02.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:72:0) after 1m0s
[17:58:02.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:72:0)
[17:58:02.329] Timer tick, asking Buildbucket for the build status
[17:58:02.447] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:02.447] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:73:0) after 1m0s
[17:59:02.459] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:73:0)
[17:59:02.459] Timer tick, asking Buildbucket for the build status
[17:59:02.564] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:02.564] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:74:0) after 1m0s
[18:00:02.566] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:74:0)
[18:00:02.566] Timer tick, asking Buildbucket for the build status
[18:00:03.007] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:03.007] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:75:0) after 1m0s
[18:01:03.008] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:75:0)
[18:01:03.008] Timer tick, asking Buildbucket for the build status
[18:01:03.659] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:03.659] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:76:0) after 1m0s
[18:02:03.657] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:76:0)
[18:02:03.657] Timer tick, asking Buildbucket for the build status
[18:02:03.842] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:03.842] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:77:0) after 1m0s
[18:03:03.841] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:77:0)
[18:03:03.841] Timer tick, asking Buildbucket for the build status
[18:03:04.066] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:04.066] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:78:0) after 1m0s
[18:04:04.096] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:78:0)
[18:04:04.096] Timer tick, asking Buildbucket for the build status
[18:04:04.403] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:04.403] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:79:0) after 1m0s
[18:05:04.423] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:79:0)
[18:05:04.423] Timer tick, asking Buildbucket for the build status
[18:05:04.750] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:04.750] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:80:0) after 1m0s
[18:06:04.782] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:80:0)
[18:06:04.782] Timer tick, asking Buildbucket for the build status
[18:06:05.771] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:05.771] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:81:0) after 1m0s
[18:07:05.794] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:81:0)
[18:07:05.794] Timer tick, asking Buildbucket for the build status
[18:07:06.020] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:06.020] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:82:0) after 1m0s
[18:08:06.044] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:82:0)
[18:08:06.044] Timer tick, asking Buildbucket for the build status
[18:08:06.334] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:06.334] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:83:0) after 1m0s
[18:09:06.356] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:83:0)
[18:09:06.356] Timer tick, asking Buildbucket for the build status
[18:09:07.483] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:07.483] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:84:0) after 1m0s
[18:10:07.504] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:84:0)
[18:10:07.504] Timer tick, asking Buildbucket for the build status
[18:10:07.705] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:07.705] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:85:0) after 1m0s
[18:11:07.742] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:85:0)
[18:11:07.742] Timer tick, asking Buildbucket for the build status
[18:11:07.887] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:07.887] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:86:0) after 1m0s
[18:12:07.982] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:86:0)
[18:12:07.983] Timer tick, asking Buildbucket for the build status
[18:12:08.184] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:08.184] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:87:0) after 1m0s
[18:13:08.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:87:0)
[18:13:08.265] Timer tick, asking Buildbucket for the build status
[18:13:08.450] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:08.450] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:88:0) after 1m0s
[18:14:08.441] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:88:0)
[18:14:08.441] Timer tick, asking Buildbucket for the build status
[18:14:09.360] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:09.360] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:89:0) after 1m0s
[18:15:09.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:89:0)
[18:15:09.363] Timer tick, asking Buildbucket for the build status
[18:15:09.557] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:09.557] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:90:0) after 1m0s
[18:16:09.588] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:90:0)
[18:16:09.588] Timer tick, asking Buildbucket for the build status
[18:16:10.242] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:10.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:91:0) after 1m0s
[18:17:10.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:91:0)
[18:17:10.222] Timer tick, asking Buildbucket for the build status
[18:17:10.895] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:10.895] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:92:0) after 1m0s
[18:18:10.897] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:92:0)
[18:18:10.897] Timer tick, asking Buildbucket for the build status
[18:18:11.221] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:11.221] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:93:0) after 1m0s
[18:19:11.233] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:93:0)
[18:19:11.233] Timer tick, asking Buildbucket for the build status
[18:19:11.487] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:11.487] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:94:0) after 1m0s
[18:20:11.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:94:0)
[18:20:11.520] Timer tick, asking Buildbucket for the build status
[18:20:11.659] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:11.659] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:95:0) after 1m0s
[18:21:11.685] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:95:0)
[18:21:11.685] Timer tick, asking Buildbucket for the build status
[18:21:11.872] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:11.872] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:96:0) after 1m0s
[18:22:11.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:96:0)
[18:22:11.903] Timer tick, asking Buildbucket for the build status
[18:22:12.012] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:12.012] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:97:0) after 1m0s
[18:23:12.016] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:97:0)
[18:23:12.016] Timer tick, asking Buildbucket for the build status
[18:23:12.709] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:12.709] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:98:0) after 1m0s
[18:24:12.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:98:0)
[18:24:12.691] Timer tick, asking Buildbucket for the build status
[18:24:12.980] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:12.980] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:99:0) after 1m0s
[18:25:13.003] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:99:0)
[18:25:13.003] Timer tick, asking Buildbucket for the build status
[18:25:13.307] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:13.307] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:100:0) after 1m0s
[18:26:13.290] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:100:0)
[18:26:13.290] Timer tick, asking Buildbucket for the build status
[18:26:13.695] Build 8917906275425373376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:13.695] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083336337756101088:101:0) after 1m0s
[18:27:13.106] Received PubSub notification, asking Buildbucket for the build status
[18:27:13.211] Build 8917906275425373376: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[18:27:13.211] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1553624832530047",
"created_by": "project:chromium",
"created_ts": "1553618851216005",
"failure_reason": "BUILD_FAILURE",
"id": "8917906275425373376",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"321d70a0ca6f17ad8984430c5332166868053e99\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"2 tests failed: ['non_network_service_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\": 11556, \"got_angle_revision\": \"da37e7f6759d9852d116bdab55346513c23324d3\", \"got_dawn_revision\": \"d3d3aa03e109bdf6d9b0d8c73fba9ec91d3cc99f\", \"got_nacl_revision\": \"de8da4841bc3d1ed020d798d5a7fd6fb3d817fa1\", \"got_revision\": \"321d70a0ca6f17ad8984430c5332166868053e99\", \"got_revision_cp\": \"refs/heads/master@{#644370}\", \"got_swarming_client_revision\": \"aa60736aded9fc32a0e21a81f5fc51f6009d01f3\", \"got_v8_revision\": \"7857648f71ae10d7175cd5225fc73ffe873bba66\", \"got_v8_revision_cp\": \"refs/heads/7.5.108@{#2}\", \"got_webrtc_revision\": \"8ea8dcbae6cb97675d5ee9ca43523085f96a14b4\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#27288}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.chromiumos\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"321d70a0ca6f17ad8984430c5332166868053e99\", \"swarm_hashes\": {\"accessibility_unittests\": \"722d32bc84e78453198fd136d62286194626a44b\", \"angle_unittests\": \"f6598ee59af86fd996c2a4308dd8eabda4856955\", \"app_list_unittests\": \"131fd6bf42f8dd9dec196022670a176001c514a2\", \"app_shell_unittests\": \"0df97580845a7c97abd7c20e083242b28b4190ba\", \"ash_unittests\": \"1c66e1701db21e20720d0ca4a1519be87a1df9b5\", \"aura_unittests\": \"36c6e1e965243a6e7c5340efd8c7f5077a62c2df\", \"base_unittests\": \"95c6a2cca77714806babbcc0207d90706188051f\", \"blink_common_unittests\": \"39f6512966c7325df7293a92f3fda983234e55fb\", \"blink_fuzzer_unittests\": \"a01dca48324a6c05d1ca28f5c4ee4a3bf7503f3a\", \"blink_heap_unittests\": \"44eac188317c12cedcfb29e7582239d69109b3ad\", \"blink_platform_unittests\": \"3e9418cba42553f486d7263d361d26a2317adf28\", \"blink_unittests\": \"2aa152683dbfd8fd5e3afe2883bd8a975ee50010\", \"boringssl_crypto_tests\": \"dbc68c8d4456ea4e033e368c7fc889a813604354\", \"boringssl_ssl_tests\": \"67409f5f485ca3a81a033cc618f301ac4a09fdef\", \"browser_tests\": \"0f9db9770e4d10b25ce95241cc338efd15f8a93c\", \"cacheinvalidation_unittests\": \"ce1e4b65278ecd8bbe7e43a2da9c901e01bd8534\", \"capture_unittests\": \"4252b76aa6015f1aa5d5b9039326fc2c1b4693eb\", \"cast_unittests\": \"82598b4922e602aa20d84c50ed80daf260b853e6\", \"cc_unittests\": \"9f639d2dcd8070da12cacb96c515fbda81caa2a5\", \"chrome_app_unittests\": \"ba658938391b672b341296c46cda8372493e9466\", \"chromedriver_unittests\": \"77f075d468bc663610e83f915a479ed5101e9c2e\", \"chromeos_components_unittests\": \"9376edf1346b308ed85122a235d21b79e09b4cf8\", \"chromeos_unittests\": \"be2a7ddd89f3de7e89720d8413bf06c2c73856d6\", \"components_browsertests\": \"5655c5d2b5ab50a9df7da2b10762e7c559699379\", \"components_unittests\": \"00b8a3799b248d454c89ed22f708e67e281c1a75\", \"compositor_unittests\": \"a04236df3e8b1d3e21a53117afab0ce6ffa4b733\", \"content_browsertests\": \"c79132ff3b7f58440867411465e187ea89e0b3a9\", \"content_unittests\": \"8ae463d96f314b89d2bf629fcb79d578d2b3f3b7\", \"crypto_unittests\": \"a305fa61b02c3bd92883a8223cef6639ca7b5ea0\", \"dbus_unittests\": \"9e0f14270d6bebc3095592cb750defb913a206ba\", \"device_unittests\": \"e6588d1fd046b78af8e550cfc9620ed1ae6b8f76\", \"display_unittests\": \"bf5e0049dfc028e8a20e92cb1721eac05bb03e26\", \"events_unittests\": \"67b19e6e7978f967d019376b51d95850e125db37\", \"exo_unittests\": \"a4f8a7f6df4191c17536637e708415da80a905b1\", \"extensions_browsertests\": \"0715d95cfc858e108cafa80c6476b69fe8e7b464\", \"extensions_unittests\": \"24338d8c887f731d2964e15cac25ab3e7880d684\", \"filesystem_service_unittests\": \"fede7cddec35896300886fd4b90da9d2ba01bb99\", \"gcm_unit_tests\": \"d61287fbb3a0f23682c79349dcadc1ff30576a50\", \"gfx_unittests\": \"509ad948af13bf540db5e75cce01b05f5967602b\", \"gin_unittests\": \"b9369eb354e42cd14af1b0d09e1cb2754b145f4d\", \"gl_unittests_ozone\": \"55088bce7965701d1243e37de24f926ac9549ebe\", \"google_apis_unittests\": \"b3ccc71b1bc70151398be23fc0c87006ee3edb03\", \"gpu_unittests\": \"4839dc83defcd61dc3e004b7018a69d251854564\", \"interactive_ui_tests\": \"d160e92219163ec5c54de976aea895b46c428c9e\", \"ipc_tests\": \"385c2f42ad7499a852abb1d8eee2315f41939a67\", \"jingle_unittests\": \"5e5f86daba1915aef7dd6d8db90a66bfba1756eb\", \"keyboard_unittests\": \"da8b755ba273f9e2757fb1e71ffb3a75dd48043a\", \"latency_unittests\": \"0d4b36fd25bd8573ec88b0086c9b12dfc415fb1e\", \"leveldb_service_unittests\": \"65371bdf9a70c36d00557b838917a74d6bd6a16a\", \"libjingle_xmpp_unittests\": \"b68edb9ae64930ae0258ca2f5ce3e7d62f6fb12a\", \"media_blink_unittests\": \"491aeb243e1ee4a1b650b45219fcab595ea25291\", \"media_service_unittests\": \"41eac5371c7f412eae1c13006b020e13adbce2ce\", \"media_unittests\": \"ceb1b9996c7139a74c4fc1668181ac4a65bb09df\", \"message_center_unittests\": \"5fc64ea7bad03f7877185991ad10d16a40da4e59\", \"midi_unittests\": \"319e3f14eecb8bcc7107ef4eccf305a3c4adfb41\", \"mojo_core_unittests\": \"4134c88d2b135506a68a2510656c7a1e86bbea0a\", \"mojo_unittests\": \"f9ef44892356a4ed7acaf7351fd676ea189ef518\", \"nacl_helper_nonsfi_unittests\": \"353b4f4cbf3a86a16e5715bdd08dad3d6988b260\", \"nacl_loader_unittests\": \"0cdcdcad220466ba136f709283e6c8e093bb0ef7\", \"native_theme_unittests\": \"878b19a5b26fa2b7136ac07fd0c98a50a37ac0ec\", \"net_unittests\": \"6fbc4fdca041d3b735601ef05c74df8ac6d6e194\", \"ozone_gl_unittests\": \"cbcae3da5886b24146de44f770278d9ff13e17af\", \"ozone_unittests\": \"de02122eee74db370e296bcc4ce4d97cf9775853\", \"ozone_x11_unittests\": \"83a299841136de62e95849b0bc3778a7d4c21fce\", \"pdf_unittests\": \"03b6039fba0125bb7b4cbf1759e3f327c3b9f4af\", \"perfetto_unittests\": \"eb03a6d5ae00dd3ce3213ab7a4d54af5580cad4c\", \"ppapi_unittests\": \"1a41d45a45f9e4fe70af61abce5182980d1e9c5e\", \"printing_unittests\": \"442cc779213938ce1305bd845b107acf8fc27e43\", \"remoting_unittests\": \"c7bac021a4fca6f3a425f2ec13b986b0a836303a\", \"sandbox_linux_unittests\": \"66f2cd227aaab6b9f5ad00949667cee3e6a526dc\", \"service_manager_unittests\": \"43c3ab27cb44bffee87cb315c8eb4c7f754089a1\", \"services_unittests\": \"58bd66197eff00740a2bd1451e67e9015c8d2e54\", \"shell_dialogs_unittests\": \"c3149f4d20dee137bd6c00a195beb1e64742ab18\", \"skia_unittests\": \"f534e10e5c4d89c16920654ae31b4acc97c6f357\", \"snapshot_unittests\": \"736405fcf9465471835a6195749c70ee100eaead\", \"sql_unittests\": \"1af285cb28698ea158052604eda1cbb9d027d906\", \"storage_unittests\": \"826fcbbd37c180286c86194797ff7b87505d1b44\", \"sync_integration_tests\": \"9e60c4971921afef7629a3e7c8f60d5a46dac53e\", \"traffic_annotation_auditor_unittests\": \"654b13a8d156119d917c306c7c8f29e31334f1c6\", \"ui_base_unittests\": \"ee08e0c9ca6de358d2f487185d56664d57f4082b\", \"ui_chromeos_unittests\": \"36330a89773190618b6405c04ebd9a6848b46fdb\", \"ui_touch_selection_unittests\": \"bd441b8efa477534cdb79b05373123d6b863f8be\", \"unit_tests\": \"13b3a0a9dd9f826a118cb66f25eb9f738562c46a\", \"url_unittests\": \"8988914ca89bdd8d204d95a845f4ea5db1be97a2\", \"usage_time_limit_unittests\": \"7be0795af0c96089cc638af9d67136be03385586\", \"views_unittests\": \"7bbe8d623c883752879d1268f940e70363371ef6\", \"viz_unittests\": \"b52133c65af52dc7d20cc0c403b59fadfea45560\", \"wm_unittests\": \"c2de19184d805093b036d5ea0610087e197e9a63\", \"wtf_unittests\": \"6cc40625aef78363fb832e70875fc03b8213e161\"}, \"swarm_hashes_refs/heads/master(at){#644370}_without_patch\": {\"accessibility_unittests\": \"722d32bc84e78453198fd136d62286194626a44b\", \"angle_unittests\": \"f6598ee59af86fd996c2a4308dd8eabda4856955\", \"app_list_unittests\": \"131fd6bf42f8dd9dec196022670a176001c514a2\", \"app_shell_unittests\": \"0df97580845a7c97abd7c20e083242b28b4190ba\", \"ash_unittests\": \"1c66e1701db21e20720d0ca4a1519be87a1df9b5\", \"aura_unittests\": \"36c6e1e965243a6e7c5340efd8c7f5077a62c2df\", \"base_unittests\": \"95c6a2cca77714806babbcc0207d90706188051f\", \"blink_common_unittests\": \"39f6512966c7325df7293a92f3fda983234e55fb\", \"blink_fuzzer_unittests\": \"a01dca48324a6c05d1ca28f5c4ee4a3bf7503f3a\", \"blink_heap_unittests\": \"44eac188317c12cedcfb29e7582239d69109b3ad\", \"blink_platform_unittests\": \"3e9418cba42553f486d7263d361d26a2317adf28\", \"blink_unittests\": \"2aa152683dbfd8fd5e3afe2883bd8a975ee50010\", \"boringssl_crypto_tests\": \"dbc68c8d4456ea4e033e368c7fc889a813604354\", \"boringssl_ssl_tests\": \"67409f5f485ca3a81a033cc618f301ac4a09fdef\", \"browser_tests\": \"0f9db9770e4d10b25ce95241cc338efd15f8a93c\", \"cacheinvalidation_unittests\": \"ce1e4b65278ecd8bbe7e43a2da9c901e01bd8534\", \"capture_unittests\": \"4252b76aa6015f1aa5d5b9039326fc2c1b4693eb\", \"cast_unittests\": \"82598b4922e602aa20d84c50ed80daf260b853e6\", \"cc_unittests\": \"9f639d2dcd8070da12cacb96c515fbda81caa2a5\", \"chrome_app_unittests\": \"ba658938391b672b341296c46cda8372493e9466\", \"chromedriver_unittests\": \"77f075d468bc663610e83f915a479ed5101e9c2e\", \"chromeos_components_unittests\": \"9376edf1346b308ed85122a235d21b79e09b4cf8\", \"chromeos_unittests\": \"be2a7ddd89f3de7e89720d8413bf06c2c73856d6\", \"components_browsertests\": \"5655c5d2b5ab50a9df7da2b10762e7c559699379\", \"components_unittests\": \"00b8a3799b248d454c89ed22f708e67e281c1a75\", \"compositor_unittests\": \"a04236df3e8b1d3e21a53117afab0ce6ffa4b733\", \"content_browsertests\": \"c79132ff3b7f58440867411465e187ea89e0b3a9\", \"content_unittests\": \"8ae463d96f314b89d2bf629fcb79d578d2b3f3b7\", \"crypto_unittests\": \"a305fa61b02c3bd92883a8223cef6639ca7b5ea0\", \"dbus_unittests\": \"9e0f14270d6bebc3095592cb750defb913a206ba\", \"device_unittests\": \"e6588d1fd046b78af8e550cfc9620ed1ae6b8f76\", \"display_unittests\": \"bf5e0049dfc028e8a20e92cb1721eac05bb03e26\", \"events_unittests\": \"67b19e6e7978f967d019376b51d95850e125db37\", \"exo_unittests\": \"a4f8a7f6df4191c17536637e708415da80a905b1\", \"extensions_browsertests\": \"0715d95cfc858e108cafa80c6476b69fe8e7b464\", \"extensions_unittests\": \"24338d8c887f731d2964e15cac25ab3e7880d684\", \"filesystem_service_unittests\": \"fede7cddec35896300886fd4b90da9d2ba01bb99\", \"gcm_unit_tests\": \"d61287fbb3a0f23682c79349dcadc1ff30576a50\", \"gfx_unittests\": \"509ad948af13bf540db5e75cce01b05f5967602b\", \"gin_unittests\": \"b9369eb354e42cd14af1b0d09e1cb2754b145f4d\", \"gl_unittests_ozone\": \"55088bce7965701d1243e37de24f926ac9549ebe\", \"google_apis_unittests\": \"b3ccc71b1bc70151398be23fc0c87006ee3edb03\", \"gpu_unittests\": \"4839dc83defcd61dc3e004b7018a69d251854564\", \"interactive_ui_tests\": \"d160e92219163ec5c54de976aea895b46c428c9e\", \"ipc_tests\": \"385c2f42ad7499a852abb1d8eee2315f41939a67\", \"jingle_unittests\": \"5e5f86daba1915aef7dd6d8db90a66bfba1756eb\", \"keyboard_unittests\": \"da8b755ba273f9e2757fb1e71ffb3a75dd48043a\", \"latency_unittests\": \"0d4b36fd25bd8573ec88b0086c9b12dfc415fb1e\", \"leveldb_service_unittests\": \"65371bdf9a70c36d00557b838917a74d6bd6a16a\", \"libjingle_xmpp_unittests\": \"b68edb9ae64930ae0258ca2f5ce3e7d62f6fb12a\", \"media_blink_unittests\": \"491aeb243e1ee4a1b650b45219fcab595ea25291\", \"media_service_unittests\": \"41eac5371c7f412eae1c13006b020e13adbce2ce\", \"media_unittests\": \"ceb1b9996c7139a74c4fc1668181ac4a65bb09df\", \"message_center_unittests\": \"5fc64ea7bad03f7877185991ad10d16a40da4e59\", \"midi_unittests\": \"319e3f14eecb8bcc7107ef4eccf305a3c4adfb41\", \"mojo_core_unittests\": \"4134c88d2b135506a68a2510656c7a1e86bbea0a\", \"mojo_unittests\": \"f9ef44892356a4ed7acaf7351fd676ea189ef518\", \"nacl_helper_nonsfi_unittests\": \"353b4f4cbf3a86a16e5715bdd08dad3d6988b260\", \"nacl_loader_unittests\": \"0cdcdcad220466ba136f709283e6c8e093bb0ef7\", \"native_theme_unittests\": \"878b19a5b26fa2b7136ac07fd0c98a50a37ac0ec\", \"net_unittests\": \"6fbc4fdca041d3b735601ef05c74df8ac6d6e194\", \"ozone_gl_unittests\": \"cbcae3da5886b24146de44f770278d9ff13e17af\", \"ozone_unittests\": \"de02122eee74db370e296bcc4ce4d97cf9775853\", \"ozone_x11_unittests\": \"83a299841136de62e95849b0bc3778a7d4c21fce\", \"pdf_unittests\": \"03b6039fba0125bb7b4cbf1759e3f327c3b9f4af\", \"perfetto_unittests\": \"eb03a6d5ae00dd3ce3213ab7a4d54af5580cad4c\", \"ppapi_unittests\": \"1a41d45a45f9e4fe70af61abce5182980d1e9c5e\", \"printing_unittests\": \"442cc779213938ce1305bd845b107acf8fc27e43\", \"remoting_unittests\": \"c7bac021a4fca6f3a425f2ec13b986b0a836303a\", \"sandbox_linux_unittests\": \"66f2cd227aaab6b9f5ad00949667cee3e6a526dc\", \"service_manager_unittests\": \"43c3ab27cb44bffee87cb315c8eb4c7f754089a1\", \"services_unittests\": \"58bd66197eff00740a2bd1451e67e9015c8d2e54\", \"shell_dialogs_unittests\": \"c3149f4d20dee137bd6c00a195beb1e64742ab18\", \"skia_unittests\": \"f534e10e5c4d89c16920654ae31b4acc97c6f357\", \"snapshot_unittests\": \"736405fcf9465471835a6195749c70ee100eaead\", \"sql_unittests\": \"1af285cb28698ea158052604eda1cbb9d027d906\", \"storage_unittests\": \"826fcbbd37c180286c86194797ff7b87505d1b44\", \"sync_integration_tests\": \"9e60c4971921afef7629a3e7c8f60d5a46dac53e\", \"traffic_annotation_auditor_unittests\": \"654b13a8d156119d917c306c7c8f29e31334f1c6\", \"ui_base_unittests\": \"ee08e0c9ca6de358d2f487185d56664d57f4082b\", \"ui_chromeos_unittests\": \"36330a89773190618b6405c04ebd9a6848b46fdb\", \"ui_touch_selection_unittests\": \"bd441b8efa477534cdb79b05373123d6b863f8be\", \"unit_tests\": \"13b3a0a9dd9f826a118cb66f25eb9f738562c46a\", \"url_unittests\": \"8988914ca89bdd8d204d95a845f4ea5db1be97a2\", \"usage_time_limit_unittests\": \"7be0795af0c96089cc638af9d67136be03385586\", \"views_unittests\": \"7bbe8d623c883752879d1268f940e70363371ef6\", \"viz_unittests\": \"b52133c65af52dc7d20cc0c403b59fadfea45560\", \"wm_unittests\": \"c2de19184d805093b036d5ea0610087e197e9a63\", \"wtf_unittests\": \"6cc40625aef78363fb832e70875fc03b8213e161\"}}, \"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\": \"2 tests failed: ['non_network_service_browser_tests', 'non_network_service_interactive_ui_tests']\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1553619260960363",
"status": "COMPLETED",
"status_changed_ts": "1553619261324232",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/11556",
"builder:linux-chromeos-dbg",
"buildset:commit/git/321d70a0ca6f17ad8984430c5332166868053e99",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/321d70a0ca6f17ad8984430c5332166868053e99",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9083336337756101088",
"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/8917906275425373376/+/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:43d3b7e11c360310",
"user_agent:luci-scheduler"
],
"updated_ts": "1553624832799142",
"url": "https://ci.chromium.org/b/8917906275425373376",
"utcnow_ts": "1553624833200510"
}
}
[18:27:13.211] Invocation finished in 1h39m43.601087966s with status FAILED