[18:58:32.657] New invocation is queued and will start shortly
[18:58:33.749] Starting the invocation (attempt 1)
[18:58:33.805] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:58:33.806] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:58:33.806] Buildbucket request:
{
"bucket": "luci.dart.ci.sandbox",
"client_operation_id": "9063034372299530032",
"parameters_json": "{\"builder_name\":\"analyzer-win-release\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://dart.googlesource.com/sdk\",\"revision\":\"e65d95e8c869a6ef26a5fdb6951267ea06c3e6fe\"},\"id\":\"https://dart.googlesource.com/sdk/+/refs/heads/master@e65d95e8c869a6ef26a5fdb6951267ea06c3e6fe\",\"title\":\"e65d95e8c869a6ef26a5fdb6951267ea06c3e6fe\",\"url\":\"https://dart.googlesource.com/sdk/+/e65d95e8c869a6ef26a5fdb6951267ea06c3e6fe\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://dart.googlesource.com/sdk\",\"revision\":\"e65d95e8c869a6ef26a5fdb6951267ea06c3e6fe\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:analyzer-win-release",
"scheduler_invocation_id:9063034372299530032",
"scheduler_job_id:dart/analyzer-win-release",
"user_agent:luci-scheduler",
"buildset:commit/git/e65d95e8c869a6ef26a5fdb6951267ea06c3e6fe",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/e65d95e8c869a6ef26a5fdb6951267ea06c3e6fe",
"gitiles_ref:refs/heads/master"
]
}
[18:58:34.975] Buildbucket response:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:dart",
"created_ts": "1572980314049573",
"id": "8897604310174389728",
"parameters_json": "{\"builder_name\": \"analyzer-win-release\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://dart.googlesource.com/sdk\", \"revision\": \"e65d95e8c869a6ef26a5fdb6951267ea06c3e6fe\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@e65d95e8c869a6ef26a5fdb6951267ea06c3e6fe\", \"title\": \"e65d95e8c869a6ef26a5fdb6951267ea06c3e6fe\", \"url\": \"https://dart.googlesource.com/sdk/+/e65d95e8c869a6ef26a5fdb6951267ea06c3e6fe\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk\", \"revision\": \"e65d95e8c869a6ef26a5fdb6951267ea06c3e6fe\"}}",
"project": "dart",
"result_details_json": "{\"properties\": {}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1572980314720850",
"tags": [
"build_address:luci.dart.ci.sandbox/analyzer-win-release/7706",
"builder:analyzer-win-release",
"buildset:commit/git/e65d95e8c869a6ef26a5fdb6951267ea06c3e6fe",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/e65d95e8c869a6ef26a5fdb6951267ea06c3e6fe",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9063034372299530032",
"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/8897604310174389728/+/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": "1572980314721032",
"url": "https://ci.chromium.org/b/8897604310174389728",
"utcnow_ts": "1572980314961016"
}
}
[18:58:34.975] Task URL: https://ci.chromium.org/b/8897604310174389728
[18:58:34.975] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:2:0) after 1m0s
[18:59:34.988] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:2:0)
[18:59:34.988] Timer tick, asking Buildbucket for the build status
[18:59:35.180] Build 8897604310174389728: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:59:35.180] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:3:0) after 1m0s
[19:00:35.254] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:3:0)
[19:00:35.254] Timer tick, asking Buildbucket for the build status
[19:00:35.603] Build 8897604310174389728: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:00:35.603] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:4:0) after 1m0s
[19:01:35.617] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:4:0)
[19:01:35.617] Timer tick, asking Buildbucket for the build status
[19:01:35.847] Build 8897604310174389728: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:01:35.847] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:5:0) after 1m0s
[19:02:35.936] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:5:0)
[19:02:35.936] Timer tick, asking Buildbucket for the build status
[19:02:36.203] Build 8897604310174389728: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:02:36.203] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:6:0) after 1m0s
[19:03:36.253] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:6:0)
[19:03:36.253] Timer tick, asking Buildbucket for the build status
[19:03:37.256] Build 8897604310174389728: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:03:37.256] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:7:0) after 1m0s
[19:04:37.387] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:7:0)
[19:04:37.387] Timer tick, asking Buildbucket for the build status
[19:04:37.707] Build 8897604310174389728: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:04:37.707] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:8:0) after 1m0s
[19:05:37.774] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:8:0)
[19:05:37.774] Timer tick, asking Buildbucket for the build status
[19:05:38.033] Build 8897604310174389728: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:05:38.033] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:9:0) after 1m0s
[19:06:38.114] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:9:0)
[19:06:38.114] Timer tick, asking Buildbucket for the build status
[19:06:38.790] Build 8897604310174389728: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:06:38.790] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:10:0) after 1m0s
[19:07:38.821] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:10:0)
[19:07:38.821] Timer tick, asking Buildbucket for the build status
[19:07:39.040] Build 8897604310174389728: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:07:39.040] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:11:0) after 1m0s
[19:08:13.364] Received PubSub notification, asking Buildbucket for the build status
[19:08:13.498] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:39.071] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:11:0)
[19:08:39.071] Timer tick, asking Buildbucket for the build status
[19:08:39.195] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:39.195] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:13:0) after 1m0s
[19:09:39.315] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:13:0)
[19:09:39.316] Timer tick, asking Buildbucket for the build status
[19:09:39.915] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:39.915] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:14:0) after 1m0s
[19:10:39.969] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:14:0)
[19:10:39.969] Timer tick, asking Buildbucket for the build status
[19:10:40.184] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:40.184] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:15:0) after 1m0s
[19:11:40.293] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:15:0)
[19:11:40.293] Timer tick, asking Buildbucket for the build status
[19:11:40.503] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:40.503] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:16:0) after 1m0s
[19:12:40.599] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:16:0)
[19:12:40.599] Timer tick, asking Buildbucket for the build status
[19:12:40.909] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:40.909] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:17:0) after 1m0s
[19:13:41.148] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:17:0)
[19:13:41.148] Timer tick, asking Buildbucket for the build status
[19:13:41.351] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:41.351] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:18:0) after 1m0s
[19:14:41.498] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:18:0)
[19:14:41.498] Timer tick, asking Buildbucket for the build status
[19:14:41.793] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:41.793] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:19:0) after 1m0s
[19:15:42.043] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:19:0)
[19:15:42.043] Timer tick, asking Buildbucket for the build status
[19:15:42.908] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:42.908] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:20:0) after 1m0s
[19:16:43.038] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:20:0)
[19:16:43.038] Timer tick, asking Buildbucket for the build status
[19:16:45.100] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:45.100] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:21:0) after 1m0s
[19:17:45.307] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:21:0)
[19:17:45.307] Timer tick, asking Buildbucket for the build status
[19:17:45.931] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:45.931] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:22:0) after 1m0s
[19:18:46.022] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:22:0)
[19:18:46.022] Timer tick, asking Buildbucket for the build status
[19:18:46.397] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:46.397] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:23:0) after 1m0s
[19:19:46.422] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:23:0)
[19:19:46.422] Timer tick, asking Buildbucket for the build status
[19:19:48.287] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:48.287] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:24:0) after 1m0s
[19:20:48.358] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:24:0)
[19:20:48.358] Timer tick, asking Buildbucket for the build status
[19:20:50.939] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:50.939] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:25:0) after 1m0s
[19:21:51.136] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:25:0)
[19:21:51.136] Timer tick, asking Buildbucket for the build status
[19:21:51.383] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:51.383] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:26:0) after 1m0s
[19:22:51.449] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:26:0)
[19:22:51.449] Timer tick, asking Buildbucket for the build status
[19:22:52.105] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:52.105] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:27:0) after 1m0s
[19:23:52.210] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:27:0)
[19:23:52.210] Timer tick, asking Buildbucket for the build status
[19:23:52.684] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:52.684] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:28:0) after 1m0s
[19:24:52.784] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:28:0)
[19:24:52.784] Timer tick, asking Buildbucket for the build status
[19:24:53.381] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:53.381] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:29:0) after 1m0s
[19:25:53.473] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:29:0)
[19:25:53.473] Timer tick, asking Buildbucket for the build status
[19:25:53.646] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:53.646] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:30:0) after 1m0s
[19:26:53.715] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:30:0)
[19:26:53.715] Timer tick, asking Buildbucket for the build status
[19:26:53.868] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:53.868] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:31:0) after 1m0s
[19:27:53.905] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:31:0)
[19:27:53.905] Timer tick, asking Buildbucket for the build status
[19:27:56.449] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:56.449] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:32:0) after 1m0s
[19:28:56.599] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:32:0)
[19:28:56.599] Timer tick, asking Buildbucket for the build status
[19:28:56.761] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:56.761] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:33:0) after 1m0s
[19:29:56.782] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:33:0)
[19:29:56.782] Timer tick, asking Buildbucket for the build status
[19:29:57.074] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:57.074] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:34:0) after 1m0s
[19:30:57.301] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:34:0)
[19:30:57.301] Timer tick, asking Buildbucket for the build status
[19:30:57.486] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:57.486] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:35:0) after 1m0s
[19:31:57.946] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:35:0)
[19:31:57.946] Timer tick, asking Buildbucket for the build status
[19:31:58.126] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:58.126] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:36:0) after 1m0s
[19:32:58.739] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:36:0)
[19:32:58.739] Timer tick, asking Buildbucket for the build status
[19:32:59.425] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:59.425] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:37:0) after 1m0s
[19:33:59.535] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:37:0)
[19:33:59.535] Timer tick, asking Buildbucket for the build status
[19:33:59.699] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:59.699] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:38:0) after 1m0s
[19:35:00.123] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:38:0)
[19:35:00.123] Timer tick, asking Buildbucket for the build status
[19:35:01.154] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:01.154] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:39:0) after 1m0s
[19:36:01.432] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:39:0)
[19:36:01.432] Timer tick, asking Buildbucket for the build status
[19:36:04.799] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:04.799] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:40:0) after 1m0s
[19:37:05.219] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:40:0)
[19:37:05.220] Timer tick, asking Buildbucket for the build status
[19:37:05.441] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:05.441] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:41:0) after 1m0s
[19:38:05.733] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:41:0)
[19:38:05.733] Timer tick, asking Buildbucket for the build status
[19:38:05.938] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:05.938] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:42:0) after 1m0s
[19:39:06.235] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:42:0)
[19:39:06.236] Timer tick, asking Buildbucket for the build status
[19:39:06.637] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:06.637] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:43:0) after 1m0s
[19:40:06.859] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:43:0)
[19:40:06.859] Timer tick, asking Buildbucket for the build status
[19:40:07.548] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:07.548] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:44:0) after 1m0s
[19:41:07.887] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:44:0)
[19:41:07.887] Timer tick, asking Buildbucket for the build status
[19:41:09.028] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:09.028] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:45:0) after 1m0s
[19:42:09.348] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:45:0)
[19:42:09.348] Timer tick, asking Buildbucket for the build status
[19:42:09.627] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:09.627] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:46:0) after 1m0s
[19:43:09.769] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:46:0)
[19:43:09.769] Timer tick, asking Buildbucket for the build status
[19:43:09.977] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:09.977] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:47:0) after 1m0s
[19:44:10.049] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:47:0)
[19:44:10.049] Timer tick, asking Buildbucket for the build status
[19:44:10.473] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:10.473] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:48:0) after 1m0s
[19:45:10.524] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:48:0)
[19:45:10.524] Timer tick, asking Buildbucket for the build status
[19:45:10.631] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:10.631] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:49:0) after 1m0s
[19:46:10.660] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:49:0)
[19:46:10.660] Timer tick, asking Buildbucket for the build status
[19:46:12.275] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:12.275] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:50:0) after 1m0s
[19:47:12.325] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:50:0)
[19:47:12.325] Timer tick, asking Buildbucket for the build status
[19:47:12.695] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:12.695] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:51:0) after 1m0s
[19:48:12.835] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:51:0)
[19:48:12.835] Timer tick, asking Buildbucket for the build status
[19:48:13.130] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:13.130] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:52:0) after 1m0s
[19:49:13.186] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:52:0)
[19:49:13.186] Timer tick, asking Buildbucket for the build status
[19:49:13.684] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:13.684] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:53:0) after 1m0s
[19:50:13.708] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:53:0)
[19:50:13.708] Timer tick, asking Buildbucket for the build status
[19:50:14.214] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:14.214] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:54:0) after 1m0s
[19:51:14.254] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:54:0)
[19:51:14.254] Timer tick, asking Buildbucket for the build status
[19:51:14.440] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:14.440] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:55:0) after 1m0s
[19:52:14.560] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:55:0)
[19:52:14.560] Timer tick, asking Buildbucket for the build status
[19:52:14.835] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:14.835] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:56:0) after 1m0s
[19:53:15.024] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:56:0)
[19:53:15.024] Timer tick, asking Buildbucket for the build status
[19:53:15.247] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:15.247] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:57:0) after 1m0s
[19:54:15.321] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:57:0)
[19:54:15.321] Timer tick, asking Buildbucket for the build status
[19:54:16.416] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:16.416] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:58:0) after 1m0s
[19:55:16.547] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:58:0)
[19:55:16.547] Timer tick, asking Buildbucket for the build status
[19:55:19.596] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:19.597] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:59:0) after 1m0s
[19:56:19.705] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:59:0)
[19:56:19.706] Timer tick, asking Buildbucket for the build status
[19:56:19.914] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:19.914] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:60:0) after 1m0s
[19:57:19.938] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:60:0)
[19:57:19.938] Timer tick, asking Buildbucket for the build status
[19:57:20.208] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:20.208] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:61:0) after 1m0s
[19:58:20.290] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:61:0)
[19:58:20.290] Timer tick, asking Buildbucket for the build status
[19:58:20.479] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:20.479] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:62:0) after 1m0s
[19:59:20.563] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:62:0)
[19:59:20.563] Timer tick, asking Buildbucket for the build status
[19:59:20.727] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:20.727] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:63:0) after 1m0s
[20:00:21.561] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:63:0)
[20:00:21.561] Timer tick, asking Buildbucket for the build status
[20:00:21.916] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:21.916] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:64:0) after 1m0s
[20:01:22.163] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:64:0)
[20:01:22.163] Timer tick, asking Buildbucket for the build status
[20:01:22.347] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:22.347] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:65:0) after 1m0s
[20:02:22.589] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:65:0)
[20:02:22.589] Timer tick, asking Buildbucket for the build status
[20:02:22.681] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:22.681] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:66:0) after 1m0s
[20:03:22.734] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:66:0)
[20:03:22.734] Timer tick, asking Buildbucket for the build status
[20:03:24.126] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:24.126] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:67:0) after 1m0s
[20:04:24.344] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:67:0)
[20:04:24.344] Timer tick, asking Buildbucket for the build status
[20:04:24.741] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:24.741] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:68:0) after 1m0s
[20:05:24.865] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:68:0)
[20:05:24.865] Timer tick, asking Buildbucket for the build status
[20:05:25.231] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:25.231] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:69:0) after 1m0s
[20:06:25.270] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:69:0)
[20:06:25.270] Timer tick, asking Buildbucket for the build status
[20:06:25.547] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:25.547] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:70:0) after 1m0s
[20:07:25.584] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:70:0)
[20:07:25.584] Timer tick, asking Buildbucket for the build status
[20:07:26.103] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:26.103] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:71:0) after 1m0s
[20:08:26.207] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:71:0)
[20:08:26.207] Timer tick, asking Buildbucket for the build status
[20:08:28.237] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:28.237] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:72:0) after 1m0s
[20:09:28.221] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:72:0)
[20:09:28.221] Timer tick, asking Buildbucket for the build status
[20:09:28.437] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:28.437] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:73:0) after 1m0s
[20:10:28.492] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:73:0)
[20:10:28.492] Timer tick, asking Buildbucket for the build status
[20:10:30.099] Build 8897604310174389728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:30.099] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9063034372299530032:74:0) after 1m0s
[20:11:28.331] Received PubSub notification, asking Buildbucket for the build status
[20:11:29.854] Build 8897604310174389728: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[20:11:29.854] Buildbucket build:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1572984686187820",
"created_by": "project:dart",
"created_ts": "1572980314049573",
"failure_reason": "BUILD_FAILURE",
"id": "8897604310174389728",
"parameters_json": "{\"builder_name\": \"analyzer-win-release\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://dart.googlesource.com/sdk\", \"revision\": \"e65d95e8c869a6ef26a5fdb6951267ea06c3e6fe\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@e65d95e8c869a6ef26a5fdb6951267ea06c3e6fe\", \"title\": \"e65d95e8c869a6ef26a5fdb6951267ea06c3e6fe\", \"url\": \"https://dart.googlesource.com/sdk/+/e65d95e8c869a6ef26a5fdb6951267ea06c3e6fe\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk\", \"revision\": \"e65d95e8c869a6ef26a5fdb6951267ea06c3e6fe\"}}",
"project": "dart",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 out of 2 aggregated steps failed: 1 out of 1 aggregated steps failed: Step('test results') (retcode: 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}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://dart.googlesource.com/sdk\", \"revision\": \"e65d95e8c869a6ef26a5fdb6951267ea06c3e6fe\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@e65d95e8c869a6ef26a5fdb6951267ea06c3e6fe\", \"title\": \"e65d95e8c869a6ef26a5fdb6951267ea06c3e6fe\", \"url\": \"https://dart.googlesource.com/sdk/+/e65d95e8c869a6ef26a5fdb6951267ea06c3e6fe\"}]}, \"bot_id\": \"luci-dart-try-win10-9-jgha\", \"branch\": \"refs/heads/master\", \"buildername\": \"analyzer-win-release\", \"buildnumber\": 7706, \"clobber\": \"true\", \"got_revision\": \"e65d95e8c869a6ef26a5fdb6951267ea06c3e6fe\", \"new_workflow_enabled\": true, \"path_config\": \"generic\", \"recipe\": \"dart/neo\", \"repository\": \"https://dart.googlesource.com/sdk\", \"revision\": \"e65d95e8c869a6ef26a5fdb6951267ea06c3e6fe\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_148cfedf85f034438764d46098ca39be15c5a78077600d642d6f6a78998f136a_v2\", \"builder_be064052482d6ca5a964976b1243dc771bb92525cbcbd9d5c12144fe17d4ab42_v2\", \"builder_d6f396784d1bacfeb26d12c7d2f46eacb6fe10d26ab756565a33004b6afc6592_v2\", \"builder_ed4b5414dd762070fa13e34211fddc453760b8558a461a1504ce197f395eb375_v2\", \"builder_ef3e73fc15b32b92058bb8d202e07de466ff011148432befe1b168cce52937e0_v2\", \"git\", \"goma_v2\", \"swarming_module_cache_vpython\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"host_class\": [\"default\"], \"id\": [\"luci-dart-try-win10-9-jgha\"], \"image\": [\"chrome-win10-1703-19102400-d35fedf5a0d\"], \"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\": [\"4621-f8a5b1c\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-c\"]}}, \"ui\": {\"info\": \"1 out of 2 aggregated steps failed: 1 out of 1 aggregated steps failed: Step('test results') (retcode: 1)\"}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"started_ts": "1572980892428752",
"status": "COMPLETED",
"status_changed_ts": "1572980892955550",
"tags": [
"build_address:luci.dart.ci.sandbox/analyzer-win-release/7706",
"builder:analyzer-win-release",
"buildset:commit/git/e65d95e8c869a6ef26a5fdb6951267ea06c3e6fe",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/e65d95e8c869a6ef26a5fdb6951267ea06c3e6fe",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9063034372299530032",
"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/8897604310174389728/+/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:4855c0e9bd959710",
"user_agent:luci-scheduler"
],
"updated_ts": "1572984687427591",
"url": "https://ci.chromium.org/b/8897604310174389728",
"utcnow_ts": "1572984689793849"
}
}
[20:11:29.855] Invocation finished in 1h12m57.216182949s with status FAILED