[17:43:04.903] New invocation is queued and will start shortly
[17:43:11.456] Starting the invocation (attempt 1)
[17:43:11.505] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:43:11.505] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:43:11.505] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030061824221836688",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f057adfd4280fa280fe5c6bdf25eea18d74f8a02\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9030061824221836688",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/f057adfd4280fa280fe5c6bdf25eea18d74f8a02",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f057adfd4280fa280fe5c6bdf25eea18d74f8a02",
"gitiles_ref:refs/heads/master"
]
}
[17:43:12.457] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604425391597122",
"id": "8864631756539058608",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f057adfd4280fa280fe5c6bdf25eea18d74f8a02\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604425392220550",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21131",
"builder:linux-chromeos-dbg",
"buildset:commit/git/f057adfd4280fa280fe5c6bdf25eea18d74f8a02",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f057adfd4280fa280fe5c6bdf25eea18d74f8a02",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030061824221836688",
"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/8864631756539058608/+/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": "1604425392220735",
"url": "https://ci.chromium.org/b/8864631756539058608",
"utcnow_ts": "1604425392449567"
}
}
[17:43:12.457] Task URL: https://ci.chromium.org/b/8864631756539058608
[17:43:12.457] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:2:0) after 1m0s
[17:44:12.710] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:2:0)
[17:44:12.710] Timer tick, asking Buildbucket for the build status
[17:44:12.812] Build 8864631756539058608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:44:12.812] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:3:0) after 1m0s
[17:45:12.988] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:3:0)
[17:45:12.988] Timer tick, asking Buildbucket for the build status
[17:45:13.077] Build 8864631756539058608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:45:13.077] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:4:0) after 1m0s
[17:46:13.128] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:4:0)
[17:46:13.128] Timer tick, asking Buildbucket for the build status
[17:46:13.472] Build 8864631756539058608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:46:13.472] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:5:0) after 1m0s
[17:46:15.910] Received PubSub notification, asking Buildbucket for the build status
[17:46:16.398] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:13.622] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:5:0)
[17:47:13.622] Timer tick, asking Buildbucket for the build status
[17:47:14.003] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:14.003] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:7:0) after 1m0s
[17:48:14.596] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:7:0)
[17:48:14.596] Timer tick, asking Buildbucket for the build status
[17:48:16.583] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:16.583] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:8:0) after 1m0s
[17:49:16.759] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:8:0)
[17:49:16.759] Timer tick, asking Buildbucket for the build status
[17:49:16.948] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:16.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:9:0) after 1m0s
[17:50:17.043] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:9:0)
[17:50:17.043] Timer tick, asking Buildbucket for the build status
[17:50:17.483] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:17.483] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:10:0) after 1m0s
[17:51:17.552] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:10:0)
[17:51:17.552] Timer tick, asking Buildbucket for the build status
[17:51:17.700] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:17.700] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:11:0) after 1m0s
[17:52:17.788] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:11:0)
[17:52:17.788] Timer tick, asking Buildbucket for the build status
[17:52:18.106] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:18.106] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:12:0) after 1m0s
[17:53:18.266] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:12:0)
[17:53:18.266] Timer tick, asking Buildbucket for the build status
[17:53:18.683] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:18.683] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:13:0) after 1m0s
[17:54:18.955] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:13:0)
[17:54:18.955] Timer tick, asking Buildbucket for the build status
[17:54:19.064] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:19.064] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:14:0) after 1m0s
[17:55:19.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:14:0)
[17:55:19.232] Timer tick, asking Buildbucket for the build status
[17:55:19.319] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:19.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:15:0) after 1m0s
[17:56:19.406] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:15:0)
[17:56:19.406] Timer tick, asking Buildbucket for the build status
[17:56:19.555] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:19.555] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:16:0) after 1m0s
[17:57:19.623] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:16:0)
[17:57:19.623] Timer tick, asking Buildbucket for the build status
[17:57:19.705] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:19.705] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:17:0) after 1m0s
[17:58:19.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:17:0)
[17:58:19.824] Timer tick, asking Buildbucket for the build status
[17:58:20.167] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:20.167] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:18:0) after 1m0s
[17:59:20.345] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:18:0)
[17:59:20.345] Timer tick, asking Buildbucket for the build status
[17:59:20.425] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:20.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:19:0) after 1m0s
[18:00:20.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:19:0)
[18:00:20.571] Timer tick, asking Buildbucket for the build status
[18:00:20.836] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:20.836] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:20:0) after 1m0s
[18:01:21.452] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:20:0)
[18:01:21.452] Timer tick, asking Buildbucket for the build status
[18:01:21.572] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:21.572] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:21:0) after 1m0s
[18:02:21.678] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:21:0)
[18:02:21.678] Timer tick, asking Buildbucket for the build status
[18:02:21.773] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:21.773] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:22:0) after 1m0s
[18:03:21.864] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:22:0)
[18:03:21.864] Timer tick, asking Buildbucket for the build status
[18:03:22.079] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:22.079] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:23:0) after 1m0s
[18:04:22.253] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:23:0)
[18:04:22.253] Timer tick, asking Buildbucket for the build status
[18:04:22.400] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:22.400] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:24:0) after 1m0s
[18:05:22.494] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:24:0)
[18:05:22.494] Timer tick, asking Buildbucket for the build status
[18:05:22.695] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:22.695] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:25:0) after 1m0s
[18:06:22.848] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:25:0)
[18:06:22.848] Timer tick, asking Buildbucket for the build status
[18:06:22.961] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:22.961] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:26:0) after 1m0s
[18:07:23.118] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:26:0)
[18:07:23.118] Timer tick, asking Buildbucket for the build status
[18:07:23.201] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:23.201] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:27:0) after 1m0s
[18:08:23.248] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:27:0)
[18:08:23.248] Timer tick, asking Buildbucket for the build status
[18:08:23.428] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:23.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:28:0) after 1m0s
[18:09:23.441] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:28:0)
[18:09:23.441] Timer tick, asking Buildbucket for the build status
[18:09:23.598] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:23.598] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:29:0) after 1m0s
[18:10:23.684] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:29:0)
[18:10:23.684] Timer tick, asking Buildbucket for the build status
[18:10:23.779] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:23.779] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:30:0) after 1m0s
[18:11:23.789] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:30:0)
[18:11:23.789] Timer tick, asking Buildbucket for the build status
[18:11:23.858] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:23.858] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:31:0) after 1m0s
[18:12:23.915] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:31:0)
[18:12:23.915] Timer tick, asking Buildbucket for the build status
[18:12:24.748] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:24.748] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:32:0) after 1m0s
[18:13:24.808] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:32:0)
[18:13:24.808] Timer tick, asking Buildbucket for the build status
[18:13:25.005] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:25.005] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:33:0) after 1m0s
[18:14:25.132] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:33:0)
[18:14:25.132] Timer tick, asking Buildbucket for the build status
[18:14:25.214] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:25.214] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:34:0) after 1m0s
[18:15:25.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:34:0)
[18:15:25.537] Timer tick, asking Buildbucket for the build status
[18:15:25.614] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:25.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:35:0) after 1m0s
[18:16:25.630] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:35:0)
[18:16:25.630] Timer tick, asking Buildbucket for the build status
[18:16:25.713] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:25.713] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:36:0) after 1m0s
[18:17:25.746] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:36:0)
[18:17:25.746] Timer tick, asking Buildbucket for the build status
[18:17:25.839] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:25.839] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:37:0) after 1m0s
[18:18:25.944] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:37:0)
[18:18:25.944] Timer tick, asking Buildbucket for the build status
[18:18:26.267] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:26.267] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:38:0) after 1m0s
[18:19:26.330] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:38:0)
[18:19:26.330] Timer tick, asking Buildbucket for the build status
[18:19:26.465] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:26.465] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:39:0) after 1m0s
[18:20:26.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:39:0)
[18:20:26.513] Timer tick, asking Buildbucket for the build status
[18:20:26.689] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:26.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:40:0) after 1m0s
[18:21:26.787] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:40:0)
[18:21:26.787] Timer tick, asking Buildbucket for the build status
[18:21:26.912] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:26.912] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:41:0) after 1m0s
[18:22:26.964] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:41:0)
[18:22:26.964] Timer tick, asking Buildbucket for the build status
[18:22:27.055] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:27.055] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:42:0) after 1m0s
[18:23:27.082] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:42:0)
[18:23:27.082] Timer tick, asking Buildbucket for the build status
[18:23:27.196] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:27.196] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:43:0) after 1m0s
[18:24:27.364] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:43:0)
[18:24:27.364] Timer tick, asking Buildbucket for the build status
[18:24:27.455] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:27.455] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:44:0) after 1m0s
[18:25:27.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:44:0)
[18:25:27.527] Timer tick, asking Buildbucket for the build status
[18:25:27.607] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:27.607] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:45:0) after 1m0s
[18:26:27.669] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:45:0)
[18:26:27.669] Timer tick, asking Buildbucket for the build status
[18:26:27.862] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:27.862] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:46:0) after 1m0s
[18:27:27.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:46:0)
[18:27:27.941] Timer tick, asking Buildbucket for the build status
[18:27:28.382] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:28.382] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:47:0) after 1m0s
[18:28:28.464] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:47:0)
[18:28:28.464] Timer tick, asking Buildbucket for the build status
[18:28:29.060] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:29.060] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:48:0) after 1m0s
[18:29:29.247] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:48:0)
[18:29:29.247] Timer tick, asking Buildbucket for the build status
[18:29:29.398] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:29.398] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:49:0) after 1m0s
[18:30:29.485] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:49:0)
[18:30:29.485] Timer tick, asking Buildbucket for the build status
[18:30:29.905] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:29.905] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:50:0) after 1m0s
[18:31:30.025] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:50:0)
[18:31:30.025] Timer tick, asking Buildbucket for the build status
[18:31:30.169] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:30.169] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:51:0) after 1m0s
[18:32:30.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:51:0)
[18:32:30.238] Timer tick, asking Buildbucket for the build status
[18:32:31.009] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:31.009] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:52:0) after 1m0s
[18:33:31.144] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:52:0)
[18:33:31.144] Timer tick, asking Buildbucket for the build status
[18:33:31.334] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:31.334] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:53:0) after 1m0s
[18:34:31.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:53:0)
[18:34:31.468] Timer tick, asking Buildbucket for the build status
[18:34:31.803] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:31.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:54:0) after 1m0s
[18:35:31.851] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:54:0)
[18:35:31.851] Timer tick, asking Buildbucket for the build status
[18:35:33.454] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:33.454] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:55:0) after 1m0s
[18:36:33.523] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:55:0)
[18:36:33.523] Timer tick, asking Buildbucket for the build status
[18:36:33.656] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:33.656] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:56:0) after 1m0s
[18:37:33.775] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:56:0)
[18:37:33.775] Timer tick, asking Buildbucket for the build status
[18:37:33.871] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:33.871] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:57:0) after 1m0s
[18:38:33.995] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:57:0)
[18:38:33.995] Timer tick, asking Buildbucket for the build status
[18:38:34.656] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:34.656] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:58:0) after 1m0s
[18:39:34.662] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:58:0)
[18:39:34.662] Timer tick, asking Buildbucket for the build status
[18:39:34.798] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:34.798] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:59:0) after 1m0s
[18:40:34.962] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:59:0)
[18:40:34.962] Timer tick, asking Buildbucket for the build status
[18:40:35.641] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:35.641] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:60:0) after 1m0s
[18:41:35.729] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:60:0)
[18:41:35.729] Timer tick, asking Buildbucket for the build status
[18:41:35.876] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:35.876] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:61:0) after 1m0s
[18:42:35.954] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:61:0)
[18:42:35.954] Timer tick, asking Buildbucket for the build status
[18:42:36.273] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:36.273] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:62:0) after 1m0s
[18:43:36.366] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:62:0)
[18:43:36.366] Timer tick, asking Buildbucket for the build status
[18:43:36.522] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:36.522] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:63:0) after 1m0s
[18:44:36.569] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:63:0)
[18:44:36.569] Timer tick, asking Buildbucket for the build status
[18:44:36.697] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:36.697] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:64:0) after 1m0s
[18:45:36.821] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:64:0)
[18:45:36.821] Timer tick, asking Buildbucket for the build status
[18:45:37.245] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:37.245] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:65:0) after 1m0s
[18:46:37.328] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:65:0)
[18:46:37.328] Timer tick, asking Buildbucket for the build status
[18:46:38.755] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:38.755] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:66:0) after 1m0s
[18:47:38.778] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:66:0)
[18:47:38.778] Timer tick, asking Buildbucket for the build status
[18:47:38.948] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:38.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:67:0) after 1m0s
[18:48:39.164] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:67:0)
[18:48:39.165] Timer tick, asking Buildbucket for the build status
[18:48:39.580] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:39.580] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:68:0) after 1m0s
[18:49:39.629] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:68:0)
[18:49:39.629] Timer tick, asking Buildbucket for the build status
[18:49:39.711] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:39.711] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:69:0) after 1m0s
[18:50:39.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:69:0)
[18:50:39.762] Timer tick, asking Buildbucket for the build status
[18:50:40.251] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:40.251] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:70:0) after 1m0s
[18:51:40.333] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:70:0)
[18:51:40.333] Timer tick, asking Buildbucket for the build status
[18:51:40.456] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:40.456] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:71:0) after 1m0s
[18:52:40.518] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:71:0)
[18:52:40.518] Timer tick, asking Buildbucket for the build status
[18:52:41.135] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:41.135] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:72:0) after 1m0s
[18:53:41.273] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:72:0)
[18:53:41.273] Timer tick, asking Buildbucket for the build status
[18:53:41.731] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:41.731] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:73:0) after 1m0s
[18:54:41.850] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:73:0)
[18:54:41.850] Timer tick, asking Buildbucket for the build status
[18:54:42.758] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:42.758] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:74:0) after 1m0s
[18:55:42.827] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:74:0)
[18:55:42.827] Timer tick, asking Buildbucket for the build status
[18:55:42.960] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:42.960] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:75:0) after 1m0s
[18:56:43.027] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:75:0)
[18:56:43.027] Timer tick, asking Buildbucket for the build status
[18:56:43.299] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:43.300] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:76:0) after 1m0s
[18:57:43.316] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:76:0)
[18:57:43.316] Timer tick, asking Buildbucket for the build status
[18:57:43.810] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:43.810] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:77:0) after 1m0s
[18:58:43.837] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:77:0)
[18:58:43.837] Timer tick, asking Buildbucket for the build status
[18:58:43.991] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:43.991] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:78:0) after 1m0s
[18:59:44.039] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:78:0)
[18:59:44.039] Timer tick, asking Buildbucket for the build status
[18:59:44.124] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:44.124] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:79:0) after 1m0s
[19:00:44.188] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:79:0)
[19:00:44.188] Timer tick, asking Buildbucket for the build status
[19:00:45.315] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:45.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:80:0) after 1m0s
[19:01:45.361] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:80:0)
[19:01:45.361] Timer tick, asking Buildbucket for the build status
[19:01:45.474] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:45.474] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:81:0) after 1m0s
[19:02:45.536] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:81:0)
[19:02:45.536] Timer tick, asking Buildbucket for the build status
[19:02:47.426] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:47.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:82:0) after 1m0s
[19:03:47.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:82:0)
[19:03:47.495] Timer tick, asking Buildbucket for the build status
[19:03:48.102] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:48.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:83:0) after 1m0s
[19:04:48.167] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:83:0)
[19:04:48.167] Timer tick, asking Buildbucket for the build status
[19:04:48.264] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:48.264] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:84:0) after 1m0s
[19:05:48.337] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:84:0)
[19:05:48.338] Timer tick, asking Buildbucket for the build status
[19:05:48.894] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:48.894] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:85:0) after 1m0s
[19:06:49.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:85:0)
[19:06:49.095] Timer tick, asking Buildbucket for the build status
[19:06:49.301] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:49.301] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:86:0) after 1m0s
[19:07:49.307] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:86:0)
[19:07:49.307] Timer tick, asking Buildbucket for the build status
[19:07:49.395] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:49.395] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:87:0) after 1m0s
[19:08:49.482] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:87:0)
[19:08:49.482] Timer tick, asking Buildbucket for the build status
[19:08:49.617] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:49.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:88:0) after 1m0s
[19:09:49.712] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:88:0)
[19:09:49.712] Timer tick, asking Buildbucket for the build status
[19:09:49.801] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:49.801] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:89:0) after 1m0s
[19:10:49.852] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:89:0)
[19:10:49.852] Timer tick, asking Buildbucket for the build status
[19:10:50.077] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:50.077] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:90:0) after 1m0s
[19:11:50.081] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:90:0)
[19:11:50.081] Timer tick, asking Buildbucket for the build status
[19:11:50.162] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:50.162] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:91:0) after 1m0s
[19:12:50.193] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:91:0)
[19:12:50.193] Timer tick, asking Buildbucket for the build status
[19:12:50.285] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:50.285] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:92:0) after 1m0s
[19:13:50.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:92:0)
[19:13:50.334] Timer tick, asking Buildbucket for the build status
[19:13:50.570] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:50.570] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:93:0) after 1m0s
[19:14:50.598] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:93:0)
[19:14:50.598] Timer tick, asking Buildbucket for the build status
[19:14:50.684] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:50.684] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:94:0) after 1m0s
[19:15:50.733] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:94:0)
[19:15:50.733] Timer tick, asking Buildbucket for the build status
[19:15:50.866] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:50.866] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:95:0) after 1m0s
[19:16:50.926] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:95:0)
[19:16:50.926] Timer tick, asking Buildbucket for the build status
[19:16:51.197] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:51.197] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:96:0) after 1m0s
[19:17:51.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:96:0)
[19:17:51.353] Timer tick, asking Buildbucket for the build status
[19:17:51.612] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:51.612] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:97:0) after 1m0s
[19:18:51.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:97:0)
[19:18:51.691] Timer tick, asking Buildbucket for the build status
[19:18:51.827] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:51.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:98:0) after 1m0s
[19:19:51.902] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:98:0)
[19:19:51.902] Timer tick, asking Buildbucket for the build status
[19:19:52.158] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:52.158] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:99:0) after 1m0s
[19:20:52.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:99:0)
[19:20:52.198] Timer tick, asking Buildbucket for the build status
[19:20:53.485] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:53.485] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:100:0) after 1m0s
[19:21:53.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:100:0)
[19:21:53.514] Timer tick, asking Buildbucket for the build status
[19:21:53.617] Build 8864631756539058608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:53.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030061824221836688:101:0) after 1m0s
[19:22:22.277] Received PubSub notification, asking Buildbucket for the build status
[19:22:22.358] Build 8864631756539058608: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:22:22.358] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604431341291452",
"created_by": "project:chromium",
"created_ts": "1604425391597122",
"id": "8864631756539058608",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f057adfd4280fa280fe5c6bdf25eea18d74f8a02\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"f057adfd4280fa280fe5c6bdf25eea18d74f8a02\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-40-5hxr\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21131, \"got_angle_revision\": \"6a4c9bbd518521d0471880c938635c8afefd3042\", \"got_dawn_revision\": \"43ef0a365b8443226916c090b88b3a0b09d6df96\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"f057adfd4280fa280fe5c6bdf25eea18d74f8a02\", \"got_revision_cp\": \"refs/heads/master@{#823592}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"b5bf82693f85b53ce31846705d323764a582489b\", \"got_v8_revision\": \"ba40ae7eef4ddab929ee4ffc61fccc5da96ee00e\", \"got_v8_revision_cp\": \"refs/heads/8.8.223@{#1}\", \"got_webrtc_revision\": \"42cafa5696f516712bbe6709fedeedffac61544c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32540}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f057adfd4280fa280fe5c6bdf25eea18d74f8a02\", \"swarm_hashes_refs/heads/master(at){#823592}_without_patch\": {\"absl_hardening_tests\": \"25816a2391955383050ca8616bbafa6a1fe451bb\", \"accessibility_unittests\": \"eeb109ccb0d370ba85b39bbbda183a22ec096357\", \"angle_unittests\": \"4c80903e2bf52d2d9261206fd72bb6bd37fa7e8a\", \"app_list_unittests\": \"0751653b68ecd36aa60858539c59b72da8e541ea\", \"app_shell_unittests\": \"91c7dfedb569b7304ce3268f5ebf707ac7377cd2\", \"ash_unittests\": \"4f02d4c31bec3c53746e11015cd126dd46050d1f\", \"aura_unittests\": \"8d79b3530414b25a97386795d8eca3940f2f1fb6\", \"base_unittests\": \"dd95f699eb163bd24f1909d30bd6ef6a1e50cc28\", \"base_util_unittests\": \"d0c961dfb29fe4b4c5be0e2e4309a7e81d4b6b1e\", \"blink_common_unittests\": \"d2dfccc20e107cc8aff476b6e62f6ab5d80bfa8e\", \"blink_fuzzer_unittests\": \"142a5b678f55267685b520413046a223e42c275f\", \"blink_heap_unittests\": \"2d84572017560d32a782f88bfee23190ba4a65b6\", \"blink_platform_unittests\": \"bd29cea1fd450ea56dd95f76ad9e546f796460e9\", \"blink_unittests\": \"7e46dc83cce1761104403646f34d95b43055ba1a\", \"boringssl_crypto_tests\": \"9f5ab1cb800a0614510e46fdc2e993ded7b61cde\", \"boringssl_ssl_tests\": \"c59f03788cefe014c552053215d4995de5c289b8\", \"browser_tests\": \"5b4363804abdbff88953b353deadbcb3859d6eb0\", \"capture_unittests\": \"fbfa278d471e78ca7f238f328aedfb9b5328c05f\", \"cast_unittests\": \"63e100024e20d2923b5587fd927cb492dea24897\", \"cc_unittests\": \"427566e48cab558cc22e021ac89a41e9031993d3\", \"chrome_app_unittests\": \"458e7a8c861d30a25af2ffcb7fdda29278b239c5\", \"chromedriver_unittests\": \"a534848004830a9097cd89af503f9799149b0d28\", \"chromeos_components_unittests\": \"0bac46f710df5ec5e168e1bcb4b89807562b5015\", \"chromeos_unittests\": \"ba9bc363521224432ba0c4eb6f29713597e86df5\", \"components_browsertests\": \"582bf05da41a99e95e50da3185ab34d3a2e74f34\", \"components_unittests\": \"96a52d2ed2be0a8aae1aa700fb8f4c9793c4598e\", \"compositor_unittests\": \"a6af3fd2908338aa3d4891a2984663a6e0ad8c0b\", \"content_browsertests\": \"700aed112e4f31a8572bbe2675a965706c24058b\", \"content_unittests\": \"a24eb97ea9988d256aa97ca074b8dd58e8f59ade\", \"crypto_unittests\": \"6c1176ea5b54ae51292460c08c74098df5003773\", \"dbus_unittests\": \"35df4e8e0c21bcaf6348f210ce85be3550476d2f\", \"device_unittests\": \"8f32d3531d343f91fd79c3b86133bf91e1c2d6b4\", \"display_unittests\": \"1b7cc6b83b826df8275bab6b9418c8162b132947\", \"events_unittests\": \"3c6afd995e20e3cd1f1e875a934cc6134ef286c9\", \"exo_unittests\": \"e37b27f0980bca23e12689439575edd37b592b5a\", \"extensions_browsertests\": \"09857b770a50f0dc640be9147f12334f1e59a3f9\", \"extensions_unittests\": \"546332d7abc1239c2ecfae13eb0704f3ae60f468\", \"filesystem_service_unittests\": \"7ee61d499cc72a8c29152e58e333cb71f98cd12c\", \"gcm_unit_tests\": \"57cce875a7c86c604d4f51ca8edca0cb86b57904\", \"gfx_unittests\": \"a7fad557a3e448aa37f7ea28f3369c53b42a1c49\", \"gin_unittests\": \"137282a096265fabba22cfd9745af01b8dd8aca1\", \"gl_unittests_ozone\": \"ce186445c757c9040124fb0fcbb1eda750d90b7c\", \"google_apis_unittests\": \"b360c58fdde70ed64113ed2e005a977dc33900da\", \"gpu_unittests\": \"f0715508b6f1a0c0be6c24f095e22fda6b38bf4b\", \"gwp_asan_unittests\": \"acc0058be2a7f5d79122a4c61afb41639978f36e\", \"interactive_ui_tests\": \"0eba181d904ad5af280f2a61d20400c7f341b8db\", \"ipc_tests\": \"dcd8efefd376aad4783de04066a24f66df022238\", \"jingle_unittests\": \"9c9f851601309680cb9d2e31905e5f18b3210ab6\", \"keyboard_unittests\": \"d471089d526ce97b633d781a79165c86af3782f3\", \"latency_unittests\": \"84da26855af1b76dbd4754d91bbe13d13ede5bad\", \"libjingle_xmpp_unittests\": \"0be5f15d3a0eeb3178dcfab242f972f74c0fd68f\", \"liburlpattern_unittests\": \"f90a76eeadbe2251acd0b30ca41e086129ceb922\", \"media_blink_unittests\": \"9785d8e807b259a72238adaf7863a6357cb04133\", \"media_unittests\": \"96d1c059df8206afd711a3fbcad2e4f29ddf691c\", \"message_center_unittests\": \"caa8bbfdbcdfc0d527be08387ab7d5a88fd5433d\", \"midi_unittests\": \"8213f33592f874ed54fbd996e0a1631bc4385910\", \"mojo_core_unittests\": \"636df01a5e6c7e0da859090a09982892e0985632\", \"mojo_unittests\": \"0b87b9d302d307ea14645603fac0f81aec62982e\", \"nacl_helper_nonsfi_unittests\": \"1eb51d80280cb84937605c3e56422e06b7787f8b\", \"nacl_loader_unittests\": \"8fd593e33dac8fedab78eb656e408c7e12e0b1ce\", \"native_theme_unittests\": \"3f45a6b61a3d84ee5985de965dfc4510df5ff7c6\", \"net_unittests\": \"8734289391ab92acffa5eb10b5838cc1b5950d3b\", \"ozone_gl_unittests\": \"2b12d1f0bb68792ee608be27aba74bb0edaa038d\", \"ozone_unittests\": \"c28397f70f54c9852d90dcd51f984509ed7f6d62\", \"ozone_x11_unittests\": \"fad6e85b4f472a2c4db233b4f78597594c5d05e3\", \"pdf_unittests\": \"e75e22a19ff7f1aeaf06d380bdfb2717dd35fa05\", \"perfetto_unittests\": \"00e1f3bd1fa5ad495278344eea2ee9cc9a367645\", \"ppapi_unittests\": \"275fca4a6c7cddf2e412624b55749d8cb2004609\", \"printing_unittests\": \"3efa7d9536b7f5eba4eb918430d17302e09d7683\", \"remoting_unittests\": \"478dacf751f29d5f2d390758412a8310f727a970\", \"sandbox_linux_unittests\": \"1e3f36cea0ed947ee4ec3a93c0b6677c526c44bd\", \"service_manager_unittests\": \"a98b463aafbc119b9fba030b3bdf85d77facf765\", \"services_unittests\": \"2e603c9cc2ae1bfd768d34f1589c102653ecba2c\", \"shell_dialogs_unittests\": \"6bc6a21eb9d2a284d58170a23b230932a2bbac4c\", \"skia_unittests\": \"46835da91de2ff32ff215311e0da84763083bbab\", \"snapshot_unittests\": \"84d81b8597dddaf707e08abc62a032344bb50a27\", \"sql_unittests\": \"03cd7ffde4daf8576cca153d417e89d89722a653\", \"storage_unittests\": \"9be5de7f9235cbb7b28657b2ff90fc89cafd8d91\", \"sync_integration_tests\": \"e76c06ac266ec8f59b6c260cb359bb208dcb4d2f\", \"traffic_annotation_auditor_unittests\": \"989b999edce597b22183229accdb05e8fb369172\", \"ui_base_unittests\": \"3802a9844658693cd2bfe45b5858f1175307af18\", \"ui_chromeos_unittests\": \"61108446afee1feb0cd71f4dfaa50d1e08da03d9\", \"ui_touch_selection_unittests\": \"e654426be052cc09664b6c60c8f171f6517ff064\", \"unit_tests\": \"adf55321ea74f2cb4b5e7b1855b49eb5cebbbd8a\", \"url_unittests\": \"4d95259afec1d392370e376007c293ef9bb2bc45\", \"usage_time_limit_unittests\": \"c9e91db181d0a5d094b257daaf49dc41889b0830\", \"views_unittests\": \"c4055d205055028ac3ac08953612a911d9d31a17\", \"viz_unittests\": \"d386da2c6f70768c28f13571bba55181deff3d95\", \"wm_unittests\": \"a3edd27d69febdc12c5b3ae8d8d44e005b58d167\", \"wtf_unittests\": \"173312551ea5005907f56695eb6acbef408f92cb\", \"zlib_unittests\": \"a6f75116e6a4b3169c92100fe6355e1b8cb33e95\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2295bac873f7edd8c9763e89419d85b38a875955550d968c436d775d3f06377b_v2\", \"builder_33498e86c0181efb6d75c3f73059d9522f6d5d2b3b1c7a2dc2a1c6b75cd205cd_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_a432d290b72bc0f3cae401fbd647c33c14340f64e89770e9c9c39d6230495526_v2\", \"builder_dc45faf1d7d5fa61c97a020287f0c8532c944f5ffcf96875ec590f5c9bab0d83_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-40-5hxr\"], \"image\": [\"chrome-xenial-20102500-5da31bca5f9\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604425574725388",
"status": "COMPLETED",
"status_changed_ts": "1604431341715365",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21131",
"builder:linux-chromeos-dbg",
"buildset:commit/git/f057adfd4280fa280fe5c6bdf25eea18d74f8a02",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f057adfd4280fa280fe5c6bdf25eea18d74f8a02",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030061824221836688",
"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/8864631756539058608/+/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:4fa806297a47e310",
"user_agent:luci-scheduler"
],
"updated_ts": "1604431341719765",
"url": "https://ci.chromium.org/b/8864631756539058608",
"utcnow_ts": "1604431342347039"
}
}
[19:22:22.358] Invocation finished in 1h39m17.471322836s with status SUCCEEDED