[21:21:12.167] New invocation is queued and will start shortly
[21:21:13.261] Starting the invocation (attempt 1)
[21:21:13.303] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:21:13.304] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:21:13.304] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9078970463086576240",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"ffd7185dd83717f9d9887db0a20e8ad20f073eaf\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9078970463086576240",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/ffd7185dd83717f9d9887db0a20e8ad20f073eaf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ffd7185dd83717f9d9887db0a20e8ad20f073eaf",
"gitiles_ref:refs/heads/master"
]
}
[21:21:15.864] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "project:chromium",
"created_ts": "1557782473556879",
"id": "8913540400966712640",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"ffd7185dd83717f9d9887db0a20e8ad20f073eaf\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1557782475435196",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/12373",
"builder:linux-chromeos-dbg",
"buildset:commit/git/ffd7185dd83717f9d9887db0a20e8ad20f073eaf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ffd7185dd83717f9d9887db0a20e8ad20f073eaf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9078970463086576240",
"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/8913540400966712640/+/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": "1557782475435283",
"url": "https://ci.chromium.org/b/8913540400966712640",
"utcnow_ts": "1557782475856005"
}
}
[21:21:15.864] Task URL: https://ci.chromium.org/b/8913540400966712640
[21:21:15.864] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:2:0) after 1m0s
[21:21:24.297] Received PubSub notification, asking Buildbucket for the build status
[21:21:24.436] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:15.877] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:2:0)
[21:22:15.877] Timer tick, asking Buildbucket for the build status
[21:22:16.026] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:16.026] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:4:0) after 1m0s
[21:23:16.023] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:4:0)
[21:23:16.023] Timer tick, asking Buildbucket for the build status
[21:23:16.298] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:16.298] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:5:0) after 1m0s
[21:24:16.337] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:5:0)
[21:24:16.337] Timer tick, asking Buildbucket for the build status
[21:24:16.487] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:16.487] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:6:0) after 1m0s
[21:25:16.477] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:6:0)
[21:25:16.477] Timer tick, asking Buildbucket for the build status
[21:25:16.830] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:16.830] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:7:0) after 1m0s
[21:26:16.852] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:7:0)
[21:26:16.852] Timer tick, asking Buildbucket for the build status
[21:26:17.296] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:17.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:8:0) after 1m0s
[21:27:17.309] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:8:0)
[21:27:17.309] Timer tick, asking Buildbucket for the build status
[21:27:17.483] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:17.483] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:9:0) after 1m0s
[21:28:17.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:9:0)
[21:28:17.495] Timer tick, asking Buildbucket for the build status
[21:28:18.065] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:18.065] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:10:0) after 1m0s
[21:29:18.046] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:10:0)
[21:29:18.046] Timer tick, asking Buildbucket for the build status
[21:29:18.226] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:18.226] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:11:0) after 1m0s
[21:30:18.246] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:11:0)
[21:30:18.246] Timer tick, asking Buildbucket for the build status
[21:30:18.434] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:18.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:12:0) after 1m0s
[21:31:18.466] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:12:0)
[21:31:18.466] Timer tick, asking Buildbucket for the build status
[21:31:18.604] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:18.604] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:13:0) after 1m0s
[21:32:18.632] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:13:0)
[21:32:18.632] Timer tick, asking Buildbucket for the build status
[21:32:18.780] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:18.780] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:14:0) after 1m0s
[21:33:18.835] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:14:0)
[21:33:18.835] Timer tick, asking Buildbucket for the build status
[21:33:20.324] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:20.324] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:15:0) after 1m0s
[21:34:20.375] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:15:0)
[21:34:20.375] Timer tick, asking Buildbucket for the build status
[21:34:20.495] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:20.495] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:16:0) after 1m0s
[21:35:20.484] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:16:0)
[21:35:20.484] Timer tick, asking Buildbucket for the build status
[21:35:23.981] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:23.981] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:17:0) after 1m0s
[21:36:24.011] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:17:0)
[21:36:24.011] Timer tick, asking Buildbucket for the build status
[21:36:26.232] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:26.232] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:18:0) after 1m0s
[21:37:27.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:18:0)
[21:37:27.506] Timer tick, asking Buildbucket for the build status
[21:37:28.070] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:28.070] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:19:0) after 1m0s
[21:38:28.041] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:19:0)
[21:38:28.041] Timer tick, asking Buildbucket for the build status
[21:38:28.891] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:28.892] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:20:0) after 1m0s
[21:39:28.916] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:20:0)
[21:39:28.916] Timer tick, asking Buildbucket for the build status
[21:39:29.031] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:29.031] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:21:0) after 1m0s
[21:40:29.049] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:21:0)
[21:40:29.049] Timer tick, asking Buildbucket for the build status
[21:40:29.751] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:29.751] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:22:0) after 1m0s
[21:41:29.754] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:22:0)
[21:41:29.754] Timer tick, asking Buildbucket for the build status
[21:41:29.877] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:29.877] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:23:0) after 1m0s
[21:42:29.910] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:23:0)
[21:42:29.910] Timer tick, asking Buildbucket for the build status
[21:42:31.280] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:31.280] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:24:0) after 1m0s
[21:43:31.299] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:24:0)
[21:43:31.299] Timer tick, asking Buildbucket for the build status
[21:43:31.663] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:31.663] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:25:0) after 1m0s
[21:44:31.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:25:0)
[21:44:31.683] Timer tick, asking Buildbucket for the build status
[21:44:31.989] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:31.989] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:26:0) after 1m0s
[21:45:31.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:26:0)
[21:45:31.960] Timer tick, asking Buildbucket for the build status
[21:45:32.117] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:32.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:27:0) after 1m0s
[21:46:32.174] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:27:0)
[21:46:32.174] Timer tick, asking Buildbucket for the build status
[21:46:32.595] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:32.595] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:28:0) after 1m0s
[21:47:32.602] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:28:0)
[21:47:32.602] Timer tick, asking Buildbucket for the build status
[21:47:32.988] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:32.988] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:29:0) after 1m0s
[21:48:33.047] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:29:0)
[21:48:33.047] Timer tick, asking Buildbucket for the build status
[21:48:33.195] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:33.195] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:30:0) after 1m0s
[21:49:33.172] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:30:0)
[21:49:33.173] Timer tick, asking Buildbucket for the build status
[21:49:33.549] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:33.549] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:31:0) after 1m0s
[21:50:33.572] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:31:0)
[21:50:33.572] Timer tick, asking Buildbucket for the build status
[21:50:33.979] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:33.979] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:32:0) after 1m0s
[21:51:33.998] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:32:0)
[21:51:33.998] Timer tick, asking Buildbucket for the build status
[21:51:35.000] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:35.000] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:33:0) after 1m0s
[21:52:35.006] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:33:0)
[21:52:35.006] Timer tick, asking Buildbucket for the build status
[21:52:35.136] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:35.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:34:0) after 1m0s
[21:53:35.165] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:34:0)
[21:53:35.165] Timer tick, asking Buildbucket for the build status
[21:53:35.566] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:35.566] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:35:0) after 1m0s
[21:54:35.695] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:35:0)
[21:54:35.695] Timer tick, asking Buildbucket for the build status
[21:54:35.921] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:35.921] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:36:0) after 1m0s
[21:55:36.042] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:36:0)
[21:55:36.042] Timer tick, asking Buildbucket for the build status
[21:55:36.643] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:36.643] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:37:0) after 1m0s
[21:56:36.673] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:37:0)
[21:56:36.673] Timer tick, asking Buildbucket for the build status
[21:56:36.853] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:36.853] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:38:0) after 1m0s
[21:57:36.872] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:38:0)
[21:57:36.872] Timer tick, asking Buildbucket for the build status
[21:57:37.239] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:37.239] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:39:0) after 1m0s
[21:58:37.273] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:39:0)
[21:58:37.273] Timer tick, asking Buildbucket for the build status
[21:58:37.602] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:37.602] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:40:0) after 1m0s
[21:59:37.581] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:40:0)
[21:59:37.581] Timer tick, asking Buildbucket for the build status
[21:59:37.999] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:37.999] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:41:0) after 1m0s
[22:00:37.973] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:41:0)
[22:00:37.973] Timer tick, asking Buildbucket for the build status
[22:00:40.703] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:40.703] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:42:0) after 1m0s
[22:01:40.727] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:42:0)
[22:01:40.727] Timer tick, asking Buildbucket for the build status
[22:01:40.841] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:40.841] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:43:0) after 1m0s
[22:02:40.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:43:0)
[22:02:40.857] Timer tick, asking Buildbucket for the build status
[22:02:41.301] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:41.301] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:44:0) after 1m0s
[22:03:41.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:44:0)
[22:03:41.327] Timer tick, asking Buildbucket for the build status
[22:03:41.593] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:41.593] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:45:0) after 1m0s
[22:04:41.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:45:0)
[22:04:41.615] Timer tick, asking Buildbucket for the build status
[22:04:44.754] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:44.754] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:46:0) after 1m0s
[22:05:44.799] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:46:0)
[22:05:44.799] Timer tick, asking Buildbucket for the build status
[22:05:45.678] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:45.678] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:47:0) after 1m0s
[22:06:45.689] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:47:0)
[22:06:45.689] Timer tick, asking Buildbucket for the build status
[22:06:46.502] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:46.502] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:48:0) after 1m0s
[22:07:46.480] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:48:0)
[22:07:46.480] Timer tick, asking Buildbucket for the build status
[22:07:48.520] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:48.520] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:49:0) after 1m0s
[22:08:48.539] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:49:0)
[22:08:48.539] Timer tick, asking Buildbucket for the build status
[22:08:49.460] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:49.460] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:50:0) after 1m0s
[22:09:49.487] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:50:0)
[22:09:49.487] Timer tick, asking Buildbucket for the build status
[22:09:49.669] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:49.669] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:51:0) after 1m0s
[22:10:49.695] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:51:0)
[22:10:49.696] Timer tick, asking Buildbucket for the build status
[22:10:51.961] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:51.961] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:52:0) after 1m0s
[22:11:52.005] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:52:0)
[22:11:52.005] Timer tick, asking Buildbucket for the build status
[22:11:52.170] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:52.170] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:53:0) after 1m0s
[22:12:52.192] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:53:0)
[22:12:52.192] Timer tick, asking Buildbucket for the build status
[22:12:52.867] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:52.867] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:54:0) after 1m0s
[22:13:52.873] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:54:0)
[22:13:52.873] Timer tick, asking Buildbucket for the build status
[22:13:53.070] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:53.070] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:55:0) after 1m0s
[22:14:53.116] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:55:0)
[22:14:53.116] Timer tick, asking Buildbucket for the build status
[22:14:53.354] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:53.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:56:0) after 1m0s
[22:15:53.453] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:56:0)
[22:15:53.453] Timer tick, asking Buildbucket for the build status
[22:15:53.575] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:53.575] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:57:0) after 1m0s
[22:16:54.132] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:57:0)
[22:16:54.132] Timer tick, asking Buildbucket for the build status
[22:16:54.422] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:54.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:58:0) after 1m0s
[22:17:54.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:58:0)
[22:17:54.442] Timer tick, asking Buildbucket for the build status
[22:17:54.709] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:54.709] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:59:0) after 1m0s
[22:18:54.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:59:0)
[22:18:54.925] Timer tick, asking Buildbucket for the build status
[22:18:55.121] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:55.121] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:60:0) after 1m0s
[22:19:55.451] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:60:0)
[22:19:55.451] Timer tick, asking Buildbucket for the build status
[22:19:56.427] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:56.427] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:61:0) after 1m0s
[22:20:56.451] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:61:0)
[22:20:56.451] Timer tick, asking Buildbucket for the build status
[22:20:57.082] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:57.082] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:62:0) after 1m0s
[22:21:58.401] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:62:0)
[22:21:58.401] Timer tick, asking Buildbucket for the build status
[22:21:59.289] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:59.289] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:63:0) after 1m0s
[22:23:00.152] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:63:0)
[22:23:00.152] Timer tick, asking Buildbucket for the build status
[22:23:03.263] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:03.263] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:64:0) after 1m0s
[22:24:03.430] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:64:0)
[22:24:03.430] Timer tick, asking Buildbucket for the build status
[22:24:03.653] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:03.653] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:65:0) after 1m0s
[22:25:03.719] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:65:0)
[22:25:03.719] Timer tick, asking Buildbucket for the build status
[22:25:05.315] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:05.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:66:0) after 1m0s
[22:26:05.339] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:66:0)
[22:26:05.339] Timer tick, asking Buildbucket for the build status
[22:26:06.042] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:06.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:67:0) after 1m0s
[22:27:06.079] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:67:0)
[22:27:06.079] Timer tick, asking Buildbucket for the build status
[22:27:06.592] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:06.592] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:68:0) after 1m0s
[22:28:06.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:68:0)
[22:28:06.615] Timer tick, asking Buildbucket for the build status
[22:28:06.876] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:06.876] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:69:0) after 1m0s
[22:29:06.901] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:69:0)
[22:29:06.901] Timer tick, asking Buildbucket for the build status
[22:29:07.477] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:07.477] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:70:0) after 1m0s
[22:30:07.503] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:70:0)
[22:30:07.503] Timer tick, asking Buildbucket for the build status
[22:30:08.342] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:08.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:71:0) after 1m0s
[22:31:08.374] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:71:0)
[22:31:08.374] Timer tick, asking Buildbucket for the build status
[22:31:09.487] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:09.487] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:72:0) after 1m0s
[22:32:09.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:72:0)
[22:32:09.537] Timer tick, asking Buildbucket for the build status
[22:32:09.706] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:09.706] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:73:0) after 1m0s
[22:33:09.718] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:73:0)
[22:33:09.718] Timer tick, asking Buildbucket for the build status
[22:33:09.939] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:09.939] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:74:0) after 1m0s
[22:34:09.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:74:0)
[22:34:09.975] Timer tick, asking Buildbucket for the build status
[22:34:10.589] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:10.589] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:75:0) after 1m0s
[22:35:10.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:75:0)
[22:35:10.615] Timer tick, asking Buildbucket for the build status
[22:35:10.819] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:10.819] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:76:0) after 1m0s
[22:36:10.821] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:76:0)
[22:36:10.821] Timer tick, asking Buildbucket for the build status
[22:36:11.063] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:11.063] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:77:0) after 1m0s
[22:37:11.091] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:77:0)
[22:37:11.091] Timer tick, asking Buildbucket for the build status
[22:37:12.301] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:12.301] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:78:0) after 1m0s
[22:38:12.325] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:78:0)
[22:38:12.325] Timer tick, asking Buildbucket for the build status
[22:38:12.901] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:12.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:79:0) after 1m0s
[22:39:12.910] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:79:0)
[22:39:12.910] Timer tick, asking Buildbucket for the build status
[22:39:13.009] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:13.009] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:80:0) after 1m0s
[22:40:13.028] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:80:0)
[22:40:13.028] Timer tick, asking Buildbucket for the build status
[22:40:13.887] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:13.887] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:81:0) after 1m0s
[22:41:13.907] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:81:0)
[22:41:13.907] Timer tick, asking Buildbucket for the build status
[22:41:15.004] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:15.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:82:0) after 1m0s
[22:42:15.013] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:82:0)
[22:42:15.013] Timer tick, asking Buildbucket for the build status
[22:42:15.809] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:15.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:83:0) after 1m0s
[22:43:15.877] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:83:0)
[22:43:15.877] Timer tick, asking Buildbucket for the build status
[22:43:18.022] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:18.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:84:0) after 1m0s
[22:44:18.111] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:84:0)
[22:44:18.111] Timer tick, asking Buildbucket for the build status
[22:44:18.450] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:18.450] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:85:0) after 1m0s
[22:45:18.588] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:85:0)
[22:45:18.588] Timer tick, asking Buildbucket for the build status
[22:45:18.935] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:18.935] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:86:0) after 1m0s
[22:46:18.961] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:86:0)
[22:46:18.961] Timer tick, asking Buildbucket for the build status
[22:46:19.211] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:19.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:87:0) after 1m0s
[22:47:19.277] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:87:0)
[22:47:19.277] Timer tick, asking Buildbucket for the build status
[22:47:19.588] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:19.588] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:88:0) after 1m0s
[22:48:19.688] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:88:0)
[22:48:19.688] Timer tick, asking Buildbucket for the build status
[22:48:19.897] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:19.897] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:89:0) after 1m0s
[22:49:19.908] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:89:0)
[22:49:19.908] Timer tick, asking Buildbucket for the build status
[22:49:20.830] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:20.830] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:90:0) after 1m0s
[22:50:20.865] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:90:0)
[22:50:20.865] Timer tick, asking Buildbucket for the build status
[22:50:21.191] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:21.191] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:91:0) after 1m0s
[22:51:21.211] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:91:0)
[22:51:21.211] Timer tick, asking Buildbucket for the build status
[22:51:24.566] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:24.567] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:92:0) after 1m0s
[22:52:24.588] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:92:0)
[22:52:24.588] Timer tick, asking Buildbucket for the build status
[22:52:24.710] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:24.710] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:93:0) after 1m0s
[22:53:24.738] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:93:0)
[22:53:24.738] Timer tick, asking Buildbucket for the build status
[22:53:24.834] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:24.834] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:94:0) after 1m0s
[22:54:24.872] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:94:0)
[22:54:24.872] Timer tick, asking Buildbucket for the build status
[22:54:25.032] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:25.032] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:95:0) after 1m0s
[22:55:25.069] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:95:0)
[22:55:25.069] Timer tick, asking Buildbucket for the build status
[22:55:25.455] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:25.455] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:96:0) after 1m0s
[22:56:25.484] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:96:0)
[22:56:25.484] Timer tick, asking Buildbucket for the build status
[22:56:28.227] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:28.227] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:97:0) after 1m0s
[22:57:28.277] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:97:0)
[22:57:28.277] Timer tick, asking Buildbucket for the build status
[22:57:30.870] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:30.870] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:98:0) after 1m0s
[22:58:30.887] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:98:0)
[22:58:30.887] Timer tick, asking Buildbucket for the build status
[22:58:30.999] Build 8913540400966712640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:30.999] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9078970463086576240:99:0) after 1m0s
[22:58:53.174] Received PubSub notification, asking Buildbucket for the build status
[22:58:54.270] Build 8913540400966712640: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[22:58:54.270] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1557788332132230",
"created_by": "project:chromium",
"created_ts": "1557782473556879",
"failure_reason": "BUILD_FAILURE",
"id": "8913540400966712640",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"ffd7185dd83717f9d9887db0a20e8ad20f073eaf\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"3 tests failed: ['ash_unittests', 'unit_tests', 'exo_unittests']\"}, \"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\": 12373, \"got_angle_revision\": \"0a1eeb80641a30db9b27bafc78e0fcfd6ac792c1\", \"got_dawn_revision\": \"97f08fa2e68f3505384395a8b6594fb70bdec6a3\", \"got_nacl_revision\": \"ca374f5112fca6b36fc5d73e117a60b82f394993\", \"got_revision\": \"ffd7185dd83717f9d9887db0a20e8ad20f073eaf\", \"got_revision_cp\": \"refs/heads/master@{#659211}\", \"got_swarming_client_revision\": \"1b65f4e862045f3ba430a4cbd0643f5b1b66c230\", \"got_v8_revision\": \"4894cb223bbf534d11c95d4c3319408b2e1c6ec3\", \"got_v8_revision_cp\": \"refs/heads/7.6.163@{#1}\", \"got_webrtc_revision\": \"5fc28b11a029b22c341c59dac8e766c178b02d95\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#27933}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.chromiumos\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"ffd7185dd83717f9d9887db0a20e8ad20f073eaf\", \"swarm_hashes\": {\"accessibility_unittests\": \"b05ada13e68ab9f5d55b6e6d9a320687cb5d7eee\", \"angle_unittests\": \"3db5bba4514d9a5a31ad6bf26c76b9abe494ac93\", \"app_list_unittests\": \"461e2a0d0e8237c747cd16ef4e7228a0721b1c93\", \"app_shell_unittests\": \"315cba50f158f50b903f5df7636233e0616c3d91\", \"ash_unittests\": \"5e68c0c4834544f314b25d8c573a1b1603a2f20e\", \"aura_unittests\": \"91dd0f9ee414d07515f2c9dd6868365b841f0b02\", \"base_unittests\": \"7f5269ca71644c6cd4f046fb14cef0c315b25e94\", \"base_util_unittests\": \"c1b7abfc6afd0f16ca760f2455d53e1c70ae4bf0\", \"blink_common_unittests\": \"88e147c8992f5bd27481df08e40ef09aece8927a\", \"blink_fuzzer_unittests\": \"e599bafce678e3b22f753f3fb0efc8a2455074a8\", \"blink_heap_unittests\": \"b2f7501bc0770207524a46bd2a611e18556968f8\", \"blink_platform_unittests\": \"26ebaf9e07022adb6ca375510d6700376c6d989b\", \"blink_unittests\": \"6d45628e6075e89350ad5c2c7d389928d8dcb616\", \"boringssl_crypto_tests\": \"8144b0dd3bd459fddde6e56527a4105b6a227f8a\", \"boringssl_ssl_tests\": \"a404ac642c0f1f006236bea012084b7e450531b7\", \"browser_tests\": \"54192c32a11662a08acc9dce584c1b4d57f1d9a2\", \"cacheinvalidation_unittests\": \"16c16b33f1b590e03579db834b282693161bb641\", \"capture_unittests\": \"53361020f92eb59d5e11cca036fe15f3d2b2cefc\", \"cast_unittests\": \"458a7fc2b82d66238e980e38ce91c88e579342f0\", \"cc_unittests\": \"f96a3c43b36f4c5e333f36d46c76f2084a97d837\", \"chrome_app_unittests\": \"a0146ab2d17b1f12bb04d8571666b4e017e25ff2\", \"chromedriver_unittests\": \"b2b7434e17319728ae3ea00c1fe197ea9ce0b02d\", \"chromeos_components_unittests\": \"9fc8457bd14f8eb4160bdf8ca29faf6a0dc82eb6\", \"chromeos_unittests\": \"8b82b611c73dffad3e1d597eab0f415a358b3f1f\", \"components_browsertests\": \"cb56bc48bdbb0f7ccc7069fe4c6752e21f5482f2\", \"components_unittests\": \"3178cb4656489f708635ad41150d2a74ad698811\", \"compositor_unittests\": \"e85e59633d7cf560f6f82c23ccd4186485167c6d\", \"content_browsertests\": \"27b07fc91fab15827b22ece6c8c9b7573035201d\", \"content_unittests\": \"3eda2763d0a4e82438b121a9a9137a39c2db94cf\", \"crypto_unittests\": \"10fcbb81e5e1bc88c0e08a81b2fc545b932962d2\", \"dbus_unittests\": \"5830c44b258d60bfdfef47721c14dc025ed87662\", \"device_unittests\": \"876e20f1826aff7b21c71e1566ec26877a8e65e5\", \"display_unittests\": \"2abfcc42f6415ca86d52d9886a6f9addfe56cba4\", \"events_unittests\": \"3335c0dd856582a38b11b42d5b4b4fb51d8d4fd5\", \"exo_unittests\": \"08c4f7bcbb03ba5aec2748e25b6ad9143ee84c3e\", \"extensions_browsertests\": \"4e6289527206162c095c8bc712b3ca5bc21b9c3f\", \"extensions_unittests\": \"087e679efff3893ca53c5b631b386e3b47b1a08d\", \"filesystem_service_unittests\": \"daf86fb9746980423e8ef9d7c599603cb6965418\", \"gcm_unit_tests\": \"bdbad51e688e7ae56ebcdfdf2dc96fcb4d581000\", \"gfx_unittests\": \"fe3b21cd0f5afc7ed3a82ade254ab2537fcab495\", \"gin_unittests\": \"17366157265e12e55fe3a46db8d3cd8029565640\", \"gl_unittests_ozone\": \"ba73d37aa79cc685993f27ef42bd8149705ee74f\", \"google_apis_unittests\": \"ddcad310f70924c4fd813501b53cfe366bd79386\", \"gpu_unittests\": \"ed942dba0d32d67435a8604cd5e0168e4e20cd76\", \"interactive_ui_tests\": \"19ca704a6920b75dc0266b4f79fd2d3484136049\", \"ipc_tests\": \"695ae6fdfdf53ae45399d34bcf4edf368043fe18\", \"jingle_unittests\": \"cd79a457807fbcb71bed7419ecec7d31af589306\", \"keyboard_unittests\": \"2b84b6df49f24dfca53f336358d419f02fb308a5\", \"latency_unittests\": \"650f93c951bee8fa5aab6ae2a1a3f9c9341136d4\", \"leveldb_service_unittests\": \"53ddb7117c048960051e820f0f841f30689be08a\", \"libjingle_xmpp_unittests\": \"a0b88e0de9cfb71adaa6e022d3091aaef5280321\", \"media_blink_unittests\": \"b42f083de8c9c67b546619d04cd1254ca9971764\", \"media_service_unittests\": \"88fe4a3aec6a3838c37edf8f87d97b50d9bec20e\", \"media_unittests\": \"2a41a3772a2a8b2d5e7490527836b64be4f96bcd\", \"message_center_unittests\": \"bf27d3ab50bf3ded9f3f864d695cea58b73076b1\", \"midi_unittests\": \"a9d726efb82e571368d83129c73e84e4c5d0c99c\", \"mojo_core_unittests\": \"476646d74eed0aa92078c6e5eb8f7e67b6d57df8\", \"mojo_unittests\": \"1e59343aaa4525664bfe47f4175fb097f7116f95\", \"nacl_helper_nonsfi_unittests\": \"ef0e1e317f2c16d25b6366574e2ba1e5136f2e7a\", \"nacl_loader_unittests\": \"9c30a7c664eac1ec814ecdb388abccae2c1d3e5b\", \"native_theme_unittests\": \"9176f1a0ad175f4b5ded69b9afb39138237a77fb\", \"net_unittests\": \"38683ac5fd5f3529b4416bcb6f292ac56eb62268\", \"ozone_gl_unittests\": \"3ff799a74f9d5c96479d2ff2aced533d67967d91\", \"ozone_unittests\": \"f51869e51ad67805ac16403eae54795487f22315\", \"ozone_x11_unittests\": \"da370d8548dc5a0c5737b414acc15216d0813d91\", \"pdf_unittests\": \"668e51e8ce6f95575acd31becf73c36da75549c7\", \"perfetto_unittests\": \"9794d3401c1c481d08a26a95faf5b245bdcf63b5\", \"ppapi_unittests\": \"3bfae7fc51697c34b08d0e922e5755aaed9a1a80\", \"printing_unittests\": \"777b157a613c4b4291cbd282e9d6a889d1a6624c\", \"remoting_unittests\": \"32ac6ec8e9661bec80492fe37430a2ab6947bb13\", \"sandbox_linux_unittests\": \"831832a17e626429d4c23875acd743e1ca1e4d51\", \"service_manager_unittests\": \"aeaa0adc7716251f4d3d1d8de28c3a7410b9877c\", \"services_unittests\": \"705ce2a8ff33752b4580b64d72890a87975799b7\", \"shell_dialogs_unittests\": \"6e881c796ae024e7984b11948adb4de172ba8bcf\", \"skia_unittests\": \"ea18ec7ebbcca102dc1b8f180a72bcabef9564f6\", \"snapshot_unittests\": \"4a2c24d47e8b7273f80155ee6bfc1d7da86a2590\", \"sql_unittests\": \"31c401f8b41920215238705afd976257da7db963\", \"storage_unittests\": \"38ed18066db654ddba725e2a19e489d24f6e03ab\", \"sync_integration_tests\": \"d1e009bc174e33e4d68f32d0004cf6c6f58daed3\", \"traffic_annotation_auditor_unittests\": \"4054d1b3600553b00d3e4ef33d0211f8a32ba178\", \"ui_base_unittests\": \"ad488a4d9d8eff6a2e0315ac272dea21a8bca5ee\", \"ui_chromeos_unittests\": \"d666c455cffb693b03b527497ca1a69fa6366f17\", \"ui_touch_selection_unittests\": \"b9b9e64faa9ce543e8d32ec07dce54332eb0ff92\", \"unit_tests\": \"d5c5c45b221df508517c36f45fa24c1101f75a81\", \"url_unittests\": \"e823e3626369ef22d0f0b28ec54d3d794a9d7785\", \"usage_time_limit_unittests\": \"b7aa82f6a785dd41e7453d3de05a0f48e98cbfd5\", \"views_unittests\": \"3e8edb6d92caa2fbe79f3f38f6ee59d5c1837cb9\", \"viz_unittests\": \"309309e685ad5b0156e282912ed1731db34ceaa7\", \"wm_unittests\": \"841094abbb6d52d0e5b5059fde51adebc3181344\", \"wtf_unittests\": \"616cdde1d9972927d886c2fb9bf20715c50a4255\"}, \"swarm_hashes_refs/heads/master(at){#659211}_without_patch\": {\"accessibility_unittests\": \"b05ada13e68ab9f5d55b6e6d9a320687cb5d7eee\", \"angle_unittests\": \"3db5bba4514d9a5a31ad6bf26c76b9abe494ac93\", \"app_list_unittests\": \"461e2a0d0e8237c747cd16ef4e7228a0721b1c93\", \"app_shell_unittests\": \"315cba50f158f50b903f5df7636233e0616c3d91\", \"ash_unittests\": \"5e68c0c4834544f314b25d8c573a1b1603a2f20e\", \"aura_unittests\": \"91dd0f9ee414d07515f2c9dd6868365b841f0b02\", \"base_unittests\": \"7f5269ca71644c6cd4f046fb14cef0c315b25e94\", \"base_util_unittests\": \"c1b7abfc6afd0f16ca760f2455d53e1c70ae4bf0\", \"blink_common_unittests\": \"88e147c8992f5bd27481df08e40ef09aece8927a\", \"blink_fuzzer_unittests\": \"e599bafce678e3b22f753f3fb0efc8a2455074a8\", \"blink_heap_unittests\": \"b2f7501bc0770207524a46bd2a611e18556968f8\", \"blink_platform_unittests\": \"26ebaf9e07022adb6ca375510d6700376c6d989b\", \"blink_unittests\": \"6d45628e6075e89350ad5c2c7d389928d8dcb616\", \"boringssl_crypto_tests\": \"8144b0dd3bd459fddde6e56527a4105b6a227f8a\", \"boringssl_ssl_tests\": \"a404ac642c0f1f006236bea012084b7e450531b7\", \"browser_tests\": \"54192c32a11662a08acc9dce584c1b4d57f1d9a2\", \"cacheinvalidation_unittests\": \"16c16b33f1b590e03579db834b282693161bb641\", \"capture_unittests\": \"53361020f92eb59d5e11cca036fe15f3d2b2cefc\", \"cast_unittests\": \"458a7fc2b82d66238e980e38ce91c88e579342f0\", \"cc_unittests\": \"f96a3c43b36f4c5e333f36d46c76f2084a97d837\", \"chrome_app_unittests\": \"a0146ab2d17b1f12bb04d8571666b4e017e25ff2\", \"chromedriver_unittests\": \"b2b7434e17319728ae3ea00c1fe197ea9ce0b02d\", \"chromeos_components_unittests\": \"9fc8457bd14f8eb4160bdf8ca29faf6a0dc82eb6\", \"chromeos_unittests\": \"8b82b611c73dffad3e1d597eab0f415a358b3f1f\", \"components_browsertests\": \"cb56bc48bdbb0f7ccc7069fe4c6752e21f5482f2\", \"components_unittests\": \"3178cb4656489f708635ad41150d2a74ad698811\", \"compositor_unittests\": \"e85e59633d7cf560f6f82c23ccd4186485167c6d\", \"content_browsertests\": \"27b07fc91fab15827b22ece6c8c9b7573035201d\", \"content_unittests\": \"3eda2763d0a4e82438b121a9a9137a39c2db94cf\", \"crypto_unittests\": \"10fcbb81e5e1bc88c0e08a81b2fc545b932962d2\", \"dbus_unittests\": \"5830c44b258d60bfdfef47721c14dc025ed87662\", \"device_unittests\": \"876e20f1826aff7b21c71e1566ec26877a8e65e5\", \"display_unittests\": \"2abfcc42f6415ca86d52d9886a6f9addfe56cba4\", \"events_unittests\": \"3335c0dd856582a38b11b42d5b4b4fb51d8d4fd5\", \"exo_unittests\": \"08c4f7bcbb03ba5aec2748e25b6ad9143ee84c3e\", \"extensions_browsertests\": \"4e6289527206162c095c8bc712b3ca5bc21b9c3f\", \"extensions_unittests\": \"087e679efff3893ca53c5b631b386e3b47b1a08d\", \"filesystem_service_unittests\": \"daf86fb9746980423e8ef9d7c599603cb6965418\", \"gcm_unit_tests\": \"bdbad51e688e7ae56ebcdfdf2dc96fcb4d581000\", \"gfx_unittests\": \"fe3b21cd0f5afc7ed3a82ade254ab2537fcab495\", \"gin_unittests\": \"17366157265e12e55fe3a46db8d3cd8029565640\", \"gl_unittests_ozone\": \"ba73d37aa79cc685993f27ef42bd8149705ee74f\", \"google_apis_unittests\": \"ddcad310f70924c4fd813501b53cfe366bd79386\", \"gpu_unittests\": \"ed942dba0d32d67435a8604cd5e0168e4e20cd76\", \"interactive_ui_tests\": \"19ca704a6920b75dc0266b4f79fd2d3484136049\", \"ipc_tests\": \"695ae6fdfdf53ae45399d34bcf4edf368043fe18\", \"jingle_unittests\": \"cd79a457807fbcb71bed7419ecec7d31af589306\", \"keyboard_unittests\": \"2b84b6df49f24dfca53f336358d419f02fb308a5\", \"latency_unittests\": \"650f93c951bee8fa5aab6ae2a1a3f9c9341136d4\", \"leveldb_service_unittests\": \"53ddb7117c048960051e820f0f841f30689be08a\", \"libjingle_xmpp_unittests\": \"a0b88e0de9cfb71adaa6e022d3091aaef5280321\", \"media_blink_unittests\": \"b42f083de8c9c67b546619d04cd1254ca9971764\", \"media_service_unittests\": \"88fe4a3aec6a3838c37edf8f87d97b50d9bec20e\", \"media_unittests\": \"2a41a3772a2a8b2d5e7490527836b64be4f96bcd\", \"message_center_unittests\": \"bf27d3ab50bf3ded9f3f864d695cea58b73076b1\", \"midi_unittests\": \"a9d726efb82e571368d83129c73e84e4c5d0c99c\", \"mojo_core_unittests\": \"476646d74eed0aa92078c6e5eb8f7e67b6d57df8\", \"mojo_unittests\": \"1e59343aaa4525664bfe47f4175fb097f7116f95\", \"nacl_helper_nonsfi_unittests\": \"ef0e1e317f2c16d25b6366574e2ba1e5136f2e7a\", \"nacl_loader_unittests\": \"9c30a7c664eac1ec814ecdb388abccae2c1d3e5b\", \"native_theme_unittests\": \"9176f1a0ad175f4b5ded69b9afb39138237a77fb\", \"net_unittests\": \"38683ac5fd5f3529b4416bcb6f292ac56eb62268\", \"ozone_gl_unittests\": \"3ff799a74f9d5c96479d2ff2aced533d67967d91\", \"ozone_unittests\": \"f51869e51ad67805ac16403eae54795487f22315\", \"ozone_x11_unittests\": \"da370d8548dc5a0c5737b414acc15216d0813d91\", \"pdf_unittests\": \"668e51e8ce6f95575acd31becf73c36da75549c7\", \"perfetto_unittests\": \"9794d3401c1c481d08a26a95faf5b245bdcf63b5\", \"ppapi_unittests\": \"3bfae7fc51697c34b08d0e922e5755aaed9a1a80\", \"printing_unittests\": \"777b157a613c4b4291cbd282e9d6a889d1a6624c\", \"remoting_unittests\": \"32ac6ec8e9661bec80492fe37430a2ab6947bb13\", \"sandbox_linux_unittests\": \"831832a17e626429d4c23875acd743e1ca1e4d51\", \"service_manager_unittests\": \"aeaa0adc7716251f4d3d1d8de28c3a7410b9877c\", \"services_unittests\": \"705ce2a8ff33752b4580b64d72890a87975799b7\", \"shell_dialogs_unittests\": \"6e881c796ae024e7984b11948adb4de172ba8bcf\", \"skia_unittests\": \"ea18ec7ebbcca102dc1b8f180a72bcabef9564f6\", \"snapshot_unittests\": \"4a2c24d47e8b7273f80155ee6bfc1d7da86a2590\", \"sql_unittests\": \"31c401f8b41920215238705afd976257da7db963\", \"storage_unittests\": \"38ed18066db654ddba725e2a19e489d24f6e03ab\", \"sync_integration_tests\": \"d1e009bc174e33e4d68f32d0004cf6c6f58daed3\", \"traffic_annotation_auditor_unittests\": \"4054d1b3600553b00d3e4ef33d0211f8a32ba178\", \"ui_base_unittests\": \"ad488a4d9d8eff6a2e0315ac272dea21a8bca5ee\", \"ui_chromeos_unittests\": \"d666c455cffb693b03b527497ca1a69fa6366f17\", \"ui_touch_selection_unittests\": \"b9b9e64faa9ce543e8d32ec07dce54332eb0ff92\", \"unit_tests\": \"d5c5c45b221df508517c36f45fa24c1101f75a81\", \"url_unittests\": \"e823e3626369ef22d0f0b28ec54d3d794a9d7785\", \"usage_time_limit_unittests\": \"b7aa82f6a785dd41e7453d3de05a0f48e98cbfd5\", \"views_unittests\": \"3e8edb6d92caa2fbe79f3f38f6ee59d5c1837cb9\", \"viz_unittests\": \"309309e685ad5b0156e282912ed1731db34ceaa7\", \"wm_unittests\": \"841094abbb6d52d0e5b5059fde51adebc3181344\", \"wtf_unittests\": \"616cdde1d9972927d886c2fb9bf20715c50a4255\"}}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"linux-chromeos-dbg\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"swarm1567-c4\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4293-d3520ea\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"3 tests failed: ['ash_unittests', 'unit_tests', 'exo_unittests']\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1557782482971856",
"status": "COMPLETED",
"status_changed_ts": "1557782484075386",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/12373",
"builder:linux-chromeos-dbg",
"buildset:commit/git/ffd7185dd83717f9d9887db0a20e8ad20f073eaf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ffd7185dd83717f9d9887db0a20e8ad20f073eaf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9078970463086576240",
"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/8913540400966712640/+/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:44cbe3bf80861810",
"user_agent:luci-scheduler"
],
"updated_ts": "1557788332894297",
"url": "https://ci.chromium.org/b/8913540400966712640",
"utcnow_ts": "1557788334244491"
}
}
[22:58:54.270] Invocation finished in 1h37m42.118984604s with status FAILED