[01:23:34.312] New invocation is queued and will start shortly
[01:23:35.532] Starting the invocation (attempt 1)
[01:23:35.570] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:23:35.571] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:23:35.571] Buildbucket request:
{
"bucket": "luci.dart.ci.sandbox",
"client_operation_id": "9087018344554576192",
"parameters_json": "{\"builder_name\":\"pkg-win-release\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://dart.googlesource.com/sdk/\",\"revision\":\"92460b8923898af97c4ac388b3912ef29be25dbf\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:pkg-win-release",
"scheduler_invocation_id:9087018344554576192",
"scheduler_job_id:dart/pkg-win-release",
"user_agent:luci-scheduler",
"buildset:commit/git/92460b8923898af97c4ac388b3912ef29be25dbf",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/92460b8923898af97c4ac388b3912ef29be25dbf",
"gitiles_ref:refs/heads/master"
]
}
[01:23:37.127] Buildbucket response:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1550107416131153",
"id": "8921588281980992800",
"lease_expiration_ts": "1550226216767639",
"lease_key": "792739205",
"parameters_json": "{\"builder_name\": \"pkg-win-release\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk/\", \"revision\": \"92460b8923898af97c4ac388b3912ef29be25dbf\"}}",
"project": "dart",
"result_details_json": "{\"properties\": {}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1550107417015283",
"tags": [
"build_address:luci.dart.ci.sandbox/pkg-win-release/4134",
"builder:pkg-win-release",
"buildset:commit/git/92460b8923898af97c4ac388b3912ef29be25dbf",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/92460b8923898af97c4ac388b3912ef29be25dbf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9087018344554576192",
"scheduler_job_id:dart/pkg-win-release",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/dart/buildbucket/cr-buildbucket.appspot.com/8921588281980992800/+/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:43026b9fd8519f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1550107417015404",
"url": "https://ci.chromium.org/b/8921588281980992800",
"utcnow_ts": "1550107417113514"
}
}
[01:23:37.127] Task URL: https://ci.chromium.org/b/8921588281980992800
[01:23:37.127] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:2:0) after 1m0s
[01:24:37.145] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:2:0)
[01:24:37.145] Timer tick, asking Buildbucket for the build status
[01:24:37.606] Build 8921588281980992800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:24:37.606] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:3:0) after 1m0s
[01:25:37.621] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:3:0)
[01:25:37.621] Timer tick, asking Buildbucket for the build status
[01:25:37.727] Build 8921588281980992800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:25:37.727] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:4:0) after 1m0s
[01:26:37.743] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:4:0)
[01:26:37.743] Timer tick, asking Buildbucket for the build status
[01:26:37.933] Build 8921588281980992800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:26:37.933] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:5:0) after 1m0s
[01:27:37.948] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:5:0)
[01:27:37.948] Timer tick, asking Buildbucket for the build status
[01:27:38.077] Build 8921588281980992800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:27:38.077] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:6:0) after 1m0s
[01:28:38.096] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:6:0)
[01:28:38.096] Timer tick, asking Buildbucket for the build status
[01:28:39.247] Build 8921588281980992800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:28:39.247] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:7:0) after 1m0s
[01:29:39.264] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:7:0)
[01:29:39.264] Timer tick, asking Buildbucket for the build status
[01:29:39.961] Build 8921588281980992800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:29:39.961] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:8:0) after 1m0s
[01:30:39.979] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:8:0)
[01:30:39.979] Timer tick, asking Buildbucket for the build status
[01:30:40.132] Build 8921588281980992800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:30:40.132] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:9:0) after 1m0s
[01:31:40.149] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:9:0)
[01:31:40.149] Timer tick, asking Buildbucket for the build status
[01:31:41.188] Build 8921588281980992800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:31:41.188] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:10:0) after 1m0s
[01:32:41.205] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:10:0)
[01:32:41.205] Timer tick, asking Buildbucket for the build status
[01:32:41.454] Build 8921588281980992800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:32:41.454] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:11:0) after 1m0s
[01:33:41.495] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:11:0)
[01:33:41.495] Timer tick, asking Buildbucket for the build status
[01:33:41.557] Build 8921588281980992800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:33:41.557] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:12:0) after 1m0s
[01:34:41.581] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:12:0)
[01:34:41.581] Timer tick, asking Buildbucket for the build status
[01:34:42.323] Build 8921588281980992800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:34:42.323] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:13:0) after 1m0s
[01:35:42.343] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:13:0)
[01:35:42.343] Timer tick, asking Buildbucket for the build status
[01:35:42.678] Build 8921588281980992800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:35:42.678] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:14:0) after 1m0s
[01:36:42.693] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:14:0)
[01:36:42.693] Timer tick, asking Buildbucket for the build status
[01:36:42.904] Build 8921588281980992800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:36:42.904] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:15:0) after 1m0s
[01:37:42.925] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:15:0)
[01:37:42.925] Timer tick, asking Buildbucket for the build status
[01:37:43.151] Build 8921588281980992800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:37:43.151] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:16:0) after 1m0s
[01:38:43.171] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:16:0)
[01:38:43.171] Timer tick, asking Buildbucket for the build status
[01:38:43.242] Build 8921588281980992800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:38:43.242] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:17:0) after 1m0s
[01:39:43.258] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:17:0)
[01:39:43.258] Timer tick, asking Buildbucket for the build status
[01:39:43.666] Build 8921588281980992800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:39:43.666] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:18:0) after 1m0s
[01:40:43.685] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:18:0)
[01:40:43.685] Timer tick, asking Buildbucket for the build status
[01:40:43.794] Build 8921588281980992800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:40:43.794] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:19:0) after 1m0s
[01:41:41.158] Received PubSub notification, asking Buildbucket for the build status
[01:41:42.157] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:43.814] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:19:0)
[01:41:43.814] Timer tick, asking Buildbucket for the build status
[01:41:44.105] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:44.105] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:21:0) after 1m0s
[01:42:44.131] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:21:0)
[01:42:44.131] Timer tick, asking Buildbucket for the build status
[01:42:44.237] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:44.238] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:22:0) after 1m0s
[01:43:44.272] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:22:0)
[01:43:44.272] Timer tick, asking Buildbucket for the build status
[01:43:44.455] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:44.455] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:23:0) after 1m0s
[01:44:44.472] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:23:0)
[01:44:44.472] Timer tick, asking Buildbucket for the build status
[01:44:44.778] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:44.778] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:24:0) after 1m0s
[01:45:44.795] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:24:0)
[01:45:44.795] Timer tick, asking Buildbucket for the build status
[01:45:45.154] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:45.154] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:25:0) after 1m0s
[01:46:45.175] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:25:0)
[01:46:45.175] Timer tick, asking Buildbucket for the build status
[01:46:45.435] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:45.435] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:26:0) after 1m0s
[01:47:45.455] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:26:0)
[01:47:45.455] Timer tick, asking Buildbucket for the build status
[01:47:45.559] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:45.559] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:27:0) after 1m0s
[01:48:45.577] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:27:0)
[01:48:45.577] Timer tick, asking Buildbucket for the build status
[01:48:45.793] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:45.793] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:28:0) after 1m0s
[01:49:45.887] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:28:0)
[01:49:45.887] Timer tick, asking Buildbucket for the build status
[01:49:45.955] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:45.955] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:29:0) after 1m0s
[01:50:45.971] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:29:0)
[01:50:45.971] Timer tick, asking Buildbucket for the build status
[01:50:46.196] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:46.196] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:30:0) after 1m0s
[01:51:46.224] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:30:0)
[01:51:46.224] Timer tick, asking Buildbucket for the build status
[01:51:46.334] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:46.334] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:31:0) after 1m0s
[01:52:46.354] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:31:0)
[01:52:46.354] Timer tick, asking Buildbucket for the build status
[01:52:46.403] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:46.403] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:32:0) after 1m0s
[01:53:46.454] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:32:0)
[01:53:46.454] Timer tick, asking Buildbucket for the build status
[01:53:46.646] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:46.646] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:33:0) after 1m0s
[01:54:46.661] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:33:0)
[01:54:46.661] Timer tick, asking Buildbucket for the build status
[01:54:46.758] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:46.758] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:34:0) after 1m0s
[01:55:46.809] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:34:0)
[01:55:46.809] Timer tick, asking Buildbucket for the build status
[01:55:46.888] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:46.888] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:35:0) after 1m0s
[01:56:46.978] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:35:0)
[01:56:46.978] Timer tick, asking Buildbucket for the build status
[01:56:47.099] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:47.099] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:36:0) after 1m0s
[01:57:47.118] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:36:0)
[01:57:47.118] Timer tick, asking Buildbucket for the build status
[01:57:47.164] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:47.164] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:37:0) after 1m0s
[01:58:47.189] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:37:0)
[01:58:47.189] Timer tick, asking Buildbucket for the build status
[01:58:47.299] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:47.299] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:38:0) after 1m0s
[01:59:47.318] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:38:0)
[01:59:47.318] Timer tick, asking Buildbucket for the build status
[01:59:47.388] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:47.388] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:39:0) after 1m0s
[02:00:47.442] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:39:0)
[02:00:47.442] Timer tick, asking Buildbucket for the build status
[02:00:47.585] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:47.586] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:40:0) after 1m0s
[02:01:47.605] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:40:0)
[02:01:47.605] Timer tick, asking Buildbucket for the build status
[02:01:47.663] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:47.663] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:41:0) after 1m0s
[02:02:47.683] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:41:0)
[02:02:47.683] Timer tick, asking Buildbucket for the build status
[02:02:47.736] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:47.736] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:42:0) after 1m0s
[02:03:47.755] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:42:0)
[02:03:47.755] Timer tick, asking Buildbucket for the build status
[02:03:47.828] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:47.828] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:43:0) after 1m0s
[02:04:47.848] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:43:0)
[02:04:47.848] Timer tick, asking Buildbucket for the build status
[02:04:47.896] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:47.896] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:44:0) after 1m0s
[02:05:47.917] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:44:0)
[02:05:47.917] Timer tick, asking Buildbucket for the build status
[02:05:47.977] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:47.977] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:45:0) after 1m0s
[02:06:48.010] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:45:0)
[02:06:48.010] Timer tick, asking Buildbucket for the build status
[02:06:48.193] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:48.193] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:46:0) after 1m0s
[02:07:48.213] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:46:0)
[02:07:48.213] Timer tick, asking Buildbucket for the build status
[02:07:48.265] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:48.265] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:47:0) after 1m0s
[02:08:48.287] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:47:0)
[02:08:48.287] Timer tick, asking Buildbucket for the build status
[02:08:48.336] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:48.336] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:48:0) after 1m0s
[02:09:48.405] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:48:0)
[02:09:48.405] Timer tick, asking Buildbucket for the build status
[02:09:48.466] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:48.466] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:49:0) after 1m0s
[02:10:48.484] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:49:0)
[02:10:48.484] Timer tick, asking Buildbucket for the build status
[02:10:48.548] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:48.548] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:50:0) after 1m0s
[02:11:48.571] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:50:0)
[02:11:48.572] Timer tick, asking Buildbucket for the build status
[02:11:48.673] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:48.673] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:51:0) after 1m0s
[02:12:48.691] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:51:0)
[02:12:48.691] Timer tick, asking Buildbucket for the build status
[02:12:48.798] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:48.798] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:52:0) after 1m0s
[02:13:48.815] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:52:0)
[02:13:48.815] Timer tick, asking Buildbucket for the build status
[02:13:48.900] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:48.900] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:53:0) after 1m0s
[02:14:48.921] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:53:0)
[02:14:48.921] Timer tick, asking Buildbucket for the build status
[02:14:48.975] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:48.975] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:54:0) after 1m0s
[02:15:48.995] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:54:0)
[02:15:48.995] Timer tick, asking Buildbucket for the build status
[02:15:49.042] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:49.042] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:55:0) after 1m0s
[02:16:49.078] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:55:0)
[02:16:49.078] Timer tick, asking Buildbucket for the build status
[02:16:49.131] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:49.131] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:56:0) after 1m0s
[02:17:49.161] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:56:0)
[02:17:49.161] Timer tick, asking Buildbucket for the build status
[02:17:49.247] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:49.247] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:57:0) after 1m0s
[02:18:49.265] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:57:0)
[02:18:49.265] Timer tick, asking Buildbucket for the build status
[02:18:49.319] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:49.319] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:58:0) after 1m0s
[02:19:49.385] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:58:0)
[02:19:49.385] Timer tick, asking Buildbucket for the build status
[02:19:49.472] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:49.472] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:59:0) after 1m0s
[02:20:49.492] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:59:0)
[02:20:49.493] Timer tick, asking Buildbucket for the build status
[02:20:49.573] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:49.573] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:60:0) after 1m0s
[02:21:49.591] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:60:0)
[02:21:49.591] Timer tick, asking Buildbucket for the build status
[02:21:49.714] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:49.714] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:61:0) after 1m0s
[02:22:49.735] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:61:0)
[02:22:49.735] Timer tick, asking Buildbucket for the build status
[02:22:49.780] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:49.780] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:62:0) after 1m0s
[02:23:49.818] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:62:0)
[02:23:49.818] Timer tick, asking Buildbucket for the build status
[02:23:49.854] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:49.854] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:63:0) after 1m0s
[02:24:49.873] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:63:0)
[02:24:49.873] Timer tick, asking Buildbucket for the build status
[02:24:50.297] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:50.297] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:64:0) after 1m0s
[02:25:50.390] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:64:0)
[02:25:50.390] Timer tick, asking Buildbucket for the build status
[02:25:50.472] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:50.472] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:65:0) after 1m0s
[02:26:50.490] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:65:0)
[02:26:50.490] Timer tick, asking Buildbucket for the build status
[02:26:50.777] Build 8921588281980992800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:50.777] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9087018344554576192:66:0) after 1m0s
[02:27:34.513] Received PubSub notification, asking Buildbucket for the build status
[02:27:34.559] Build 8921588281980992800: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[02:27:34.559] Buildbucket build:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "AUTO",
"completed_ts": "1550111253500238",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1550107416131153",
"failure_reason": "BUILD_FAILURE",
"id": "8921588281980992800",
"parameters_json": "{\"builder_name\": \"pkg-win-release\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk/\", \"revision\": \"92460b8923898af97c4ac388b3912ef29be25dbf\"}}",
"project": "dart",
"result": "FAILURE",
"result_details_json": "{\"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"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\": [\"4098-34330fc\"], \"machine_type\": [\"n1-standard-8\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"integrity\": [\"high\"], \"id\": [\"win10-dart-fedce810-us-central1-c-skz5\"], \"pool\": [\"dart.tests\", \"luci.dart.try\"], \"caches\": [\"builder_1c0ef31f5f8d1f18f7fd8c84ad96f89f648d151bb815f45fcb9371a45c954f04_v2\", \"builder_25ee1422577e844c44bbdff63b591f09ef27a58893168e9dc9dc636d175a9801_v2\", \"git\", \"goma_v2\", \"swarming_module_cache_vpython\", \"vpython\"]}}, \"ui\": {\"info\": \"Failure test results\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"buildnumber\": 4134, \"$recipe_engine/buildbucket\": {\"build\": {\"tags\": [{\"value\": \"pkg-win-release\", \"key\": \"builder\"}, {\"value\": \"commit/git/92460b8923898af97c4ac388b3912ef29be25dbf\", \"key\": \"buildset\"}, {\"value\": \"commit/gitiles/dart.googlesource.com/sdk/+/92460b8923898af97c4ac388b3912ef29be25dbf\", \"key\": \"buildset\"}, {\"value\": \"9087018344554576192\", \"key\": \"scheduler_invocation_id\"}, {\"value\": \"dart/pkg-win-release\", \"key\": \"scheduler_job_id\"}, {\"value\": \"luci-scheduler\", \"key\": \"user_agent\"}], \"builder\": {\"project\": \"dart\", \"builder\": \"pkg-win-release\", \"bucket\": \"ci.sandbox\"}, \"number\": 4134, \"infra\": {\"buildbucket\": {\"serviceConfigRevision\": \"6aef5327da3458f30853917b657b22c0910618fa\"}, \"recipe\": {\"name\": \"dart/neo\", \"cipdPackage\": \"infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build\"}, \"swarming\": {\"hostname\": \"chromium-swarm.appspot.com\"}}, \"createdBy\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"id\": \"8921588281980992800\", \"input\": {\"gitilesCommit\": {\"project\": \"sdk\", \"host\": \"dart.googlesource.com\", \"ref\": \"refs/heads/master\", \"id\": \"92460b8923898af97c4ac388b3912ef29be25dbf\"}}, \"createTime\": \"2019-02-14T01:23:36.131153Z\"}}, \"repository\": \"https://dart.googlesource.com/sdk/\", \"buildername\": \"pkg-win-release\", \"new_workflow_enabled\": true, \"got_revision\": \"92460b8923898af97c4ac388b3912ef29be25dbf\", \"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\": 1550107416131153, \"tags\": [\"build_address:luci.dart.ci.sandbox/pkg-win-release/4134\", \"builder:pkg-win-release\", \"buildset:commit/git/92460b8923898af97c4ac388b3912ef29be25dbf\", \"buildset:commit/gitiles/dart.googlesource.com/sdk/+/92460b8923898af97c4ac388b3912ef29be25dbf\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9087018344554576192\", \"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\": \"8921588281980992800\"}}, \"branch\": \"refs/heads/master\", \"path_config\": \"generic\", \"revision\": \"92460b8923898af97c4ac388b3912ef29be25dbf\", \"bot_id\": \"win10-dart-fedce810-us-central1-c-skz5\"}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"started_ts": "1550108500432328",
"status": "COMPLETED",
"status_changed_ts": "1550111254145359",
"tags": [
"build_address:luci.dart.ci.sandbox/pkg-win-release/4134",
"builder:pkg-win-release",
"buildset:commit/git/92460b8923898af97c4ac388b3912ef29be25dbf",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/92460b8923898af97c4ac388b3912ef29be25dbf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9087018344554576192",
"scheduler_job_id:dart/pkg-win-release",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/dart/buildbucket/cr-buildbucket.appspot.com/8921588281980992800/+/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:43026b9fd8519f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1550111254147601",
"url": "https://ci.chromium.org/b/8921588281980992800",
"utcnow_ts": "1550111254549555"
}
}
[02:27:34.559] Invocation finished in 1h4m0.266023761s with status FAILED