[21:21:01.404] New invocation is queued and will start shortly
[21:21:02.764] Starting the invocation (attempt 1)
[21:21:02.799] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:21:02.799] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:21:02.799] Buildbucket request:
{
"bucket": "luci.dart.ci.sandbox",
"client_operation_id": "9098358225183882736",
"parameters_json": "{\"builder_name\":\"analyzer-win-release\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://dart.googlesource.com/sdk/\",\"revision\":\"63c9a241e3da352ab6460c73454bc0813904a8e4\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:analyzer-win-release",
"scheduler_invocation_id:9098358225183882736",
"scheduler_job_id:dart/analyzer-win-release",
"user_agent:luci-scheduler",
"buildset:commit/git/63c9a241e3da352ab6460c73454bc0813904a8e4",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/63c9a241e3da352ab6460c73454bc0813904a8e4",
"gitiles_ref:refs/heads/master"
]
}
[21:21:06.383] Buildbucket response:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1539292862984581",
"id": "8932928162862001456",
"lease_expiration_ts": "1539411666101315",
"lease_key": "1997601104",
"parameters_json": "{\"builder_name\": \"analyzer-win-release\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk/\", \"revision\": \"63c9a241e3da352ab6460c73454bc0813904a8e4\"}}",
"project": "dart",
"result_details_json": "null",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1539292866263487",
"tags": [
"build_address:luci.dart.ci.sandbox/analyzer-win-release/2703",
"builder:analyzer-win-release",
"buildset:commit/git/63c9a241e3da352ab6460c73454bc0813904a8e4",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/63c9a241e3da352ab6460c73454bc0813904a8e4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9098358225183882736",
"scheduler_job_id:dart/analyzer-win-release",
"swarming_dimension:caches:builder_c030046225ec729a1456fb10d7df0c625fafe542ce1c45e90c45620f248ee546_v2",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Windows",
"swarming_dimension:pool:luci.dart.try",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.dart.ci.sandbox/analyzer-win-release/2703",
"swarming_tag:buildbucket_bucket:luci.dart.ci.sandbox",
"swarming_tag:buildbucket_build_id:8932928162862001456",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:4c790cbde9342069ed9b59b6709c8807b14f2913",
"swarming_tag:builder:analyzer-win-release",
"swarming_tag:buildset:commit/git/63c9a241e3da352ab6460c73454bc0813904a8e4",
"swarming_tag:buildset:commit/gitiles/dart.googlesource.com/sdk/+/63c9a241e3da352ab6460c73454bc0813904a8e4",
"swarming_tag:caches:builder_c030046225ec729a1456fb10d7df0c625fafe542ce1c45e90c45620f248ee546_v2",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/dart/buildbucket/cr-buildbucket.appspot.com/8932928162862001456/+/annotations",
"swarming_tag:luci_project:dart",
"swarming_tag:os:Windows",
"swarming_tag:pool:luci.dart.try",
"swarming_tag:priority:50",
"swarming_tag:recipe_name:dart/neo",
"swarming_tag:recipe_repository:https://chromium.googlesource.com/chromium/tools/build.git",
"swarming_tag:scheduler_invocation_id:9098358225183882736",
"swarming_tag:scheduler_job_id:dart/analyzer-win-release",
"swarming_tag:service_account:dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:02984296a6429d35f9eb152239263b748ed182ad",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:407dd2ad8f07a510",
"user_agent:luci-scheduler"
],
"updated_ts": "1539292866263616",
"url": "https://ci.chromium.org/p/dart/builders/luci.dart.ci.sandbox/analyzer-win-release/2703",
"utcnow_ts": "1539292866368111"
}
}
[21:21:06.383] Task URL: https://ci.chromium.org/p/dart/builders/luci.dart.ci.sandbox/analyzer-win-release/2703
[21:21:06.383] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:2:0) after 1m0s
[21:22:06.562] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:2:0)
[21:22:06.562] Timer tick, asking Buildbucket for the build status
[21:22:06.707] Build 8932928162862001456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:22:06.707] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:3:0) after 1m0s
[21:23:06.725] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:3:0)
[21:23:06.725] Timer tick, asking Buildbucket for the build status
[21:23:06.767] Build 8932928162862001456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:23:06.767] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:4:0) after 1m0s
[21:24:06.789] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:4:0)
[21:24:06.790] Timer tick, asking Buildbucket for the build status
[21:24:06.853] Build 8932928162862001456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:24:06.853] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:5:0) after 1m0s
[21:25:06.881] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:5:0)
[21:25:06.881] Timer tick, asking Buildbucket for the build status
[21:25:06.947] Build 8932928162862001456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:25:06.947] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:6:0) after 1m0s
[21:26:06.972] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:6:0)
[21:26:06.972] Timer tick, asking Buildbucket for the build status
[21:26:07.022] Build 8932928162862001456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:26:07.022] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:7:0) after 1m0s
[21:27:07.047] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:7:0)
[21:27:07.047] Timer tick, asking Buildbucket for the build status
[21:27:07.120] Build 8932928162862001456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:27:07.120] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:8:0) after 1m0s
[21:28:07.137] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:8:0)
[21:28:07.137] Timer tick, asking Buildbucket for the build status
[21:28:07.197] Build 8932928162862001456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:28:07.197] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:9:0) after 1m0s
[21:29:07.214] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:9:0)
[21:29:07.214] Timer tick, asking Buildbucket for the build status
[21:29:07.249] Build 8932928162862001456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:29:07.249] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:10:0) after 1m0s
[21:30:07.273] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:10:0)
[21:30:07.273] Timer tick, asking Buildbucket for the build status
[21:30:07.319] Build 8932928162862001456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:30:07.319] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:11:0) after 1m0s
[21:31:07.339] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:11:0)
[21:31:07.339] Timer tick, asking Buildbucket for the build status
[21:31:07.484] Build 8932928162862001456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:31:07.484] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:12:0) after 1m0s
[21:32:07.501] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:12:0)
[21:32:07.501] Timer tick, asking Buildbucket for the build status
[21:32:07.564] Build 8932928162862001456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:32:07.564] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:13:0) after 1m0s
[21:33:07.587] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:13:0)
[21:33:07.587] Timer tick, asking Buildbucket for the build status
[21:33:07.628] Build 8932928162862001456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:33:07.628] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:14:0) after 1m0s
[21:34:07.651] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:14:0)
[21:34:07.651] Timer tick, asking Buildbucket for the build status
[21:34:07.698] Build 8932928162862001456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:34:07.698] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:15:0) after 1m0s
[21:35:07.716] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:15:0)
[21:35:07.716] Timer tick, asking Buildbucket for the build status
[21:35:07.782] Build 8932928162862001456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:35:07.782] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:16:0) after 1m0s
[21:36:07.838] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:16:0)
[21:36:07.838] Timer tick, asking Buildbucket for the build status
[21:36:07.896] Build 8932928162862001456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:36:07.896] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:17:0) after 1m0s
[21:37:07.913] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:17:0)
[21:37:07.913] Timer tick, asking Buildbucket for the build status
[21:37:07.960] Build 8932928162862001456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:37:07.960] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:18:0) after 1m0s
[21:38:07.982] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:18:0)
[21:38:07.982] Timer tick, asking Buildbucket for the build status
[21:38:08.032] Build 8932928162862001456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:38:08.032] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:19:0) after 1m0s
[21:39:08.056] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:19:0)
[21:39:08.056] Timer tick, asking Buildbucket for the build status
[21:39:08.151] Build 8932928162862001456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:39:08.151] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:20:0) after 1m0s
[21:40:08.170] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:20:0)
[21:40:08.170] Timer tick, asking Buildbucket for the build status
[21:40:08.231] Build 8932928162862001456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:40:08.231] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:21:0) after 1m0s
[21:41:08.258] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:21:0)
[21:41:08.258] Timer tick, asking Buildbucket for the build status
[21:41:08.327] Build 8932928162862001456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:41:08.327] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:22:0) after 1m0s
[21:42:08.390] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:22:0)
[21:42:08.390] Timer tick, asking Buildbucket for the build status
[21:42:08.608] Build 8932928162862001456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:42:08.608] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:23:0) after 1m0s
[21:43:08.643] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:23:0)
[21:43:08.643] Timer tick, asking Buildbucket for the build status
[21:43:08.725] Build 8932928162862001456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:43:08.725] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:24:0) after 1m0s
[21:44:09.205] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:24:0)
[21:44:09.205] Timer tick, asking Buildbucket for the build status
[21:44:09.344] Build 8932928162862001456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:44:09.344] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:25:0) after 1m0s
[21:45:09.440] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:25:0)
[21:45:09.440] Timer tick, asking Buildbucket for the build status
[21:45:09.472] Build 8932928162862001456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:45:09.472] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:26:0) after 1m0s
[21:46:09.501] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:26:0)
[21:46:09.501] Timer tick, asking Buildbucket for the build status
[21:46:09.541] Build 8932928162862001456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:46:09.541] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:27:0) after 1m0s
[21:47:09.561] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:27:0)
[21:47:09.561] Timer tick, asking Buildbucket for the build status
[21:47:09.661] Build 8932928162862001456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:47:09.661] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:28:0) after 1m0s
[21:48:09.690] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:28:0)
[21:48:09.690] Timer tick, asking Buildbucket for the build status
[21:48:09.736] Build 8932928162862001456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:48:09.736] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:29:0) after 1m0s
[21:49:09.751] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:29:0)
[21:49:09.751] Timer tick, asking Buildbucket for the build status
[21:49:09.812] Build 8932928162862001456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:49:09.812] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:30:0) after 1m0s
[21:50:09.839] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:30:0)
[21:50:09.839] Timer tick, asking Buildbucket for the build status
[21:50:09.891] Build 8932928162862001456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:50:09.891] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:31:0) after 1m0s
[21:51:09.921] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:31:0)
[21:51:09.921] Timer tick, asking Buildbucket for the build status
[21:51:09.958] Build 8932928162862001456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:51:09.958] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:32:0) after 1m0s
[21:51:56.335] Received PubSub notification, asking Buildbucket for the build status
[21:51:56.369] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:10.010] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:32:0)
[21:52:10.010] Timer tick, asking Buildbucket for the build status
[21:52:10.048] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:10.048] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:34:0) after 1m0s
[21:53:10.070] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:34:0)
[21:53:10.070] Timer tick, asking Buildbucket for the build status
[21:53:10.131] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:10.131] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:35:0) after 1m0s
[21:54:10.229] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:35:0)
[21:54:10.229] Timer tick, asking Buildbucket for the build status
[21:54:10.272] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:10.272] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:36:0) after 1m0s
[21:55:10.300] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:36:0)
[21:55:10.300] Timer tick, asking Buildbucket for the build status
[21:55:10.390] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:10.390] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:37:0) after 1m0s
[21:56:10.408] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:37:0)
[21:56:10.408] Timer tick, asking Buildbucket for the build status
[21:56:10.474] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:10.474] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:38:0) after 1m0s
[21:57:10.520] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:38:0)
[21:57:10.520] Timer tick, asking Buildbucket for the build status
[21:57:10.621] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:10.621] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:39:0) after 1m0s
[21:58:10.782] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:39:0)
[21:58:10.782] Timer tick, asking Buildbucket for the build status
[21:58:10.845] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:10.845] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:40:0) after 1m0s
[21:59:10.872] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:40:0)
[21:59:10.872] Timer tick, asking Buildbucket for the build status
[21:59:10.945] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:10.945] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:41:0) after 1m0s
[22:00:10.966] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:41:0)
[22:00:10.966] Timer tick, asking Buildbucket for the build status
[22:00:10.997] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:10.997] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:42:0) after 1m0s
[22:01:11.032] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:42:0)
[22:01:11.032] Timer tick, asking Buildbucket for the build status
[22:01:11.071] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:11.071] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:43:0) after 1m0s
[22:02:11.103] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:43:0)
[22:02:11.103] Timer tick, asking Buildbucket for the build status
[22:02:11.141] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:11.141] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:44:0) after 1m0s
[22:03:11.160] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:44:0)
[22:03:11.160] Timer tick, asking Buildbucket for the build status
[22:03:11.197] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:11.197] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:45:0) after 1m0s
[22:04:11.268] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:45:0)
[22:04:11.268] Timer tick, asking Buildbucket for the build status
[22:04:11.361] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:11.361] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:46:0) after 1m0s
[22:05:11.385] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:46:0)
[22:05:11.385] Timer tick, asking Buildbucket for the build status
[22:05:11.428] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:11.428] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:47:0) after 1m0s
[22:06:11.448] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:47:0)
[22:06:11.448] Timer tick, asking Buildbucket for the build status
[22:06:11.716] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:11.716] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:48:0) after 1m0s
[22:07:11.747] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:48:0)
[22:07:11.747] Timer tick, asking Buildbucket for the build status
[22:07:11.790] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:11.790] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:49:0) after 1m0s
[22:08:11.919] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:49:0)
[22:08:11.919] Timer tick, asking Buildbucket for the build status
[22:08:11.972] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:11.972] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:50:0) after 1m0s
[22:09:11.996] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:50:0)
[22:09:11.996] Timer tick, asking Buildbucket for the build status
[22:09:12.083] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:12.083] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:51:0) after 1m0s
[22:10:12.144] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:51:0)
[22:10:12.144] Timer tick, asking Buildbucket for the build status
[22:10:12.221] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:12.221] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:52:0) after 1m0s
[22:11:12.248] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:52:0)
[22:11:12.248] Timer tick, asking Buildbucket for the build status
[22:11:12.290] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:12.290] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:53:0) after 1m0s
[22:12:12.308] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:53:0)
[22:12:12.308] Timer tick, asking Buildbucket for the build status
[22:12:12.356] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:12.356] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:54:0) after 1m0s
[22:13:12.381] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:54:0)
[22:13:12.381] Timer tick, asking Buildbucket for the build status
[22:13:12.442] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:12.442] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:55:0) after 1m0s
[22:14:12.571] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:55:0)
[22:14:12.571] Timer tick, asking Buildbucket for the build status
[22:14:12.608] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:12.608] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:56:0) after 1m0s
[22:15:12.645] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:56:0)
[22:15:12.645] Timer tick, asking Buildbucket for the build status
[22:15:12.730] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:12.730] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:57:0) after 1m0s
[22:16:12.749] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:57:0)
[22:16:12.749] Timer tick, asking Buildbucket for the build status
[22:16:12.827] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:12.827] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:58:0) after 1m0s
[22:17:12.844] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:58:0)
[22:17:12.844] Timer tick, asking Buildbucket for the build status
[22:17:12.895] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:12.895] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:59:0) after 1m0s
[22:18:12.962] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:59:0)
[22:18:12.962] Timer tick, asking Buildbucket for the build status
[22:18:13.024] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:13.024] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:60:0) after 1m0s
[22:19:13.067] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:60:0)
[22:19:13.067] Timer tick, asking Buildbucket for the build status
[22:19:13.124] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:13.124] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:61:0) after 1m0s
[22:20:13.223] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:61:0)
[22:20:13.223] Timer tick, asking Buildbucket for the build status
[22:20:13.255] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:13.255] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:62:0) after 1m0s
[22:21:13.279] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:62:0)
[22:21:13.279] Timer tick, asking Buildbucket for the build status
[22:21:13.332] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:13.332] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:63:0) after 1m0s
[22:22:13.359] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:63:0)
[22:22:13.359] Timer tick, asking Buildbucket for the build status
[22:22:13.456] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:13.456] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:64:0) after 1m0s
[22:23:13.499] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:64:0)
[22:23:13.499] Timer tick, asking Buildbucket for the build status
[22:23:13.605] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:13.605] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:65:0) after 1m0s
[22:24:13.624] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:65:0)
[22:24:13.624] Timer tick, asking Buildbucket for the build status
[22:24:13.695] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:13.695] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:66:0) after 1m0s
[22:25:13.714] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:66:0)
[22:25:13.714] Timer tick, asking Buildbucket for the build status
[22:25:13.771] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:13.771] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:67:0) after 1m0s
[22:26:13.793] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:67:0)
[22:26:13.793] Timer tick, asking Buildbucket for the build status
[22:26:13.905] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:13.905] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:68:0) after 1m0s
[22:27:13.954] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:68:0)
[22:27:13.954] Timer tick, asking Buildbucket for the build status
[22:27:13.989] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:13.989] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:69:0) after 1m0s
[22:28:14.007] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:69:0)
[22:28:14.007] Timer tick, asking Buildbucket for the build status
[22:28:14.116] Build 8932928162862001456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:14.116] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9098358225183882736:70:0) after 1m0s
[22:28:55.477] Received PubSub notification, asking Buildbucket for the build status
[22:28:55.509] Build 8932928162862001456: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:28:55.509] Buildbucket build:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "AUTO",
"completed_ts": "1539296933511572",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1539292862984581",
"id": "8932928162862001456",
"parameters_json": "{\"builder_name\": \"analyzer-win-release\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk/\", \"revision\": \"63c9a241e3da352ab6460c73454bc0813904a8e4\"}}",
"project": "dart",
"result": "SUCCESS",
"result_details_json": "{\"ui\": {\"info\": \"\"}, \"build_run_result\": {\"infraFailure\": null, \"recipeResult\": {\"jsonResult\": \"null\"}, \"recipeExitCode\": {\"value\": 0}, \"recipe\": {\"name\": \"dart/neo\", \"repository\": \"https://chromium.googlesource.com/chromium/tools/build.git\", \"revision\": \"60244ecda47add0d1d1d452b9a7a2b575b721a39\"}, \"annotationUrl\": \"logdog://logs.chromium.org/dart/buildbucket/cr-buildbucket.appspot.com/8932928162862001456/+/annotations\"}, \"swarming\": {\"bot_dimensions\": {\"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-c\"], \"locale\": [\"en_US.cp1252\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"python\": [\"2.7.13\"], \"server_version\": [\"3809-a31bbe1\"], \"machine_type\": [\"n1-standard-8\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"integrity\": [\"high\"], \"id\": [\"win10-dart-fedce810-us-central1-c-wq7b\"], \"pool\": [\"dart.tests\", \"luci.dart.try\"], \"caches\": [\"builder_002dbd92414fc23289da5b3d0214257cd1a1d00856876c2d39c2322596148b66_v2\", \"builder_06372fcac682057fd23d549417c761089c9ba1fc93ba5cff486781db5664f3cb_v2\", \"builder_6cb1d8cc15da394241552e9aa4d03e326bcb3c35dba6a1944a6903d0ccadd24a_v2\", \"git\", \"goma_v2\", \"swarming_module_cache_vpython\", \"vpython\"]}}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"buildnumber\": 2703, \"repository\": \"https://dart.googlesource.com/sdk/\", \"buildername\": \"analyzer-win-release\", \"got_revision\": \"63c9a241e3da352ab6460c73454bc0813904a8e4\", \"recipe\": \"dart/neo\", \"mastername\": \"client.dart\", \"clobber\": \"true\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1539292862984581, \"tags\": [\"builder:analyzer-win-release\", \"buildset:commit/git/63c9a241e3da352ab6460c73454bc0813904a8e4\", \"buildset:commit/gitiles/dart.googlesource.com/sdk/+/63c9a241e3da352ab6460c73454bc0813904a8e4\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9098358225183882736\", \"scheduler_job_id:dart/analyzer-win-release\", \"user_agent:luci-scheduler\"], \"bucket\": \"luci.dart.ci.sandbox\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"dart\", \"id\": \"8932928162862001456\"}}, \"branch\": \"refs/heads/master\", \"path_config\": \"generic\", \"revision\": \"63c9a241e3da352ab6460c73454bc0813904a8e4\", \"bot_id\": \"win10-dart-fedce810-us-central1-c-wq7b\"}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"started_ts": "1539294715339979",
"status": "COMPLETED",
"status_changed_ts": "1539296934977896",
"tags": [
"build_address:luci.dart.ci.sandbox/analyzer-win-release/2703",
"builder:analyzer-win-release",
"buildset:commit/git/63c9a241e3da352ab6460c73454bc0813904a8e4",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/63c9a241e3da352ab6460c73454bc0813904a8e4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9098358225183882736",
"scheduler_job_id:dart/analyzer-win-release",
"swarming_dimension:caches:builder_c030046225ec729a1456fb10d7df0c625fafe542ce1c45e90c45620f248ee546_v2",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Windows",
"swarming_dimension:pool:luci.dart.try",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.dart.ci.sandbox/analyzer-win-release/2703",
"swarming_tag:buildbucket_bucket:luci.dart.ci.sandbox",
"swarming_tag:buildbucket_build_id:8932928162862001456",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:4c790cbde9342069ed9b59b6709c8807b14f2913",
"swarming_tag:builder:analyzer-win-release",
"swarming_tag:buildset:commit/git/63c9a241e3da352ab6460c73454bc0813904a8e4",
"swarming_tag:buildset:commit/gitiles/dart.googlesource.com/sdk/+/63c9a241e3da352ab6460c73454bc0813904a8e4",
"swarming_tag:caches:builder_c030046225ec729a1456fb10d7df0c625fafe542ce1c45e90c45620f248ee546_v2",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/dart/buildbucket/cr-buildbucket.appspot.com/8932928162862001456/+/annotations",
"swarming_tag:luci_project:dart",
"swarming_tag:os:Windows",
"swarming_tag:pool:luci.dart.try",
"swarming_tag:priority:50",
"swarming_tag:recipe_name:dart/neo",
"swarming_tag:recipe_repository:https://chromium.googlesource.com/chromium/tools/build.git",
"swarming_tag:scheduler_invocation_id:9098358225183882736",
"swarming_tag:scheduler_job_id:dart/analyzer-win-release",
"swarming_tag:service_account:dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:02984296a6429d35f9eb152239263b748ed182ad",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:407dd2ad8f07a510",
"user_agent:luci-scheduler"
],
"updated_ts": "1539296934979578",
"url": "https://ci.chromium.org/p/dart/builders/luci.dart.ci.sandbox/analyzer-win-release/2703",
"utcnow_ts": "1539296935499217"
}
}
[22:28:55.509] Invocation finished in 1h7m54.12327204s with status SUCCEEDED