[17:40:10.198] New invocation is queued and will start shortly
[17:40:11.467] Starting the invocation (attempt 1)
[17:40:11.563] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:40:11.563] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:40:11.563] Buildbucket request:
{
"bucket": "luci.dart.ci.sandbox",
"client_operation_id": "9095110629288981952",
"parameters_json": "{\"builder_name\":\"pkg-win-release\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://dart.googlesource.com/sdk/\",\"revision\":\"bdf8b0bc79331346f5264b3e4264407f314475ad\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:pkg-win-release",
"scheduler_invocation_id:9095110629288981952",
"scheduler_job_id:dart/pkg-win-release",
"user_agent:luci-scheduler",
"buildset:commit/git/bdf8b0bc79331346f5264b3e4264407f314475ad",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/bdf8b0bc79331346f5264b3e4264407f314475ad",
"gitiles_ref:refs/heads/master"
]
}
[17:40:13.209] Buildbucket response:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1542390011708131",
"id": "8929680567041119760",
"lease_expiration_ts": "1542508812776451",
"lease_key": "370666211",
"parameters_json": "{\"builder_name\": \"pkg-win-release\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk/\", \"revision\": \"bdf8b0bc79331346f5264b3e4264407f314475ad\"}}",
"project": "dart",
"result_details_json": "null",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1542390012973860",
"tags": [
"build_address:luci.dart.ci.sandbox/pkg-win-release/3118",
"builder:pkg-win-release",
"buildset:commit/git/bdf8b0bc79331346f5264b3e4264407f314475ad",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/bdf8b0bc79331346f5264b3e4264407f314475ad",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9095110629288981952",
"scheduler_job_id:dart/pkg-win-release",
"swarming_dimension:caches:builder_25ee1422577e844c44bbdff63b591f09ef27a58893168e9dc9dc636d175a9801_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/pkg-win-release/3118",
"swarming_tag:buildbucket_bucket:dart/ci.sandbox",
"swarming_tag:buildbucket_build_id:8929680567041119760",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:1ec59250bddb61762cb629d1319c038a649d4580",
"swarming_tag:builder:pkg-win-release",
"swarming_tag:buildset:commit/git/bdf8b0bc79331346f5264b3e4264407f314475ad",
"swarming_tag:buildset:commit/gitiles/dart.googlesource.com/sdk/+/bdf8b0bc79331346f5264b3e4264407f314475ad",
"swarming_tag:caches:builder_25ee1422577e844c44bbdff63b591f09ef27a58893168e9dc9dc636d175a9801_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/8929680567041119760/+/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:9095110629288981952",
"swarming_tag:scheduler_job_id:dart/pkg-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:468d9e2dea961985edaee65928b78c057e4193e9",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:41366d619c184910",
"user_agent:luci-scheduler"
],
"updated_ts": "1542390012973954",
"url": "https://ci.chromium.org/b/8929680567041119760",
"utcnow_ts": "1542390013198132"
}
}
[17:40:13.209] Task URL: https://ci.chromium.org/b/8929680567041119760
[17:40:13.209] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:2:0) after 1m0s
[17:41:13.229] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:2:0)
[17:41:13.229] Timer tick, asking Buildbucket for the build status
[17:41:13.311] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:41:13.311] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:3:0) after 1m0s
[17:42:13.329] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:3:0)
[17:42:13.329] Timer tick, asking Buildbucket for the build status
[17:42:13.377] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:42:13.377] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:4:0) after 1m0s
[17:43:13.396] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:4:0)
[17:43:13.396] Timer tick, asking Buildbucket for the build status
[17:43:13.437] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:43:13.437] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:5:0) after 1m0s
[17:44:13.454] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:5:0)
[17:44:13.454] Timer tick, asking Buildbucket for the build status
[17:44:13.513] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:44:13.513] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:6:0) after 1m0s
[17:45:13.531] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:6:0)
[17:45:13.531] Timer tick, asking Buildbucket for the build status
[17:45:13.625] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:45:13.625] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:7:0) after 1m0s
[17:46:13.644] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:7:0)
[17:46:13.644] Timer tick, asking Buildbucket for the build status
[17:46:13.740] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:46:13.740] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:8:0) after 1m0s
[17:47:13.755] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:8:0)
[17:47:13.755] Timer tick, asking Buildbucket for the build status
[17:47:13.815] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:47:13.815] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:9:0) after 1m0s
[17:48:13.845] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:9:0)
[17:48:13.845] Timer tick, asking Buildbucket for the build status
[17:48:13.991] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:48:13.991] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:10:0) after 1m0s
[17:49:14.011] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:10:0)
[17:49:14.011] Timer tick, asking Buildbucket for the build status
[17:49:14.057] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:49:14.057] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:11:0) after 1m0s
[17:50:14.076] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:11:0)
[17:50:14.076] Timer tick, asking Buildbucket for the build status
[17:50:14.136] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:50:14.136] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:12:0) after 1m0s
[17:51:14.158] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:12:0)
[17:51:14.158] Timer tick, asking Buildbucket for the build status
[17:51:14.216] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:51:14.216] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:13:0) after 1m0s
[17:52:14.252] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:13:0)
[17:52:14.252] Timer tick, asking Buildbucket for the build status
[17:52:14.628] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:52:14.628] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:14:0) after 1m0s
[17:53:14.648] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:14:0)
[17:53:14.648] Timer tick, asking Buildbucket for the build status
[17:53:14.725] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:53:14.725] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:15:0) after 1m0s
[17:54:14.929] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:15:0)
[17:54:14.929] Timer tick, asking Buildbucket for the build status
[17:54:14.988] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:54:14.988] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:16:0) after 1m0s
[17:55:15.055] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:16:0)
[17:55:15.055] Timer tick, asking Buildbucket for the build status
[17:55:15.110] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:55:15.110] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:17:0) after 1m0s
[17:56:15.172] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:17:0)
[17:56:15.172] Timer tick, asking Buildbucket for the build status
[17:56:15.205] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:56:15.205] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:18:0) after 1m0s
[17:57:15.232] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:18:0)
[17:57:15.232] Timer tick, asking Buildbucket for the build status
[17:57:15.308] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:57:15.308] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:19:0) after 1m0s
[17:58:15.332] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:19:0)
[17:58:15.332] Timer tick, asking Buildbucket for the build status
[17:58:15.951] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:58:15.951] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:20:0) after 1m0s
[17:59:16.018] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:20:0)
[17:59:16.018] Timer tick, asking Buildbucket for the build status
[17:59:16.211] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:59:16.211] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:21:0) after 1m0s
[18:00:16.232] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:21:0)
[18:00:16.232] Timer tick, asking Buildbucket for the build status
[18:00:16.359] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:00:16.359] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:22:0) after 1m0s
[18:01:16.391] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:22:0)
[18:01:16.391] Timer tick, asking Buildbucket for the build status
[18:01:16.460] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:01:16.460] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:23:0) after 1m0s
[18:02:16.487] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:23:0)
[18:02:16.487] Timer tick, asking Buildbucket for the build status
[18:02:16.520] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:02:16.520] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:24:0) after 1m0s
[18:03:16.537] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:24:0)
[18:03:16.537] Timer tick, asking Buildbucket for the build status
[18:03:16.689] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:03:16.689] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:25:0) after 1m0s
[18:04:16.707] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:25:0)
[18:04:16.707] Timer tick, asking Buildbucket for the build status
[18:04:16.782] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:04:16.782] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:26:0) after 1m0s
[18:05:16.819] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:26:0)
[18:05:16.819] Timer tick, asking Buildbucket for the build status
[18:05:16.930] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:05:16.930] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:27:0) after 1m0s
[18:06:16.991] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:27:0)
[18:06:16.991] Timer tick, asking Buildbucket for the build status
[18:06:17.062] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:06:17.062] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:28:0) after 1m0s
[18:07:17.080] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:28:0)
[18:07:17.080] Timer tick, asking Buildbucket for the build status
[18:07:17.132] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:07:17.132] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:29:0) after 1m0s
[18:08:17.150] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:29:0)
[18:08:17.150] Timer tick, asking Buildbucket for the build status
[18:08:17.215] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:08:17.215] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:30:0) after 1m0s
[18:09:17.232] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:30:0)
[18:09:17.232] Timer tick, asking Buildbucket for the build status
[18:09:17.267] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:09:17.267] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:31:0) after 1m0s
[18:10:17.286] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:31:0)
[18:10:17.286] Timer tick, asking Buildbucket for the build status
[18:10:17.432] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:10:17.432] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:32:0) after 1m0s
[18:11:17.464] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:32:0)
[18:11:17.464] Timer tick, asking Buildbucket for the build status
[18:11:17.511] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:11:17.511] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:33:0) after 1m0s
[18:12:17.613] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:33:0)
[18:12:17.613] Timer tick, asking Buildbucket for the build status
[18:12:17.671] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:12:17.671] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:34:0) after 1m0s
[18:13:17.691] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:34:0)
[18:13:17.691] Timer tick, asking Buildbucket for the build status
[18:13:17.800] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:13:17.800] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:35:0) after 1m0s
[18:14:17.819] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:35:0)
[18:14:17.819] Timer tick, asking Buildbucket for the build status
[18:14:17.934] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:14:17.934] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:36:0) after 1m0s
[18:15:17.951] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:36:0)
[18:15:17.952] Timer tick, asking Buildbucket for the build status
[18:15:17.999] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:15:17.999] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:37:0) after 1m0s
[18:16:18.020] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:37:0)
[18:16:18.020] Timer tick, asking Buildbucket for the build status
[18:16:18.082] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:16:18.082] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:38:0) after 1m0s
[18:17:17.668] Received PubSub notification, asking Buildbucket for the build status
[18:17:17.706] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:18.100] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:38:0)
[18:17:18.100] Timer tick, asking Buildbucket for the build status
[18:17:18.183] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:18.183] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:40:0) after 1m0s
[18:18:18.233] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:40:0)
[18:18:18.233] Timer tick, asking Buildbucket for the build status
[18:18:18.290] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:18:18.290] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:41:0) after 1m0s
[18:19:18.308] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:41:0)
[18:19:18.308] Timer tick, asking Buildbucket for the build status
[18:19:18.377] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:19:18.377] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:42:0) after 1m0s
[18:20:18.395] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:42:0)
[18:20:18.395] Timer tick, asking Buildbucket for the build status
[18:20:18.471] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:20:18.471] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:43:0) after 1m0s
[18:21:18.502] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:43:0)
[18:21:18.502] Timer tick, asking Buildbucket for the build status
[18:21:18.538] Build 8929680567041119760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:21:18.538] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:44:0) after 1m0s
[18:22:04.940] Received PubSub notification, asking Buildbucket for the build status
[18:22:04.980] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:18.560] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:44:0)
[18:22:18.560] Timer tick, asking Buildbucket for the build status
[18:22:18.596] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:18.596] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:46:0) after 1m0s
[18:23:18.619] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:46:0)
[18:23:18.619] Timer tick, asking Buildbucket for the build status
[18:23:18.791] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:18.791] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:47:0) after 1m0s
[18:24:18.813] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:47:0)
[18:24:18.813] Timer tick, asking Buildbucket for the build status
[18:24:19.030] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:19.030] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:48:0) after 1m0s
[18:25:19.065] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:48:0)
[18:25:19.065] Timer tick, asking Buildbucket for the build status
[18:25:19.130] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:19.130] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:49:0) after 1m0s
[18:26:19.272] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:49:0)
[18:26:19.272] Timer tick, asking Buildbucket for the build status
[18:26:19.310] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:19.310] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:50:0) after 1m0s
[18:27:20.312] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:50:0)
[18:27:20.312] Timer tick, asking Buildbucket for the build status
[18:27:20.480] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:20.480] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:51:0) after 1m0s
[18:28:20.684] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:51:0)
[18:28:20.684] Timer tick, asking Buildbucket for the build status
[18:28:20.720] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:20.720] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:52:0) after 1m0s
[18:29:20.776] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:52:0)
[18:29:20.776] Timer tick, asking Buildbucket for the build status
[18:29:20.811] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:20.811] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:53:0) after 1m0s
[18:30:20.940] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:53:0)
[18:30:20.940] Timer tick, asking Buildbucket for the build status
[18:30:21.003] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:21.003] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:54:0) after 1m0s
[18:31:21.081] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:54:0)
[18:31:21.081] Timer tick, asking Buildbucket for the build status
[18:31:21.154] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:21.154] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:55:0) after 1m0s
[18:32:21.367] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:55:0)
[18:32:21.367] Timer tick, asking Buildbucket for the build status
[18:32:21.399] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:21.399] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:56:0) after 1m0s
[18:33:21.692] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:56:0)
[18:33:21.693] Timer tick, asking Buildbucket for the build status
[18:33:21.754] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:21.754] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:57:0) after 1m0s
[18:34:21.866] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:57:0)
[18:34:21.866] Timer tick, asking Buildbucket for the build status
[18:34:21.919] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:21.919] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:58:0) after 1m0s
[18:35:22.709] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:58:0)
[18:35:22.709] Timer tick, asking Buildbucket for the build status
[18:35:22.836] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:22.836] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:59:0) after 1m0s
[18:36:23.162] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:59:0)
[18:36:23.162] Timer tick, asking Buildbucket for the build status
[18:36:23.215] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:23.215] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:60:0) after 1m0s
[18:37:23.248] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:60:0)
[18:37:23.248] Timer tick, asking Buildbucket for the build status
[18:37:23.305] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:23.305] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:61:0) after 1m0s
[18:38:24.030] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:61:0)
[18:38:24.030] Timer tick, asking Buildbucket for the build status
[18:38:24.076] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:24.076] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:62:0) after 1m0s
[18:39:24.107] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:62:0)
[18:39:24.107] Timer tick, asking Buildbucket for the build status
[18:39:24.164] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:24.164] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:63:0) after 1m0s
[18:40:24.270] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:63:0)
[18:40:24.270] Timer tick, asking Buildbucket for the build status
[18:40:24.344] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:24.344] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:64:0) after 1m0s
[18:41:24.387] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:64:0)
[18:41:24.387] Timer tick, asking Buildbucket for the build status
[18:41:24.444] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:24.444] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:65:0) after 1m0s
[18:42:24.478] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:65:0)
[18:42:24.478] Timer tick, asking Buildbucket for the build status
[18:42:24.534] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:24.534] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:66:0) after 1m0s
[18:43:24.557] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:66:0)
[18:43:24.557] Timer tick, asking Buildbucket for the build status
[18:43:24.625] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:24.625] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:67:0) after 1m0s
[18:44:24.912] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:67:0)
[18:44:24.912] Timer tick, asking Buildbucket for the build status
[18:44:24.965] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:24.965] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:68:0) after 1m0s
[18:45:24.997] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:68:0)
[18:45:24.997] Timer tick, asking Buildbucket for the build status
[18:45:25.075] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:25.075] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:69:0) after 1m0s
[18:46:25.402] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:69:0)
[18:46:25.403] Timer tick, asking Buildbucket for the build status
[18:46:25.478] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:25.478] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:70:0) after 1m0s
[18:47:25.690] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:70:0)
[18:47:25.690] Timer tick, asking Buildbucket for the build status
[18:47:25.911] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:25.912] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:71:0) after 1m0s
[18:48:25.988] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:71:0)
[18:48:25.988] Timer tick, asking Buildbucket for the build status
[18:48:26.031] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:26.031] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:72:0) after 1m0s
[18:49:26.281] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:72:0)
[18:49:26.281] Timer tick, asking Buildbucket for the build status
[18:49:26.487] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:26.487] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:73:0) after 1m0s
[18:50:26.509] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:73:0)
[18:50:26.509] Timer tick, asking Buildbucket for the build status
[18:50:26.585] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:26.585] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:74:0) after 1m0s
[18:51:26.967] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:74:0)
[18:51:26.967] Timer tick, asking Buildbucket for the build status
[18:51:27.019] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:27.019] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:75:0) after 1m0s
[18:52:27.325] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:75:0)
[18:52:27.325] Timer tick, asking Buildbucket for the build status
[18:52:27.372] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:27.372] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:76:0) after 1m0s
[18:53:27.889] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:76:0)
[18:53:27.889] Timer tick, asking Buildbucket for the build status
[18:53:27.932] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:27.932] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:77:0) after 1m0s
[18:54:28.415] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:77:0)
[18:54:28.415] Timer tick, asking Buildbucket for the build status
[18:54:28.542] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:28.542] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:78:0) after 1m0s
[18:55:28.605] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:78:0)
[18:55:28.605] Timer tick, asking Buildbucket for the build status
[18:55:28.686] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:28.686] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:79:0) after 1m0s
[18:56:28.885] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:79:0)
[18:56:28.885] Timer tick, asking Buildbucket for the build status
[18:56:28.962] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:28.962] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:80:0) after 1m0s
[18:57:29.143] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:80:0)
[18:57:29.143] Timer tick, asking Buildbucket for the build status
[18:57:29.393] Build 8929680567041119760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:29.393] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9095110629288981952:81:0) after 1m0s
[18:57:36.224] Received PubSub notification, asking Buildbucket for the build status
[18:57:36.286] Build 8929680567041119760: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:57:36.286] Buildbucket build:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "AUTO",
"completed_ts": "1542394655015181",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1542390011708131",
"id": "8929680567041119760",
"parameters_json": "{\"builder_name\": \"pkg-win-release\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk/\", \"revision\": \"bdf8b0bc79331346f5264b3e4264407f314475ad\"}}",
"project": "dart",
"result": "SUCCESS",
"result_details_json": "{\"ui\": {\"info\": \"\"}, \"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\": [\"3844-124e68f\"], \"machine_type\": [\"n1-standard-8\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"integrity\": [\"high\"], \"id\": [\"win10-dart-fedce810-us-central1-c-7mrw\"], \"pool\": [\"dart.tests\", \"luci.dart.try\"], \"caches\": [\"swarming_module_cache_vpython\"]}}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"buildnumber\": 3118, \"repository\": \"https://dart.googlesource.com/sdk/\", \"buildername\": \"pkg-win-release\", \"got_revision\": \"bdf8b0bc79331346f5264b3e4264407f314475ad\", \"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\": 1542390011708131, \"tags\": [\"builder:pkg-win-release\", \"buildset:commit/git/bdf8b0bc79331346f5264b3e4264407f314475ad\", \"buildset:commit/gitiles/dart.googlesource.com/sdk/+/bdf8b0bc79331346f5264b3e4264407f314475ad\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9095110629288981952\", \"scheduler_job_id:dart/pkg-win-release\", \"user_agent:luci-scheduler\"], \"bucket\": \"luci.dart.ci.sandbox\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"dart\", \"id\": \"8929680567041119760\"}}, \"branch\": \"refs/heads/master\", \"path_config\": \"generic\", \"revision\": \"bdf8b0bc79331346f5264b3e4264407f314475ad\", \"bot_id\": \"win10-dart-fedce810-us-central1-c-7mrw\"}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"started_ts": "1542392236463556",
"status": "COMPLETED",
"status_changed_ts": "1542394655843551",
"tags": [
"build_address:luci.dart.ci.sandbox/pkg-win-release/3118",
"builder:pkg-win-release",
"buildset:commit/git/bdf8b0bc79331346f5264b3e4264407f314475ad",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/bdf8b0bc79331346f5264b3e4264407f314475ad",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9095110629288981952",
"scheduler_job_id:dart/pkg-win-release",
"swarming_dimension:caches:builder_25ee1422577e844c44bbdff63b591f09ef27a58893168e9dc9dc636d175a9801_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/pkg-win-release/3118",
"swarming_tag:buildbucket_bucket:dart/ci.sandbox",
"swarming_tag:buildbucket_build_id:8929680567041119760",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:1ec59250bddb61762cb629d1319c038a649d4580",
"swarming_tag:builder:pkg-win-release",
"swarming_tag:buildset:commit/git/bdf8b0bc79331346f5264b3e4264407f314475ad",
"swarming_tag:buildset:commit/gitiles/dart.googlesource.com/sdk/+/bdf8b0bc79331346f5264b3e4264407f314475ad",
"swarming_tag:caches:builder_25ee1422577e844c44bbdff63b591f09ef27a58893168e9dc9dc636d175a9801_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/8929680567041119760/+/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:9095110629288981952",
"swarming_tag:scheduler_job_id:dart/pkg-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:468d9e2dea961985edaee65928b78c057e4193e9",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:41366d619c184910",
"user_agent:luci-scheduler"
],
"updated_ts": "1542394655845077",
"url": "https://ci.chromium.org/b/8929680567041119760",
"utcnow_ts": "1542394656273284"
}
}
[18:57:36.286] Invocation finished in 1h17m26.104758715s with status SUCCEEDED