[04:09:16.139] New invocation is queued and will start shortly
[04:09:17.211] Starting the invocation (attempt 1)
[04:09:17.244] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:09:17.244] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:09:17.244] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9083384041136260464",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"2cfb4656b8fdc62f5e837945e9898e66f176d58c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9083384041136260464",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/2cfb4656b8fdc62f5e837945e9898e66f176d58c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2cfb4656b8fdc62f5e837945e9898e66f176d58c",
"gitiles_ref:refs/heads/master"
]
}
[04:09:18.541] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "project:chromium",
"created_ts": "1553573357704116",
"id": "8917953978830501104",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"2cfb4656b8fdc62f5e837945e9898e66f176d58c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1553573358305312",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/11548",
"builder:linux-chromeos-dbg",
"buildset:commit/git/2cfb4656b8fdc62f5e837945e9898e66f176d58c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2cfb4656b8fdc62f5e837945e9898e66f176d58c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9083384041136260464",
"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/8917953978830501104/+/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": "1553573358305481",
"url": "https://ci.chromium.org/b/8917953978830501104",
"utcnow_ts": "1553573358528726"
}
}
[04:09:18.541] Task URL: https://ci.chromium.org/b/8917953978830501104
[04:09:18.541] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:2:0) after 1m0s
[04:10:18.560] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:2:0)
[04:10:18.560] Timer tick, asking Buildbucket for the build status
[04:10:18.660] Build 8917953978830501104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:10:18.660] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:3:0) after 1m0s
[04:11:18.666] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:3:0)
[04:11:18.666] Timer tick, asking Buildbucket for the build status
[04:11:19.287] Build 8917953978830501104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:11:19.287] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:4:0) after 1m0s
[04:12:19.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:4:0)
[04:12:19.305] Timer tick, asking Buildbucket for the build status
[04:12:19.412] Build 8917953978830501104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:12:19.412] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:5:0) after 1m0s
[04:13:19.430] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:5:0)
[04:13:19.430] Timer tick, asking Buildbucket for the build status
[04:13:19.860] Build 8917953978830501104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:13:19.860] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:6:0) after 1m0s
[04:14:19.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:6:0)
[04:14:19.888] Timer tick, asking Buildbucket for the build status
[04:14:20.037] Build 8917953978830501104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:14:20.037] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:7:0) after 1m0s
[04:15:06.652] Received PubSub notification, asking Buildbucket for the build status
[04:15:06.904] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:20.056] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:7:0)
[04:15:20.056] Timer tick, asking Buildbucket for the build status
[04:15:20.487] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:20.487] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:9:0) after 1m0s
[04:16:20.509] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:9:0)
[04:16:20.509] Timer tick, asking Buildbucket for the build status
[04:16:21.170] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:21.170] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:10:0) after 1m0s
[04:17:21.175] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:10:0)
[04:17:21.175] Timer tick, asking Buildbucket for the build status
[04:17:21.320] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:21.320] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:11:0) after 1m0s
[04:18:21.354] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:11:0)
[04:18:21.354] Timer tick, asking Buildbucket for the build status
[04:18:21.519] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:21.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:12:0) after 1m0s
[04:19:21.532] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:12:0)
[04:19:21.532] Timer tick, asking Buildbucket for the build status
[04:19:21.629] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:21.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:13:0) after 1m0s
[04:20:21.700] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:13:0)
[04:20:21.700] Timer tick, asking Buildbucket for the build status
[04:20:21.954] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:21.954] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:14:0) after 1m0s
[04:21:21.973] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:14:0)
[04:21:21.973] Timer tick, asking Buildbucket for the build status
[04:21:22.465] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:22.465] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:15:0) after 1m0s
[04:22:22.459] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:15:0)
[04:22:22.460] Timer tick, asking Buildbucket for the build status
[04:22:22.864] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:22.864] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:16:0) after 1m0s
[04:23:22.873] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:16:0)
[04:23:22.873] Timer tick, asking Buildbucket for the build status
[04:23:23.007] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:23.007] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:17:0) after 1m0s
[04:24:23.024] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:17:0)
[04:24:23.024] Timer tick, asking Buildbucket for the build status
[04:24:23.467] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:23.467] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:18:0) after 1m0s
[04:25:23.485] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:18:0)
[04:25:23.485] Timer tick, asking Buildbucket for the build status
[04:25:23.623] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:23.623] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:19:0) after 1m0s
[04:26:23.641] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:19:0)
[04:26:23.641] Timer tick, asking Buildbucket for the build status
[04:26:24.282] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:24.282] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:20:0) after 1m0s
[04:27:24.299] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:20:0)
[04:27:24.300] Timer tick, asking Buildbucket for the build status
[04:27:24.393] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:24.393] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:21:0) after 1m0s
[04:28:24.419] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:21:0)
[04:28:24.419] Timer tick, asking Buildbucket for the build status
[04:28:24.771] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:24.771] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:22:0) after 1m0s
[04:29:24.779] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:22:0)
[04:29:24.779] Timer tick, asking Buildbucket for the build status
[04:29:24.887] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:24.887] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:23:0) after 1m0s
[04:30:24.858] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:23:0)
[04:30:24.858] Timer tick, asking Buildbucket for the build status
[04:30:25.566] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:25.566] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:24:0) after 1m0s
[04:31:25.607] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:24:0)
[04:31:25.607] Timer tick, asking Buildbucket for the build status
[04:31:25.712] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:25.712] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:25:0) after 1m0s
[04:32:25.740] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:25:0)
[04:32:25.740] Timer tick, asking Buildbucket for the build status
[04:32:27.178] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:27.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:26:0) after 1m0s
[04:33:27.197] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:26:0)
[04:33:27.197] Timer tick, asking Buildbucket for the build status
[04:33:27.478] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:27.478] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:27:0) after 1m0s
[04:34:27.557] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:27:0)
[04:34:27.557] Timer tick, asking Buildbucket for the build status
[04:34:27.846] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:27.846] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:28:0) after 1m0s
[04:35:27.865] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:28:0)
[04:35:27.865] Timer tick, asking Buildbucket for the build status
[04:35:27.948] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:27.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:29:0) after 1m0s
[04:36:27.967] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:29:0)
[04:36:27.967] Timer tick, asking Buildbucket for the build status
[04:36:28.466] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:28.466] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:30:0) after 1m0s
[04:37:28.487] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:30:0)
[04:37:28.487] Timer tick, asking Buildbucket for the build status
[04:37:29.130] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:29.130] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:31:0) after 1m0s
[04:38:29.155] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:31:0)
[04:38:29.155] Timer tick, asking Buildbucket for the build status
[04:38:29.249] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:29.250] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:32:0) after 1m0s
[04:39:29.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:32:0)
[04:39:29.252] Timer tick, asking Buildbucket for the build status
[04:39:29.811] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:29.811] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:33:0) after 1m0s
[04:40:29.891] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:33:0)
[04:40:29.891] Timer tick, asking Buildbucket for the build status
[04:40:30.187] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:30.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:34:0) after 1m0s
[04:41:30.271] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:34:0)
[04:41:30.271] Timer tick, asking Buildbucket for the build status
[04:41:30.350] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:30.350] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:35:0) after 1m0s
[04:42:30.370] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:35:0)
[04:42:30.370] Timer tick, asking Buildbucket for the build status
[04:42:30.705] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:30.705] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:36:0) after 1m0s
[04:43:30.725] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:36:0)
[04:43:30.725] Timer tick, asking Buildbucket for the build status
[04:43:31.401] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:31.401] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:37:0) after 1m0s
[04:44:31.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:37:0)
[04:44:31.421] Timer tick, asking Buildbucket for the build status
[04:44:31.996] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:31.997] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:38:0) after 1m0s
[04:45:32.016] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:38:0)
[04:45:32.016] Timer tick, asking Buildbucket for the build status
[04:45:32.152] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:32.152] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:39:0) after 1m0s
[04:46:32.172] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:39:0)
[04:46:32.172] Timer tick, asking Buildbucket for the build status
[04:46:33.497] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:33.497] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:40:0) after 1m0s
[04:47:33.524] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:40:0)
[04:47:33.524] Timer tick, asking Buildbucket for the build status
[04:47:33.778] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:33.778] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:41:0) after 1m0s
[04:48:33.799] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:41:0)
[04:48:33.799] Timer tick, asking Buildbucket for the build status
[04:48:34.092] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:34.092] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:42:0) after 1m0s
[04:49:34.105] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:42:0)
[04:49:34.105] Timer tick, asking Buildbucket for the build status
[04:49:34.594] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:34.594] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:43:0) after 1m0s
[04:50:34.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:43:0)
[04:50:34.571] Timer tick, asking Buildbucket for the build status
[04:50:34.796] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:34.796] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:44:0) after 1m0s
[04:51:34.831] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:44:0)
[04:51:34.831] Timer tick, asking Buildbucket for the build status
[04:51:34.957] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:34.957] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:45:0) after 1m0s
[04:52:34.993] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:45:0)
[04:52:34.993] Timer tick, asking Buildbucket for the build status
[04:52:35.118] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:35.118] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:46:0) after 1m0s
[04:53:35.155] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:46:0)
[04:53:35.155] Timer tick, asking Buildbucket for the build status
[04:53:35.563] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:35.563] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:47:0) after 1m0s
[04:54:35.560] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:47:0)
[04:54:35.560] Timer tick, asking Buildbucket for the build status
[04:54:35.889] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:35.889] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:48:0) after 1m0s
[04:55:35.872] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:48:0)
[04:55:35.872] Timer tick, asking Buildbucket for the build status
[04:55:36.057] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:36.057] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:49:0) after 1m0s
[04:56:36.079] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:49:0)
[04:56:36.079] Timer tick, asking Buildbucket for the build status
[04:56:36.230] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:36.230] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:50:0) after 1m0s
[04:57:36.266] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:50:0)
[04:57:36.266] Timer tick, asking Buildbucket for the build status
[04:57:36.604] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:36.604] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:51:0) after 1m0s
[04:58:36.616] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:51:0)
[04:58:36.616] Timer tick, asking Buildbucket for the build status
[04:58:37.184] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:37.184] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:52:0) after 1m0s
[04:59:37.183] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:52:0)
[04:59:37.183] Timer tick, asking Buildbucket for the build status
[04:59:37.786] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:37.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:53:0) after 1m0s
[05:00:37.798] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:53:0)
[05:00:37.798] Timer tick, asking Buildbucket for the build status
[05:00:37.947] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:37.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:54:0) after 1m0s
[05:01:37.967] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:54:0)
[05:01:37.967] Timer tick, asking Buildbucket for the build status
[05:01:38.530] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:38.530] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:55:0) after 1m0s
[05:02:38.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:55:0)
[05:02:38.514] Timer tick, asking Buildbucket for the build status
[05:02:38.953] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:38.953] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:56:0) after 1m0s
[05:03:38.981] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:56:0)
[05:03:38.981] Timer tick, asking Buildbucket for the build status
[05:03:39.251] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:39.251] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:57:0) after 1m0s
[05:04:39.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:57:0)
[05:04:39.236] Timer tick, asking Buildbucket for the build status
[05:04:39.704] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:39.704] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:58:0) after 1m0s
[05:05:39.721] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:58:0)
[05:05:39.721] Timer tick, asking Buildbucket for the build status
[05:05:40.590] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:40.590] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:59:0) after 1m0s
[05:06:40.570] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:59:0)
[05:06:40.570] Timer tick, asking Buildbucket for the build status
[05:06:40.958] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:40.958] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:60:0) after 1m0s
[05:07:40.981] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:60:0)
[05:07:40.981] Timer tick, asking Buildbucket for the build status
[05:07:41.201] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:41.201] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:61:0) after 1m0s
[05:08:41.223] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:61:0)
[05:08:41.223] Timer tick, asking Buildbucket for the build status
[05:08:41.320] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:41.320] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:62:0) after 1m0s
[05:09:41.330] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:62:0)
[05:09:41.330] Timer tick, asking Buildbucket for the build status
[05:09:41.476] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:41.476] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:63:0) after 1m0s
[05:10:41.500] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:63:0)
[05:10:41.500] Timer tick, asking Buildbucket for the build status
[05:10:41.659] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:41.659] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:64:0) after 1m0s
[05:11:41.681] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:64:0)
[05:11:41.681] Timer tick, asking Buildbucket for the build status
[05:11:41.805] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:41.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:65:0) after 1m0s
[05:12:41.823] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:65:0)
[05:12:41.823] Timer tick, asking Buildbucket for the build status
[05:12:42.419] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:42.419] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:66:0) after 1m0s
[05:13:42.418] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:66:0)
[05:13:42.418] Timer tick, asking Buildbucket for the build status
[05:13:42.767] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:42.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:67:0) after 1m0s
[05:14:42.774] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:67:0)
[05:14:42.774] Timer tick, asking Buildbucket for the build status
[05:14:42.896] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:42.896] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:68:0) after 1m0s
[05:15:42.917] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:68:0)
[05:15:42.917] Timer tick, asking Buildbucket for the build status
[05:15:43.048] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:43.048] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:69:0) after 1m0s
[05:16:43.063] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:69:0)
[05:16:43.063] Timer tick, asking Buildbucket for the build status
[05:16:44.261] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:44.261] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:70:0) after 1m0s
[05:17:44.276] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:70:0)
[05:17:44.276] Timer tick, asking Buildbucket for the build status
[05:17:44.396] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:44.396] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:71:0) after 1m0s
[05:18:44.418] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:71:0)
[05:18:44.418] Timer tick, asking Buildbucket for the build status
[05:18:44.531] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:44.531] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:72:0) after 1m0s
[05:19:44.567] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:72:0)
[05:19:44.567] Timer tick, asking Buildbucket for the build status
[05:19:45.093] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:45.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:73:0) after 1m0s
[05:20:45.099] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:73:0)
[05:20:45.099] Timer tick, asking Buildbucket for the build status
[05:20:45.255] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:45.255] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:74:0) after 1m0s
[05:21:45.288] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:74:0)
[05:21:45.288] Timer tick, asking Buildbucket for the build status
[05:21:45.595] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:45.595] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:75:0) after 1m0s
[05:22:45.683] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:75:0)
[05:22:45.683] Timer tick, asking Buildbucket for the build status
[05:22:46.495] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:46.495] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:76:0) after 1m0s
[05:23:46.519] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:76:0)
[05:23:46.519] Timer tick, asking Buildbucket for the build status
[05:23:47.200] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:47.200] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:77:0) after 1m0s
[05:24:47.223] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:77:0)
[05:24:47.223] Timer tick, asking Buildbucket for the build status
[05:24:47.911] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:47.911] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:78:0) after 1m0s
[05:25:47.901] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:78:0)
[05:25:47.901] Timer tick, asking Buildbucket for the build status
[05:25:48.056] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:48.056] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:79:0) after 1m0s
[05:26:48.063] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:79:0)
[05:26:48.063] Timer tick, asking Buildbucket for the build status
[05:26:48.167] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:48.167] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:80:0) after 1m0s
[05:27:48.194] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:80:0)
[05:27:48.194] Timer tick, asking Buildbucket for the build status
[05:27:48.731] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:48.732] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:81:0) after 1m0s
[05:28:48.737] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:81:0)
[05:28:48.737] Timer tick, asking Buildbucket for the build status
[05:28:48.860] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:48.860] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:82:0) after 1m0s
[05:29:48.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:82:0)
[05:29:48.882] Timer tick, asking Buildbucket for the build status
[05:29:49.148] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:49.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:83:0) after 1m0s
[05:30:49.171] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:83:0)
[05:30:49.171] Timer tick, asking Buildbucket for the build status
[05:30:49.604] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:49.604] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:84:0) after 1m0s
[05:31:49.609] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:84:0)
[05:31:49.609] Timer tick, asking Buildbucket for the build status
[05:31:50.081] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:50.081] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:85:0) after 1m0s
[05:32:50.106] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:85:0)
[05:32:50.106] Timer tick, asking Buildbucket for the build status
[05:32:50.466] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:50.466] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:86:0) after 1m0s
[05:33:50.490] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:86:0)
[05:33:50.490] Timer tick, asking Buildbucket for the build status
[05:33:50.695] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:50.695] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:87:0) after 1m0s
[05:34:50.717] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:87:0)
[05:34:50.717] Timer tick, asking Buildbucket for the build status
[05:34:50.837] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:50.837] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:88:0) after 1m0s
[05:35:50.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:88:0)
[05:35:50.857] Timer tick, asking Buildbucket for the build status
[05:35:50.982] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:50.982] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:89:0) after 1m0s
[05:36:51.018] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:89:0)
[05:36:51.018] Timer tick, asking Buildbucket for the build status
[05:36:51.677] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:51.677] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:90:0) after 1m0s
[05:37:51.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:90:0)
[05:37:51.711] Timer tick, asking Buildbucket for the build status
[05:37:51.860] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:51.860] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:91:0) after 1m0s
[05:38:51.881] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:91:0)
[05:38:51.881] Timer tick, asking Buildbucket for the build status
[05:38:52.449] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:52.449] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:92:0) after 1m0s
[05:39:52.470] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:92:0)
[05:39:52.470] Timer tick, asking Buildbucket for the build status
[05:39:53.165] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:53.165] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:93:0) after 1m0s
[05:40:53.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:93:0)
[05:40:53.186] Timer tick, asking Buildbucket for the build status
[05:40:53.492] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:53.492] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:94:0) after 1m0s
[05:41:53.472] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:94:0)
[05:41:53.472] Timer tick, asking Buildbucket for the build status
[05:41:54.157] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:54.157] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:95:0) after 1m0s
[05:42:54.179] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:95:0)
[05:42:54.179] Timer tick, asking Buildbucket for the build status
[05:42:54.490] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:54.490] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:96:0) after 1m0s
[05:43:54.524] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:96:0)
[05:43:54.524] Timer tick, asking Buildbucket for the build status
[05:43:54.684] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:54.684] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:97:0) after 1m0s
[05:44:54.692] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:97:0)
[05:44:54.692] Timer tick, asking Buildbucket for the build status
[05:44:54.875] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:54.875] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:98:0) after 1m0s
[05:45:54.896] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:98:0)
[05:45:54.896] Timer tick, asking Buildbucket for the build status
[05:45:55.873] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:55.873] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:99:0) after 1m0s
[05:46:55.892] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:99:0)
[05:46:55.892] Timer tick, asking Buildbucket for the build status
[05:46:56.061] Build 8917953978830501104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:56.061] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9083384041136260464:100:0) after 1m0s
[05:47:16.776] Received PubSub notification, asking Buildbucket for the build status
[05:47:16.880] Build 8917953978830501104: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[05:47:16.880] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1553579235914059",
"created_by": "project:chromium",
"created_ts": "1553573357704116",
"failure_reason": "BUILD_FAILURE",
"id": "8917953978830501104",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"2cfb4656b8fdc62f5e837945e9898e66f176d58c\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"4 tests failed: ['non_network_service_browser_tests', 'non_single_process_mash_browser_tests', 'webui_polymer1_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\": 11548, \"got_angle_revision\": \"da37e7f6759d9852d116bdab55346513c23324d3\", \"got_dawn_revision\": \"041aca1620e8f905df3342882af33618803b8a41\", \"got_nacl_revision\": \"de8da4841bc3d1ed020d798d5a7fd6fb3d817fa1\", \"got_revision\": \"2cfb4656b8fdc62f5e837945e9898e66f176d58c\", \"got_revision_cp\": \"refs/heads/master@{#644184}\", \"got_swarming_client_revision\": \"aa60736aded9fc32a0e21a81f5fc51f6009d01f3\", \"got_v8_revision\": \"8fea8cc7643ed2cf5b66862c692492e031915617\", \"got_v8_revision_cp\": \"refs/heads/7.5.106@{#1}\", \"got_webrtc_revision\": \"6da14388cd3c5d1b5b79840ad14d8d037deedc58\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#27273}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.chromiumos\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"2cfb4656b8fdc62f5e837945e9898e66f176d58c\", \"swarm_hashes\": {\"accessibility_unittests\": \"ed41449d06c34e1b97af4e074fc5e73ed6d3e746\", \"angle_unittests\": \"87f66def6a15ded25f7253a3dbe86ea05ed3df00\", \"app_list_unittests\": \"500a20a6cde5d637b35825075ed38bfa4458a7f7\", \"app_shell_unittests\": \"ba16188e66f292b37f5ebca94fce3c4f2a3753e1\", \"ash_unittests\": \"5577b0e83fe3fe7699aa7efa8fe5f33b68966302\", \"aura_unittests\": \"3b672034a93e250b40f5884e9d148cc2c7324bbb\", \"base_unittests\": \"951d0acd20e8a2bf9681b91bed992618c17a56cc\", \"blink_common_unittests\": \"628a549c0f8bee6dbd02b0c6828e88cd8ec11414\", \"blink_fuzzer_unittests\": \"8924125b5bcbfb100b8425c4eae9480348654d3c\", \"blink_heap_unittests\": \"1f7d275953be996644e55c948b1bd60cf030a1bc\", \"blink_platform_unittests\": \"759d35906e901232f0ae0d749e03ba3037f1383d\", \"blink_unittests\": \"45a2013fba6be62ce337d4cc49fe1ecc9b509ef6\", \"boringssl_crypto_tests\": \"1b5eb8819b551405e7ce140f1bacec0f44a7e5fc\", \"boringssl_ssl_tests\": \"586381f78b18abaf9ecbe14cad81fbfe53f3a551\", \"browser_tests\": \"44d8e4629050e06432e25e13b8d33d0a36934846\", \"cacheinvalidation_unittests\": \"9ed62bba7ff78126cb166092cb43bf4c2c9ba0c4\", \"capture_unittests\": \"ca0d52d15360e24fded16a11270392d65117a41b\", \"cast_unittests\": \"a2fec7ba499eaee739b62b1c1f2f1f1f672e81d9\", \"cc_unittests\": \"297e02beb0412a9a5e2cf67fc2785eb9399888f7\", \"chrome_app_unittests\": \"da81d63c0968453f73a70c2cb6a16de7e9490659\", \"chromedriver_unittests\": \"3181657373971ab38d6b94ecf7b7ab1bc834ac89\", \"chromeos_components_unittests\": \"26dad7c600df82778c6469d1959f210566f77abb\", \"chromeos_unittests\": \"de09de55ee9ac11884ad37688db9e7832ae3fa96\", \"components_browsertests\": \"713aca3da57eebef93a2218403b308df3f99dab4\", \"components_unittests\": \"044afbdd1e4bae63894ee38151d0c3e4651bdbc0\", \"compositor_unittests\": \"5ec88fe1a0005de65fb619535918bc8ee21f02b6\", \"content_browsertests\": \"3ce3fb995a6aa05b977942ded6e8975838bd3d9a\", \"content_unittests\": \"e72d4178fc35413159fedd997daf65bb8a785443\", \"crypto_unittests\": \"dbad1f128b47c691f347a629bb30343dbc4c64ac\", \"dbus_unittests\": \"e0bc16ae2f16b30567761091d57a0865bed87aef\", \"device_unittests\": \"ebdfaace38d25c63f7c6e46b0eb92f8ec657b049\", \"display_unittests\": \"370be7ce9d4a5b637602c3ec796de26457f3dfd8\", \"events_unittests\": \"16f25c9a0385daa790b474eb245b58af4a593657\", \"exo_unittests\": \"1e6e59ff9944ba689154810b8bff32b84783a10c\", \"extensions_browsertests\": \"15571c2deab2a8818c2b4b55339cd423392785d6\", \"extensions_unittests\": \"58bf435397b1be7e6b7370e860c16df009f32019\", \"filesystem_service_unittests\": \"10e9b063f265d49fbffdf125e2214e6c773c02cf\", \"gcm_unit_tests\": \"d0d2666cca53505e9fe4a2f511592f81394d6ddd\", \"gfx_unittests\": \"cac3f4ad1670d1cf4e09dca88a4193a4392e2ba2\", \"gin_unittests\": \"3a6d5aadc9669a3bcd6820891eeefe5d80c79861\", \"gl_unittests_ozone\": \"3cc9925ae5db77e67b3bafc80c60054688eec187\", \"google_apis_unittests\": \"6711049020eaab6b4b0b9a4165fb32c20defe135\", \"gpu_unittests\": \"2ab5f9005e5c381ed7c2cc8e4f7e3dabd961d71f\", \"interactive_ui_tests\": \"af294e0ca5fdc3eff976d72a3a04b7464e7870c7\", \"ipc_tests\": \"9d7ccd713811fc7626decb89d28b31543c37ce39\", \"jingle_unittests\": \"8f9e67c35a7c4a54fe58249d915839f204ca2bb3\", \"keyboard_unittests\": \"a67507d04f3f2f934be96ab06ff6db62715894ef\", \"latency_unittests\": \"ecdabfbe253b5961f5a50d1a5366e46d471eddbc\", \"leveldb_service_unittests\": \"22a51c5d631605ef5e15af1beb2acb8bf1154f4e\", \"libjingle_xmpp_unittests\": \"9b270105ddbff3ec27967d242e894c20d8591623\", \"media_blink_unittests\": \"3f2e46c9d394d2620117a27419ae80ead74c8cd4\", \"media_service_unittests\": \"f15f82a5ff477ad2e23fa687ab2221a8bb485a81\", \"media_unittests\": \"b51c5b4c1b3b9a239b2638e2b1a4425dc8b5587d\", \"message_center_unittests\": \"a8a64422412d11f91270f157cd104b326adffac2\", \"midi_unittests\": \"e34c7e773cad876b4790930276bd7af76486edb2\", \"mojo_core_unittests\": \"d355184911b8f2a1bb7d278146fd5da815b10c27\", \"mojo_unittests\": \"6509d6d348bd941188cc605146389217ce1106e3\", \"nacl_helper_nonsfi_unittests\": \"e2977e270ecfb796e217d8c33430a0f7d1250415\", \"nacl_loader_unittests\": \"d69ce073ee8668a3045c71a74fa70b5f87c4cce4\", \"native_theme_unittests\": \"0fd7b905f63fb7fa729e03c00b20702c6049b9ad\", \"net_unittests\": \"44b7699aacf77c3d77add34faf819ba3c2d14827\", \"ozone_gl_unittests\": \"918ad4083a49b52dc6c875c62acc18b8db2aaa62\", \"ozone_unittests\": \"e5e2eb1bf1510d2148e198f94224c72b46306c52\", \"ozone_x11_unittests\": \"6116ed17e423c9431e00753ee34c56df5b5167bd\", \"pdf_unittests\": \"2e54767cbf2117ee3a4a73237285b00008387a58\", \"perfetto_unittests\": \"98b29dc1e1159cb70430a0a9021e1c643c74d228\", \"ppapi_unittests\": \"6e18e7970a234bd9af9218e9c4690040eefe3f4a\", \"printing_unittests\": \"60df41e56c50ce6ee3c59192776b741bdcc24824\", \"remoting_unittests\": \"5bca4ca39e79e764f89e231b9ac0a259d1f6e507\", \"sandbox_linux_unittests\": \"37c335d3b1503a17e41bcd5f2aaac6e563a1e70b\", \"service_manager_unittests\": \"2fc4f47f328bfaba25c3feddbb26f7f0b9fa96a9\", \"services_unittests\": \"a3003833a790df97a2203807c308878ee84df9b0\", \"shell_dialogs_unittests\": \"7bfd87ed0b5d37fdee334c88d4ac51f3149ff08b\", \"skia_unittests\": \"e5ad78d232db2cbcf2c5f029e6642b763835803e\", \"snapshot_unittests\": \"a4d543750809341ef43353f1022fc681c6911ae2\", \"sql_unittests\": \"867a88f71710837e1ba1d20063c6d90a986dc138\", \"storage_unittests\": \"d8cb6481464caa6ab150ec46b6cf34204a460549\", \"sync_integration_tests\": \"7112af8168e56ec52ad05b64d18f9c89e817fdf1\", \"traffic_annotation_auditor_unittests\": \"c64b5439300f1d53fd0cb5b17a8ac13dd01f266f\", \"ui_base_unittests\": \"5657c43330a1e18af3285d5bddface367dd15c40\", \"ui_chromeos_unittests\": \"525d351a7741d5b95d07e752f5fcb6fefe0fa10d\", \"ui_touch_selection_unittests\": \"697c8a2ab4dfd48472fe74031e1114e1bdd797ab\", \"unit_tests\": \"0fc7e247a55c847a73447fa8032a6a3a41665ee1\", \"url_unittests\": \"ddd7cbbff89e82b85faf9d4b016911beed4ae750\", \"usage_time_limit_unittests\": \"4c8928dda616c918b9528abe41a652c1d1ac83c6\", \"views_unittests\": \"c9ccf789cf4f11e8fd4ff2437ea5065d898b307e\", \"viz_unittests\": \"596e50fbd3e048e712739938d6e17d51e9f80305\", \"wm_unittests\": \"dd0e3917eb916bd20108cbef5b305be14fd15864\", \"wtf_unittests\": \"bc0738f060a1cf114adcd4646dfed35cb1d51c4c\"}, \"swarm_hashes_refs/heads/master(at){#644184}_without_patch\": {\"accessibility_unittests\": \"ed41449d06c34e1b97af4e074fc5e73ed6d3e746\", \"angle_unittests\": \"87f66def6a15ded25f7253a3dbe86ea05ed3df00\", \"app_list_unittests\": \"500a20a6cde5d637b35825075ed38bfa4458a7f7\", \"app_shell_unittests\": \"ba16188e66f292b37f5ebca94fce3c4f2a3753e1\", \"ash_unittests\": \"5577b0e83fe3fe7699aa7efa8fe5f33b68966302\", \"aura_unittests\": \"3b672034a93e250b40f5884e9d148cc2c7324bbb\", \"base_unittests\": \"951d0acd20e8a2bf9681b91bed992618c17a56cc\", \"blink_common_unittests\": \"628a549c0f8bee6dbd02b0c6828e88cd8ec11414\", \"blink_fuzzer_unittests\": \"8924125b5bcbfb100b8425c4eae9480348654d3c\", \"blink_heap_unittests\": \"1f7d275953be996644e55c948b1bd60cf030a1bc\", \"blink_platform_unittests\": \"759d35906e901232f0ae0d749e03ba3037f1383d\", \"blink_unittests\": \"45a2013fba6be62ce337d4cc49fe1ecc9b509ef6\", \"boringssl_crypto_tests\": \"1b5eb8819b551405e7ce140f1bacec0f44a7e5fc\", \"boringssl_ssl_tests\": \"586381f78b18abaf9ecbe14cad81fbfe53f3a551\", \"browser_tests\": \"44d8e4629050e06432e25e13b8d33d0a36934846\", \"cacheinvalidation_unittests\": \"9ed62bba7ff78126cb166092cb43bf4c2c9ba0c4\", \"capture_unittests\": \"ca0d52d15360e24fded16a11270392d65117a41b\", \"cast_unittests\": \"a2fec7ba499eaee739b62b1c1f2f1f1f672e81d9\", \"cc_unittests\": \"297e02beb0412a9a5e2cf67fc2785eb9399888f7\", \"chrome_app_unittests\": \"da81d63c0968453f73a70c2cb6a16de7e9490659\", \"chromedriver_unittests\": \"3181657373971ab38d6b94ecf7b7ab1bc834ac89\", \"chromeos_components_unittests\": \"26dad7c600df82778c6469d1959f210566f77abb\", \"chromeos_unittests\": \"de09de55ee9ac11884ad37688db9e7832ae3fa96\", \"components_browsertests\": \"713aca3da57eebef93a2218403b308df3f99dab4\", \"components_unittests\": \"044afbdd1e4bae63894ee38151d0c3e4651bdbc0\", \"compositor_unittests\": \"5ec88fe1a0005de65fb619535918bc8ee21f02b6\", \"content_browsertests\": \"3ce3fb995a6aa05b977942ded6e8975838bd3d9a\", \"content_unittests\": \"e72d4178fc35413159fedd997daf65bb8a785443\", \"crypto_unittests\": \"dbad1f128b47c691f347a629bb30343dbc4c64ac\", \"dbus_unittests\": \"e0bc16ae2f16b30567761091d57a0865bed87aef\", \"device_unittests\": \"ebdfaace38d25c63f7c6e46b0eb92f8ec657b049\", \"display_unittests\": \"370be7ce9d4a5b637602c3ec796de26457f3dfd8\", \"events_unittests\": \"16f25c9a0385daa790b474eb245b58af4a593657\", \"exo_unittests\": \"1e6e59ff9944ba689154810b8bff32b84783a10c\", \"extensions_browsertests\": \"15571c2deab2a8818c2b4b55339cd423392785d6\", \"extensions_unittests\": \"58bf435397b1be7e6b7370e860c16df009f32019\", \"filesystem_service_unittests\": \"10e9b063f265d49fbffdf125e2214e6c773c02cf\", \"gcm_unit_tests\": \"d0d2666cca53505e9fe4a2f511592f81394d6ddd\", \"gfx_unittests\": \"cac3f4ad1670d1cf4e09dca88a4193a4392e2ba2\", \"gin_unittests\": \"3a6d5aadc9669a3bcd6820891eeefe5d80c79861\", \"gl_unittests_ozone\": \"3cc9925ae5db77e67b3bafc80c60054688eec187\", \"google_apis_unittests\": \"6711049020eaab6b4b0b9a4165fb32c20defe135\", \"gpu_unittests\": \"2ab5f9005e5c381ed7c2cc8e4f7e3dabd961d71f\", \"interactive_ui_tests\": \"af294e0ca5fdc3eff976d72a3a04b7464e7870c7\", \"ipc_tests\": \"9d7ccd713811fc7626decb89d28b31543c37ce39\", \"jingle_unittests\": \"8f9e67c35a7c4a54fe58249d915839f204ca2bb3\", \"keyboard_unittests\": \"a67507d04f3f2f934be96ab06ff6db62715894ef\", \"latency_unittests\": \"ecdabfbe253b5961f5a50d1a5366e46d471eddbc\", \"leveldb_service_unittests\": \"22a51c5d631605ef5e15af1beb2acb8bf1154f4e\", \"libjingle_xmpp_unittests\": \"9b270105ddbff3ec27967d242e894c20d8591623\", \"media_blink_unittests\": \"3f2e46c9d394d2620117a27419ae80ead74c8cd4\", \"media_service_unittests\": \"f15f82a5ff477ad2e23fa687ab2221a8bb485a81\", \"media_unittests\": \"b51c5b4c1b3b9a239b2638e2b1a4425dc8b5587d\", \"message_center_unittests\": \"a8a64422412d11f91270f157cd104b326adffac2\", \"midi_unittests\": \"e34c7e773cad876b4790930276bd7af76486edb2\", \"mojo_core_unittests\": \"d355184911b8f2a1bb7d278146fd5da815b10c27\", \"mojo_unittests\": \"6509d6d348bd941188cc605146389217ce1106e3\", \"nacl_helper_nonsfi_unittests\": \"e2977e270ecfb796e217d8c33430a0f7d1250415\", \"nacl_loader_unittests\": \"d69ce073ee8668a3045c71a74fa70b5f87c4cce4\", \"native_theme_unittests\": \"0fd7b905f63fb7fa729e03c00b20702c6049b9ad\", \"net_unittests\": \"44b7699aacf77c3d77add34faf819ba3c2d14827\", \"ozone_gl_unittests\": \"918ad4083a49b52dc6c875c62acc18b8db2aaa62\", \"ozone_unittests\": \"e5e2eb1bf1510d2148e198f94224c72b46306c52\", \"ozone_x11_unittests\": \"6116ed17e423c9431e00753ee34c56df5b5167bd\", \"pdf_unittests\": \"2e54767cbf2117ee3a4a73237285b00008387a58\", \"perfetto_unittests\": \"98b29dc1e1159cb70430a0a9021e1c643c74d228\", \"ppapi_unittests\": \"6e18e7970a234bd9af9218e9c4690040eefe3f4a\", \"printing_unittests\": \"60df41e56c50ce6ee3c59192776b741bdcc24824\", \"remoting_unittests\": \"5bca4ca39e79e764f89e231b9ac0a259d1f6e507\", \"sandbox_linux_unittests\": \"37c335d3b1503a17e41bcd5f2aaac6e563a1e70b\", \"service_manager_unittests\": \"2fc4f47f328bfaba25c3feddbb26f7f0b9fa96a9\", \"services_unittests\": \"a3003833a790df97a2203807c308878ee84df9b0\", \"shell_dialogs_unittests\": \"7bfd87ed0b5d37fdee334c88d4ac51f3149ff08b\", \"skia_unittests\": \"e5ad78d232db2cbcf2c5f029e6642b763835803e\", \"snapshot_unittests\": \"a4d543750809341ef43353f1022fc681c6911ae2\", \"sql_unittests\": \"867a88f71710837e1ba1d20063c6d90a986dc138\", \"storage_unittests\": \"d8cb6481464caa6ab150ec46b6cf34204a460549\", \"sync_integration_tests\": \"7112af8168e56ec52ad05b64d18f9c89e817fdf1\", \"traffic_annotation_auditor_unittests\": \"c64b5439300f1d53fd0cb5b17a8ac13dd01f266f\", \"ui_base_unittests\": \"5657c43330a1e18af3285d5bddface367dd15c40\", \"ui_chromeos_unittests\": \"525d351a7741d5b95d07e752f5fcb6fefe0fa10d\", \"ui_touch_selection_unittests\": \"697c8a2ab4dfd48472fe74031e1114e1bdd797ab\", \"unit_tests\": \"0fc7e247a55c847a73447fa8032a6a3a41665ee1\", \"url_unittests\": \"ddd7cbbff89e82b85faf9d4b016911beed4ae750\", \"usage_time_limit_unittests\": \"4c8928dda616c918b9528abe41a652c1d1ac83c6\", \"views_unittests\": \"c9ccf789cf4f11e8fd4ff2437ea5065d898b307e\", \"viz_unittests\": \"596e50fbd3e048e712739938d6e17d51e9f80305\", \"wm_unittests\": \"dd0e3917eb916bd20108cbef5b305be14fd15864\", \"wtf_unittests\": \"bc0738f060a1cf114adcd4646dfed35cb1d51c4c\"}}, \"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\": \"4 tests failed: ['non_network_service_browser_tests', 'non_single_process_mash_browser_tests', 'webui_polymer1_browser_tests', 'non_network_service_interactive_ui_tests']\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1553573706179978",
"status": "COMPLETED",
"status_changed_ts": "1553573706437009",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/11548",
"builder:linux-chromeos-dbg",
"buildset:commit/git/2cfb4656b8fdc62f5e837945e9898e66f176d58c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2cfb4656b8fdc62f5e837945e9898e66f176d58c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9083384041136260464",
"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/8917953978830501104/+/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:43d101b592682810",
"user_agent:luci-scheduler"
],
"updated_ts": "1553579236473413",
"url": "https://ci.chromium.org/b/8917953978830501104",
"utcnow_ts": "1553579236868889"
}
}
[05:47:16.880] Invocation finished in 1h38m0.759529509s with status FAILED