[10:22:01.785] New invocation is queued and will start shortly
[10:22:02.869] Starting the invocation (attempt 1)
[10:22:02.935] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:22:02.935] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:22:02.935] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9017858982348971776",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e4d487dee9afbfdf0229e79742a3b8e570c199c3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9017858982348971776",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/e4d487dee9afbfdf0229e79742a3b8e570c199c3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e4d487dee9afbfdf0229e79742a3b8e570c199c3",
"gitiles_ref:refs/heads/master"
]
}
[10:22:03.817] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1616062923075231",
"id": "8852428920331692528",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e4d487dee9afbfdf0229e79742a3b8e570c199c3\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1616062923609895",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/46246",
"builder:linux-chromeos-rel",
"buildset:commit/git/e4d487dee9afbfdf0229e79742a3b8e570c199c3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e4d487dee9afbfdf0229e79742a3b8e570c199c3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017858982348971776",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8852428920331692528/+/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": "1616062923610039",
"url": "https://ci.chromium.org/b/8852428920331692528",
"utcnow_ts": "1616062923809663"
}
}
[10:22:03.817] Task URL: https://ci.chromium.org/b/8852428920331692528
[10:22:03.817] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:2:0) after 1m0s
[10:23:03.938] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:2:0)
[10:23:03.938] Timer tick, asking Buildbucket for the build status
[10:23:04.044] Build 8852428920331692528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:23:04.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:3:0) after 1m0s
[10:24:04.069] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:3:0)
[10:24:04.069] Timer tick, asking Buildbucket for the build status
[10:24:04.136] Build 8852428920331692528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:24:04.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:4:0) after 1m0s
[10:25:04.224] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:4:0)
[10:25:04.224] Timer tick, asking Buildbucket for the build status
[10:25:04.404] Build 8852428920331692528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:25:04.404] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:5:0) after 1m0s
[10:26:04.439] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:5:0)
[10:26:04.439] Timer tick, asking Buildbucket for the build status
[10:26:04.579] Build 8852428920331692528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:26:04.579] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:6:0) after 1m0s
[10:27:01.897] Received PubSub notification, asking Buildbucket for the build status
[10:27:01.985] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:04.607] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:6:0)
[10:27:04.607] Timer tick, asking Buildbucket for the build status
[10:27:04.677] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:04.677] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:8:0) after 1m0s
[10:28:07.872] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:8:0)
[10:28:07.872] Timer tick, asking Buildbucket for the build status
[10:28:07.953] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:07.953] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:9:0) after 1m0s
[10:29:07.980] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:9:0)
[10:29:07.980] Timer tick, asking Buildbucket for the build status
[10:29:08.058] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:08.058] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:10:0) after 1m0s
[10:30:08.158] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:10:0)
[10:30:08.158] Timer tick, asking Buildbucket for the build status
[10:30:08.241] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:08.241] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:11:0) after 1m0s
[10:31:08.255] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:11:0)
[10:31:08.255] Timer tick, asking Buildbucket for the build status
[10:31:08.326] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:08.326] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:12:0) after 1m0s
[10:32:08.362] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:12:0)
[10:32:08.362] Timer tick, asking Buildbucket for the build status
[10:32:08.625] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:08.626] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:13:0) after 1m0s
[10:33:08.678] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:13:0)
[10:33:08.679] Timer tick, asking Buildbucket for the build status
[10:33:08.807] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:08.807] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:14:0) after 1m0s
[10:34:08.893] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:14:0)
[10:34:08.893] Timer tick, asking Buildbucket for the build status
[10:34:09.042] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:09.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:15:0) after 1m0s
[10:35:09.064] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:15:0)
[10:35:09.064] Timer tick, asking Buildbucket for the build status
[10:35:09.146] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:09.146] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:16:0) after 1m0s
[10:36:09.163] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:16:0)
[10:36:09.163] Timer tick, asking Buildbucket for the build status
[10:36:09.223] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:09.223] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:17:0) after 1m0s
[10:37:09.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:17:0)
[10:37:09.238] Timer tick, asking Buildbucket for the build status
[10:37:09.350] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:09.350] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:18:0) after 1m0s
[10:38:09.385] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:18:0)
[10:38:09.385] Timer tick, asking Buildbucket for the build status
[10:38:09.462] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:09.462] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:19:0) after 1m0s
[10:39:09.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:19:0)
[10:39:09.520] Timer tick, asking Buildbucket for the build status
[10:39:09.598] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:09.598] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:20:0) after 1m0s
[10:40:09.653] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:20:0)
[10:40:09.653] Timer tick, asking Buildbucket for the build status
[10:40:09.718] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:09.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:21:0) after 1m0s
[10:41:09.910] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:21:0)
[10:41:09.910] Timer tick, asking Buildbucket for the build status
[10:41:09.989] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:09.989] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:22:0) after 1m0s
[10:42:10.214] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:22:0)
[10:42:10.214] Timer tick, asking Buildbucket for the build status
[10:42:10.297] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:10.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:23:0) after 1m0s
[10:43:10.375] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:23:0)
[10:43:10.375] Timer tick, asking Buildbucket for the build status
[10:43:10.438] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:10.439] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:24:0) after 1m0s
[10:44:10.492] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:24:0)
[10:44:10.492] Timer tick, asking Buildbucket for the build status
[10:44:10.581] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:10.581] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:25:0) after 1m0s
[10:45:10.640] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:25:0)
[10:45:10.640] Timer tick, asking Buildbucket for the build status
[10:45:10.748] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:10.748] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:26:0) after 1m0s
[10:46:11.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:26:0)
[10:46:11.296] Timer tick, asking Buildbucket for the build status
[10:46:11.375] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:11.375] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:27:0) after 1m0s
[10:47:11.567] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:27:0)
[10:47:11.567] Timer tick, asking Buildbucket for the build status
[10:47:11.657] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:11.657] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:28:0) after 1m0s
[10:48:11.724] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:28:0)
[10:48:11.724] Timer tick, asking Buildbucket for the build status
[10:48:11.793] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:11.793] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:29:0) after 1m0s
[10:49:11.850] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:29:0)
[10:49:11.850] Timer tick, asking Buildbucket for the build status
[10:49:11.958] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:11.958] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:30:0) after 1m0s
[10:50:11.987] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:30:0)
[10:50:11.987] Timer tick, asking Buildbucket for the build status
[10:50:12.471] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:12.471] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:31:0) after 1m0s
[10:51:12.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:31:0)
[10:51:12.454] Timer tick, asking Buildbucket for the build status
[10:51:12.932] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:12.932] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:32:0) after 1m0s
[10:52:12.990] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:32:0)
[10:52:12.990] Timer tick, asking Buildbucket for the build status
[10:52:13.354] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:13.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:33:0) after 1m0s
[10:53:13.424] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:33:0)
[10:53:13.424] Timer tick, asking Buildbucket for the build status
[10:53:13.778] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:13.778] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:34:0) after 1m0s
[10:54:13.851] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:34:0)
[10:54:13.851] Timer tick, asking Buildbucket for the build status
[10:54:13.916] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:13.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:35:0) after 1m0s
[10:55:13.979] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:35:0)
[10:55:13.979] Timer tick, asking Buildbucket for the build status
[10:55:14.053] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:14.053] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:36:0) after 1m0s
[10:56:14.122] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:36:0)
[10:56:14.122] Timer tick, asking Buildbucket for the build status
[10:56:14.231] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:14.231] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:37:0) after 1m0s
[10:57:14.250] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:37:0)
[10:57:14.250] Timer tick, asking Buildbucket for the build status
[10:57:14.412] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:14.412] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:38:0) after 1m0s
[10:58:14.416] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:38:0)
[10:58:14.416] Timer tick, asking Buildbucket for the build status
[10:58:14.613] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:14.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:39:0) after 1m0s
[10:59:14.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:39:0)
[10:59:14.667] Timer tick, asking Buildbucket for the build status
[10:59:14.745] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:14.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:40:0) after 1m0s
[11:00:14.783] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:40:0)
[11:00:14.783] Timer tick, asking Buildbucket for the build status
[11:00:14.852] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:14.852] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:41:0) after 1m0s
[11:01:14.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:41:0)
[11:01:14.920] Timer tick, asking Buildbucket for the build status
[11:01:14.987] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:14.987] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:42:0) after 1m0s
[11:02:15.024] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:42:0)
[11:02:15.024] Timer tick, asking Buildbucket for the build status
[11:02:15.151] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:15.151] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:43:0) after 1m0s
[11:03:15.165] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:43:0)
[11:03:15.165] Timer tick, asking Buildbucket for the build status
[11:03:15.248] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:15.248] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:44:0) after 1m0s
[11:04:15.290] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:44:0)
[11:04:15.290] Timer tick, asking Buildbucket for the build status
[11:04:15.354] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:15.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:45:0) after 1m0s
[11:05:15.489] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:45:0)
[11:05:15.489] Timer tick, asking Buildbucket for the build status
[11:05:15.560] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:15.560] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:46:0) after 1m0s
[11:06:15.683] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:46:0)
[11:06:15.683] Timer tick, asking Buildbucket for the build status
[11:06:15.761] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:15.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:47:0) after 1m0s
[11:07:15.817] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:47:0)
[11:07:15.817] Timer tick, asking Buildbucket for the build status
[11:07:15.906] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:15.906] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:48:0) after 1m0s
[11:08:15.982] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:48:0)
[11:08:15.982] Timer tick, asking Buildbucket for the build status
[11:08:16.055] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:16.055] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:49:0) after 1m0s
[11:09:16.078] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:49:0)
[11:09:16.078] Timer tick, asking Buildbucket for the build status
[11:09:16.176] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:16.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:50:0) after 1m0s
[11:10:16.369] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:50:0)
[11:10:16.369] Timer tick, asking Buildbucket for the build status
[11:10:16.500] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:16.501] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:51:0) after 1m0s
[11:11:16.763] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:51:0)
[11:11:16.763] Timer tick, asking Buildbucket for the build status
[11:11:16.864] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:16.864] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:52:0) after 1m0s
[11:12:17.263] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:52:0)
[11:12:17.263] Timer tick, asking Buildbucket for the build status
[11:12:17.571] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:17.571] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:53:0) after 1m0s
[11:13:17.584] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:53:0)
[11:13:17.584] Timer tick, asking Buildbucket for the build status
[11:13:17.648] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:17.648] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:54:0) after 1m0s
[11:14:17.740] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:54:0)
[11:14:17.740] Timer tick, asking Buildbucket for the build status
[11:14:17.812] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:17.812] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:55:0) after 1m0s
[11:15:17.949] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:55:0)
[11:15:17.949] Timer tick, asking Buildbucket for the build status
[11:15:18.040] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:18.040] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:56:0) after 1m0s
[11:16:18.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:56:0)
[11:16:18.402] Timer tick, asking Buildbucket for the build status
[11:16:18.527] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:18.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:57:0) after 1m0s
[11:17:18.695] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:57:0)
[11:17:18.695] Timer tick, asking Buildbucket for the build status
[11:17:18.773] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:18.773] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:58:0) after 1m0s
[11:18:19.075] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:58:0)
[11:18:19.075] Timer tick, asking Buildbucket for the build status
[11:18:19.141] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:19.141] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:59:0) after 1m0s
[11:19:19.291] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:59:0)
[11:19:19.291] Timer tick, asking Buildbucket for the build status
[11:19:19.480] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:19.480] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:60:0) after 1m0s
[11:20:19.546] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:60:0)
[11:20:19.546] Timer tick, asking Buildbucket for the build status
[11:20:19.620] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:19.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:61:0) after 1m0s
[11:21:19.670] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:61:0)
[11:21:19.671] Timer tick, asking Buildbucket for the build status
[11:21:19.743] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:19.743] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:62:0) after 1m0s
[11:22:19.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:62:0)
[11:22:19.882] Timer tick, asking Buildbucket for the build status
[11:22:19.966] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:19.966] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:63:0) after 1m0s
[11:23:20.038] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:63:0)
[11:23:20.038] Timer tick, asking Buildbucket for the build status
[11:23:20.136] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:20.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:64:0) after 1m0s
[11:24:20.212] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:64:0)
[11:24:20.212] Timer tick, asking Buildbucket for the build status
[11:24:20.460] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:20.460] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:65:0) after 1m0s
[11:25:20.500] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:65:0)
[11:25:20.500] Timer tick, asking Buildbucket for the build status
[11:25:20.774] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:20.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:66:0) after 1m0s
[11:26:20.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:66:0)
[11:26:20.792] Timer tick, asking Buildbucket for the build status
[11:26:20.901] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:20.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:67:0) after 1m0s
[11:27:20.944] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:67:0)
[11:27:20.944] Timer tick, asking Buildbucket for the build status
[11:27:21.031] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:21.031] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:68:0) after 1m0s
[11:28:21.084] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:68:0)
[11:28:21.084] Timer tick, asking Buildbucket for the build status
[11:28:21.203] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:21.203] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:69:0) after 1m0s
[11:29:21.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:69:0)
[11:29:21.314] Timer tick, asking Buildbucket for the build status
[11:29:21.391] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:21.391] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:70:0) after 1m0s
[11:30:21.481] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:70:0)
[11:30:21.481] Timer tick, asking Buildbucket for the build status
[11:30:21.667] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:21.667] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:71:0) after 1m0s
[11:31:21.670] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:71:0)
[11:31:21.670] Timer tick, asking Buildbucket for the build status
[11:31:21.736] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:21.736] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:72:0) after 1m0s
[11:32:22.044] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:72:0)
[11:32:22.044] Timer tick, asking Buildbucket for the build status
[11:32:22.135] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:22.135] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:73:0) after 1m0s
[11:33:22.247] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:73:0)
[11:33:22.247] Timer tick, asking Buildbucket for the build status
[11:33:22.361] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:22.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:74:0) after 1m0s
[11:34:22.431] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:74:0)
[11:34:22.431] Timer tick, asking Buildbucket for the build status
[11:34:22.553] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:22.553] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:75:0) after 1m0s
[11:35:22.594] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:75:0)
[11:35:22.594] Timer tick, asking Buildbucket for the build status
[11:35:22.697] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:22.697] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:76:0) after 1m0s
[11:36:22.684] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:76:0)
[11:36:22.684] Timer tick, asking Buildbucket for the build status
[11:36:22.757] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:22.757] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:77:0) after 1m0s
[11:37:22.757] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:77:0)
[11:37:22.757] Timer tick, asking Buildbucket for the build status
[11:37:22.821] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:22.821] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:78:0) after 1m0s
[11:38:22.808] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:78:0)
[11:38:22.808] Timer tick, asking Buildbucket for the build status
[11:38:22.957] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:22.957] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:79:0) after 1m0s
[11:39:23.003] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:79:0)
[11:39:23.003] Timer tick, asking Buildbucket for the build status
[11:39:23.078] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:23.078] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:80:0) after 1m0s
[11:40:23.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:80:0)
[11:40:23.117] Timer tick, asking Buildbucket for the build status
[11:40:23.181] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:23.181] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:81:0) after 1m0s
[11:41:23.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:81:0)
[11:41:23.238] Timer tick, asking Buildbucket for the build status
[11:41:23.301] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:23.301] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:82:0) after 1m0s
[11:42:23.355] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:82:0)
[11:42:23.355] Timer tick, asking Buildbucket for the build status
[11:42:23.454] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:23.454] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:83:0) after 1m0s
[11:43:23.483] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:83:0)
[11:43:23.483] Timer tick, asking Buildbucket for the build status
[11:43:23.698] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:23.698] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:84:0) after 1m0s
[11:44:23.698] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:84:0)
[11:44:23.698] Timer tick, asking Buildbucket for the build status
[11:44:23.914] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:23.914] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:85:0) after 1m0s
[11:45:23.987] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:85:0)
[11:45:23.987] Timer tick, asking Buildbucket for the build status
[11:45:24.052] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:24.052] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:86:0) after 1m0s
[11:46:24.111] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:86:0)
[11:46:24.111] Timer tick, asking Buildbucket for the build status
[11:46:24.284] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:24.284] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:87:0) after 1m0s
[11:47:24.365] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:87:0)
[11:47:24.365] Timer tick, asking Buildbucket for the build status
[11:47:25.235] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:25.235] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:88:0) after 1m0s
[11:48:25.423] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:88:0)
[11:48:25.423] Timer tick, asking Buildbucket for the build status
[11:48:25.491] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:25.491] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:89:0) after 1m0s
[11:49:25.499] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:89:0)
[11:49:25.499] Timer tick, asking Buildbucket for the build status
[11:49:26.228] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:26.228] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:90:0) after 1m0s
[11:50:26.248] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:90:0)
[11:50:26.248] Timer tick, asking Buildbucket for the build status
[11:50:26.311] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:26.311] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:91:0) after 1m0s
[11:51:26.420] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:91:0)
[11:51:26.420] Timer tick, asking Buildbucket for the build status
[11:51:26.580] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:26.580] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:92:0) after 1m0s
[11:52:26.790] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:92:0)
[11:52:26.790] Timer tick, asking Buildbucket for the build status
[11:52:26.921] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:26.921] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:93:0) after 1m0s
[11:53:26.992] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:93:0)
[11:53:26.992] Timer tick, asking Buildbucket for the build status
[11:53:27.072] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:27.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:94:0) after 1m0s
[11:54:27.153] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:94:0)
[11:54:27.153] Timer tick, asking Buildbucket for the build status
[11:54:27.279] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:27.279] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:95:0) after 1m0s
[11:55:27.293] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:95:0)
[11:55:27.293] Timer tick, asking Buildbucket for the build status
[11:55:27.436] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:27.436] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:96:0) after 1m0s
[11:56:27.577] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:96:0)
[11:56:27.577] Timer tick, asking Buildbucket for the build status
[11:56:27.828] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:27.828] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:97:0) after 1m0s
[11:57:28.287] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:97:0)
[11:57:28.287] Timer tick, asking Buildbucket for the build status
[11:57:28.378] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:28.378] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:98:0) after 1m0s
[11:58:29.785] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:98:0)
[11:58:29.785] Timer tick, asking Buildbucket for the build status
[11:58:29.947] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:29.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:99:0) after 1m0s
[11:59:30.138] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:99:0)
[11:59:30.138] Timer tick, asking Buildbucket for the build status
[11:59:30.355] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:30.355] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:100:0) after 1m0s
[12:00:30.606] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:100:0)
[12:00:30.606] Timer tick, asking Buildbucket for the build status
[12:00:30.691] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:30.691] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:101:0) after 1m0s
[12:01:30.725] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:101:0)
[12:01:30.725] Timer tick, asking Buildbucket for the build status
[12:01:31.415] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:31.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:102:0) after 1m0s
[12:02:31.501] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:102:0)
[12:02:31.501] Timer tick, asking Buildbucket for the build status
[12:02:31.597] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:31.597] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:103:0) after 1m0s
[12:03:31.637] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:103:0)
[12:03:31.637] Timer tick, asking Buildbucket for the build status
[12:03:31.836] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:31.836] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:104:0) after 1m0s
[12:04:31.847] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:104:0)
[12:04:31.847] Timer tick, asking Buildbucket for the build status
[12:04:31.920] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:31.920] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:105:0) after 1m0s
[12:05:31.967] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:105:0)
[12:05:31.967] Timer tick, asking Buildbucket for the build status
[12:05:32.044] Build 8852428920331692528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:32.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9017858982348971776:106:0) after 1m0s
[12:05:58.077] Received PubSub notification, asking Buildbucket for the build status
[12:05:58.264] Build 8852428920331692528: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:05:58.264] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1616069157388186",
"created_by": "project:chromium",
"created_ts": "1616062923075231",
"id": "8852428920331692528",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e4d487dee9afbfdf0229e79742a3b8e570c199c3\"}}",
"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\": \"e4d487dee9afbfdf0229e79742a3b8e570c199c3\", \"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-146-h93r\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 46246, \"got_angle_revision\": \"39296f396f5bf9abb8c8d80b147be7029c633964\", \"got_dawn_revision\": \"3209df5a9cc2de5415688653d1142b1adda554db\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"e4d487dee9afbfdf0229e79742a3b8e570c199c3\", \"got_revision_cp\": \"refs/heads/master@{#864176}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"a98fb3f8380a3a5c9ae3e0175634ba88c85a434f\", \"got_v8_revision\": \"4f0f4e2a3c5ad9dc7312774da5197e0179c30863\", \"got_v8_revision_cp\": \"refs/heads/9.1.146@{#1}\", \"got_webrtc_revision\": \"92a768ad66f54ca57002f6f2e87c7a732e3fec39\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33488}\", \"is_cached\": false, \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-inverse-fieldtrials-fyi-rel\", \"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e4d487dee9afbfdf0229e79742a3b8e570c199c3\", \"swarm_hashes_refs/heads/master(at){#864176}_without_patch\": {\"absl_hardening_tests\": \"4935bf268dc12350d6e3a94e23810a8e9dd03872\", \"accessibility_unittests\": \"efd912490ca50b29213666ebb23a5b0b79c3cb92\", \"angle_unittests\": \"040b576470b0aded643acf1a549b4d21c381edae\", \"app_list_unittests\": \"177eaf5c67adb4f52a0ee16fa7f31a4893eab4c9\", \"app_shell_unittests\": \"94cb3ea43859f719fa10fbc645429fb2faa4c497\", \"ash_unittests\": \"3e640584ec848302d402dcf911bbf087ea9ae4a0\", \"aura_unittests\": \"2f94cd3f4e7b08aa41fdf07ef9c36429eb1e85aa\", \"base_unittests\": \"676cd87550bc23895cfa5a3bcf43da7ea46d0bc4\", \"base_util_unittests\": \"e0d9a0f39ba56122b31f8b610dd5893ba169e4ae\", \"blink_common_unittests\": \"671c3919ff5f5862b280091fdb52801e3d360dcc\", \"blink_fuzzer_unittests\": \"d7e87ff318b601857307fc9301ddaf67489de4cb\", \"blink_heap_unittests\": \"2533444914635ea0db4252838198cbc026ea44a4\", \"blink_platform_unittests\": \"bd75f5303ee82b5afb8bff4da793505c3dd077a3\", \"blink_unittests\": \"ac5f7c70edc5a32432bf7a006a62a656ffe3ee64\", \"boringssl_crypto_tests\": \"dac91dc4bdc55647c890c62cdc8dfee1ff9cb10f\", \"boringssl_ssl_tests\": \"e9a754554c1dc9d6501ccd8b5cdc066236acf3d3\", \"browser_tests\": \"7721d7408f317354814749c66eb685ba2d4d266a\", \"capture_unittests\": \"29d48a58068278a0d2e321aa1dac4a7ed7ccd60c\", \"cast_unittests\": \"952e81fa48c93a9bcb8f7b7d7048c9b7a3bd2a60\", \"cc_unittests\": \"0d958e22d9094e30f4f1d781ef60b9b8b2872d6a\", \"chrome_app_unittests\": \"05b08af407c4ef85d01f1b9e21bf392d903cb55c\", \"chromedriver_unittests\": \"b6ce1f5a24da8a1ecb3731a7fd46bbbc7d8fde37\", \"chromeos_components_unittests\": \"8a9796745c71ecc4adcc32a95cf36ec4b9f70e27\", \"chromeos_unittests\": \"988fa28f3b60e2ae638a6f2018525527f1a73d98\", \"color_unittests\": \"0e01824ce151b8adc8826d7fbd98a3b1ff0b7066\", \"components_browsertests\": \"069ea539a23772b7a9a926f903b22e31d5513032\", \"components_unittests\": \"4552c67882e080cab3e1f5bf60722fa5a53d71d7\", \"compositor_unittests\": \"e6cbe0ede61e25260cc034cce8dfe0d1d676cc38\", \"content_browsertests\": \"7b419a39c5e1f43da352c29762003c8a7aef4347\", \"content_unittests\": \"badcb411922990a9493cc4a4f5e6f7bc2151d284\", \"crashpad_tests\": \"b7745f09d8768038e510a5cfd1782d5ec015a87b\", \"crypto_unittests\": \"516d76cf1d8dc45084d1a1015646a91ebc966257\", \"dbus_unittests\": \"a0e64c5d3e7d600697bc594d05ab8c865399a90d\", \"device_unittests\": \"1aaa2dfd07d1691ea010fbbeade58fd746b05fb7\", \"display_unittests\": \"eced663f06d77798b3877f828af6d7413df9bdfa\", \"events_unittests\": \"740d8d361f98426cd175238b9d68ce008afcd006\", \"exo_unittests\": \"928cd40dc4cbf647997933257fb702530a33840f\", \"extensions_browsertests\": \"c2ce5d11d4c5aef91db269d7e5c67b3c832da3f6\", \"extensions_unittests\": \"f0f0c33632f6ab276d3d775d39e981e401bb970d\", \"filesystem_service_unittests\": \"342a4c43e94146ccb953c5444f990b49fd5c60cd\", \"gcm_unit_tests\": \"22b2cf871e2518bad3f46b1c999743de4252783c\", \"gfx_unittests\": \"75ac7136b28f98b49fd2342034872204d7db6713\", \"gin_unittests\": \"1e0324b3b4e51ab4282934b9dfce8a81c321855b\", \"gl_unittests_ozone\": \"653e12f1b73578ffae7d1c6c049058273852d9ff\", \"google_apis_unittests\": \"42786ed98b1be52e695096d7cba31266b29e1568\", \"gpu_unittests\": \"ed40bda7c4b3ac8d75f4aaa430229fbb405f6842\", \"gwp_asan_unittests\": \"29c6a8797f3cb2259424e6048fae6ef0cfbffecf\", \"interactive_ui_tests\": \"1951137a2f1b7b07a7ae2b828fada8393832827f\", \"ipc_tests\": \"a7b5ebec1b0d021bda865400d8ddb1597fdcfc8c\", \"jingle_unittests\": \"4f7c0c3de9e992c1f8fe0b560c0caf93dca7d219\", \"keyboard_unittests\": \"623d6ce7f5a4dc13bfe8bae42aa37e1e0ee00bb5\", \"latency_unittests\": \"92e40a16485742f942eab2f61bcf4503eabeefae\", \"libjingle_xmpp_unittests\": \"0d5f64b999407de9ba65cbf7e59371ff8dfeb90b\", \"liburlpattern_unittests\": \"df1cba4560fa86d619afd328e400f9b8b66d594a\", \"media_blink_unittests\": \"7f0d50a6ee6792d4ee76ce5c2d8d56d69344623e\", \"media_unittests\": \"a10f5087cd4cf5d76906aadb105554eef4ad64ff\", \"message_center_unittests\": \"d3602d0b6d5e675b1634dc9bc6967b506a53d2ce\", \"midi_unittests\": \"a856d31aa5e5dcad63b45a8ce1bb3f76f06dfdd0\", \"mojo_core_unittests\": \"f5bd63162f68a19f4cf5a39d3ad2c23938bf71a7\", \"mojo_unittests\": \"38677107de65ffaa9423af8f5d640f1c016490bc\", \"nacl_helper_nonsfi_unittests\": \"ae7540b09536b48b8d46840159831787925b089c\", \"nacl_loader_unittests\": \"abad669515c29d585fc9004ea86afbf108226545\", \"native_theme_unittests\": \"6d685f54d112331d75c50d7c42a6b79b2fcd95db\", \"net_unittests\": \"6842a938f58b09d393aeb93c36817783166fcb09\", \"ozone_gl_unittests\": \"321a32acfb55638afce61e7d00f6fbd9703b43a3\", \"ozone_unittests\": \"9f990ae0d9d67859b5998b20a48f19dd503671ef\", \"ozone_x11_unittests\": \"c636cd1912a4c08d7b8d6eaab57c891e34b85dc0\", \"pdf_unittests\": \"8a8dd186e812235e33d0bcb99fee878a0bccd5fe\", \"perfetto_unittests\": \"90d6b00053178c26902d95e6c4d247b034cfd1e8\", \"ppapi_unittests\": \"f48cdcc35ea899c2c24ba191d7d63181cd7658dc\", \"printing_unittests\": \"682e59453563ae3ec7cc74c892404abf5c553d87\", \"remoting_unittests\": \"cce2e92c0e1ead078c1b94b780c26686055bf48d\", \"sandbox_linux_unittests\": \"49fbc4993896ea3c47237b4e035c99f801325c95\", \"service_manager_unittests\": \"86485e05a1da2cafa7981f798d5b0f55e5b32976\", \"services_unittests\": \"780be888e1a96c6f8031b2ce1cf6967874c6716a\", \"shell_dialogs_unittests\": \"39b9064d31e712da62b8aa0c5e9bf13c5662dce8\", \"shell_encryption_unittests\": \"f02a7465a3d43a61f774acfe6788be488e05ab3a\", \"skia_unittests\": \"24b43e90ccad2880e302d1f73598b4fa8de638cc\", \"snapshot_unittests\": \"216b6134dc5219c8dcbb3a52ba07feaba0628bbe\", \"sql_unittests\": \"f26be8a7a73039e856a2c30bc9c50d51c7d7c181\", \"storage_unittests\": \"f7760aaf562e8031749e88eb94adc205750d5e5c\", \"sync_integration_tests\": \"bfea22969495862934044403566709dbbbc9eac6\", \"traffic_annotation_auditor_unittests\": \"4953ab9dfeb836209ea60511706fe27672ffcf95\", \"ui_base_unittests\": \"6b31a624cebb39580cd2423732050a66a36eabf0\", \"ui_chromeos_unittests\": \"e171c7d79da83cfe96b9a9b043a80a29e7e1a21c\", \"ui_touch_selection_unittests\": \"d67df18e4fe899bfbe073bb71e959fdd62a1f870\", \"unit_tests\": \"2f8f3980c308c0a4bd130c64f413ba90709f0397\", \"url_unittests\": \"d7b24bae7a4e216078cdaaab2fc20d0cb49ffcc8\", \"usage_time_limit_unittests\": \"895405f29920bfd923f89bef755c8b1268b4cd10\", \"views_unittests\": \"4cf66ef78e77936c60ce0609248546db6cb948ef\", \"viz_unittests\": \"78198029a3066ecdcfd2b6872c2911fd5cee9efd\", \"wayland_client_perftests\": \"1129f092e1bb099c40f4543367e5dc6f7a26bdb7\", \"wayland_client_tests\": \"26de4fea10f790ba0e46c57fac79fd0180cf55f1\", \"wm_unittests\": \"edf2680e632d16eb477ae5a3e49cf9c6ce0d64cd\", \"wtf_unittests\": \"5c663e5f1f79c5dced28b83c75e8f703683fac34\", \"zlib_unittests\": \"4d4eea0c5d4da214eec389666e8b0bcd22cc4335\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0b457c29832afe9869549a9d3fb1269d99c2cbc2ef2da9533a15fddd8d201757_v2\", \"builder_4a782824ba39c0c6a32b2128ebb0687e83cb58dc0cbed64e2911b02f7893cfe6_v2\", \"builder_65ed874bd033a5984c3cbb528261ef1b136b40627f077f473aaaca27b3fa3caf_v2\", \"builder_70f3607e3f7d84b5c3698c0eed74813ee5c700477d5aec13835ae2ecc5ee2d5b_v2\", \"builder_94dc7d486ab1bafc5bfb11010ef18f0cf20e8e07ae86b58c09f57ba294c280ac_v2\", \"builder_be6033c31ad7fe993e51aceefec32c9781d9cb2aa7f3fe71df24045d7e98805a_v2\", \"builder_d1071779fa62103c126fbddd8eb4d0fa2c72f39bcf76fe56968d2607dc4a05dd_v2\", \"builder_dbb86507a6c3fadd4cf4e1827f5f960c6207016e30a949100a00998d3583e722_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-146-h93r\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"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\", \"2.7\", \"2.7.12\"], \"server_version\": [\"5776-cb9e157\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1616063221332902",
"status": "COMPLETED",
"status_changed_ts": "1616069157631747",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/46246",
"builder:linux-chromeos-rel",
"buildset:commit/git/e4d487dee9afbfdf0229e79742a3b8e570c199c3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e4d487dee9afbfdf0229e79742a3b8e570c199c3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017858982348971776",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8852428920331692528/+/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:525daccd317de010",
"user_agent:luci-scheduler"
],
"updated_ts": "1616069157637507",
"url": "https://ci.chromium.org/b/8852428920331692528",
"utcnow_ts": "1616069158256500"
}
}
[12:05:58.264] Invocation finished in 1h43m56.495399783s with status SUCCEEDED