[12:36:04.709] New invocation is queued and will start shortly
[12:36:05.787] Starting the invocation (attempt 1)
[12:36:05.821] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:36:05.821] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:36:05.821] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9025188903007783696",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d1902a4603fe89d7d4a5b8ce61aa491527c572f1\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9025188903007783696",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/d1902a4603fe89d7d4a5b8ce61aa491527c572f1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d1902a4603fe89d7d4a5b8ce61aa491527c572f1",
"gitiles_ref:refs/heads/master"
]
}
[12:36:07.521] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1609072565932568",
"id": "8859758841063797632",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d1902a4603fe89d7d4a5b8ce61aa491527c572f1\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1609072567284919",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44081",
"builder:linux-chromeos-rel",
"buildset:commit/git/d1902a4603fe89d7d4a5b8ce61aa491527c572f1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d1902a4603fe89d7d4a5b8ce61aa491527c572f1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025188903007783696",
"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/8859758841063797632/+/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": "1609072567285174",
"url": "https://ci.chromium.org/b/8859758841063797632",
"utcnow_ts": "1609072567513656"
}
}
[12:36:07.521] Task URL: https://ci.chromium.org/b/8859758841063797632
[12:36:07.521] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:2:0) after 1m0s
[12:37:07.546] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:2:0)
[12:37:07.546] Timer tick, asking Buildbucket for the build status
[12:37:07.635] Build 8859758841063797632: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:37:07.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:3:0) after 1m0s
[12:38:07.720] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:3:0)
[12:38:07.720] Timer tick, asking Buildbucket for the build status
[12:38:08.019] Build 8859758841063797632: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:38:08.019] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:4:0) after 1m0s
[12:39:08.036] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:4:0)
[12:39:08.036] Timer tick, asking Buildbucket for the build status
[12:39:08.092] Build 8859758841063797632: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:39:08.092] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:5:0) after 1m0s
[12:40:08.104] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:5:0)
[12:40:08.104] Timer tick, asking Buildbucket for the build status
[12:40:08.176] Build 8859758841063797632: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:40:08.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:6:0) after 1m0s
[12:41:08.199] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:6:0)
[12:41:08.199] Timer tick, asking Buildbucket for the build status
[12:41:08.292] Build 8859758841063797632: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:41:08.292] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:7:0) after 1m0s
[12:42:08.313] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:7:0)
[12:42:08.313] Timer tick, asking Buildbucket for the build status
[12:42:08.495] Build 8859758841063797632: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:42:08.495] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:8:0) after 1m0s
[12:43:08.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:8:0)
[12:43:08.514] Timer tick, asking Buildbucket for the build status
[12:43:08.573] Build 8859758841063797632: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:43:08.573] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:9:0) after 1m0s
[12:44:08.591] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:9:0)
[12:44:08.591] Timer tick, asking Buildbucket for the build status
[12:44:08.666] Build 8859758841063797632: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:44:08.666] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:10:0) after 1m0s
[12:45:08.775] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:10:0)
[12:45:08.775] Timer tick, asking Buildbucket for the build status
[12:45:08.844] Build 8859758841063797632: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:45:08.845] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:11:0) after 1m0s
[12:46:08.866] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:11:0)
[12:46:08.866] Timer tick, asking Buildbucket for the build status
[12:46:08.955] Build 8859758841063797632: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:46:08.955] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:12:0) after 1m0s
[12:47:09.202] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:12:0)
[12:47:09.202] Timer tick, asking Buildbucket for the build status
[12:47:09.282] Build 8859758841063797632: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:47:09.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:13:0) after 1m0s
[12:48:09.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:13:0)
[12:48:09.305] Timer tick, asking Buildbucket for the build status
[12:48:09.409] Build 8859758841063797632: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:48:09.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:14:0) after 1m0s
[12:49:09.477] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:14:0)
[12:49:09.477] Timer tick, asking Buildbucket for the build status
[12:49:09.606] Build 8859758841063797632: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:49:09.606] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:15:0) after 1m0s
[12:50:09.623] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:15:0)
[12:50:09.623] Timer tick, asking Buildbucket for the build status
[12:50:09.758] Build 8859758841063797632: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:50:09.758] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:16:0) after 1m0s
[12:51:09.779] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:16:0)
[12:51:09.779] Timer tick, asking Buildbucket for the build status
[12:51:09.864] Build 8859758841063797632: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:51:09.864] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:17:0) after 1m0s
[12:52:09.883] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:17:0)
[12:52:09.883] Timer tick, asking Buildbucket for the build status
[12:52:09.938] Build 8859758841063797632: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:52:09.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:18:0) after 1m0s
[12:52:57.645] Received PubSub notification, asking Buildbucket for the build status
[12:52:57.709] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:09.984] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:18:0)
[12:53:09.984] Timer tick, asking Buildbucket for the build status
[12:53:10.429] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:10.429] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:20:0) after 1m0s
[12:54:10.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:20:0)
[12:54:10.514] Timer tick, asking Buildbucket for the build status
[12:54:10.606] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:10.606] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:21:0) after 1m0s
[12:55:10.664] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:21:0)
[12:55:10.664] Timer tick, asking Buildbucket for the build status
[12:55:10.754] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:10.754] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:22:0) after 1m0s
[12:56:10.786] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:22:0)
[12:56:10.786] Timer tick, asking Buildbucket for the build status
[12:56:10.905] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:10.905] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:23:0) after 1m0s
[12:57:10.916] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:23:0)
[12:57:10.916] Timer tick, asking Buildbucket for the build status
[12:57:10.990] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:10.990] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:24:0) after 1m0s
[12:58:11.011] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:24:0)
[12:58:11.011] Timer tick, asking Buildbucket for the build status
[12:58:11.061] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:11.061] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:25:0) after 1m0s
[12:59:11.082] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:25:0)
[12:59:11.082] Timer tick, asking Buildbucket for the build status
[12:59:11.173] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:11.173] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:26:0) after 1m0s
[13:00:11.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:26:0)
[13:00:11.238] Timer tick, asking Buildbucket for the build status
[13:00:11.325] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:11.325] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:27:0) after 1m0s
[13:01:11.400] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:27:0)
[13:01:11.400] Timer tick, asking Buildbucket for the build status
[13:01:12.316] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:12.316] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:28:0) after 1m0s
[13:02:12.344] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:28:0)
[13:02:12.344] Timer tick, asking Buildbucket for the build status
[13:02:12.483] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:12.483] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:29:0) after 1m0s
[13:03:12.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:29:0)
[13:03:12.508] Timer tick, asking Buildbucket for the build status
[13:03:12.619] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:12.619] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:30:0) after 1m0s
[13:04:12.685] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:30:0)
[13:04:12.685] Timer tick, asking Buildbucket for the build status
[13:04:12.745] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:12.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:31:0) after 1m0s
[13:05:12.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:31:0)
[13:05:12.748] Timer tick, asking Buildbucket for the build status
[13:05:12.812] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:12.812] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:32:0) after 1m0s
[13:06:12.834] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:32:0)
[13:06:12.834] Timer tick, asking Buildbucket for the build status
[13:06:12.925] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:12.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:33:0) after 1m0s
[13:07:12.944] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:33:0)
[13:07:12.944] Timer tick, asking Buildbucket for the build status
[13:07:13.789] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:13.789] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:34:0) after 1m0s
[13:08:13.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:34:0)
[13:08:13.878] Timer tick, asking Buildbucket for the build status
[13:08:14.223] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:14.223] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:35:0) after 1m0s
[13:09:14.272] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:35:0)
[13:09:14.272] Timer tick, asking Buildbucket for the build status
[13:09:14.409] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:14.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:36:0) after 1m0s
[13:10:14.428] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:36:0)
[13:10:14.428] Timer tick, asking Buildbucket for the build status
[13:10:14.538] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:14.538] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:37:0) after 1m0s
[13:11:14.701] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:37:0)
[13:11:14.701] Timer tick, asking Buildbucket for the build status
[13:11:14.912] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:14.912] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:38:0) after 1m0s
[13:12:14.917] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:38:0)
[13:12:14.917] Timer tick, asking Buildbucket for the build status
[13:12:14.984] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:14.984] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:39:0) after 1m0s
[13:13:15.015] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:39:0)
[13:13:15.015] Timer tick, asking Buildbucket for the build status
[13:13:15.092] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:15.092] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:40:0) after 1m0s
[13:14:15.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:40:0)
[13:14:15.117] Timer tick, asking Buildbucket for the build status
[13:14:15.174] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:15.174] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:41:0) after 1m0s
[13:15:15.248] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:41:0)
[13:15:15.248] Timer tick, asking Buildbucket for the build status
[13:15:15.311] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:15.311] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:42:0) after 1m0s
[13:16:15.290] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:42:0)
[13:16:15.290] Timer tick, asking Buildbucket for the build status
[13:16:15.381] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:15.381] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:43:0) after 1m0s
[13:17:15.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:43:0)
[13:17:15.402] Timer tick, asking Buildbucket for the build status
[13:17:15.452] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:15.452] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:44:0) after 1m0s
[13:18:15.572] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:44:0)
[13:18:15.572] Timer tick, asking Buildbucket for the build status
[13:18:15.624] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:15.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:45:0) after 1m0s
[13:19:15.713] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:45:0)
[13:19:15.713] Timer tick, asking Buildbucket for the build status
[13:19:15.771] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:15.771] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:46:0) after 1m0s
[13:20:15.972] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:46:0)
[13:20:15.972] Timer tick, asking Buildbucket for the build status
[13:20:16.023] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:16.023] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:47:0) after 1m0s
[13:21:16.277] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:47:0)
[13:21:16.277] Timer tick, asking Buildbucket for the build status
[13:21:16.479] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:16.479] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:48:0) after 1m0s
[13:22:16.716] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:48:0)
[13:22:16.716] Timer tick, asking Buildbucket for the build status
[13:22:16.770] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:16.770] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:49:0) after 1m0s
[13:23:16.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:49:0)
[13:23:16.903] Timer tick, asking Buildbucket for the build status
[13:23:16.960] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:16.960] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:50:0) after 1m0s
[13:24:17.147] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:50:0)
[13:24:17.147] Timer tick, asking Buildbucket for the build status
[13:24:17.246] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:17.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:51:0) after 1m0s
[13:25:17.448] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:51:0)
[13:25:17.448] Timer tick, asking Buildbucket for the build status
[13:25:17.529] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:17.529] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:52:0) after 1m0s
[13:26:17.624] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:52:0)
[13:26:17.624] Timer tick, asking Buildbucket for the build status
[13:26:17.734] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:17.734] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:53:0) after 1m0s
[13:27:17.795] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:53:0)
[13:27:17.795] Timer tick, asking Buildbucket for the build status
[13:27:17.997] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:17.997] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:54:0) after 1m0s
[13:28:18.083] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:54:0)
[13:28:18.083] Timer tick, asking Buildbucket for the build status
[13:28:18.130] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:18.130] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:55:0) after 1m0s
[13:29:18.354] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:55:0)
[13:29:18.354] Timer tick, asking Buildbucket for the build status
[13:29:18.602] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:18.602] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:56:0) after 1m0s
[13:30:18.825] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:56:0)
[13:30:18.825] Timer tick, asking Buildbucket for the build status
[13:30:18.871] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:18.871] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:57:0) after 1m0s
[13:31:18.924] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:57:0)
[13:31:18.924] Timer tick, asking Buildbucket for the build status
[13:31:19.022] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:19.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:58:0) after 1m0s
[13:32:19.104] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:58:0)
[13:32:19.104] Timer tick, asking Buildbucket for the build status
[13:32:19.159] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:19.159] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:59:0) after 1m0s
[13:33:19.212] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:59:0)
[13:33:19.212] Timer tick, asking Buildbucket for the build status
[13:33:19.267] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:19.267] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:60:0) after 1m0s
[13:34:19.301] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:60:0)
[13:34:19.301] Timer tick, asking Buildbucket for the build status
[13:34:19.360] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:19.360] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:61:0) after 1m0s
[13:35:19.387] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:61:0)
[13:35:19.387] Timer tick, asking Buildbucket for the build status
[13:35:19.441] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:19.441] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:62:0) after 1m0s
[13:36:19.460] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:62:0)
[13:36:19.460] Timer tick, asking Buildbucket for the build status
[13:36:19.691] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:19.691] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:63:0) after 1m0s
[13:37:19.687] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:63:0)
[13:37:19.687] Timer tick, asking Buildbucket for the build status
[13:37:19.756] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:19.756] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:64:0) after 1m0s
[13:38:19.827] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:64:0)
[13:38:19.827] Timer tick, asking Buildbucket for the build status
[13:38:19.881] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:19.881] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:65:0) after 1m0s
[13:39:19.919] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:65:0)
[13:39:19.919] Timer tick, asking Buildbucket for the build status
[13:39:20.199] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:20.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:66:0) after 1m0s
[13:40:20.294] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:66:0)
[13:40:20.294] Timer tick, asking Buildbucket for the build status
[13:40:20.420] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:20.420] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:67:0) after 1m0s
[13:41:20.444] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:67:0)
[13:41:20.444] Timer tick, asking Buildbucket for the build status
[13:41:20.539] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:20.539] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:68:0) after 1m0s
[13:42:20.559] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:68:0)
[13:42:20.559] Timer tick, asking Buildbucket for the build status
[13:42:20.616] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:20.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:69:0) after 1m0s
[13:43:20.636] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:69:0)
[13:43:20.636] Timer tick, asking Buildbucket for the build status
[13:43:20.689] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:20.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:70:0) after 1m0s
[13:44:20.688] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:70:0)
[13:44:20.688] Timer tick, asking Buildbucket for the build status
[13:44:20.801] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:20.801] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:71:0) after 1m0s
[13:45:20.876] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:71:0)
[13:45:20.876] Timer tick, asking Buildbucket for the build status
[13:45:20.939] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:20.939] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:72:0) after 1m0s
[13:46:21.032] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:72:0)
[13:46:21.032] Timer tick, asking Buildbucket for the build status
[13:46:21.274] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:21.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:73:0) after 1m0s
[13:47:21.298] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:73:0)
[13:47:21.298] Timer tick, asking Buildbucket for the build status
[13:47:21.354] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:21.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:74:0) after 1m0s
[13:48:21.457] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:74:0)
[13:48:21.457] Timer tick, asking Buildbucket for the build status
[13:48:21.529] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:21.529] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:75:0) after 1m0s
[13:49:21.696] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:75:0)
[13:49:21.696] Timer tick, asking Buildbucket for the build status
[13:49:21.753] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:21.753] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:76:0) after 1m0s
[13:50:21.972] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:76:0)
[13:50:21.972] Timer tick, asking Buildbucket for the build status
[13:50:22.021] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:22.021] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:77:0) after 1m0s
[13:51:22.063] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:77:0)
[13:51:22.063] Timer tick, asking Buildbucket for the build status
[13:51:22.223] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:22.223] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:78:0) after 1m0s
[13:52:22.229] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:78:0)
[13:52:22.229] Timer tick, asking Buildbucket for the build status
[13:52:22.283] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:22.284] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:79:0) after 1m0s
[13:53:22.395] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:79:0)
[13:53:22.395] Timer tick, asking Buildbucket for the build status
[13:53:22.501] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:22.501] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:80:0) after 1m0s
[13:54:22.578] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:80:0)
[13:54:22.578] Timer tick, asking Buildbucket for the build status
[13:54:22.758] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:22.758] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:81:0) after 1m0s
[13:55:22.848] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:81:0)
[13:55:22.848] Timer tick, asking Buildbucket for the build status
[13:55:22.906] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:22.906] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:82:0) after 1m0s
[13:56:23.017] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:82:0)
[13:56:23.017] Timer tick, asking Buildbucket for the build status
[13:56:23.397] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:23.397] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:83:0) after 1m0s
[13:57:23.703] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:83:0)
[13:57:23.704] Timer tick, asking Buildbucket for the build status
[13:57:23.985] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:23.985] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:84:0) after 1m0s
[13:58:24.014] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:84:0)
[13:58:24.014] Timer tick, asking Buildbucket for the build status
[13:58:24.104] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:24.104] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:85:0) after 1m0s
[13:59:24.124] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:85:0)
[13:59:24.124] Timer tick, asking Buildbucket for the build status
[13:59:24.244] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:24.244] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:86:0) after 1m0s
[14:00:24.269] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:86:0)
[14:00:24.269] Timer tick, asking Buildbucket for the build status
[14:00:24.394] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:24.394] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:87:0) after 1m0s
[14:01:24.451] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:87:0)
[14:01:24.451] Timer tick, asking Buildbucket for the build status
[14:01:24.817] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:24.818] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:88:0) after 1m0s
[14:02:24.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:88:0)
[14:02:24.941] Timer tick, asking Buildbucket for the build status
[14:02:25.025] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:25.025] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:89:0) after 1m0s
[14:03:25.124] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:89:0)
[14:03:25.124] Timer tick, asking Buildbucket for the build status
[14:03:25.255] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:25.255] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:90:0) after 1m0s
[14:04:25.286] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:90:0)
[14:04:25.286] Timer tick, asking Buildbucket for the build status
[14:04:25.404] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:25.404] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:91:0) after 1m0s
[14:05:25.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:91:0)
[14:05:25.558] Timer tick, asking Buildbucket for the build status
[14:05:25.667] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:25.667] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:92:0) after 1m0s
[14:06:25.687] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:92:0)
[14:06:25.687] Timer tick, asking Buildbucket for the build status
[14:06:26.042] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:26.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:93:0) after 1m0s
[14:07:26.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:93:0)
[14:07:26.127] Timer tick, asking Buildbucket for the build status
[14:07:26.328] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:26.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:94:0) after 1m0s
[14:08:26.430] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:94:0)
[14:08:26.430] Timer tick, asking Buildbucket for the build status
[14:08:26.573] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:26.573] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:95:0) after 1m0s
[14:09:26.780] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:95:0)
[14:09:26.780] Timer tick, asking Buildbucket for the build status
[14:09:26.893] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:26.893] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:96:0) after 1m0s
[14:10:26.944] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:96:0)
[14:10:26.944] Timer tick, asking Buildbucket for the build status
[14:10:27.708] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:27.708] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:97:0) after 1m0s
[14:11:27.898] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:97:0)
[14:11:27.898] Timer tick, asking Buildbucket for the build status
[14:11:28.018] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:28.018] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:98:0) after 1m0s
[14:12:28.161] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:98:0)
[14:12:28.161] Timer tick, asking Buildbucket for the build status
[14:12:28.380] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:28.380] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:99:0) after 1m0s
[14:13:28.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:99:0)
[14:13:28.495] Timer tick, asking Buildbucket for the build status
[14:13:28.597] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:28.597] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:100:0) after 1m0s
[14:14:28.705] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:100:0)
[14:14:28.705] Timer tick, asking Buildbucket for the build status
[14:14:28.808] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:28.808] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:101:0) after 1m0s
[14:15:28.828] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:101:0)
[14:15:28.828] Timer tick, asking Buildbucket for the build status
[14:15:28.929] Build 8859758841063797632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:28.929] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9025188903007783696:102:0) after 1m0s
[14:15:58.502] Received PubSub notification, asking Buildbucket for the build status
[14:15:58.905] Build 8859758841063797632: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:15:58.905] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1609078557778421",
"created_by": "project:chromium",
"created_ts": "1609072565932568",
"id": "8859758841063797632",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d1902a4603fe89d7d4a5b8ce61aa491527c572f1\"}}",
"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\": \"d1902a4603fe89d7d4a5b8ce61aa491527c572f1\", \"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-east1-d-8-32-skcr\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 44081, \"got_angle_revision\": \"5e606e5bfce2b23c139c5289cbf1299844fa4b43\", \"got_dawn_revision\": \"c8d5277e86ee8c51b1dd7892b41e83eb26ac2ede\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"d1902a4603fe89d7d4a5b8ce61aa491527c572f1\", \"got_revision_cp\": \"refs/heads/master@{#839388}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1cc5b3357d2ff3c81ef7ec0b07a6660796bde5cd\", \"got_v8_revision\": \"4d7ae9713defe93b6f3de031454727a30c70a734\", \"got_v8_revision_cp\": \"refs/heads/8.9.192@{#1}\", \"got_webrtc_revision\": \"b90546580ec3e8236225f39f9e5e5e7b7128c24b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32881}\", \"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\": \"d1902a4603fe89d7d4a5b8ce61aa491527c572f1\", \"swarm_hashes_refs/heads/master(at){#839388}_without_patch\": {\"absl_hardening_tests\": \"ae1aa648691ef72ebd3d01b9abc02d9fdd8d37b6\", \"accessibility_unittests\": \"ddfa1bd65d103af60c0f45a0165178e082cb2e8f\", \"angle_unittests\": \"50b699f650f1c20671b36c842617d37e846ce921\", \"app_list_unittests\": \"a85df2994406412f282423556b9936ba3a664943\", \"app_shell_unittests\": \"a7fd03582ba0619a762e2bd6ce8efe4889f96944\", \"ash_unittests\": \"5cee72d13bcdf83271f3e24e39cedf4522a338b8\", \"aura_unittests\": \"05c8d0af84aba0e60c510fb4380d333e7af4a3cd\", \"base_unittests\": \"fa25c15c8c2ac1eabcb609f6111e28481bf7082c\", \"base_util_unittests\": \"86273209e2f008e8bb21451338e3db63e81cdaf8\", \"blink_common_unittests\": \"93e4a13ff1a7f66b6a86b9a37cc4d526057fad16\", \"blink_fuzzer_unittests\": \"4d30ae1b6287a7c5d692bef8b31c3790503b2278\", \"blink_heap_unittests\": \"8f6aa0bf1bdfafdffe5ced19c8508cdc030f4920\", \"blink_platform_unittests\": \"4ecda095707c640bd30e233a0969da30dc53e80b\", \"blink_unittests\": \"db7534948e82f9d65efcaf928750f7f79e661a39\", \"boringssl_crypto_tests\": \"e12738af3abc659da928996082d21d2dfbf64df7\", \"boringssl_ssl_tests\": \"7af857c917284c71d6f1a8ffed0aa31ba027a9ff\", \"browser_tests\": \"530465c0b7818bbce85487eb3e0464225010f3e8\", \"capture_unittests\": \"3302eb9a7c3ff0ebc4bcd0e69d3f5764d57b6d98\", \"cast_unittests\": \"09869eabf730841be97cf28757b653d911b64b3a\", \"cc_unittests\": \"c7134d8e70a51cb48dd5845200909761019e9f85\", \"chrome_app_unittests\": \"e2c61bf12a83a2d0a50382d9f86f3becd9ac0971\", \"chromedriver_unittests\": \"d6ad70148e5aff0aa154723b9d2e74d1245de3e0\", \"chromeos_components_unittests\": \"16f6663076a395bbfecec1332136240db10403d0\", \"chromeos_unittests\": \"e6de417da737a01d7e8efebe70222c4c64e7b009\", \"components_browsertests\": \"4f69cb3b0b99887e2579af93d9fd42a86e276b27\", \"components_unittests\": \"b6cdb2da7b7f873338dd0105303c63f61916d0fa\", \"compositor_unittests\": \"0ae44a119c526a6017d559819d607f26c3542d8c\", \"content_browsertests\": \"655453c746b584d758e3182ceace19f45fab139b\", \"content_unittests\": \"ce934f272117970fda1b128a5b27d33df24f88b2\", \"crashpad_tests\": \"c5a0af31e7d708ba7a897a45e3c5e4f98c4ee6f9\", \"crypto_unittests\": \"cc3f3b8428c592485624eccdd87696d115cbd97d\", \"dbus_unittests\": \"ee40acaefadd8b356461c7cbfb7891eb446b081f\", \"device_unittests\": \"348d0e4196472c88f643602e46ac834a44f05e2a\", \"display_unittests\": \"054099eddc9f5e419f0d868889a7103558716fc3\", \"events_unittests\": \"a5e86e5e80ba080825872c30bd71aca38412b93d\", \"exo_unittests\": \"f2969ebac5abf7ccf26b0727cb6f06b39de288be\", \"extensions_browsertests\": \"cff806e0c1ce10be1e11bec419f5046c5172bff2\", \"extensions_unittests\": \"8f7130d6f38eca31b94af2d954b52110363e4a37\", \"filesystem_service_unittests\": \"9b0f045e5656aa94b8b1f5d514bb0c882ec29820\", \"gcm_unit_tests\": \"915ec11a87ab3c49f94acfab8cc77035770b7aa6\", \"gfx_unittests\": \"e141fa1c0776bcc8ec51a70658c5a5b51c6a0f8e\", \"gin_unittests\": \"cccb3d1448205c1a5c2b4a0ae8b8ca0bbb50e436\", \"gl_unittests_ozone\": \"a0db905d37c02f24f4f33a469ed7ad60c5872167\", \"google_apis_unittests\": \"39513c08f6df43719cb497ee862873c6655644b6\", \"gpu_unittests\": \"60847b8481afbc12a5e5d59640ab1a84f0b033c3\", \"gwp_asan_unittests\": \"152362009ee411854c06d1a58575ff0297f8b6c0\", \"interactive_ui_tests\": \"061eecf72a104cb0b37e961c91418f14d7101aa3\", \"ipc_tests\": \"92343c6901fc5ff5be465ac0f517713178e6d7f8\", \"jingle_unittests\": \"685a529ae44be48d1756c9f60e8573c2073ac0f1\", \"keyboard_unittests\": \"00706449839334a4d8006942245af57b2cc6c47b\", \"latency_unittests\": \"e6f76b3f55291b4ab646ca963bd6b2afc54a0794\", \"libjingle_xmpp_unittests\": \"371e30309991d8f22b3cf4d68b6a3ed36018621d\", \"liburlpattern_unittests\": \"a0b8ee26c82002bbe252d204acf7e39903f4d116\", \"media_blink_unittests\": \"16cbfb7179003e4a8cf8825d36ac2f353aa5cac7\", \"media_unittests\": \"7c8c848b7c14f18e76bfc32ec84617b260199d7d\", \"message_center_unittests\": \"9111ca08a2abc910ab2bf03257405046d13bd189\", \"midi_unittests\": \"4a3ff402d4ae6e55fdd57152b8c36b310bc61cda\", \"mojo_core_unittests\": \"52bc5c4a1cbba3fa3bc994946139dc1aa71e2a28\", \"mojo_unittests\": \"57f4f76cf13bf627589364f73a5cd00c025b32b9\", \"nacl_helper_nonsfi_unittests\": \"257055ada806334c556487ae9a21824e2e7ca538\", \"nacl_loader_unittests\": \"7a330c88740fd625fac13b139eb4da062861ee60\", \"native_theme_unittests\": \"7c050445d88d4ef19ed48cb9f23fc7f6c3cd3b76\", \"net_unittests\": \"f8298533b2463f91556f0f3aa7a7c5570545b9e1\", \"ozone_gl_unittests\": \"3444d24382529535024c099a0681799cc4f21349\", \"ozone_unittests\": \"1f18422fe52303c269b39b3ad38e41b1ac8e6e64\", \"ozone_x11_unittests\": \"88a23aa12d65f9297f36e4acc98ed3a7be2ead3f\", \"pdf_unittests\": \"34c843ddd8742d3afa170db59722202b428738c3\", \"perfetto_unittests\": \"f4a0a9bf15fae238b65e9d93ba1b4af97e27f2ba\", \"ppapi_unittests\": \"a581634e9efcfc047ac70fc639413a2a6ffe028b\", \"printing_unittests\": \"f6a1c84c57859eab432ec1a29737dfca0149feb6\", \"remoting_unittests\": \"65cfcb76eb187506f18e504470e635b162a19930\", \"sandbox_linux_unittests\": \"3bc5d666198278021222a7ece5193f5f80da6d82\", \"service_manager_unittests\": \"512a6ab985c0e9f3908a50edd010cd7845f002a4\", \"services_unittests\": \"ae330f60d2ff3f35493ae41c38e19b3605cfecbb\", \"shell_dialogs_unittests\": \"336a709a0e1df753636abe4332f076e17e572f63\", \"shell_encryption_unittests\": \"0fd14d66dbc469b2500df36bdb73ecf0553aa870\", \"skia_unittests\": \"d63afa88f37db0c5a9560658ff2284628e4583cf\", \"snapshot_unittests\": \"95f3244d34168a3887c5c93d685ef67a22d659db\", \"sql_unittests\": \"3acdf58217b8c2db50c03d6ee1b0e9e69db0b5c6\", \"storage_unittests\": \"ca88e95bb9f832797ffbf6d7bf87933c1e56abae\", \"sync_integration_tests\": \"d4313a3fc1d65a6e4baaea6c4e090c8d5ae90e7c\", \"traffic_annotation_auditor_unittests\": \"c24a1fb0190a295c77a6d8a96b178b24a8863a8f\", \"ui_base_unittests\": \"447413a68e4120e155f282c6dfec914a6b1565f2\", \"ui_chromeos_unittests\": \"ebf3d5eb3ab5764a4868eefebdbad66caf1acfd3\", \"ui_touch_selection_unittests\": \"86e8a02a5cbf733ce640f747674b9c7a6c0aedc7\", \"unit_tests\": \"943cbcf2294a444758b621d80942100ada0517f3\", \"url_unittests\": \"11baa3d85d390fb1ed7ce2046ac2d9e6d5081b42\", \"usage_time_limit_unittests\": \"ec3813d38c1cbf77043cd4cad3c209fc98ac8051\", \"views_unittests\": \"6b46a16fc011550a643daa3baa9e5f54c9d39e78\", \"viz_unittests\": \"15104953312b33c972f7c726dc57a33b4a73bdf0\", \"wayland_client_perftests\": \"c020c54e7dac0a41e2cb6397ebd9cde7475d005a\", \"wm_unittests\": \"3ed38b935b28a81f267c1fac45dd3473649376e0\", \"wtf_unittests\": \"b6199efe0cb1e00370fc408302ac510d9b4c3f8f\", \"zlib_unittests\": \"e5e1c1390241d155d72b636a12f6164ecfca40f1\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_32ded518776cda8cac391977d607693e2958c39df4b87a6f7ec8056ca6add5b1_v2\", \"builder_349e20fa0346c22afd9d85eafc166958d65f8d3eb174d2113a3f89c2e822dead_v2\", \"builder_3ee79eab7726d87d4f9bf92f4b58b9506b0a7a0d17f466f0c3d67bd50a4697d1_v2\", \"builder_5018db700e530f8e7ae860b5b3feab2b02d3dedf1bbd3e704c6c59fde1b308dd_v2\", \"builder_61faa0d0c1c079ecf670d8cfa4f78ad3b1687a5534233c7377462c3ee6819708_v2\", \"builder_8e7ad9a10a7772feba5b42dda56992e918fe88f23579c3ddaf696dde66ee4238_v2\", \"builder_8f1f1a811acb8ac7cee91f001f34cb98db55e889611ed2a31914ce7c854c1541_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-east1-d-8-32-skcr\"], \"image\": [\"chrome-xenial-20122000-38c59757d9b\"], \"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\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1609073576928498",
"status": "COMPLETED",
"status_changed_ts": "1609078558032880",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44081",
"builder:linux-chromeos-rel",
"buildset:commit/git/d1902a4603fe89d7d4a5b8ce61aa491527c572f1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d1902a4603fe89d7d4a5b8ce61aa491527c572f1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025188903007783696",
"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/8859758841063797632/+/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:50bd046ce5343d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1609078558040560",
"url": "https://ci.chromium.org/b/8859758841063797632",
"utcnow_ts": "1609078558890010"
}
}
[14:15:58.905] Invocation finished in 1h39m54.21134835s with status SUCCEEDED