[04:50:50.369] New invocation is queued and will start shortly
[04:50:51.440] Starting the invocation (attempt 1)
[04:50:51.481] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:50:51.481] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:50:51.481] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9085193365072791712",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"e543f5fcb71b61820704cd8df91ae7499c4e67e7\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9085193365072791712",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/e543f5fcb71b61820704cd8df91ae7499c4e67e7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e543f5fcb71b61820704cd8df91ae7499c4e67e7",
"gitiles_ref:refs/heads/master"
]
}
[04:50:53.487] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1551847851564053",
"id": "8919763303156860320",
"lease_expiration_ts": "1551966652901001",
"lease_key": "330774975",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"e543f5fcb71b61820704cd8df91ae7499c4e67e7\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1551847853273266",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/11214",
"builder:linux-chromeos-dbg",
"buildset:commit/git/e543f5fcb71b61820704cd8df91ae7499c4e67e7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e543f5fcb71b61820704cd8df91ae7499c4e67e7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9085193365072791712",
"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/8919763303156860320/+/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:436a28928c0ca610",
"user_agent:luci-scheduler"
],
"updated_ts": "1551847853273485",
"url": "https://ci.chromium.org/b/8919763303156860320",
"utcnow_ts": "1551847853474041"
}
}
[04:50:53.487] Task URL: https://ci.chromium.org/b/8919763303156860320
[04:50:53.487] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:2:0) after 1m0s
[04:51:36.968] Received PubSub notification, asking Buildbucket for the build status
[04:51:37.016] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:53.515] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:2:0)
[04:51:53.515] Timer tick, asking Buildbucket for the build status
[04:51:53.690] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:53.690] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:4:0) after 1m0s
[04:52:53.680] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:4:0)
[04:52:53.680] Timer tick, asking Buildbucket for the build status
[04:52:53.887] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:53.887] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:5:0) after 1m0s
[04:53:53.906] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:5:0)
[04:53:53.906] Timer tick, asking Buildbucket for the build status
[04:53:53.955] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:53.955] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:6:0) after 1m0s
[04:54:53.976] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:6:0)
[04:54:53.976] Timer tick, asking Buildbucket for the build status
[04:54:54.024] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:54.024] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:7:0) after 1m0s
[04:55:54.044] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:7:0)
[04:55:54.044] Timer tick, asking Buildbucket for the build status
[04:55:54.159] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:54.159] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:8:0) after 1m0s
[04:56:54.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:8:0)
[04:56:54.198] Timer tick, asking Buildbucket for the build status
[04:56:54.270] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:54.270] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:9:0) after 1m0s
[04:57:54.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:9:0)
[04:57:54.296] Timer tick, asking Buildbucket for the build status
[04:57:54.576] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:54.576] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:10:0) after 1m0s
[04:58:54.619] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:10:0)
[04:58:54.619] Timer tick, asking Buildbucket for the build status
[04:58:54.770] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:54.770] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:11:0) after 1m0s
[04:59:54.789] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:11:0)
[04:59:54.789] Timer tick, asking Buildbucket for the build status
[04:59:54.859] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:54.859] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:12:0) after 1m0s
[05:00:54.877] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:12:0)
[05:00:54.877] Timer tick, asking Buildbucket for the build status
[05:00:55.000] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:55.000] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:13:0) after 1m0s
[05:01:55.016] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:13:0)
[05:01:55.016] Timer tick, asking Buildbucket for the build status
[05:01:55.187] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:55.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:14:0) after 1m0s
[05:02:55.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:14:0)
[05:02:55.206] Timer tick, asking Buildbucket for the build status
[05:02:55.263] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:55.263] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:15:0) after 1m0s
[05:03:55.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:15:0)
[05:03:55.265] Timer tick, asking Buildbucket for the build status
[05:03:55.371] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:55.371] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:16:0) after 1m0s
[05:04:55.375] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:16:0)
[05:04:55.375] Timer tick, asking Buildbucket for the build status
[05:04:55.415] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:55.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:17:0) after 1m0s
[05:05:55.473] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:17:0)
[05:05:55.473] Timer tick, asking Buildbucket for the build status
[05:05:55.517] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:55.517] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:18:0) after 1m0s
[05:06:55.496] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:18:0)
[05:06:55.496] Timer tick, asking Buildbucket for the build status
[05:06:55.537] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:55.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:19:0) after 1m0s
[05:07:55.556] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:19:0)
[05:07:55.556] Timer tick, asking Buildbucket for the build status
[05:07:55.592] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:55.592] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:20:0) after 1m0s
[05:08:55.591] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:20:0)
[05:08:55.591] Timer tick, asking Buildbucket for the build status
[05:08:55.789] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:55.789] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:21:0) after 1m0s
[05:09:55.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:21:0)
[05:09:55.784] Timer tick, asking Buildbucket for the build status
[05:09:55.824] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:55.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:22:0) after 1m0s
[05:10:55.834] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:22:0)
[05:10:55.834] Timer tick, asking Buildbucket for the build status
[05:10:55.874] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:55.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:23:0) after 1m0s
[05:11:55.910] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:23:0)
[05:11:55.910] Timer tick, asking Buildbucket for the build status
[05:11:56.136] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:56.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:24:0) after 1m0s
[05:12:56.107] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:24:0)
[05:12:56.107] Timer tick, asking Buildbucket for the build status
[05:12:56.151] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:56.151] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:25:0) after 1m0s
[05:13:56.172] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:25:0)
[05:13:56.172] Timer tick, asking Buildbucket for the build status
[05:13:56.232] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:56.232] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:26:0) after 1m0s
[05:14:56.250] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:26:0)
[05:14:56.250] Timer tick, asking Buildbucket for the build status
[05:14:56.312] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:56.312] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:27:0) after 1m0s
[05:15:56.306] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:27:0)
[05:15:56.306] Timer tick, asking Buildbucket for the build status
[05:15:56.426] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:56.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:28:0) after 1m0s
[05:16:56.406] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:28:0)
[05:16:56.406] Timer tick, asking Buildbucket for the build status
[05:16:56.564] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:56.564] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:29:0) after 1m0s
[05:17:56.584] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:29:0)
[05:17:56.584] Timer tick, asking Buildbucket for the build status
[05:17:56.666] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:56.666] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:30:0) after 1m0s
[05:18:56.658] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:30:0)
[05:18:56.658] Timer tick, asking Buildbucket for the build status
[05:18:56.976] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:56.976] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:31:0) after 1m0s
[05:19:56.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:31:0)
[05:19:56.970] Timer tick, asking Buildbucket for the build status
[05:19:57.029] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:57.029] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:32:0) after 1m0s
[05:20:57.022] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:32:0)
[05:20:57.022] Timer tick, asking Buildbucket for the build status
[05:20:57.369] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:57.369] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:33:0) after 1m0s
[05:21:57.389] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:33:0)
[05:21:57.389] Timer tick, asking Buildbucket for the build status
[05:21:57.434] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:57.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:34:0) after 1m0s
[05:22:57.422] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:34:0)
[05:22:57.422] Timer tick, asking Buildbucket for the build status
[05:22:57.530] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:57.530] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:35:0) after 1m0s
[05:23:57.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:35:0)
[05:23:57.508] Timer tick, asking Buildbucket for the build status
[05:23:57.603] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:57.603] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:36:0) after 1m0s
[05:24:57.607] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:36:0)
[05:24:57.607] Timer tick, asking Buildbucket for the build status
[05:24:57.919] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:57.919] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:37:0) after 1m0s
[05:25:57.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:37:0)
[05:25:57.940] Timer tick, asking Buildbucket for the build status
[05:25:58.048] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:58.048] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:38:0) after 1m0s
[05:26:58.017] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:38:0)
[05:26:58.017] Timer tick, asking Buildbucket for the build status
[05:26:58.124] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:58.124] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:39:0) after 1m0s
[05:27:58.145] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:39:0)
[05:27:58.145] Timer tick, asking Buildbucket for the build status
[05:27:58.224] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:58.224] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:40:0) after 1m0s
[05:28:58.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:40:0)
[05:28:58.222] Timer tick, asking Buildbucket for the build status
[05:28:58.350] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:58.350] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:41:0) after 1m0s
[05:29:58.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:41:0)
[05:29:58.371] Timer tick, asking Buildbucket for the build status
[05:29:58.500] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:58.500] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:42:0) after 1m0s
[05:30:58.485] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:42:0)
[05:30:58.485] Timer tick, asking Buildbucket for the build status
[05:30:58.680] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:58.680] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:43:0) after 1m0s
[05:31:58.681] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:43:0)
[05:31:58.681] Timer tick, asking Buildbucket for the build status
[05:31:58.812] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:58.812] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:44:0) after 1m0s
[05:32:58.851] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:44:0)
[05:32:58.851] Timer tick, asking Buildbucket for the build status
[05:32:58.913] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:58.913] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:45:0) after 1m0s
[05:33:58.910] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:45:0)
[05:33:58.910] Timer tick, asking Buildbucket for the build status
[05:33:59.201] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:59.201] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:46:0) after 1m0s
[05:34:59.224] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:46:0)
[05:34:59.224] Timer tick, asking Buildbucket for the build status
[05:34:59.332] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:59.332] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:47:0) after 1m0s
[05:35:59.340] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:47:0)
[05:35:59.340] Timer tick, asking Buildbucket for the build status
[05:35:59.501] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:59.501] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:48:0) after 1m0s
[05:36:59.523] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:48:0)
[05:36:59.523] Timer tick, asking Buildbucket for the build status
[05:36:59.570] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:59.570] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:49:0) after 1m0s
[05:37:59.594] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:49:0)
[05:37:59.594] Timer tick, asking Buildbucket for the build status
[05:37:59.682] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:59.682] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:50:0) after 1m0s
[05:38:59.704] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:50:0)
[05:38:59.704] Timer tick, asking Buildbucket for the build status
[05:38:59.753] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:59.753] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:51:0) after 1m0s
[05:39:59.783] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:51:0)
[05:39:59.783] Timer tick, asking Buildbucket for the build status
[05:40:00.016] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:00.016] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:52:0) after 1m0s
[05:40:59.989] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:52:0)
[05:40:59.989] Timer tick, asking Buildbucket for the build status
[05:41:00.125] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:00.125] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:53:0) after 1m0s
[05:42:00.163] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:53:0)
[05:42:00.163] Timer tick, asking Buildbucket for the build status
[05:42:00.501] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:00.501] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:54:0) after 1m0s
[05:43:00.521] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:54:0)
[05:43:00.521] Timer tick, asking Buildbucket for the build status
[05:43:01.060] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:01.060] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:55:0) after 1m0s
[05:44:01.071] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:55:0)
[05:44:01.071] Timer tick, asking Buildbucket for the build status
[05:44:01.138] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:01.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:56:0) after 1m0s
[05:45:01.162] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:56:0)
[05:45:01.162] Timer tick, asking Buildbucket for the build status
[05:45:01.321] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:01.321] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:57:0) after 1m0s
[05:46:01.343] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:57:0)
[05:46:01.343] Timer tick, asking Buildbucket for the build status
[05:46:01.427] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:01.427] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:58:0) after 1m0s
[05:47:01.424] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:58:0)
[05:47:01.424] Timer tick, asking Buildbucket for the build status
[05:47:01.799] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:01.799] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:59:0) after 1m0s
[05:48:01.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:59:0)
[05:48:01.792] Timer tick, asking Buildbucket for the build status
[05:48:02.145] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:02.145] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:60:0) after 1m0s
[05:49:02.133] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:60:0)
[05:49:02.133] Timer tick, asking Buildbucket for the build status
[05:49:02.403] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:02.403] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:61:0) after 1m0s
[05:50:02.407] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:61:0)
[05:50:02.407] Timer tick, asking Buildbucket for the build status
[05:50:02.475] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:02.475] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:62:0) after 1m0s
[05:51:02.494] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:62:0)
[05:51:02.494] Timer tick, asking Buildbucket for the build status
[05:51:02.555] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:02.555] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:63:0) after 1m0s
[05:52:02.578] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:63:0)
[05:52:02.578] Timer tick, asking Buildbucket for the build status
[05:52:02.889] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:02.889] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:64:0) after 1m0s
[05:53:02.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:64:0)
[05:53:02.888] Timer tick, asking Buildbucket for the build status
[05:53:03.229] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:03.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:65:0) after 1m0s
[05:54:03.213] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:65:0)
[05:54:03.213] Timer tick, asking Buildbucket for the build status
[05:54:03.323] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:03.323] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:66:0) after 1m0s
[05:55:03.347] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:66:0)
[05:55:03.347] Timer tick, asking Buildbucket for the build status
[05:55:03.414] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:03.414] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:67:0) after 1m0s
[05:56:03.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:67:0)
[05:56:03.402] Timer tick, asking Buildbucket for the build status
[05:56:03.493] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:03.493] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:68:0) after 1m0s
[05:57:03.474] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:68:0)
[05:57:03.474] Timer tick, asking Buildbucket for the build status
[05:57:03.601] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:03.601] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:69:0) after 1m0s
[05:58:03.622] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:69:0)
[05:58:03.622] Timer tick, asking Buildbucket for the build status
[05:58:03.675] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:03.675] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:70:0) after 1m0s
[05:59:03.684] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:70:0)
[05:59:03.684] Timer tick, asking Buildbucket for the build status
[05:59:03.747] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:03.747] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:71:0) after 1m0s
[06:00:03.765] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:71:0)
[06:00:03.765] Timer tick, asking Buildbucket for the build status
[06:00:03.971] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:03.971] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:72:0) after 1m0s
[06:01:03.980] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:72:0)
[06:01:03.980] Timer tick, asking Buildbucket for the build status
[06:01:04.374] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:04.374] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:73:0) after 1m0s
[06:02:04.374] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:73:0)
[06:02:04.374] Timer tick, asking Buildbucket for the build status
[06:02:04.522] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:04.522] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:74:0) after 1m0s
[06:03:04.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:74:0)
[06:03:04.513] Timer tick, asking Buildbucket for the build status
[06:03:04.784] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:04.784] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:75:0) after 1m0s
[06:04:04.816] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:75:0)
[06:04:04.816] Timer tick, asking Buildbucket for the build status
[06:04:04.886] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:04.886] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:76:0) after 1m0s
[06:05:04.868] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:76:0)
[06:05:04.868] Timer tick, asking Buildbucket for the build status
[06:05:04.939] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:04.939] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:77:0) after 1m0s
[06:06:04.961] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:77:0)
[06:06:04.961] Timer tick, asking Buildbucket for the build status
[06:06:05.197] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:05.197] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:78:0) after 1m0s
[06:07:05.220] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:78:0)
[06:07:05.220] Timer tick, asking Buildbucket for the build status
[06:07:05.314] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:05.314] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:79:0) after 1m0s
[06:08:05.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:79:0)
[06:08:05.305] Timer tick, asking Buildbucket for the build status
[06:08:05.699] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:05.699] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:80:0) after 1m0s
[06:09:05.735] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:80:0)
[06:09:05.735] Timer tick, asking Buildbucket for the build status
[06:09:05.909] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:05.909] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:81:0) after 1m0s
[06:10:05.932] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:81:0)
[06:10:05.932] Timer tick, asking Buildbucket for the build status
[06:10:05.981] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:05.981] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:82:0) after 1m0s
[06:11:06.000] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:82:0)
[06:11:06.000] Timer tick, asking Buildbucket for the build status
[06:11:06.228] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:06.228] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:83:0) after 1m0s
[06:12:06.273] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:83:0)
[06:12:06.273] Timer tick, asking Buildbucket for the build status
[06:12:06.417] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:06.417] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:84:0) after 1m0s
[06:13:06.412] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:84:0)
[06:13:06.412] Timer tick, asking Buildbucket for the build status
[06:13:06.457] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:06.457] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:85:0) after 1m0s
[06:14:06.455] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:85:0)
[06:14:06.455] Timer tick, asking Buildbucket for the build status
[06:14:06.698] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:06.698] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:86:0) after 1m0s
[06:15:06.720] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:86:0)
[06:15:06.720] Timer tick, asking Buildbucket for the build status
[06:15:06.777] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:06.777] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:87:0) after 1m0s
[06:16:06.805] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:87:0)
[06:16:06.805] Timer tick, asking Buildbucket for the build status
[06:16:06.874] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:06.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:88:0) after 1m0s
[06:17:06.848] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:88:0)
[06:17:06.848] Timer tick, asking Buildbucket for the build status
[06:17:06.999] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:06.999] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:89:0) after 1m0s
[06:18:06.992] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:89:0)
[06:18:06.992] Timer tick, asking Buildbucket for the build status
[06:18:07.041] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:07.041] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:90:0) after 1m0s
[06:19:07.064] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:90:0)
[06:19:07.064] Timer tick, asking Buildbucket for the build status
[06:19:07.176] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:07.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:91:0) after 1m0s
[06:20:07.244] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:91:0)
[06:20:07.244] Timer tick, asking Buildbucket for the build status
[06:20:07.600] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:07.600] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:92:0) after 1m0s
[06:21:07.627] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:92:0)
[06:21:07.627] Timer tick, asking Buildbucket for the build status
[06:21:07.688] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:07.688] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:93:0) after 1m0s
[06:22:07.714] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:93:0)
[06:22:07.714] Timer tick, asking Buildbucket for the build status
[06:22:07.790] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:07.790] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:94:0) after 1m0s
[06:23:07.818] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:94:0)
[06:23:07.818] Timer tick, asking Buildbucket for the build status
[06:23:07.995] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:07.995] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:95:0) after 1m0s
[06:24:08.022] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:95:0)
[06:24:08.022] Timer tick, asking Buildbucket for the build status
[06:24:08.142] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:08.142] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:96:0) after 1m0s
[06:25:08.173] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:96:0)
[06:25:08.173] Timer tick, asking Buildbucket for the build status
[06:25:08.250] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:08.250] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:97:0) after 1m0s
[06:26:08.272] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:97:0)
[06:26:08.272] Timer tick, asking Buildbucket for the build status
[06:26:08.362] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:08.362] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:98:0) after 1m0s
[06:27:08.367] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:98:0)
[06:27:08.367] Timer tick, asking Buildbucket for the build status
[06:27:08.681] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:08.681] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:99:0) after 1m0s
[06:28:08.709] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:99:0)
[06:28:08.709] Timer tick, asking Buildbucket for the build status
[06:28:08.776] Build 8919763303156860320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:08.776] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9085193365072791712:100:0) after 1m0s
[06:28:37.573] Received PubSub notification, asking Buildbucket for the build status
[06:28:37.626] Build 8919763303156860320: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[06:28:37.626] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1551853714449529",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1551847851564053",
"failure_reason": "BUILD_FAILURE",
"id": "8919763303156860320",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"e543f5fcb71b61820704cd8df91ae7499c4e67e7\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"machine_type\": [\"n1-standard-8\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"builder\": [\"linux-chromeos-dbg\"], \"kvm\": [\"1\"], \"id\": [\"swarm1567-c4\"], \"server_version\": [\"4143-92e279d\"], \"image\": [\"chrome-trusty-18042300-b7223b463e3\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"git\", \"goma_v2\", \"vpython\"]}}, \"ui\": {\"info\": \"Failure non_network_service_browser_tests\"}, \"properties\": {\"got_nacl_revision\": \"1ed9878b8eb68c1e0d0268754dafcf83e747fa8f\", \"got_swarming_client_revision\": \"7a61cf37d6a0163f0ec02d495289a1d038e62457\", \"got_revision\": \"e543f5fcb71b61820704cd8df91ae7499c4e67e7\", \"recipe\": \"chromium\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"got_dawn_revision\": \"b47470daa7377a804df5d94e7a93b5925a57f84a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#26973}\", \"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"got_revision_cp\": \"refs/heads/master@{#638010}\", \"branch\": \"refs/heads/master\", \"swarm_hashes\": {\"mojo_core_unittests\": \"87c7bb6fe546a67dfbe826d031484417a08abcda\", \"leveldb_service_unittests\": \"10f2227bda34ced18f529e9048011f994d7e3625\", \"storage_unittests\": \"f5ac5545a9ce66af292a6512299b0aa7315e1350\", \"compositor_unittests\": \"4ac8370e1f6abc6aa747eff6eb9b78f187518e75\", \"angle_unittests\": \"419a40a542c9e6071dd4567224d01468183d347d\", \"cast_unittests\": \"d98cf04b8d8f6de013c0acc0adde183e28e1dd52\", \"blink_unittests\": \"535f248a6b5491d563467989107fdf821e5afe78\", \"cc_unittests\": \"315b6c69f7c0624f153f641e0882d8cf704dea81\", \"blink_common_unittests\": \"fdd501a4c4e893ccd7663f6480c619b38549041d\", \"chromeos_components_unittests\": \"ed3184a21b8aa4704d82c6b7bc46bee9b1d97070\", \"shell_dialogs_unittests\": \"943188db9cbb62bb331c217c6e1fbb158381a78e\", \"message_center_unittests\": \"b2879cc5cae3b9a98dbe5c81250b1a179b811dad\", \"ppapi_unittests\": \"ca272294e43282c678c26967a6e9a5f1c573a077\", \"extensions_unittests\": \"1213e6cbe38ef6fe4d62369de0a3bdf2e88d3c34\", \"gl_unittests_ozone\": \"294efb79b7983c3a16f8a4f2e265f8b7a38d3570\", \"app_shell_unittests\": \"c047fa7b0c60152d06a4251820485d690a1ee887\", \"chrome_app_unittests\": \"180a12c990e7bed5e4b65e7ff701809be08741c8\", \"gcm_unit_tests\": \"02133e9dc0657ab6aad35961e51b2227aa60dd07\", \"views_unittests\": \"3ffb0fa17fd5c53655b73940bf756787736df562\", \"ash_unittests\": \"c4a5f50b9acf83da319f93be922f05b460cdf721\", \"ui_base_unittests\": \"9037947269c857449bae4db89884dca11bd61042\", \"wm_unittests\": \"17544bbc4d14cd7ca08f61cdd30c584726103e23\", \"boringssl_ssl_tests\": \"260b36baed96a066f2b12937fbc08f5ae4303a1b\", \"gin_unittests\": \"4eef8a7232cd5690ec4b20160d4837b4ce3cf80a\", \"extensions_browsertests\": \"ec5ae2cf242dd39701551ac557f8e6050f8edc8e\", \"content_unittests\": \"03e642f80dc7c51eb498705f20cfd2784249787b\", \"ozone_gl_unittests\": \"d9a8111985f08b1e2190026e995969940cbf13cc\", \"libjingle_xmpp_unittests\": \"94e65a657331baac5d1172a0e9359cfb7d4c447d\", \"remoting_unittests\": \"4fb6aa96b1caf49e0e8bd156e5bfd2d0e9bb12cc\", \"filesystem_service_unittests\": \"3843df8f5bb9f310fee37e50bfa31c8030c702f7\", \"gfx_unittests\": \"b6b372a0f75a86455bf994975dcd359d8cf8cfa4\", \"latency_unittests\": \"e874e278843f44f7764f2a5eda247f03bc741ff7\", \"boringssl_crypto_tests\": \"35d45a85d08a6ede22fb5cdd2c7b275ef41f6244\", \"display_unittests\": \"983d65003660c2d11a7dcb6be596b721c0a8e3e3\", \"chromedriver_unittests\": \"3911d40ee6ce83993c799f8f928852968fdd88bb\", \"traffic_annotation_auditor_unittests\": \"805ab46f5a2a0a6173a9afff4b98221f05da5036\", \"chromeos_unittests\": \"917ab3cd56245dfebe06c766763bbd8bc35528d5\", \"media_service_unittests\": \"98ae8f7f9bee6a96cbfabd706c8c2ae1375b9968\", \"jingle_unittests\": \"18be6f8f70c2497eb2fa8b2492476f8228dd4662\", \"capture_unittests\": \"a38d82867f4b1abbadbe3c785c2cdcf64690e04c\", \"ui_chromeos_unittests\": \"4187f81461670c5329e02bfa738b049bcbf0a84f\", \"service_manager_unittests\": \"daec94619a7701a9c786d1e44a53bd4bb2e47040\", \"media_blink_unittests\": \"27dcbf87fadd0665839c20c85ae0a677a7ae385c\", \"components_unittests\": \"ea512f7faf65200c32f33950acc134ed744e1540\", \"snapshot_unittests\": \"5405139881ee9b95ec875b3eb69090411a2cb1df\", \"accessibility_unittests\": \"c768bf0c423001dafaa6288f50003bc85edd0e87\", \"aura_unittests\": \"4c2f4e970a9390df7b0c501d81e7fd7807898084\", \"services_unittests\": \"cad5685cb41f03d35b9be364e0f2f1e56dff5d13\", \"ozone_unittests\": \"af555d41f588513a04c8843dad1e2897fe81be66\", \"events_unittests\": \"5c5fd6f4175a6616676f5c4ada1447854127149a\", \"ui_touch_selection_unittests\": \"62c8930a371a3aef30c7e13302eb9074c4c11ac0\", \"cacheinvalidation_unittests\": \"f0efa2df58efbbd97474c57ef64a2a06c90be933\", \"viz_unittests\": \"24c2018dbd3b9e01e58738d2466b1403ff4df475\", \"browser_tests\": \"210d51df1f880fbd3fcd3f73c7cf3a9e8871cd9e\", \"blink_platform_unittests\": \"06997ee1834295a4748ab591caeb0ca0f66d176d\", \"midi_unittests\": \"1ce850839ad37ac62a33d86f73d5bc163d7fe288\", \"dbus_unittests\": \"282c00b8aac59fa0ad5e520456da2b88b3b781bb\", \"gpu_unittests\": \"238c3f17678947270b3ddf03c1dda097b201d8a1\", \"exo_unittests\": \"c551ac37999e36057313e1d990fd36dd640f2a2d\", \"native_theme_unittests\": \"2fe671a03d5390f4d0d7a7ee0249ae2f7bdfd9c3\", \"ozone_x11_unittests\": \"d81c2ba515a4e0fe4db1be5917034391ac2b2962\", \"interactive_ui_tests\": \"3ee073b884d3c37ee4ac3936e1e3a022f8126b9f\", \"mojo_unittests\": \"3ba6b3bcba89e1074243ea04a56a66862e6c8581\", \"url_unittests\": \"4cfa0fc0c7f19ff92858133b69baaf7b07ad6c37\", \"google_apis_unittests\": \"f7f190ed1e4bc70ccf02d1264a3cec850336b325\", \"blink_heap_unittests\": \"26b5e1b75b6e12b0a45ac4deac8293eeefb4d289\", \"base_unittests\": \"35cb2490b8fb5b36afa71e9714143b73d80b74cf\", \"sync_integration_tests\": \"7eea964074ae03ff06152c2a4193034b5acca68f\", \"sql_unittests\": \"7ec470351bf16160998fbd4bdb57709e822a25e4\", \"nacl_helper_nonsfi_unittests\": \"370038d796dfa4806b8d831ff75d3a407f8706f8\", \"keyboard_unittests\": \"b8394fc6462f2a75245dc48be8a2ae10c849633d\", \"blink_fuzzer_unittests\": \"055b8e0000cbcf37587b3816abba4250b4945ca5\", \"app_list_unittests\": \"042d6d469ebc2eea0e18260942dac754517c157d\", \"ipc_tests\": \"250b6a14279c6cf2bca00d1dba1505b175ae1e4e\", \"net_unittests\": \"16b13a79e718089d8ed96784328d489dd369f01b\", \"components_browsertests\": \"b5a6c36f5262aa03d480d656e657a6a1741ee417\", \"media_unittests\": \"5947098dc5fd9d5885a746a8bc2652149cf3fd8a\", \"wtf_unittests\": \"09ecbd2cf2f538baea4b0f00fbf580d5936e4e94\", \"pdf_unittests\": \"55772e40d49c06156c13b51f5bbe80cb5384e9fd\", \"skia_unittests\": \"dcb02691296b6a81f61592e1fead0f61125ca304\", \"crypto_unittests\": \"48f9698fe5c04c34a236116b221d8ca394c8fd4e\", \"nacl_loader_unittests\": \"3451c06f12e35af1bf1f9ebbcc5226f3e0a147af\", \"unit_tests\": \"a50baf034b44e135f325e76ad42db5ff11cb3b53\", \"sandbox_linux_unittests\": \"7362687edd783bcd7f3343cfd8d0252979551d0c\", \"content_browsertests\": \"4732d5cee5a79f7cc55ac897c77643006ca2095a\", \"printing_unittests\": \"dc7becf58782e968d13b56ab73e33d61e4ac4594\", \"device_unittests\": \"2e9286143a3ce51cce105130e27a2b2c77000c5e\"}, \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"linux-chromeos-dbg\", \"got_webrtc_revision\": \"d36c08623d9085dad821fbb1462a7fe03badcef5\", \"mastername\": \"chromium.chromiumos\", \"got_angle_revision\": \"f094bac949922dabc3dd6944f3dec04111e953b6\", \"got_v8_revision\": \"3e8a733af17a7812eba188dad612be503bd45c57\", \"got_v8_revision_cp\": \"refs/heads/7.4.288@{#1}\", \"swarm_hashes_refs/heads/master(at){#638010}_without_patch\": {\"mojo_core_unittests\": \"87c7bb6fe546a67dfbe826d031484417a08abcda\", \"leveldb_service_unittests\": \"10f2227bda34ced18f529e9048011f994d7e3625\", \"storage_unittests\": \"f5ac5545a9ce66af292a6512299b0aa7315e1350\", \"compositor_unittests\": \"4ac8370e1f6abc6aa747eff6eb9b78f187518e75\", \"angle_unittests\": \"419a40a542c9e6071dd4567224d01468183d347d\", \"cast_unittests\": \"d98cf04b8d8f6de013c0acc0adde183e28e1dd52\", \"blink_unittests\": \"535f248a6b5491d563467989107fdf821e5afe78\", \"cc_unittests\": \"315b6c69f7c0624f153f641e0882d8cf704dea81\", \"blink_common_unittests\": \"fdd501a4c4e893ccd7663f6480c619b38549041d\", \"chromeos_components_unittests\": \"ed3184a21b8aa4704d82c6b7bc46bee9b1d97070\", \"shell_dialogs_unittests\": \"943188db9cbb62bb331c217c6e1fbb158381a78e\", \"message_center_unittests\": \"b2879cc5cae3b9a98dbe5c81250b1a179b811dad\", \"ppapi_unittests\": \"ca272294e43282c678c26967a6e9a5f1c573a077\", \"extensions_unittests\": \"1213e6cbe38ef6fe4d62369de0a3bdf2e88d3c34\", \"gl_unittests_ozone\": \"294efb79b7983c3a16f8a4f2e265f8b7a38d3570\", \"app_shell_unittests\": \"c047fa7b0c60152d06a4251820485d690a1ee887\", \"chrome_app_unittests\": \"180a12c990e7bed5e4b65e7ff701809be08741c8\", \"gcm_unit_tests\": \"02133e9dc0657ab6aad35961e51b2227aa60dd07\", \"views_unittests\": \"3ffb0fa17fd5c53655b73940bf756787736df562\", \"ash_unittests\": \"c4a5f50b9acf83da319f93be922f05b460cdf721\", \"ui_base_unittests\": \"9037947269c857449bae4db89884dca11bd61042\", \"wm_unittests\": \"17544bbc4d14cd7ca08f61cdd30c584726103e23\", \"boringssl_ssl_tests\": \"260b36baed96a066f2b12937fbc08f5ae4303a1b\", \"gin_unittests\": \"4eef8a7232cd5690ec4b20160d4837b4ce3cf80a\", \"extensions_browsertests\": \"ec5ae2cf242dd39701551ac557f8e6050f8edc8e\", \"content_unittests\": \"03e642f80dc7c51eb498705f20cfd2784249787b\", \"ozone_gl_unittests\": \"d9a8111985f08b1e2190026e995969940cbf13cc\", \"traffic_annotation_auditor_unittests\": \"805ab46f5a2a0a6173a9afff4b98221f05da5036\", \"libjingle_xmpp_unittests\": \"94e65a657331baac5d1172a0e9359cfb7d4c447d\", \"remoting_unittests\": \"4fb6aa96b1caf49e0e8bd156e5bfd2d0e9bb12cc\", \"filesystem_service_unittests\": \"3843df8f5bb9f310fee37e50bfa31c8030c702f7\", \"gfx_unittests\": \"b6b372a0f75a86455bf994975dcd359d8cf8cfa4\", \"latency_unittests\": \"e874e278843f44f7764f2a5eda247f03bc741ff7\", \"boringssl_crypto_tests\": \"35d45a85d08a6ede22fb5cdd2c7b275ef41f6244\", \"media_unittests\": \"5947098dc5fd9d5885a746a8bc2652149cf3fd8a\", \"chromedriver_unittests\": \"3911d40ee6ce83993c799f8f928852968fdd88bb\", \"sandbox_linux_unittests\": \"7362687edd783bcd7f3343cfd8d0252979551d0c\", \"chromeos_unittests\": \"917ab3cd56245dfebe06c766763bbd8bc35528d5\", \"media_service_unittests\": \"98ae8f7f9bee6a96cbfabd706c8c2ae1375b9968\", \"jingle_unittests\": \"18be6f8f70c2497eb2fa8b2492476f8228dd4662\", \"capture_unittests\": \"a38d82867f4b1abbadbe3c785c2cdcf64690e04c\", \"ui_chromeos_unittests\": \"4187f81461670c5329e02bfa738b049bcbf0a84f\", \"service_manager_unittests\": \"daec94619a7701a9c786d1e44a53bd4bb2e47040\", \"media_blink_unittests\": \"27dcbf87fadd0665839c20c85ae0a677a7ae385c\", \"components_unittests\": \"ea512f7faf65200c32f33950acc134ed744e1540\", \"snapshot_unittests\": \"5405139881ee9b95ec875b3eb69090411a2cb1df\", \"accessibility_unittests\": \"c768bf0c423001dafaa6288f50003bc85edd0e87\", \"aura_unittests\": \"4c2f4e970a9390df7b0c501d81e7fd7807898084\", \"services_unittests\": \"cad5685cb41f03d35b9be364e0f2f1e56dff5d13\", \"ozone_unittests\": \"af555d41f588513a04c8843dad1e2897fe81be66\", \"events_unittests\": \"5c5fd6f4175a6616676f5c4ada1447854127149a\", \"ui_touch_selection_unittests\": \"62c8930a371a3aef30c7e13302eb9074c4c11ac0\", \"cacheinvalidation_unittests\": \"f0efa2df58efbbd97474c57ef64a2a06c90be933\", \"viz_unittests\": \"24c2018dbd3b9e01e58738d2466b1403ff4df475\", \"browser_tests\": \"210d51df1f880fbd3fcd3f73c7cf3a9e8871cd9e\", \"net_unittests\": \"16b13a79e718089d8ed96784328d489dd369f01b\", \"midi_unittests\": \"1ce850839ad37ac62a33d86f73d5bc163d7fe288\", \"dbus_unittests\": \"282c00b8aac59fa0ad5e520456da2b88b3b781bb\", \"gpu_unittests\": \"238c3f17678947270b3ddf03c1dda097b201d8a1\", \"exo_unittests\": \"c551ac37999e36057313e1d990fd36dd640f2a2d\", \"native_theme_unittests\": \"2fe671a03d5390f4d0d7a7ee0249ae2f7bdfd9c3\", \"ozone_x11_unittests\": \"d81c2ba515a4e0fe4db1be5917034391ac2b2962\", \"interactive_ui_tests\": \"3ee073b884d3c37ee4ac3936e1e3a022f8126b9f\", \"mojo_unittests\": \"3ba6b3bcba89e1074243ea04a56a66862e6c8581\", \"url_unittests\": \"4cfa0fc0c7f19ff92858133b69baaf7b07ad6c37\", \"google_apis_unittests\": \"f7f190ed1e4bc70ccf02d1264a3cec850336b325\", \"blink_heap_unittests\": \"26b5e1b75b6e12b0a45ac4deac8293eeefb4d289\", \"base_unittests\": \"35cb2490b8fb5b36afa71e9714143b73d80b74cf\", \"sync_integration_tests\": \"7eea964074ae03ff06152c2a4193034b5acca68f\", \"sql_unittests\": \"7ec470351bf16160998fbd4bdb57709e822a25e4\", \"nacl_helper_nonsfi_unittests\": \"370038d796dfa4806b8d831ff75d3a407f8706f8\", \"keyboard_unittests\": \"b8394fc6462f2a75245dc48be8a2ae10c849633d\", \"blink_fuzzer_unittests\": \"055b8e0000cbcf37587b3816abba4250b4945ca5\", \"app_list_unittests\": \"042d6d469ebc2eea0e18260942dac754517c157d\", \"ipc_tests\": \"250b6a14279c6cf2bca00d1dba1505b175ae1e4e\", \"blink_platform_unittests\": \"06997ee1834295a4748ab591caeb0ca0f66d176d\", \"components_browsertests\": \"b5a6c36f5262aa03d480d656e657a6a1741ee417\", \"display_unittests\": \"983d65003660c2d11a7dcb6be596b721c0a8e3e3\", \"wtf_unittests\": \"09ecbd2cf2f538baea4b0f00fbf580d5936e4e94\", \"pdf_unittests\": \"55772e40d49c06156c13b51f5bbe80cb5384e9fd\", \"skia_unittests\": \"dcb02691296b6a81f61592e1fead0f61125ca304\", \"crypto_unittests\": \"48f9698fe5c04c34a236116b221d8ca394c8fd4e\", \"nacl_loader_unittests\": \"3451c06f12e35af1bf1f9ebbcc5226f3e0a147af\", \"unit_tests\": \"a50baf034b44e135f325e76ad42db5ff11cb3b53\", \"content_browsertests\": \"4732d5cee5a79f7cc55ac897c77643006ca2095a\", \"printing_unittests\": \"dc7becf58782e968d13b56ab73e33d61e4ac4594\", \"device_unittests\": \"2e9286143a3ce51cce105130e27a2b2c77000c5e\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 11214, \"path_config\": \"generic\", \"revision\": \"e543f5fcb71b61820704cd8df91ae7499c4e67e7\", \"bot_id\": \"swarm1567-c4\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1551847896134446",
"status": "COMPLETED",
"status_changed_ts": "1551853716589711",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/11214",
"builder:linux-chromeos-dbg",
"buildset:commit/git/e543f5fcb71b61820704cd8df91ae7499c4e67e7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e543f5fcb71b61820704cd8df91ae7499c4e67e7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9085193365072791712",
"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/8919763303156860320/+/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:436a28928c0ca610",
"user_agent:luci-scheduler"
],
"updated_ts": "1551853716594887",
"url": "https://ci.chromium.org/b/8919763303156860320",
"utcnow_ts": "1551853717615240"
}
}
[06:28:37.626] Invocation finished in 1h37m47.273361491s with status FAILED