[14:03:20.772] New invocation is queued and will start shortly
[14:03:21.971] Starting the invocation (attempt 1)
[14:03:22.104] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:03:22.104] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:03:22.104] Buildbucket request:
{
"bucket": "luci.dart.ci.sandbox",
"client_operation_id": "9082984277229971456",
"parameters_json": "{\"builder_name\":\"analyzer-win-release\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://dart.googlesource.com/sdk/\",\"revision\":\"94362f1af0f21455e723d1c53bc3953c830ccb6f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:analyzer-win-release",
"scheduler_invocation_id:9082984277229971456",
"scheduler_job_id:dart/analyzer-win-release",
"user_agent:luci-scheduler",
"buildset:commit/git/94362f1af0f21455e723d1c53bc3953c830ccb6f",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/94362f1af0f21455e723d1c53bc3953c830ccb6f",
"gitiles_ref:refs/heads/master"
]
}
[14:03:23.705] Buildbucket response:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "AUTO",
"created_by": "project:dart",
"created_ts": "1553954602323590",
"id": "8917554214872602464",
"parameters_json": "{\"builder_name\": \"analyzer-win-release\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk/\", \"revision\": \"94362f1af0f21455e723d1c53bc3953c830ccb6f\"}}",
"project": "dart",
"result_details_json": "{\"properties\": {}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1553954603361730",
"tags": [
"build_address:luci.dart.ci.sandbox/analyzer-win-release/4957",
"builder:analyzer-win-release",
"buildset:commit/git/94362f1af0f21455e723d1c53bc3953c830ccb6f",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/94362f1af0f21455e723d1c53bc3953c830ccb6f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9082984277229971456",
"scheduler_job_id:dart/analyzer-win-release",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/dart/buildbucket/cr-buildbucket.appspot.com/8917554214872602464/+/annotations",
"swarming_tag:luci_project:dart",
"swarming_tag:recipe_name:dart/neo",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1553954603361860",
"url": "https://ci.chromium.org/b/8917554214872602464",
"utcnow_ts": "1553954603695769"
}
}
[14:03:23.705] Task URL: https://ci.chromium.org/b/8917554214872602464
[14:03:23.705] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:2:0) after 1m0s
[14:03:30.028] Received PubSub notification, asking Buildbucket for the build status
[14:03:30.147] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:23.763] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:2:0)
[14:04:23.763] Timer tick, asking Buildbucket for the build status
[14:04:23.956] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:23.956] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:4:0) after 1m0s
[14:05:23.973] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:4:0)
[14:05:23.973] Timer tick, asking Buildbucket for the build status
[14:05:24.175] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:24.175] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:5:0) after 1m0s
[14:06:24.328] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:5:0)
[14:06:24.328] Timer tick, asking Buildbucket for the build status
[14:06:24.784] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:24.784] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:6:0) after 1m0s
[14:07:24.803] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:6:0)
[14:07:24.803] Timer tick, asking Buildbucket for the build status
[14:07:25.318] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:25.318] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:7:0) after 1m0s
[14:08:25.339] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:7:0)
[14:08:25.339] Timer tick, asking Buildbucket for the build status
[14:08:25.780] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:25.780] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:8:0) after 1m0s
[14:09:25.797] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:8:0)
[14:09:25.797] Timer tick, asking Buildbucket for the build status
[14:09:25.893] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:25.893] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:9:0) after 1m0s
[14:10:25.868] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:9:0)
[14:10:25.868] Timer tick, asking Buildbucket for the build status
[14:10:26.573] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:26.573] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:10:0) after 1m0s
[14:11:26.582] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:10:0)
[14:11:26.582] Timer tick, asking Buildbucket for the build status
[14:11:27.063] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:27.063] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:11:0) after 1m0s
[14:12:27.086] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:11:0)
[14:12:27.086] Timer tick, asking Buildbucket for the build status
[14:12:27.499] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:27.499] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:12:0) after 1m0s
[14:13:27.516] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:12:0)
[14:13:27.516] Timer tick, asking Buildbucket for the build status
[14:13:27.682] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:27.682] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:13:0) after 1m0s
[14:14:27.683] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:13:0)
[14:14:27.683] Timer tick, asking Buildbucket for the build status
[14:14:28.245] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:28.245] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:14:0) after 1m0s
[14:15:28.228] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:14:0)
[14:15:28.228] Timer tick, asking Buildbucket for the build status
[14:15:29.399] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:29.399] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:15:0) after 1m0s
[14:16:29.419] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:15:0)
[14:16:29.419] Timer tick, asking Buildbucket for the build status
[14:16:31.238] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:31.238] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:16:0) after 1m0s
[14:17:31.223] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:16:0)
[14:17:31.223] Timer tick, asking Buildbucket for the build status
[14:17:31.306] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:31.306] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:17:0) after 1m0s
[14:18:31.292] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:17:0)
[14:18:31.292] Timer tick, asking Buildbucket for the build status
[14:18:31.653] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:31.653] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:18:0) after 1m0s
[14:19:31.637] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:18:0)
[14:19:31.637] Timer tick, asking Buildbucket for the build status
[14:19:31.883] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:31.883] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:19:0) after 1m0s
[14:20:31.883] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:19:0)
[14:20:31.883] Timer tick, asking Buildbucket for the build status
[14:20:32.011] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:32.011] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:20:0) after 1m0s
[14:21:32.056] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:20:0)
[14:21:32.056] Timer tick, asking Buildbucket for the build status
[14:21:32.293] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:32.293] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:21:0) after 1m0s
[14:22:32.281] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:21:0)
[14:22:32.281] Timer tick, asking Buildbucket for the build status
[14:22:32.670] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:32.670] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:22:0) after 1m0s
[14:23:32.688] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:22:0)
[14:23:32.688] Timer tick, asking Buildbucket for the build status
[14:23:32.804] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:32.804] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:23:0) after 1m0s
[14:24:32.838] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:23:0)
[14:24:32.838] Timer tick, asking Buildbucket for the build status
[14:24:33.034] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:33.034] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:24:0) after 1m0s
[14:25:33.056] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:24:0)
[14:25:33.056] Timer tick, asking Buildbucket for the build status
[14:25:33.827] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:33.827] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:25:0) after 1m0s
[14:26:33.841] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:25:0)
[14:26:33.841] Timer tick, asking Buildbucket for the build status
[14:26:34.583] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:34.584] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:26:0) after 1m0s
[14:27:34.614] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:26:0)
[14:27:34.614] Timer tick, asking Buildbucket for the build status
[14:27:34.735] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:34.735] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:27:0) after 1m0s
[14:28:34.748] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:27:0)
[14:28:34.748] Timer tick, asking Buildbucket for the build status
[14:28:35.068] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:35.068] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:28:0) after 1m0s
[14:29:35.088] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:28:0)
[14:29:35.088] Timer tick, asking Buildbucket for the build status
[14:29:35.364] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:35.364] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:29:0) after 1m0s
[14:30:35.344] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:29:0)
[14:30:35.344] Timer tick, asking Buildbucket for the build status
[14:30:35.749] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:35.749] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:30:0) after 1m0s
[14:31:35.768] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:30:0)
[14:31:35.768] Timer tick, asking Buildbucket for the build status
[14:31:35.991] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:35.991] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:31:0) after 1m0s
[14:32:36.006] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:31:0)
[14:32:36.006] Timer tick, asking Buildbucket for the build status
[14:32:36.127] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:36.127] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:32:0) after 1m0s
[14:33:36.223] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:32:0)
[14:33:36.223] Timer tick, asking Buildbucket for the build status
[14:33:36.351] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:36.351] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:33:0) after 1m0s
[14:34:36.355] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:33:0)
[14:34:36.355] Timer tick, asking Buildbucket for the build status
[14:34:36.561] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:36.561] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:34:0) after 1m0s
[14:35:36.578] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:34:0)
[14:35:36.578] Timer tick, asking Buildbucket for the build status
[14:35:36.645] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:36.645] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:35:0) after 1m0s
[14:36:36.665] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:35:0)
[14:36:36.666] Timer tick, asking Buildbucket for the build status
[14:36:36.912] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:36.912] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:36:0) after 1m0s
[14:37:36.925] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:36:0)
[14:37:36.925] Timer tick, asking Buildbucket for the build status
[14:37:38.273] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:38.273] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:37:0) after 1m0s
[14:38:38.276] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:37:0)
[14:38:38.276] Timer tick, asking Buildbucket for the build status
[14:38:38.390] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:38.390] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:38:0) after 1m0s
[14:39:38.409] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:38:0)
[14:39:38.409] Timer tick, asking Buildbucket for the build status
[14:39:38.512] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:38.512] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:39:0) after 1m0s
[14:40:38.530] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:39:0)
[14:40:38.530] Timer tick, asking Buildbucket for the build status
[14:40:38.691] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:38.691] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:40:0) after 1m0s
[14:41:38.664] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:40:0)
[14:41:38.664] Timer tick, asking Buildbucket for the build status
[14:41:38.807] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:38.807] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:41:0) after 1m0s
[14:42:38.824] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:41:0)
[14:42:38.824] Timer tick, asking Buildbucket for the build status
[14:42:39.103] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:39.103] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:42:0) after 1m0s
[14:43:39.123] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:42:0)
[14:43:39.124] Timer tick, asking Buildbucket for the build status
[14:43:39.234] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:39.234] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:43:0) after 1m0s
[14:44:39.253] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:43:0)
[14:44:39.253] Timer tick, asking Buildbucket for the build status
[14:44:39.590] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:39.590] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:44:0) after 1m0s
[14:45:39.580] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:44:0)
[14:45:39.580] Timer tick, asking Buildbucket for the build status
[14:45:40.113] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:40.113] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:45:0) after 1m0s
[14:46:40.132] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:45:0)
[14:46:40.132] Timer tick, asking Buildbucket for the build status
[14:46:40.410] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:40.410] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:46:0) after 1m0s
[14:47:40.428] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:46:0)
[14:47:40.428] Timer tick, asking Buildbucket for the build status
[14:47:40.950] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:40.950] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:47:0) after 1m0s
[14:48:40.953] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:47:0)
[14:48:40.953] Timer tick, asking Buildbucket for the build status
[14:48:41.061] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:41.061] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:48:0) after 1m0s
[14:49:41.098] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:48:0)
[14:49:41.098] Timer tick, asking Buildbucket for the build status
[14:49:42.015] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:42.015] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:49:0) after 1m0s
[14:50:42.038] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:49:0)
[14:50:42.038] Timer tick, asking Buildbucket for the build status
[14:50:42.136] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:42.136] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:50:0) after 1m0s
[14:51:42.168] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:50:0)
[14:51:42.168] Timer tick, asking Buildbucket for the build status
[14:51:42.499] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:42.499] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:51:0) after 1m0s
[14:52:42.519] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:51:0)
[14:52:42.519] Timer tick, asking Buildbucket for the build status
[14:52:42.613] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:42.613] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:52:0) after 1m0s
[14:53:42.619] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:52:0)
[14:53:42.619] Timer tick, asking Buildbucket for the build status
[14:53:42.771] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:42.771] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:53:0) after 1m0s
[14:54:42.769] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:53:0)
[14:54:42.769] Timer tick, asking Buildbucket for the build status
[14:54:42.885] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:42.885] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:54:0) after 1m0s
[14:55:42.903] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:54:0)
[14:55:42.903] Timer tick, asking Buildbucket for the build status
[14:55:43.034] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:43.034] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:55:0) after 1m0s
[14:56:43.085] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:55:0)
[14:56:43.085] Timer tick, asking Buildbucket for the build status
[14:56:43.222] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:43.222] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:56:0) after 1m0s
[14:57:43.239] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:56:0)
[14:57:43.239] Timer tick, asking Buildbucket for the build status
[14:57:43.342] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:43.342] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:57:0) after 1m0s
[14:58:43.399] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:57:0)
[14:58:43.399] Timer tick, asking Buildbucket for the build status
[14:58:44.012] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:44.012] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:58:0) after 1m0s
[14:59:44.042] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:58:0)
[14:59:44.042] Timer tick, asking Buildbucket for the build status
[14:59:44.443] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:44.443] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:59:0) after 1m0s
[15:00:44.432] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:59:0)
[15:00:44.432] Timer tick, asking Buildbucket for the build status
[15:00:44.786] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:44.786] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:60:0) after 1m0s
[15:01:44.790] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:60:0)
[15:01:44.790] Timer tick, asking Buildbucket for the build status
[15:01:44.904] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:44.904] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:61:0) after 1m0s
[15:02:44.898] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:61:0)
[15:02:44.898] Timer tick, asking Buildbucket for the build status
[15:02:44.989] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:44.989] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:62:0) after 1m0s
[15:03:45.007] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:62:0)
[15:03:45.007] Timer tick, asking Buildbucket for the build status
[15:03:45.257] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:45.257] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:63:0) after 1m0s
[15:04:45.264] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:63:0)
[15:04:45.264] Timer tick, asking Buildbucket for the build status
[15:04:45.487] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:45.487] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:64:0) after 1m0s
[15:05:45.463] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:64:0)
[15:05:45.463] Timer tick, asking Buildbucket for the build status
[15:05:45.569] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:45.569] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:65:0) after 1m0s
[15:06:45.586] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:65:0)
[15:06:45.586] Timer tick, asking Buildbucket for the build status
[15:06:45.720] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:45.720] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:66:0) after 1m0s
[15:07:45.742] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:66:0)
[15:07:45.742] Timer tick, asking Buildbucket for the build status
[15:07:45.821] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:45.821] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:67:0) after 1m0s
[15:08:45.840] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:67:0)
[15:08:45.840] Timer tick, asking Buildbucket for the build status
[15:08:46.126] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:46.126] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:68:0) after 1m0s
[15:09:46.147] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:68:0)
[15:09:46.147] Timer tick, asking Buildbucket for the build status
[15:09:46.583] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:46.583] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:69:0) after 1m0s
[15:10:46.596] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:69:0)
[15:10:46.596] Timer tick, asking Buildbucket for the build status
[15:10:46.928] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:46.928] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:70:0) after 1m0s
[15:11:46.911] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:70:0)
[15:11:46.911] Timer tick, asking Buildbucket for the build status
[15:11:47.031] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:47.031] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:71:0) after 1m0s
[15:12:47.016] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:71:0)
[15:12:47.016] Timer tick, asking Buildbucket for the build status
[15:12:47.165] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:47.165] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:72:0) after 1m0s
[15:13:47.186] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:72:0)
[15:13:47.186] Timer tick, asking Buildbucket for the build status
[15:13:47.684] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:47.684] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:73:0) after 1m0s
[15:14:47.718] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:73:0)
[15:14:47.718] Timer tick, asking Buildbucket for the build status
[15:14:48.253] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:48.253] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:74:0) after 1m0s
[15:15:48.287] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:74:0)
[15:15:48.287] Timer tick, asking Buildbucket for the build status
[15:15:48.407] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:48.407] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:75:0) after 1m0s
[15:16:48.403] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:75:0)
[15:16:48.403] Timer tick, asking Buildbucket for the build status
[15:16:48.516] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:48.516] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:76:0) after 1m0s
[15:17:48.536] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:76:0)
[15:17:48.536] Timer tick, asking Buildbucket for the build status
[15:17:48.820] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:48.820] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:77:0) after 1m0s
[15:18:48.857] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:77:0)
[15:18:48.857] Timer tick, asking Buildbucket for the build status
[15:18:49.384] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:49.384] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:78:0) after 1m0s
[15:19:49.405] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:78:0)
[15:19:49.405] Timer tick, asking Buildbucket for the build status
[15:19:49.508] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:49.508] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:79:0) after 1m0s
[15:20:49.542] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:79:0)
[15:20:49.542] Timer tick, asking Buildbucket for the build status
[15:20:49.679] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:49.679] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:80:0) after 1m0s
[15:21:49.698] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:80:0)
[15:21:49.698] Timer tick, asking Buildbucket for the build status
[15:21:49.840] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:49.840] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:81:0) after 1m0s
[15:22:49.859] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:81:0)
[15:22:49.859] Timer tick, asking Buildbucket for the build status
[15:22:50.307] Build 8917554214872602464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:50.307] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9082984277229971456:82:0) after 1m0s
[15:23:46.608] Received PubSub notification, asking Buildbucket for the build status
[15:23:47.090] Build 8917554214872602464: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[15:23:47.090] Buildbucket build:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "AUTO",
"completed_ts": "1553959425865157",
"created_by": "project:dart",
"created_ts": "1553954602323590",
"failure_reason": "BUILD_FAILURE",
"id": "8917554214872602464",
"parameters_json": "{\"builder_name\": \"analyzer-win-release\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk/\", \"revision\": \"94362f1af0f21455e723d1c53bc3953c830ccb6f\"}}",
"project": "dart",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 out of 3 aggregated steps failed: 1 out of 1 aggregated steps failed: Step('test results') failed with return_code 1\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"win10-dart-fedce810-us-central1-c-x4hr\", \"branch\": \"refs/heads/master\", \"buildername\": \"analyzer-win-release\", \"buildnumber\": 4957, \"clobber\": \"true\", \"got_revision\": \"94362f1af0f21455e723d1c53bc3953c830ccb6f\", \"mastername\": \"client.dart\", \"new_workflow_enabled\": true, \"path_config\": \"generic\", \"recipe\": \"dart/neo\", \"repository\": \"https://dart.googlesource.com/sdk/\", \"revision\": \"94362f1af0f21455e723d1c53bc3953c830ccb6f\"}, \"swarming\": {\"bot_dimensions\": {\"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"win10-dart-fedce810-us-central1-c-x4hr\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"dart.tests\", \"luci.dart.try\"], \"python\": [\"2.7.13\"], \"server_version\": [\"4226-cfe6277\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-c\"]}}, \"ui\": {\"info\": \"1 out of 3 aggregated steps failed: 1 out of 1 aggregated steps failed: Step('test results') failed with return_code 1\"}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"started_ts": "1553954609063694",
"status": "COMPLETED",
"status_changed_ts": "1553954609643940",
"tags": [
"build_address:luci.dart.ci.sandbox/analyzer-win-release/4957",
"builder:analyzer-win-release",
"buildset:commit/git/94362f1af0f21455e723d1c53bc3953c830ccb6f",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/94362f1af0f21455e723d1c53bc3953c830ccb6f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9082984277229971456",
"scheduler_job_id:dart/analyzer-win-release",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/dart/buildbucket/cr-buildbucket.appspot.com/8917554214872602464/+/annotations",
"swarming_tag:luci_project:dart",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:dart/neo",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:43e7bb0a886cfd10",
"user_agent:luci-scheduler"
],
"updated_ts": "1553959426130531",
"url": "https://ci.chromium.org/b/8917554214872602464",
"utcnow_ts": "1553959427007457"
}
}
[15:23:47.090] Invocation finished in 1h20m26.399473206s with status FAILED