[21:26:37.261] New invocation is queued and will start shortly
[21:26:38.324] Starting the invocation (attempt 1)
[21:26:38.365] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:26:38.365] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:26:38.365] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018723139543763936",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"7d997588a9d9705dd1fde826e89bc45e7bba50b2\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9018723139543763936",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/7d997588a9d9705dd1fde826e89bc45e7bba50b2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7d997588a9d9705dd1fde826e89bc45e7bba50b2",
"gitiles_ref:refs/heads/master"
]
}
[21:26:39.264] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615238798596381",
"id": "8853293077481339104",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7d997588a9d9705dd1fde826e89bc45e7bba50b2\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615238799044610",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/46000",
"builder:linux-chromeos-rel",
"buildset:commit/git/7d997588a9d9705dd1fde826e89bc45e7bba50b2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7d997588a9d9705dd1fde826e89bc45e7bba50b2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018723139543763936",
"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/8853293077481339104/+/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": "1615238799044720",
"url": "https://ci.chromium.org/b/8853293077481339104",
"utcnow_ts": "1615238799249522"
}
}
[21:26:39.264] Task URL: https://ci.chromium.org/b/8853293077481339104
[21:26:39.264] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:2:0) after 1m0s
[21:27:39.294] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:2:0)
[21:27:39.294] Timer tick, asking Buildbucket for the build status
[21:27:39.398] Build 8853293077481339104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:27:39.398] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:3:0) after 1m0s
[21:28:39.433] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:3:0)
[21:28:39.433] Timer tick, asking Buildbucket for the build status
[21:28:39.549] Build 8853293077481339104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:28:39.549] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:4:0) after 1m0s
[21:29:39.573] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:4:0)
[21:29:39.573] Timer tick, asking Buildbucket for the build status
[21:29:39.861] Build 8853293077481339104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:29:39.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:5:0) after 1m0s
[21:30:39.876] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:5:0)
[21:30:39.876] Timer tick, asking Buildbucket for the build status
[21:30:40.019] Build 8853293077481339104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:30:40.019] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:6:0) after 1m0s
[21:31:40.074] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:6:0)
[21:31:40.074] Timer tick, asking Buildbucket for the build status
[21:31:40.137] Build 8853293077481339104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:31:40.137] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:7:0) after 1m0s
[21:32:35.608] Received PubSub notification, asking Buildbucket for the build status
[21:32:35.895] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:40.128] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:7:0)
[21:32:40.128] Timer tick, asking Buildbucket for the build status
[21:32:40.185] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:40.185] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:9:0) after 1m0s
[21:33:40.257] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:9:0)
[21:33:40.257] Timer tick, asking Buildbucket for the build status
[21:33:40.326] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:40.326] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:10:0) after 1m0s
[21:34:40.317] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:10:0)
[21:34:40.317] Timer tick, asking Buildbucket for the build status
[21:34:40.465] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:40.465] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:11:0) after 1m0s
[21:35:40.757] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:11:0)
[21:35:40.757] Timer tick, asking Buildbucket for the build status
[21:35:40.967] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:40.967] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:12:0) after 1m0s
[21:36:41.116] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:12:0)
[21:36:41.116] Timer tick, asking Buildbucket for the build status
[21:36:41.218] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:41.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:13:0) after 1m0s
[21:37:41.310] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:13:0)
[21:37:41.310] Timer tick, asking Buildbucket for the build status
[21:37:42.276] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:42.276] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:14:0) after 1m0s
[21:38:42.310] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:14:0)
[21:38:42.310] Timer tick, asking Buildbucket for the build status
[21:38:42.533] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:42.533] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:15:0) after 1m0s
[21:39:42.580] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:15:0)
[21:39:42.580] Timer tick, asking Buildbucket for the build status
[21:39:42.654] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:42.654] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:16:0) after 1m0s
[21:40:42.700] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:16:0)
[21:40:42.700] Timer tick, asking Buildbucket for the build status
[21:40:42.840] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:42.840] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:17:0) after 1m0s
[21:41:43.005] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:17:0)
[21:41:43.005] Timer tick, asking Buildbucket for the build status
[21:41:43.659] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:43.659] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:18:0) after 1m0s
[21:42:43.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:18:0)
[21:42:43.748] Timer tick, asking Buildbucket for the build status
[21:42:44.657] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:44.657] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:19:0) after 1m0s
[21:43:44.777] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:19:0)
[21:43:44.777] Timer tick, asking Buildbucket for the build status
[21:43:44.864] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:44.864] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:20:0) after 1m0s
[21:44:44.955] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:20:0)
[21:44:44.955] Timer tick, asking Buildbucket for the build status
[21:44:45.034] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:45.034] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:21:0) after 1m0s
[21:45:45.092] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:21:0)
[21:45:45.092] Timer tick, asking Buildbucket for the build status
[21:45:45.228] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:45.228] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:22:0) after 1m0s
[21:46:45.727] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:22:0)
[21:46:45.727] Timer tick, asking Buildbucket for the build status
[21:46:45.836] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:45.836] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:23:0) after 1m0s
[21:47:46.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:23:0)
[21:47:46.184] Timer tick, asking Buildbucket for the build status
[21:47:46.274] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:46.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:24:0) after 1m0s
[21:48:46.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:24:0)
[21:48:46.975] Timer tick, asking Buildbucket for the build status
[21:48:47.071] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:47.071] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:25:0) after 1m0s
[21:49:47.153] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:25:0)
[21:49:47.153] Timer tick, asking Buildbucket for the build status
[21:49:47.597] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:47.597] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:26:0) after 1m0s
[21:50:47.797] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:26:0)
[21:50:47.797] Timer tick, asking Buildbucket for the build status
[21:50:47.871] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:47.871] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:27:0) after 1m0s
[21:51:47.843] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:27:0)
[21:51:47.843] Timer tick, asking Buildbucket for the build status
[21:51:48.215] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:48.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:28:0) after 1m0s
[21:52:48.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:28:0)
[21:52:48.296] Timer tick, asking Buildbucket for the build status
[21:52:48.468] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:48.468] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:29:0) after 1m0s
[21:53:48.498] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:29:0)
[21:53:48.498] Timer tick, asking Buildbucket for the build status
[21:53:49.018] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:49.018] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:30:0) after 1m0s
[21:54:48.992] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:30:0)
[21:54:48.992] Timer tick, asking Buildbucket for the build status
[21:54:49.064] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:49.064] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:31:0) after 1m0s
[21:55:49.091] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:31:0)
[21:55:49.091] Timer tick, asking Buildbucket for the build status
[21:55:49.208] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:49.208] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:32:0) after 1m0s
[21:56:49.220] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:32:0)
[21:56:49.220] Timer tick, asking Buildbucket for the build status
[21:56:49.301] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:49.301] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:33:0) after 1m0s
[21:57:49.357] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:33:0)
[21:57:49.357] Timer tick, asking Buildbucket for the build status
[21:57:49.448] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:49.448] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:34:0) after 1m0s
[21:58:49.464] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:34:0)
[21:58:49.464] Timer tick, asking Buildbucket for the build status
[21:58:49.598] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:49.598] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:35:0) after 1m0s
[21:59:49.612] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:35:0)
[21:59:49.612] Timer tick, asking Buildbucket for the build status
[21:59:49.921] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:49.921] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:36:0) after 1m0s
[22:00:49.938] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:36:0)
[22:00:49.938] Timer tick, asking Buildbucket for the build status
[22:00:50.309] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:50.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:37:0) after 1m0s
[22:01:50.414] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:37:0)
[22:01:50.414] Timer tick, asking Buildbucket for the build status
[22:01:50.591] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:50.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:38:0) after 1m0s
[22:02:50.567] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:38:0)
[22:02:50.567] Timer tick, asking Buildbucket for the build status
[22:02:50.863] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:50.863] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:39:0) after 1m0s
[22:03:50.866] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:39:0)
[22:03:50.866] Timer tick, asking Buildbucket for the build status
[22:03:50.948] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:50.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:40:0) after 1m0s
[22:04:50.967] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:40:0)
[22:04:50.967] Timer tick, asking Buildbucket for the build status
[22:04:51.066] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:51.066] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:41:0) after 1m0s
[22:05:51.048] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:41:0)
[22:05:51.048] Timer tick, asking Buildbucket for the build status
[22:05:51.151] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:51.151] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:42:0) after 1m0s
[22:06:51.235] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:42:0)
[22:06:51.235] Timer tick, asking Buildbucket for the build status
[22:06:51.312] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:51.312] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:43:0) after 1m0s
[22:07:51.375] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:43:0)
[22:07:51.375] Timer tick, asking Buildbucket for the build status
[22:07:51.458] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:51.458] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:44:0) after 1m0s
[22:08:51.441] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:44:0)
[22:08:51.441] Timer tick, asking Buildbucket for the build status
[22:08:51.547] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:51.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:45:0) after 1m0s
[22:09:51.610] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:45:0)
[22:09:51.610] Timer tick, asking Buildbucket for the build status
[22:09:51.982] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:51.982] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:46:0) after 1m0s
[22:10:52.066] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:46:0)
[22:10:52.066] Timer tick, asking Buildbucket for the build status
[22:10:52.174] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:52.174] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:47:0) after 1m0s
[22:11:52.285] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:47:0)
[22:11:52.285] Timer tick, asking Buildbucket for the build status
[22:11:52.393] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:52.393] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:48:0) after 1m0s
[22:12:52.526] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:48:0)
[22:12:52.526] Timer tick, asking Buildbucket for the build status
[22:12:55.232] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:55.232] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:49:0) after 1m0s
[22:13:55.226] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:49:0)
[22:13:55.226] Timer tick, asking Buildbucket for the build status
[22:13:55.297] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:55.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:50:0) after 1m0s
[22:14:55.376] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:50:0)
[22:14:55.376] Timer tick, asking Buildbucket for the build status
[22:14:55.468] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:55.468] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:51:0) after 1m0s
[22:15:55.603] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:51:0)
[22:15:55.603] Timer tick, asking Buildbucket for the build status
[22:15:55.676] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:55.676] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:52:0) after 1m0s
[22:16:55.729] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:52:0)
[22:16:55.729] Timer tick, asking Buildbucket for the build status
[22:16:55.902] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:55.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:53:0) after 1m0s
[22:17:56.065] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:53:0)
[22:17:56.065] Timer tick, asking Buildbucket for the build status
[22:17:56.138] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:56.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:54:0) after 1m0s
[22:18:56.199] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:54:0)
[22:18:56.199] Timer tick, asking Buildbucket for the build status
[22:18:56.329] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:56.329] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:55:0) after 1m0s
[22:19:56.555] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:55:0)
[22:19:56.555] Timer tick, asking Buildbucket for the build status
[22:19:56.634] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:56.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:56:0) after 1m0s
[22:20:56.743] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:56:0)
[22:20:56.743] Timer tick, asking Buildbucket for the build status
[22:20:56.801] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:56.801] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:57:0) after 1m0s
[22:21:56.797] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:57:0)
[22:21:56.797] Timer tick, asking Buildbucket for the build status
[22:21:57.297] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:57.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:58:0) after 1m0s
[22:22:57.423] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:58:0)
[22:22:57.423] Timer tick, asking Buildbucket for the build status
[22:22:57.524] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:57.524] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:59:0) after 1m0s
[22:23:57.568] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:59:0)
[22:23:57.568] Timer tick, asking Buildbucket for the build status
[22:23:57.929] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:57.929] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:60:0) after 1m0s
[22:24:57.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:60:0)
[22:24:57.985] Timer tick, asking Buildbucket for the build status
[22:24:58.152] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:58.152] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:61:0) after 1m0s
[22:25:58.367] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:61:0)
[22:25:58.367] Timer tick, asking Buildbucket for the build status
[22:25:58.448] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:58.448] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:62:0) after 1m0s
[22:26:58.504] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:62:0)
[22:26:58.504] Timer tick, asking Buildbucket for the build status
[22:26:58.570] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:58.570] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:63:0) after 1m0s
[22:27:58.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:63:0)
[22:27:58.748] Timer tick, asking Buildbucket for the build status
[22:27:59.368] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:59.368] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:64:0) after 1m0s
[22:28:59.397] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:64:0)
[22:28:59.397] Timer tick, asking Buildbucket for the build status
[22:28:59.527] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:59.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:65:0) after 1m0s
[22:30:00.101] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:65:0)
[22:30:00.101] Timer tick, asking Buildbucket for the build status
[22:30:00.288] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:00.288] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:66:0) after 1m0s
[22:31:00.531] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:66:0)
[22:31:00.531] Timer tick, asking Buildbucket for the build status
[22:31:00.726] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:00.727] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:67:0) after 1m0s
[22:32:00.907] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:67:0)
[22:32:00.907] Timer tick, asking Buildbucket for the build status
[22:32:01.573] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:01.573] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:68:0) after 1m0s
[22:33:01.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:68:0)
[22:33:01.682] Timer tick, asking Buildbucket for the build status
[22:33:01.788] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:01.788] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:69:0) after 1m0s
[22:34:01.885] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:69:0)
[22:34:01.885] Timer tick, asking Buildbucket for the build status
[22:34:01.969] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:01.969] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:70:0) after 1m0s
[22:35:02.087] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:70:0)
[22:35:02.087] Timer tick, asking Buildbucket for the build status
[22:35:02.274] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:02.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:71:0) after 1m0s
[22:36:02.260] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:71:0)
[22:36:02.260] Timer tick, asking Buildbucket for the build status
[22:36:02.333] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:02.333] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:72:0) after 1m0s
[22:37:02.386] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:72:0)
[22:37:02.386] Timer tick, asking Buildbucket for the build status
[22:37:02.565] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:02.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:73:0) after 1m0s
[22:38:02.671] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:73:0)
[22:38:02.671] Timer tick, asking Buildbucket for the build status
[22:38:02.744] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:02.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:74:0) after 1m0s
[22:39:02.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:74:0)
[22:39:02.792] Timer tick, asking Buildbucket for the build status
[22:39:02.919] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:02.919] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:75:0) after 1m0s
[22:40:03.132] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:75:0)
[22:40:03.132] Timer tick, asking Buildbucket for the build status
[22:40:03.286] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:03.286] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:76:0) after 1m0s
[22:41:03.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:76:0)
[22:41:03.495] Timer tick, asking Buildbucket for the build status
[22:41:03.634] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:03.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:77:0) after 1m0s
[22:42:03.774] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:77:0)
[22:42:03.774] Timer tick, asking Buildbucket for the build status
[22:42:03.844] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:03.844] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:78:0) after 1m0s
[22:43:03.946] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:78:0)
[22:43:03.946] Timer tick, asking Buildbucket for the build status
[22:43:04.419] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:04.419] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:79:0) after 1m0s
[22:44:04.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:79:0)
[22:44:04.638] Timer tick, asking Buildbucket for the build status
[22:44:16.040] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:16.040] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:80:0) after 1m0s
[22:45:16.143] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:80:0)
[22:45:16.143] Timer tick, asking Buildbucket for the build status
[22:45:16.239] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:16.239] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:81:0) after 1m0s
[22:46:16.286] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:81:0)
[22:46:16.286] Timer tick, asking Buildbucket for the build status
[22:46:16.354] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:16.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:82:0) after 1m0s
[22:47:16.383] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:82:0)
[22:47:16.383] Timer tick, asking Buildbucket for the build status
[22:47:16.518] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:16.518] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:83:0) after 1m0s
[22:48:16.602] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:83:0)
[22:48:16.602] Timer tick, asking Buildbucket for the build status
[22:48:16.670] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:16.670] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:84:0) after 1m0s
[22:49:16.712] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:84:0)
[22:49:16.712] Timer tick, asking Buildbucket for the build status
[22:49:18.198] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:18.198] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:85:0) after 1m0s
[22:50:18.266] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:85:0)
[22:50:18.266] Timer tick, asking Buildbucket for the build status
[22:50:18.373] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:18.373] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:86:0) after 1m0s
[22:51:18.419] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:86:0)
[22:51:18.419] Timer tick, asking Buildbucket for the build status
[22:51:18.547] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:18.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:87:0) after 1m0s
[22:52:18.602] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:87:0)
[22:52:18.602] Timer tick, asking Buildbucket for the build status
[22:52:18.951] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:18.951] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:88:0) after 1m0s
[22:53:18.944] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:88:0)
[22:53:18.944] Timer tick, asking Buildbucket for the build status
[22:53:19.037] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:19.037] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:89:0) after 1m0s
[22:54:19.042] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:89:0)
[22:54:19.042] Timer tick, asking Buildbucket for the build status
[22:54:19.144] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:19.144] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:90:0) after 1m0s
[22:55:19.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:90:0)
[22:55:19.205] Timer tick, asking Buildbucket for the build status
[22:55:19.296] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:19.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:91:0) after 1m0s
[22:56:19.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:91:0)
[22:56:19.363] Timer tick, asking Buildbucket for the build status
[22:56:20.003] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:20.003] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:92:0) after 1m0s
[22:57:20.077] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:92:0)
[22:57:20.077] Timer tick, asking Buildbucket for the build status
[22:57:20.249] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:20.249] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:93:0) after 1m0s
[22:58:20.259] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:93:0)
[22:58:20.259] Timer tick, asking Buildbucket for the build status
[22:58:20.336] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:20.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:94:0) after 1m0s
[22:59:20.345] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:94:0)
[22:59:20.345] Timer tick, asking Buildbucket for the build status
[22:59:20.429] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:20.430] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:95:0) after 1m0s
[23:00:20.485] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:95:0)
[23:00:20.485] Timer tick, asking Buildbucket for the build status
[23:00:20.788] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:20.788] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:96:0) after 1m0s
[23:01:20.834] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:96:0)
[23:01:20.834] Timer tick, asking Buildbucket for the build status
[23:01:21.100] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:21.100] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:97:0) after 1m0s
[23:02:21.079] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:97:0)
[23:02:21.079] Timer tick, asking Buildbucket for the build status
[23:02:21.272] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:21.273] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:98:0) after 1m0s
[23:03:21.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:98:0)
[23:03:21.296] Timer tick, asking Buildbucket for the build status
[23:03:21.411] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:21.411] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:99:0) after 1m0s
[23:04:21.457] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:99:0)
[23:04:21.457] Timer tick, asking Buildbucket for the build status
[23:04:21.542] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:21.542] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:100:0) after 1m0s
[23:05:21.625] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:100:0)
[23:05:21.625] Timer tick, asking Buildbucket for the build status
[23:05:21.779] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:21.779] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:101:0) after 1m0s
[23:06:21.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:101:0)
[23:06:21.853] Timer tick, asking Buildbucket for the build status
[23:06:21.936] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:21.936] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:102:0) after 1m0s
[23:07:21.930] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:102:0)
[23:07:21.930] Timer tick, asking Buildbucket for the build status
[23:07:22.194] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:22.194] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:103:0) after 1m0s
[23:08:22.225] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:103:0)
[23:08:22.225] Timer tick, asking Buildbucket for the build status
[23:08:22.342] Build 8853293077481339104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:22.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018723139543763936:104:0) after 1m0s
[23:08:30.469] Received PubSub notification, asking Buildbucket for the build status
[23:08:30.655] Build 8853293077481339104: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:08:30.655] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615244909836454",
"created_by": "project:chromium",
"created_ts": "1615238798596381",
"id": "8853293077481339104",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7d997588a9d9705dd1fde826e89bc45e7bba50b2\"}}",
"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\": \"7d997588a9d9705dd1fde826e89bc45e7bba50b2\", \"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-36-qcsb\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 46000, \"got_angle_revision\": \"9bc86c50f283560a3294c256bacccc1accb5bc94\", \"got_dawn_revision\": \"010fd1a8d7c7dd4e8fabe73546be78c45b6419c2\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"7d997588a9d9705dd1fde826e89bc45e7bba50b2\", \"got_revision_cp\": \"refs/heads/master@{#860865}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"de7d5775ab25234a2c14d061e0cda342248a0e6d\", \"got_v8_revision\": \"ad7609182d57f01afd2e2769869b7c3e23282119\", \"got_v8_revision_cp\": \"refs/heads/9.1.65@{#1}\", \"got_webrtc_revision\": \"3208bf102b75e8ec1eaa6640dfa3b545310b1e02\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33382}\", \"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\": \"7d997588a9d9705dd1fde826e89bc45e7bba50b2\", \"swarm_hashes_refs/heads/master(at){#860865}_without_patch\": {\"absl_hardening_tests\": \"42033aee87f14f7caae70e62ce07b154032900b0\", \"accessibility_unittests\": \"40a9782b0364c58a26be93c1ed346a299d020cdb\", \"angle_unittests\": \"ae8a186f45d0e569998715fdeb3323f25ec421e1\", \"app_list_unittests\": \"e92e24d6a6100c12593840a10cb6e87e8bfc610b\", \"app_shell_unittests\": \"6c944dd9f5b97dfc1ac51538ee1a7ef54f8207e8\", \"ash_unittests\": \"caaf6bffdf0f14908fdf9db323f004b46be1705e\", \"aura_unittests\": \"50eddc1b3de9fe16d6a4a52aa79ede6561d63e1f\", \"base_unittests\": \"85a562ea4f0c4d1cbc9e436b34495911af5fcd48\", \"base_util_unittests\": \"f038265b759aa2a44fb55f4b054878943e935c27\", \"blink_common_unittests\": \"7517e3a934172db2d87ccd13b5f78002bd7dbc60\", \"blink_fuzzer_unittests\": \"be5e4e2b251b8ab7c53138127eeb50e753c5aa12\", \"blink_heap_unittests\": \"489332c0760403aa33aefcde498c150edcaf9ba9\", \"blink_platform_unittests\": \"4890b8f366e06b9385b86de5a3e1b319210973a6\", \"blink_unittests\": \"1e9d8e32e300997b8763c07189d2de23eae5e744\", \"boringssl_crypto_tests\": \"04d26bf044b9c9cba6645718c183748dc8917c6a\", \"boringssl_ssl_tests\": \"883a3697a0e11e7f91411a460bed70f7730065e2\", \"browser_tests\": \"32249fe0a75bb15543fbb07cb0d4485eb0a9c837\", \"capture_unittests\": \"e763144cd7ba7d5d595de7a3d5f0d6ea2533a2f9\", \"cast_unittests\": \"bdc7e233a01786c783292936a31d5d69133369bd\", \"cc_unittests\": \"f28f8c4a4bebb4caac772fce87fd61a5b50985ff\", \"chrome_app_unittests\": \"da95732b0135384b1fca6d78fbbee0b5bd82b149\", \"chromedriver_unittests\": \"15bf1e551b28070a8ca70f2b76bda20b7c4e2602\", \"chromeos_components_unittests\": \"05ae2df0726757127412b52a0de9f6c2a08627fd\", \"chromeos_unittests\": \"6b494344a3154f454777e31787301117f77b3d2f\", \"color_unittests\": \"e151b1d9223f974ba94e4d269c9f3d1d45647c7f\", \"components_browsertests\": \"b0df45a0393dafa09b660717e31fa5a675e0c1dd\", \"components_unittests\": \"ce3443afe585429037aa2b423577efa7947a22e9\", \"compositor_unittests\": \"f091f3cd5962494a2f3d8cb6dc5f321fb5c1aa15\", \"content_browsertests\": \"9c6d2b185d553f151e2ac846863b443d26125bc7\", \"content_unittests\": \"8af7bc439a1aa2a7cd8e7b826bd1b2717e142291\", \"crashpad_tests\": \"bed9a7f8091a7b7043cf2486d8ba7a1f30211a81\", \"crypto_unittests\": \"39f801dfad3f82028b384212eed182d094b979bb\", \"dbus_unittests\": \"557c61afa249290d1caa8d183c2190badb06714f\", \"device_unittests\": \"dbf8c8dcfc4768e78ea39213bced499d469752b5\", \"display_unittests\": \"648083081ffd9334ba61510375cf77fbc6b75975\", \"events_unittests\": \"ebd065fb9a8f4ba7b79a9ced111fe8c29d425f36\", \"exo_unittests\": \"4b244837ab0a352450dbc00ae0cc58c02edc31ce\", \"extensions_browsertests\": \"e744d7c84c5db9361eb173e1077a7b51bacb92d2\", \"extensions_unittests\": \"ecebf0587b0e6c0a3256cf870b65e36b77dc179b\", \"filesystem_service_unittests\": \"04aa712b4f93a427b7f3187aed405690545ca3d2\", \"gcm_unit_tests\": \"667c7a8ea36ebf5880918f9cce0125eb68c5753f\", \"gfx_unittests\": \"73e3ccd1f6b2724d6c0d58864994c7e407d65c2c\", \"gin_unittests\": \"329dec55a833377164ee5c63d70c22b0d8ccca8b\", \"gl_unittests_ozone\": \"c8118cf7b91393fc28f639c242895801ef823efc\", \"google_apis_unittests\": \"a52de821d54af5ae8b1ded557de18f4d8084005c\", \"gpu_unittests\": \"a9bc6114b93759dbd0453f8a3ca2be1c33389d5e\", \"gwp_asan_unittests\": \"1232c099c48f9b072d6f9459c4325b964cb9dd36\", \"interactive_ui_tests\": \"6e231fcfbad4f4149157de864099eac272935a08\", \"ipc_tests\": \"526671e855b620836875a6d9fe77f6231ff77563\", \"jingle_unittests\": \"96a19f1b6bf16e5d27aa1176a604ea446a15ca3d\", \"keyboard_unittests\": \"30ff601559951c1349ddb373db792f6521d83b0c\", \"latency_unittests\": \"97303aca7795243c296cda14100115e9b81197df\", \"libjingle_xmpp_unittests\": \"058025b421a779e83a418359c5e4222ed321e233\", \"liburlpattern_unittests\": \"feb9f41ec9af2f92127c0d8cb7dea692021e1e48\", \"media_blink_unittests\": \"b7d082f8140815d149552f356f4ac30f70607a15\", \"media_unittests\": \"c41f4b15f0752407d511cd9daf9d59e6a5cca6d0\", \"message_center_unittests\": \"16e2d75a07576dde57039f8566fe0e21374e02b1\", \"midi_unittests\": \"63d809856d9f4f0c9914050daa2cc001f6293a9f\", \"mojo_core_unittests\": \"469ee37ca12e97e3ff0055491a34a84f9743409b\", \"mojo_unittests\": \"fe3f415b3ff6db3772dfc37970f01143bfda2ac3\", \"nacl_helper_nonsfi_unittests\": \"be286d5c9bf95fd06396cd13dfb57a993fbacb37\", \"nacl_loader_unittests\": \"9bd481a26b9b0a8a7ab8ffe8e21058a08d07ebb9\", \"native_theme_unittests\": \"27f638fd2776d0da920cd42f3b5b7e76b0f83f6f\", \"net_unittests\": \"f3f67d18f5dad696f8631de2bc2d52d158bd0677\", \"ozone_gl_unittests\": \"f55b8d880ced96b74c400ccd1cfb0d51943219d3\", \"ozone_unittests\": \"33beb917249ca7359ef7f0252fbbb9798fe3c919\", \"ozone_x11_unittests\": \"5a7325a20ecb4aa72abad431e9200c1b949ba56b\", \"pdf_unittests\": \"16e2e6c274650f61eec59c249a1a5953d98cb2fb\", \"perfetto_unittests\": \"da691ad0c558d7d71f84a9c733901e170837fbb0\", \"ppapi_unittests\": \"73f15dbb7cf2f729cc730f0242b26d9717dc2b62\", \"printing_unittests\": \"e2adefd03d18d03e5fceb58678c11c5bd9f97eb2\", \"remoting_unittests\": \"ff07368b25d1e40fab11d0c6eb750950c791fb0d\", \"sandbox_linux_unittests\": \"023c06d1e658192614e99797d9d20a0a9aeeeeff\", \"service_manager_unittests\": \"9806ef5eb43005ea68b20eea2e1b771644582fd8\", \"services_unittests\": \"0105e8ebc1486a091d8917a6d9ae364bb3c71f62\", \"shell_dialogs_unittests\": \"164fa052739b855fd47d79daf7033aca2a5a700b\", \"shell_encryption_unittests\": \"8a970c6110ce7d4908b468486e311d726372cd66\", \"skia_unittests\": \"6e08e729f62201fdca1033595fff02b32c49cdfe\", \"snapshot_unittests\": \"bf8d03c6f335a2197b7c7b5976e7be27a5fa2041\", \"sql_unittests\": \"147f27658d54072471e57c99ccb2163e5cda7cfd\", \"storage_unittests\": \"08db7f1297a2471f891a7b623d590ffc2b3f82c9\", \"sync_integration_tests\": \"f8744befaa996d8bf542f2c00136be6163e42d42\", \"traffic_annotation_auditor_unittests\": \"5576be0a170faf8f1a5087779ee63506b7607790\", \"ui_base_unittests\": \"763ac99b41cb2151cc555b4ae75e41886e0deb79\", \"ui_chromeos_unittests\": \"1ec4fa9b456bc2b7f01b9f983fb27071f02e0bc1\", \"ui_touch_selection_unittests\": \"9c477d4f04218899e0d436c9afb1a291b78232f4\", \"unit_tests\": \"d08ba294a52d4b1b30512ee18a1b3588ab6650ed\", \"url_unittests\": \"d40284dcc4f48ffc011e2c73a1048075c611c1b3\", \"usage_time_limit_unittests\": \"bbd91edb9627fdab16fed3397fb62d64ee0baa63\", \"views_unittests\": \"2070cf48200675cf62cf9cdd987a52608bb58e9f\", \"viz_unittests\": \"9bf8de1141bec911c7324bc67aed87553aed6d97\", \"wayland_client_perftests\": \"ceb6e3f7e324d7bc9f7a13cfd51fa504b29b6b3c\", \"wayland_client_tests\": \"78f269668b157876475a534addc3bfe77cba965b\", \"wm_unittests\": \"591665da23b464daf09dd147ed6461f4bb245a4e\", \"wtf_unittests\": \"61200b2a99e390bd062a3c8e2f57b709e34a94f9\", \"zlib_unittests\": \"41f1d8fdbf0390c74e6d2133d19a39292f2a1c8f\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_043ff3f52d8d01364b204065bddda74d1a1fba0b8da9301cf8e96315f69303d6_v2\", \"builder_8da721b663411a8949c2bab4d98f074519f5dacc98d2381d19d66b38dd85adce_v2\", \"builder_dcef017f754690f3e0b2809d85023c2a50e42950d4504e0de4071c06ccf1a2cc_v2\", \"builder_f5b4454e99a04aaa5ba743b59cc70de19e20bebedef65e50e3b90534a8d6a5e4_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-36-qcsb\"], \"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.7.12\"], \"server_version\": [\"5744-5c0a4b4\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615239144665006",
"status": "COMPLETED",
"status_changed_ts": "1615244910064536",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/46000",
"builder:linux-chromeos-rel",
"buildset:commit/git/7d997588a9d9705dd1fde826e89bc45e7bba50b2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7d997588a9d9705dd1fde826e89bc45e7bba50b2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018723139543763936",
"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/8853293077481339104/+/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:522c8da8a1d5e110",
"user_agent:luci-scheduler"
],
"updated_ts": "1615244910069660",
"url": "https://ci.chromium.org/b/8853293077481339104",
"utcnow_ts": "1615244910635179"
}
}
[23:08:30.655] Invocation finished in 1h41m53.408340175s with status SUCCEEDED