[15:30:38.437] New invocation is queued and will start shortly
[15:30:39.528] Starting the invocation (attempt 1)
[15:30:39.573] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:30:39.573] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:30:39.573] Buildbucket request:
{
"bucket": "luci.dart.ci.sandbox",
"client_operation_id": "9037408510976649024",
"parameters_json": "{\"builder_name\":\"gclient\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://dart.googlesource.com/sdk\",\"revision\":\"d26790618463a08bff87b0dab0e84d805fd4fe83\"},\"id\":\"https://dart.googlesource.com/sdk/+/refs/heads/master@d26790618463a08bff87b0dab0e84d805fd4fe83\",\"title\":\"d26790618463a08bff87b0dab0e84d805fd4fe83\",\"url\":\"https://dart.googlesource.com/sdk/+/d26790618463a08bff87b0dab0e84d805fd4fe83\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://dart.googlesource.com/sdk\",\"revision\":\"d26790618463a08bff87b0dab0e84d805fd4fe83\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:gclient",
"scheduler_invocation_id:9037408510976649024",
"scheduler_job_id:dart/gclient",
"user_agent:luci-scheduler",
"buildset:commit/git/d26790618463a08bff87b0dab0e84d805fd4fe83",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/d26790618463a08bff87b0dab0e84d805fd4fe83",
"gitiles_ref:refs/heads/master"
]
}
[15:30:41.424] Buildbucket response:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"created_by": "project:dart",
"created_ts": "1597419039697375",
"id": "8871978448989039920",
"parameters_json": "{\"builder_name\": \"gclient\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://dart.googlesource.com/sdk\", \"revision\": \"d26790618463a08bff87b0dab0e84d805fd4fe83\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@d26790618463a08bff87b0dab0e84d805fd4fe83\", \"title\": \"d26790618463a08bff87b0dab0e84d805fd4fe83\", \"url\": \"https://dart.googlesource.com/sdk/+/d26790618463a08bff87b0dab0e84d805fd4fe83\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk\", \"revision\": \"d26790618463a08bff87b0dab0e84d805fd4fe83\"}}",
"project": "dart",
"result_details_json": "{\"properties\": {}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1597419041117772",
"tags": [
"build_address:luci.dart.ci.sandbox/gclient/9521",
"builder:gclient",
"buildset:commit/git/d26790618463a08bff87b0dab0e84d805fd4fe83",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/d26790618463a08bff87b0dab0e84d805fd4fe83",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9037408510976649024",
"scheduler_job_id:dart/gclient",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/dart/buildbucket/cr-buildbucket.appspot.com/8871978448989039920/+/annotations",
"swarming_tag:luci_project:dart",
"swarming_tag:recipe_name:dart/gclient",
"swarming_tag:recipe_package:dart/recipe_bundles/dart.googlesource.com/recipes",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1597419041118055",
"url": "https://ci.chromium.org/b/8871978448989039920",
"utcnow_ts": "1597419041409170"
}
}
[15:30:41.425] Task URL: https://ci.chromium.org/b/8871978448989039920
[15:30:41.425] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:2:0) after 1m0s
[15:31:41.565] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:2:0)
[15:31:41.565] Timer tick, asking Buildbucket for the build status
[15:31:41.808] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:31:41.808] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:3:0) after 1m0s
[15:32:41.855] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:3:0)
[15:32:41.855] Timer tick, asking Buildbucket for the build status
[15:32:41.967] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:32:41.967] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:4:0) after 1m0s
[15:33:42.221] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:4:0)
[15:33:42.221] Timer tick, asking Buildbucket for the build status
[15:33:42.311] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:33:42.311] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:5:0) after 1m0s
[15:34:42.535] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:5:0)
[15:34:42.535] Timer tick, asking Buildbucket for the build status
[15:34:42.652] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:34:42.652] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:6:0) after 1m0s
[15:35:42.844] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:6:0)
[15:35:42.844] Timer tick, asking Buildbucket for the build status
[15:35:43.125] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:35:43.125] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:7:0) after 1m0s
[15:36:43.263] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:7:0)
[15:36:43.263] Timer tick, asking Buildbucket for the build status
[15:36:43.810] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:36:43.810] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:8:0) after 1m0s
[15:37:43.896] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:8:0)
[15:37:43.896] Timer tick, asking Buildbucket for the build status
[15:37:44.134] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:37:44.134] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:9:0) after 1m0s
[15:38:44.213] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:9:0)
[15:38:44.213] Timer tick, asking Buildbucket for the build status
[15:38:47.062] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:38:47.062] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:10:0) after 1m0s
[15:39:47.344] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:10:0)
[15:39:47.344] Timer tick, asking Buildbucket for the build status
[15:39:47.811] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:39:47.811] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:11:0) after 1m0s
[15:40:47.945] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:11:0)
[15:40:47.945] Timer tick, asking Buildbucket for the build status
[15:40:48.245] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:40:48.245] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:12:0) after 1m0s
[15:41:48.242] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:12:0)
[15:41:48.242] Timer tick, asking Buildbucket for the build status
[15:41:48.399] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:41:48.399] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:13:0) after 1m0s
[15:42:48.500] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:13:0)
[15:42:48.500] Timer tick, asking Buildbucket for the build status
[15:42:48.597] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:42:48.597] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:14:0) after 1m0s
[15:43:48.632] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:14:0)
[15:43:48.632] Timer tick, asking Buildbucket for the build status
[15:43:48.714] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:43:48.714] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:15:0) after 1m0s
[15:44:48.850] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:15:0)
[15:44:48.850] Timer tick, asking Buildbucket for the build status
[15:44:48.968] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:44:48.968] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:16:0) after 1m0s
[15:45:49.057] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:16:0)
[15:45:49.057] Timer tick, asking Buildbucket for the build status
[15:45:51.334] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:45:51.334] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:17:0) after 1m0s
[15:46:51.354] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:17:0)
[15:46:51.354] Timer tick, asking Buildbucket for the build status
[15:46:51.526] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:46:51.527] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:18:0) after 1m0s
[15:47:51.546] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:18:0)
[15:47:51.546] Timer tick, asking Buildbucket for the build status
[15:47:51.936] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:47:51.936] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:19:0) after 1m0s
[15:48:51.958] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:19:0)
[15:48:51.958] Timer tick, asking Buildbucket for the build status
[15:48:52.062] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:48:52.062] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:20:0) after 1m0s
[15:49:52.075] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:20:0)
[15:49:52.075] Timer tick, asking Buildbucket for the build status
[15:49:52.193] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:49:52.193] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:21:0) after 1m0s
[15:50:52.253] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:21:0)
[15:50:52.253] Timer tick, asking Buildbucket for the build status
[15:50:52.392] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:50:52.392] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:22:0) after 1m0s
[15:51:52.371] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:22:0)
[15:51:52.371] Timer tick, asking Buildbucket for the build status
[15:51:52.521] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:51:52.521] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:23:0) after 1m0s
[15:52:52.544] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:23:0)
[15:52:52.544] Timer tick, asking Buildbucket for the build status
[15:52:52.631] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:52:52.631] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:24:0) after 1m0s
[15:53:52.655] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:24:0)
[15:53:52.655] Timer tick, asking Buildbucket for the build status
[15:53:52.880] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:53:52.880] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:25:0) after 1m0s
[15:54:52.912] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:25:0)
[15:54:52.912] Timer tick, asking Buildbucket for the build status
[15:54:53.065] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:54:53.065] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:26:0) after 1m0s
[15:55:53.103] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:26:0)
[15:55:53.103] Timer tick, asking Buildbucket for the build status
[15:55:53.225] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:55:53.225] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:27:0) after 1m0s
[15:56:53.234] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:27:0)
[15:56:53.234] Timer tick, asking Buildbucket for the build status
[15:56:53.347] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:56:53.347] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:28:0) after 1m0s
[15:57:53.383] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:28:0)
[15:57:53.383] Timer tick, asking Buildbucket for the build status
[15:57:53.574] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:57:53.574] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:29:0) after 1m0s
[15:58:53.695] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:29:0)
[15:58:53.695] Timer tick, asking Buildbucket for the build status
[15:58:53.906] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:58:53.906] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:30:0) after 1m0s
[15:59:53.929] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:30:0)
[15:59:53.929] Timer tick, asking Buildbucket for the build status
[15:59:54.042] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:59:54.042] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:31:0) after 1m0s
[16:00:54.134] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:31:0)
[16:00:54.134] Timer tick, asking Buildbucket for the build status
[16:00:54.525] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:00:54.525] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:32:0) after 1m0s
[16:01:54.606] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:32:0)
[16:01:54.606] Timer tick, asking Buildbucket for the build status
[16:01:54.726] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:01:54.726] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:33:0) after 1m0s
[16:02:54.814] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:33:0)
[16:02:54.814] Timer tick, asking Buildbucket for the build status
[16:02:54.893] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:02:54.893] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:34:0) after 1m0s
[16:03:54.970] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:34:0)
[16:03:54.970] Timer tick, asking Buildbucket for the build status
[16:03:55.088] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:03:55.088] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:35:0) after 1m0s
[16:04:55.119] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:35:0)
[16:04:55.119] Timer tick, asking Buildbucket for the build status
[16:04:55.337] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:04:55.337] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:36:0) after 1m0s
[16:05:55.399] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:36:0)
[16:05:55.399] Timer tick, asking Buildbucket for the build status
[16:05:55.504] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:05:55.504] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:37:0) after 1m0s
[16:06:55.499] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:37:0)
[16:06:55.499] Timer tick, asking Buildbucket for the build status
[16:06:55.592] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:06:55.592] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:38:0) after 1m0s
[16:07:55.638] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:38:0)
[16:07:55.638] Timer tick, asking Buildbucket for the build status
[16:07:55.842] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:07:55.842] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:39:0) after 1m0s
[16:08:55.904] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:39:0)
[16:08:55.904] Timer tick, asking Buildbucket for the build status
[16:08:56.001] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:08:56.002] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:40:0) after 1m0s
[16:09:56.430] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:40:0)
[16:09:56.430] Timer tick, asking Buildbucket for the build status
[16:09:56.819] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:09:56.819] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:41:0) after 1m0s
[16:10:56.872] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:41:0)
[16:10:56.872] Timer tick, asking Buildbucket for the build status
[16:10:57.009] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:10:57.009] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:42:0) after 1m0s
[16:11:57.659] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:42:0)
[16:11:57.659] Timer tick, asking Buildbucket for the build status
[16:11:57.784] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:11:57.784] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:43:0) after 1m0s
[16:12:58.091] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:43:0)
[16:12:58.091] Timer tick, asking Buildbucket for the build status
[16:12:58.243] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:12:58.243] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:44:0) after 1m0s
[16:13:58.858] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:44:0)
[16:13:58.858] Timer tick, asking Buildbucket for the build status
[16:13:59.042] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:13:59.042] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:45:0) after 1m0s
[16:14:59.246] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:45:0)
[16:14:59.246] Timer tick, asking Buildbucket for the build status
[16:14:59.468] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:14:59.468] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:46:0) after 1m0s
[16:15:59.528] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:46:0)
[16:15:59.528] Timer tick, asking Buildbucket for the build status
[16:16:00.234] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:16:00.234] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:47:0) after 1m0s
[16:17:00.867] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:47:0)
[16:17:00.867] Timer tick, asking Buildbucket for the build status
[16:17:03.555] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:17:03.555] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:48:0) after 1m0s
[16:18:03.618] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:48:0)
[16:18:03.618] Timer tick, asking Buildbucket for the build status
[16:18:03.786] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:18:03.786] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:49:0) after 1m0s
[16:19:03.832] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:49:0)
[16:19:03.832] Timer tick, asking Buildbucket for the build status
[16:19:04.089] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:19:04.089] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:50:0) after 1m0s
[16:20:04.117] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:50:0)
[16:20:04.117] Timer tick, asking Buildbucket for the build status
[16:20:04.235] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:20:04.235] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:51:0) after 1m0s
[16:21:04.315] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:51:0)
[16:21:04.315] Timer tick, asking Buildbucket for the build status
[16:21:04.508] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:21:04.508] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:52:0) after 1m0s
[16:22:04.665] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:52:0)
[16:22:04.665] Timer tick, asking Buildbucket for the build status
[16:22:04.890] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:22:04.890] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:53:0) after 1m0s
[16:23:05.118] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:53:0)
[16:23:05.118] Timer tick, asking Buildbucket for the build status
[16:23:05.225] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:23:05.225] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:54:0) after 1m0s
[16:24:05.279] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:54:0)
[16:24:05.279] Timer tick, asking Buildbucket for the build status
[16:24:05.469] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:24:05.469] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:55:0) after 1m0s
[16:25:05.566] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:55:0)
[16:25:05.566] Timer tick, asking Buildbucket for the build status
[16:25:05.666] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:25:05.666] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:56:0) after 1m0s
[16:26:05.717] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:56:0)
[16:26:05.717] Timer tick, asking Buildbucket for the build status
[16:26:05.921] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:26:05.921] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:57:0) after 1m0s
[16:27:06.048] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:57:0)
[16:27:06.048] Timer tick, asking Buildbucket for the build status
[16:27:06.154] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:27:06.154] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:58:0) after 1m0s
[16:28:06.215] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:58:0)
[16:28:06.215] Timer tick, asking Buildbucket for the build status
[16:28:06.328] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:28:06.328] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:59:0) after 1m0s
[16:29:06.405] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:59:0)
[16:29:06.405] Timer tick, asking Buildbucket for the build status
[16:29:06.548] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:29:06.548] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:60:0) after 1m0s
[16:30:06.671] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:60:0)
[16:30:06.671] Timer tick, asking Buildbucket for the build status
[16:30:07.007] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:30:07.007] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:61:0) after 1m0s
[16:31:07.176] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:61:0)
[16:31:07.176] Timer tick, asking Buildbucket for the build status
[16:31:07.383] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:31:07.383] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:62:0) after 1m0s
[16:32:07.489] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:62:0)
[16:32:07.489] Timer tick, asking Buildbucket for the build status
[16:32:07.632] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:32:07.632] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:63:0) after 1m0s
[16:33:07.699] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:63:0)
[16:33:07.699] Timer tick, asking Buildbucket for the build status
[16:33:07.844] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:33:07.844] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:64:0) after 1m0s
[16:34:07.867] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:64:0)
[16:34:07.867] Timer tick, asking Buildbucket for the build status
[16:34:08.002] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:34:08.002] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:65:0) after 1m0s
[16:35:07.984] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:65:0)
[16:35:07.984] Timer tick, asking Buildbucket for the build status
[16:35:08.171] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:35:08.171] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:66:0) after 1m0s
[16:36:08.194] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:66:0)
[16:36:08.194] Timer tick, asking Buildbucket for the build status
[16:36:08.363] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:36:08.363] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:67:0) after 1m0s
[16:37:08.419] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:67:0)
[16:37:08.419] Timer tick, asking Buildbucket for the build status
[16:37:08.818] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:37:08.818] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:68:0) after 1m0s
[16:38:08.832] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:68:0)
[16:38:08.832] Timer tick, asking Buildbucket for the build status
[16:38:08.936] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:38:08.936] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:69:0) after 1m0s
[16:39:09.059] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:69:0)
[16:39:09.059] Timer tick, asking Buildbucket for the build status
[16:39:09.344] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:39:09.344] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:70:0) after 1m0s
[16:40:09.331] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:70:0)
[16:40:09.331] Timer tick, asking Buildbucket for the build status
[16:40:09.633] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:40:09.633] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:71:0) after 1m0s
[16:41:09.670] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:71:0)
[16:41:09.670] Timer tick, asking Buildbucket for the build status
[16:41:09.861] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:41:09.861] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:72:0) after 1m0s
[16:42:09.872] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:72:0)
[16:42:09.872] Timer tick, asking Buildbucket for the build status
[16:42:10.049] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:42:10.051] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:73:0) after 1m0s
[16:43:10.195] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:73:0)
[16:43:10.195] Timer tick, asking Buildbucket for the build status
[16:43:10.274] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:43:10.274] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:74:0) after 1m0s
[16:44:10.350] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:74:0)
[16:44:10.350] Timer tick, asking Buildbucket for the build status
[16:44:10.485] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:44:10.485] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:75:0) after 1m0s
[16:45:10.564] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:75:0)
[16:45:10.564] Timer tick, asking Buildbucket for the build status
[16:45:10.665] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:45:10.665] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:76:0) after 1m0s
[16:46:10.825] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:76:0)
[16:46:10.825] Timer tick, asking Buildbucket for the build status
[16:46:10.953] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:46:10.953] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:77:0) after 1m0s
[16:47:11.096] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:77:0)
[16:47:11.096] Timer tick, asking Buildbucket for the build status
[16:47:11.433] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:47:11.433] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:78:0) after 1m0s
[16:48:11.488] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:78:0)
[16:48:11.488] Timer tick, asking Buildbucket for the build status
[16:48:11.607] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:48:11.607] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:79:0) after 1m0s
[16:49:11.634] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:79:0)
[16:49:11.634] Timer tick, asking Buildbucket for the build status
[16:49:11.806] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:49:11.806] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:80:0) after 1m0s
[16:50:11.836] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:80:0)
[16:50:11.836] Timer tick, asking Buildbucket for the build status
[16:50:11.962] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:50:11.962] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:81:0) after 1m0s
[16:51:12.007] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:81:0)
[16:51:12.007] Timer tick, asking Buildbucket for the build status
[16:51:12.626] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:51:12.626] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:82:0) after 1m0s
[16:52:12.626] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:82:0)
[16:52:12.626] Timer tick, asking Buildbucket for the build status
[16:52:12.889] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:52:12.889] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:83:0) after 1m0s
[16:53:13.042] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:83:0)
[16:53:13.042] Timer tick, asking Buildbucket for the build status
[16:53:13.167] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:53:13.167] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:84:0) after 1m0s
[16:54:13.157] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:84:0)
[16:54:13.157] Timer tick, asking Buildbucket for the build status
[16:54:13.768] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:54:13.768] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:85:0) after 1m0s
[16:55:13.860] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:85:0)
[16:55:13.860] Timer tick, asking Buildbucket for the build status
[16:55:13.984] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:55:13.985] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:86:0) after 1m0s
[16:56:14.019] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:86:0)
[16:56:14.019] Timer tick, asking Buildbucket for the build status
[16:56:14.122] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:56:14.122] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:87:0) after 1m0s
[16:57:14.277] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:87:0)
[16:57:14.277] Timer tick, asking Buildbucket for the build status
[16:57:14.522] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:57:14.522] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:88:0) after 1m0s
[16:58:14.650] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:88:0)
[16:58:14.650] Timer tick, asking Buildbucket for the build status
[16:58:15.546] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:58:15.546] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:89:0) after 1m0s
[16:59:15.549] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:89:0)
[16:59:15.549] Timer tick, asking Buildbucket for the build status
[16:59:15.668] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:59:15.668] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:90:0) after 1m0s
[17:00:15.717] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:90:0)
[17:00:15.717] Timer tick, asking Buildbucket for the build status
[17:00:15.819] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:00:15.819] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:91:0) after 1m0s
[17:01:15.879] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:91:0)
[17:01:15.879] Timer tick, asking Buildbucket for the build status
[17:01:16.251] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:01:16.251] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:92:0) after 1m0s
[17:02:16.303] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:92:0)
[17:02:16.303] Timer tick, asking Buildbucket for the build status
[17:02:16.466] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:02:16.466] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:93:0) after 1m0s
[17:03:16.549] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:93:0)
[17:03:16.549] Timer tick, asking Buildbucket for the build status
[17:03:16.660] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:03:16.660] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:94:0) after 1m0s
[17:04:16.685] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:94:0)
[17:04:16.685] Timer tick, asking Buildbucket for the build status
[17:04:16.808] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:04:16.808] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:95:0) after 1m0s
[17:05:16.810] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:95:0)
[17:05:16.810] Timer tick, asking Buildbucket for the build status
[17:05:16.904] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:05:16.904] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:96:0) after 1m0s
[17:06:16.929] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:96:0)
[17:06:16.929] Timer tick, asking Buildbucket for the build status
[17:06:17.238] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:06:17.238] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:97:0) after 1m0s
[17:07:17.536] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:97:0)
[17:07:17.536] Timer tick, asking Buildbucket for the build status
[17:07:17.671] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:07:17.671] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:98:0) after 1m0s
[17:08:17.997] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:98:0)
[17:08:17.997] Timer tick, asking Buildbucket for the build status
[17:08:18.111] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:08:18.112] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:99:0) after 1m0s
[17:09:18.187] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:99:0)
[17:09:18.187] Timer tick, asking Buildbucket for the build status
[17:09:18.498] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:09:18.498] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:100:0) after 1m0s
[17:10:18.609] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:100:0)
[17:10:18.609] Timer tick, asking Buildbucket for the build status
[17:10:18.785] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:10:18.785] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:101:0) after 1m0s
[17:11:18.806] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:101:0)
[17:11:18.806] Timer tick, asking Buildbucket for the build status
[17:11:19.426] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:11:19.426] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:102:0) after 1m0s
[17:12:19.502] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:102:0)
[17:12:19.502] Timer tick, asking Buildbucket for the build status
[17:12:19.639] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:12:19.639] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:103:0) after 1m0s
[17:13:19.857] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:103:0)
[17:13:19.857] Timer tick, asking Buildbucket for the build status
[17:13:20.138] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:13:20.138] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:104:0) after 1m0s
[17:14:20.358] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:104:0)
[17:14:20.358] Timer tick, asking Buildbucket for the build status
[17:14:20.435] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:14:20.435] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:105:0) after 1m0s
[17:15:20.564] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:105:0)
[17:15:20.564] Timer tick, asking Buildbucket for the build status
[17:15:20.740] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:15:20.740] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:106:0) after 1m0s
[17:16:20.771] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:106:0)
[17:16:20.771] Timer tick, asking Buildbucket for the build status
[17:16:21.267] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:16:21.267] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:107:0) after 1m0s
[17:17:21.464] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:107:0)
[17:17:21.464] Timer tick, asking Buildbucket for the build status
[17:17:21.574] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:17:21.574] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:108:0) after 1m0s
[17:18:21.718] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:108:0)
[17:18:21.718] Timer tick, asking Buildbucket for the build status
[17:18:21.837] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:18:21.837] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:109:0) after 1m0s
[17:19:21.924] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:109:0)
[17:19:21.924] Timer tick, asking Buildbucket for the build status
[17:19:22.232] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:19:22.232] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:110:0) after 1m0s
[17:20:22.329] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:110:0)
[17:20:22.329] Timer tick, asking Buildbucket for the build status
[17:20:22.402] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:20:22.402] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:111:0) after 1m0s
[17:21:22.463] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:111:0)
[17:21:22.463] Timer tick, asking Buildbucket for the build status
[17:21:23.138] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:21:23.138] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:112:0) after 1m0s
[17:22:23.208] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:112:0)
[17:22:23.209] Timer tick, asking Buildbucket for the build status
[17:22:23.366] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:22:23.366] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:113:0) after 1m0s
[17:23:23.396] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:113:0)
[17:23:23.396] Timer tick, asking Buildbucket for the build status
[17:23:23.791] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:23:23.791] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:114:0) after 1m0s
[17:24:24.011] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:114:0)
[17:24:24.011] Timer tick, asking Buildbucket for the build status
[17:24:24.190] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:24:24.190] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:115:0) after 1m0s
[17:25:24.217] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:115:0)
[17:25:24.217] Timer tick, asking Buildbucket for the build status
[17:25:24.328] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:25:24.328] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:116:0) after 1m0s
[17:26:24.440] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:116:0)
[17:26:24.440] Timer tick, asking Buildbucket for the build status
[17:26:24.634] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:26:24.634] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:117:0) after 1m0s
[17:27:24.729] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:117:0)
[17:27:24.729] Timer tick, asking Buildbucket for the build status
[17:27:24.869] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:27:24.869] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:118:0) after 1m0s
[17:28:24.937] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:118:0)
[17:28:24.937] Timer tick, asking Buildbucket for the build status
[17:28:25.129] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:28:25.129] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:119:0) after 1m0s
[17:29:25.125] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:119:0)
[17:29:25.125] Timer tick, asking Buildbucket for the build status
[17:29:25.241] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:29:25.241] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:120:0) after 1m0s
[17:30:25.323] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:120:0)
[17:30:25.323] Timer tick, asking Buildbucket for the build status
[17:30:25.470] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:30:25.470] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:121:0) after 1m0s
[17:31:25.533] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:121:0)
[17:31:25.533] Timer tick, asking Buildbucket for the build status
[17:31:25.674] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:31:25.674] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:122:0) after 1m0s
[17:32:25.695] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:122:0)
[17:32:25.695] Timer tick, asking Buildbucket for the build status
[17:32:25.777] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:32:25.777] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:123:0) after 1m0s
[17:33:25.814] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:123:0)
[17:33:25.814] Timer tick, asking Buildbucket for the build status
[17:33:25.917] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:33:25.917] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:124:0) after 1m0s
[17:34:25.961] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:124:0)
[17:34:25.961] Timer tick, asking Buildbucket for the build status
[17:34:26.109] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:34:26.109] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:125:0) after 1m0s
[17:35:26.216] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:125:0)
[17:35:26.216] Timer tick, asking Buildbucket for the build status
[17:35:26.555] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:35:26.561] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:126:0) after 1m0s
[17:36:26.574] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:126:0)
[17:36:26.574] Timer tick, asking Buildbucket for the build status
[17:36:27.288] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:36:27.288] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:127:0) after 1m0s
[17:37:27.284] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:127:0)
[17:37:27.284] Timer tick, asking Buildbucket for the build status
[17:37:27.734] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:37:27.734] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:128:0) after 1m0s
[17:38:27.818] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:128:0)
[17:38:27.818] Timer tick, asking Buildbucket for the build status
[17:38:27.948] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:38:27.948] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:129:0) after 1m0s
[17:39:27.961] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:129:0)
[17:39:27.961] Timer tick, asking Buildbucket for the build status
[17:39:30.117] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:39:30.117] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:130:0) after 1m0s
[17:40:30.250] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:130:0)
[17:40:30.250] Timer tick, asking Buildbucket for the build status
[17:40:30.392] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:40:30.392] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:131:0) after 1m0s
[17:41:30.554] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:131:0)
[17:41:30.554] Timer tick, asking Buildbucket for the build status
[17:41:30.712] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:41:30.712] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:132:0) after 1m0s
[17:42:30.782] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:132:0)
[17:42:30.782] Timer tick, asking Buildbucket for the build status
[17:42:30.868] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:42:30.868] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:133:0) after 1m0s
[17:43:30.893] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:133:0)
[17:43:30.893] Timer tick, asking Buildbucket for the build status
[17:43:30.978] Build 8871978448989039920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:43:30.978] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:134:0) after 1m0s
[17:43:43.455] Received PubSub notification, asking Buildbucket for the build status
[17:43:43.564] Build 8871978448989039920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:31.036] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:134:0)
[17:44:31.036] Timer tick, asking Buildbucket for the build status
[17:44:31.156] Build 8871978448989039920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:31.156] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:136:0) after 1m0s
[17:45:31.321] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:136:0)
[17:45:31.322] Timer tick, asking Buildbucket for the build status
[17:45:31.926] Build 8871978448989039920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:31.926] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:137:0) after 1m0s
[17:46:31.959] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:137:0)
[17:46:31.959] Timer tick, asking Buildbucket for the build status
[17:46:32.108] Build 8871978448989039920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:32.108] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:138:0) after 1m0s
[17:47:32.196] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:138:0)
[17:47:32.196] Timer tick, asking Buildbucket for the build status
[17:47:32.297] Build 8871978448989039920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:32.297] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:139:0) after 1m0s
[17:48:32.354] Handling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:139:0)
[17:48:32.354] Timer tick, asking Buildbucket for the build status
[17:48:32.445] Build 8871978448989039920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:32.445] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9037408510976649024:140:0) after 1m0s
[17:49:03.698] Received PubSub notification, asking Buildbucket for the build status
[17:49:03.782] Build 8871978448989039920: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:49:03.782] Buildbucket build:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"completed_ts": "1597427342811423",
"created_by": "project:dart",
"created_ts": "1597419039697375",
"id": "8871978448989039920",
"parameters_json": "{\"builder_name\": \"gclient\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://dart.googlesource.com/sdk\", \"revision\": \"d26790618463a08bff87b0dab0e84d805fd4fe83\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@d26790618463a08bff87b0dab0e84d805fd4fe83\", \"title\": \"d26790618463a08bff87b0dab0e84d805fd4fe83\", \"url\": \"https://dart.googlesource.com/sdk/+/d26790618463a08bff87b0dab0e84d805fd4fe83\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk\", \"revision\": \"d26790618463a08bff87b0dab0e84d805fd4fe83\"}}",
"project": "dart",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$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}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://dart.googlesource.com/sdk\", \"revision\": \"d26790618463a08bff87b0dab0e84d805fd4fe83\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@d26790618463a08bff87b0dab0e84d805fd4fe83\", \"title\": \"d26790618463a08bff87b0dab0e84d805fd4fe83\", \"url\": \"https://dart.googlesource.com/sdk/+/d26790618463a08bff87b0dab0e84d805fd4fe83\"}]}, \"$recipe_engine/swarming\": {\"server\": \"https://chromium-swarm.appspot.com\"}, \"bot_id\": \"luci-dart-try-xenial-92-ftg0\", \"branch\": \"refs/heads/master\", \"buildername\": \"gclient\", \"buildnumber\": 9521, \"clobber\": \"true\", \"path_config\": \"generic\", \"recipe\": \"dart/gclient\", \"repository\": \"https://dart.googlesource.com/sdk\", \"revision\": \"d26790618463a08bff87b0dab0e84d805fd4fe83\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"browsers\", \"builder_02799a17539ff755e19f9f880c89a4236df8675fe9acf5c4ef4a1989e5a03276_v2\", \"builder_252280c55c022a23a36eed1d9766143b8cedacf263fac7d67e5bf33fb68ceeca_v2\", \"builder_390c115de1588aa44715b0a51be737386537dace0abbffb181966fe58d365023_v2\", \"builder_3cd6ed73d0a1ca1ec60323b50b97cfde8325581dce07765c41a04f21400d31fd_v2\", \"builder_6d0f9ea3fc90d5c6eaff5f2ab4a1d3ed87f78a313d81cece8b90be8f7d9188e3_v2\", \"builder_b076a5b5387968aada53d33ff1c7f4b89b6a73c49ce0ebd5ac6a7185fd3656ba_v2\", \"builder_b0f70dc86e1d0a6e3ffcc95c8ea25406997bbb2d50b410328d5542c81c91a3c4_v2\", \"builder_be27d8b138dfc387884512fad7facac1b0f67a4766cc008796394f7e6facbc61_v2\", \"builder_cdfb7e4c0be45bc1d321702c4190674b9bda32c6c4e50f46ac29be7962cacf17_v2\", \"builder_e13f4302820d9262fb21c7c0dbc470fc3f63b30e43224495de56520c8aea703c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"dart-ci\"], \"gpu\": [\"none\"], \"host_class\": [\"default\"], \"id\": [\"luci-dart-try-xenial-92-ftg0\"], \"image\": [\"dart-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"dart.tests\", \"luci.dart.try\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5488-fc78d20\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"started_ts": "1597427021697313",
"status": "COMPLETED",
"status_changed_ts": "1597427343274536",
"tags": [
"build_address:luci.dart.ci.sandbox/gclient/9521",
"builder:gclient",
"buildset:commit/git/d26790618463a08bff87b0dab0e84d805fd4fe83",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/d26790618463a08bff87b0dab0e84d805fd4fe83",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9037408510976649024",
"scheduler_job_id:dart/gclient",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/dart/buildbucket/cr-buildbucket.appspot.com/8871978448989039920/+/annotations",
"swarming_tag:luci_project:dart",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:dart/gclient",
"swarming_tag:recipe_package:dart/recipe_bundles/dart.googlesource.com/recipes",
"swarming_task_id:4e0669baf14a4b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1597427343292251",
"url": "https://ci.chromium.org/b/8871978448989039920",
"utcnow_ts": "1597427343773959"
}
}
[17:49:03.782] Invocation finished in 2h18m25.364025126s with status SUCCEEDED