[17:00:44.224] New invocation is queued and will start shortly
[17:00:45.369] Starting the invocation (attempt 1)
[17:00:45.429] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:00:45.430] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:00:45.430] Buildbucket request:
{
"bucket": "luci.dart.ci.sandbox",
"client_operation_id": "9085872219656198720",
"parameters_json": "{\"builder_name\":\"pkg-win-release\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://dart.googlesource.com/sdk/\",\"revision\":\"385be0cf31938ebdadba92755bae8e049b840d9a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:pkg-win-release",
"scheduler_invocation_id:9085872219656198720",
"scheduler_job_id:dart/pkg-win-release",
"user_agent:luci-scheduler",
"buildset:commit/git/385be0cf31938ebdadba92755bae8e049b840d9a",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/385be0cf31938ebdadba92755bae8e049b840d9a",
"gitiles_ref:refs/heads/master"
]
}
[17:00:47.483] Buildbucket response:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1551200445621809",
"id": "8920442157490554944",
"lease_expiration_ts": "1551319246862909",
"lease_key": "1984451838",
"parameters_json": "{\"builder_name\": \"pkg-win-release\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk/\", \"revision\": \"385be0cf31938ebdadba92755bae8e049b840d9a\"}}",
"project": "dart",
"result_details_json": "{\"properties\": {}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1551200447075648",
"tags": [
"build_address:luci.dart.ci.sandbox/pkg-win-release/4279",
"builder:pkg-win-release",
"buildset:commit/git/385be0cf31938ebdadba92755bae8e049b840d9a",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/385be0cf31938ebdadba92755bae8e049b840d9a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9085872219656198720",
"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/8920442157490554944/+/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:434391f00f6b4110",
"user_agent:luci-scheduler"
],
"updated_ts": "1551200447075798",
"url": "https://ci.chromium.org/b/8920442157490554944",
"utcnow_ts": "1551200447463706"
}
}
[17:00:47.483] Task URL: https://ci.chromium.org/b/8920442157490554944
[17:00:47.483] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:2:0) after 1m0s
[17:01:47.480] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:2:0)
[17:01:47.480] Timer tick, asking Buildbucket for the build status
[17:01:47.620] Build 8920442157490554944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:01:47.621] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:3:0) after 1m0s
[17:02:47.653] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:3:0)
[17:02:47.653] Timer tick, asking Buildbucket for the build status
[17:02:47.806] Build 8920442157490554944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:02:47.806] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:4:0) after 1m0s
[17:03:47.784] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:4:0)
[17:03:47.784] Timer tick, asking Buildbucket for the build status
[17:03:47.882] Build 8920442157490554944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:03:47.882] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:5:0) after 1m0s
[17:04:47.954] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:5:0)
[17:04:47.954] Timer tick, asking Buildbucket for the build status
[17:04:48.030] Build 8920442157490554944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:04:48.030] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:6:0) after 1m0s
[17:05:48.050] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:6:0)
[17:05:48.050] Timer tick, asking Buildbucket for the build status
[17:05:48.117] Build 8920442157490554944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:05:48.117] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:7:0) after 1m0s
[17:06:48.114] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:7:0)
[17:06:48.114] Timer tick, asking Buildbucket for the build status
[17:06:48.212] Build 8920442157490554944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:06:48.212] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:8:0) after 1m0s
[17:07:48.194] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:8:0)
[17:07:48.194] Timer tick, asking Buildbucket for the build status
[17:07:48.286] Build 8920442157490554944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:07:48.286] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:9:0) after 1m0s
[17:08:48.270] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:9:0)
[17:08:48.270] Timer tick, asking Buildbucket for the build status
[17:08:48.353] Build 8920442157490554944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:08:48.353] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:10:0) after 1m0s
[17:09:48.371] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:10:0)
[17:09:48.371] Timer tick, asking Buildbucket for the build status
[17:09:48.428] Build 8920442157490554944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:09:48.428] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:11:0) after 1m0s
[17:10:48.405] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:11:0)
[17:10:48.405] Timer tick, asking Buildbucket for the build status
[17:10:48.469] Build 8920442157490554944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:10:48.469] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:12:0) after 1m0s
[17:11:48.490] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:12:0)
[17:11:48.490] Timer tick, asking Buildbucket for the build status
[17:11:48.547] Build 8920442157490554944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:11:48.547] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:13:0) after 1m0s
[17:12:48.558] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:13:0)
[17:12:48.558] Timer tick, asking Buildbucket for the build status
[17:12:48.603] Build 8920442157490554944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:12:48.603] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:14:0) after 1m0s
[17:13:48.649] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:14:0)
[17:13:48.649] Timer tick, asking Buildbucket for the build status
[17:13:48.703] Build 8920442157490554944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:13:48.703] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:15:0) after 1m0s
[17:14:48.729] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:15:0)
[17:14:48.729] Timer tick, asking Buildbucket for the build status
[17:14:48.798] Build 8920442157490554944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:14:48.798] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:16:0) after 1m0s
[17:15:48.817] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:16:0)
[17:15:48.817] Timer tick, asking Buildbucket for the build status
[17:15:48.899] Build 8920442157490554944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:15:48.899] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:17:0) after 1m0s
[17:16:48.931] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:17:0)
[17:16:48.931] Timer tick, asking Buildbucket for the build status
[17:16:48.983] Build 8920442157490554944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:16:48.983] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:18:0) after 1m0s
[17:17:16.033] Received PubSub notification, asking Buildbucket for the build status
[17:17:16.092] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:48.998] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:18:0)
[17:17:48.998] Timer tick, asking Buildbucket for the build status
[17:17:49.074] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:49.074] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:20:0) after 1m0s
[17:18:49.055] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:20:0)
[17:18:49.055] Timer tick, asking Buildbucket for the build status
[17:18:49.235] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:49.235] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:21:0) after 1m0s
[17:19:49.255] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:21:0)
[17:19:49.255] Timer tick, asking Buildbucket for the build status
[17:19:49.351] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:49.351] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:22:0) after 1m0s
[17:20:49.381] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:22:0)
[17:20:49.381] Timer tick, asking Buildbucket for the build status
[17:20:49.489] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:49.489] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:23:0) after 1m0s
[17:21:49.506] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:23:0)
[17:21:49.506] Timer tick, asking Buildbucket for the build status
[17:21:49.653] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:49.653] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:24:0) after 1m0s
[17:22:49.682] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:24:0)
[17:22:49.682] Timer tick, asking Buildbucket for the build status
[17:22:49.800] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:49.800] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:25:0) after 1m0s
[17:23:49.781] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:25:0)
[17:23:49.781] Timer tick, asking Buildbucket for the build status
[17:23:49.847] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:49.847] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:26:0) after 1m0s
[17:24:49.845] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:26:0)
[17:24:49.845] Timer tick, asking Buildbucket for the build status
[17:24:49.899] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:49.899] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:27:0) after 1m0s
[17:25:49.905] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:27:0)
[17:25:49.905] Timer tick, asking Buildbucket for the build status
[17:25:50.167] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:50.167] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:28:0) after 1m0s
[17:26:50.185] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:28:0)
[17:26:50.185] Timer tick, asking Buildbucket for the build status
[17:26:50.265] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:50.265] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:29:0) after 1m0s
[17:27:50.299] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:29:0)
[17:27:50.299] Timer tick, asking Buildbucket for the build status
[17:27:50.409] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:50.409] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:30:0) after 1m0s
[17:28:50.403] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:30:0)
[17:28:50.403] Timer tick, asking Buildbucket for the build status
[17:28:50.448] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:50.448] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:31:0) after 1m0s
[17:29:50.438] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:31:0)
[17:29:50.438] Timer tick, asking Buildbucket for the build status
[17:29:50.519] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:50.520] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:32:0) after 1m0s
[17:30:50.501] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:32:0)
[17:30:50.501] Timer tick, asking Buildbucket for the build status
[17:30:50.677] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:50.677] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:33:0) after 1m0s
[17:31:50.669] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:33:0)
[17:31:50.669] Timer tick, asking Buildbucket for the build status
[17:31:50.902] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:50.902] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:34:0) after 1m0s
[17:32:50.922] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:34:0)
[17:32:50.922] Timer tick, asking Buildbucket for the build status
[17:32:51.163] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:51.163] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:35:0) after 1m0s
[17:33:51.211] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:35:0)
[17:33:51.211] Timer tick, asking Buildbucket for the build status
[17:33:51.265] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:51.265] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:36:0) after 1m0s
[17:34:51.268] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:36:0)
[17:34:51.268] Timer tick, asking Buildbucket for the build status
[17:34:51.327] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:51.327] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:37:0) after 1m0s
[17:35:51.346] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:37:0)
[17:35:51.346] Timer tick, asking Buildbucket for the build status
[17:35:51.402] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:51.402] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:38:0) after 1m0s
[17:36:51.418] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:38:0)
[17:36:51.418] Timer tick, asking Buildbucket for the build status
[17:36:51.474] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:51.474] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:39:0) after 1m0s
[17:37:51.497] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:39:0)
[17:37:51.497] Timer tick, asking Buildbucket for the build status
[17:37:51.742] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:51.742] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:40:0) after 1m0s
[17:38:51.764] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:40:0)
[17:38:51.764] Timer tick, asking Buildbucket for the build status
[17:38:51.815] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:51.815] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:41:0) after 1m0s
[17:39:51.835] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:41:0)
[17:39:51.835] Timer tick, asking Buildbucket for the build status
[17:39:51.893] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:51.893] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:42:0) after 1m0s
[17:40:51.913] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:42:0)
[17:40:51.913] Timer tick, asking Buildbucket for the build status
[17:40:52.037] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:52.037] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:43:0) after 1m0s
[17:41:52.061] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:43:0)
[17:41:52.061] Timer tick, asking Buildbucket for the build status
[17:41:52.144] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:52.144] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:44:0) after 1m0s
[17:42:52.174] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:44:0)
[17:42:52.174] Timer tick, asking Buildbucket for the build status
[17:42:52.279] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:52.279] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:45:0) after 1m0s
[17:43:52.280] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:45:0)
[17:43:52.280] Timer tick, asking Buildbucket for the build status
[17:43:52.407] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:52.407] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:46:0) after 1m0s
[17:44:52.432] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:46:0)
[17:44:52.432] Timer tick, asking Buildbucket for the build status
[17:44:52.503] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:52.503] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:47:0) after 1m0s
[17:45:52.642] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:47:0)
[17:45:52.642] Timer tick, asking Buildbucket for the build status
[17:45:52.887] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:52.887] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:48:0) after 1m0s
[17:46:52.891] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:48:0)
[17:46:52.891] Timer tick, asking Buildbucket for the build status
[17:46:53.017] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:53.017] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:49:0) after 1m0s
[17:47:53.058] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:49:0)
[17:47:53.058] Timer tick, asking Buildbucket for the build status
[17:47:53.107] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:53.107] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:50:0) after 1m0s
[17:48:53.103] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:50:0)
[17:48:53.103] Timer tick, asking Buildbucket for the build status
[17:48:53.193] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:53.193] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:51:0) after 1m0s
[17:49:53.174] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:51:0)
[17:49:53.174] Timer tick, asking Buildbucket for the build status
[17:49:53.285] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:53.285] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:52:0) after 1m0s
[17:50:53.273] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:52:0)
[17:50:53.273] Timer tick, asking Buildbucket for the build status
[17:50:53.388] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:53.388] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:53:0) after 1m0s
[17:51:53.369] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:53:0)
[17:51:53.369] Timer tick, asking Buildbucket for the build status
[17:51:53.410] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:53.410] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:54:0) after 1m0s
[17:52:53.410] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:54:0)
[17:52:53.410] Timer tick, asking Buildbucket for the build status
[17:52:53.490] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:53.490] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:55:0) after 1m0s
[17:53:53.512] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:55:0)
[17:53:53.512] Timer tick, asking Buildbucket for the build status
[17:53:53.664] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:53.664] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:56:0) after 1m0s
[17:54:53.649] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:56:0)
[17:54:53.649] Timer tick, asking Buildbucket for the build status
[17:54:53.699] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:53.700] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:57:0) after 1m0s
[17:55:53.721] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:57:0)
[17:55:53.721] Timer tick, asking Buildbucket for the build status
[17:55:53.774] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:53.774] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:58:0) after 1m0s
[17:56:53.813] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:58:0)
[17:56:53.813] Timer tick, asking Buildbucket for the build status
[17:56:53.920] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:53.920] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:59:0) after 1m0s
[17:57:53.952] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:59:0)
[17:57:53.952] Timer tick, asking Buildbucket for the build status
[17:57:53.995] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:53.995] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:60:0) after 1m0s
[17:58:54.004] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:60:0)
[17:58:54.004] Timer tick, asking Buildbucket for the build status
[17:58:54.050] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:54.050] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:61:0) after 1m0s
[17:59:54.037] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:61:0)
[17:59:54.037] Timer tick, asking Buildbucket for the build status
[17:59:54.119] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:54.119] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:62:0) after 1m0s
[18:00:54.139] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:62:0)
[18:00:54.139] Timer tick, asking Buildbucket for the build status
[18:00:54.195] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:54.195] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:63:0) after 1m0s
[18:01:54.225] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:63:0)
[18:01:54.225] Timer tick, asking Buildbucket for the build status
[18:01:54.393] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:54.393] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:64:0) after 1m0s
[18:02:54.417] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:64:0)
[18:02:54.417] Timer tick, asking Buildbucket for the build status
[18:02:54.494] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:54.494] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:65:0) after 1m0s
[18:03:54.514] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:65:0)
[18:03:54.514] Timer tick, asking Buildbucket for the build status
[18:03:54.666] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:54.666] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:66:0) after 1m0s
[18:04:54.668] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:66:0)
[18:04:54.668] Timer tick, asking Buildbucket for the build status
[18:04:54.738] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:54.738] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:67:0) after 1m0s
[18:05:54.723] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:67:0)
[18:05:54.723] Timer tick, asking Buildbucket for the build status
[18:05:54.779] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:54.779] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:68:0) after 1m0s
[18:06:54.797] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:68:0)
[18:06:54.797] Timer tick, asking Buildbucket for the build status
[18:06:54.868] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:54.868] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:69:0) after 1m0s
[18:07:54.886] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:69:0)
[18:07:54.886] Timer tick, asking Buildbucket for the build status
[18:07:54.937] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:54.937] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:70:0) after 1m0s
[18:08:54.967] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:70:0)
[18:08:54.967] Timer tick, asking Buildbucket for the build status
[18:08:55.037] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:55.037] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:71:0) after 1m0s
[18:09:55.048] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:71:0)
[18:09:55.048] Timer tick, asking Buildbucket for the build status
[18:09:55.189] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:55.189] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:72:0) after 1m0s
[18:10:55.210] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:72:0)
[18:10:55.210] Timer tick, asking Buildbucket for the build status
[18:10:55.252] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:55.252] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:73:0) after 1m0s
[18:11:55.266] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:73:0)
[18:11:55.266] Timer tick, asking Buildbucket for the build status
[18:11:55.409] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:55.409] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:74:0) after 1m0s
[18:12:55.438] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:74:0)
[18:12:55.438] Timer tick, asking Buildbucket for the build status
[18:12:55.522] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:55.522] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:75:0) after 1m0s
[18:13:55.600] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:75:0)
[18:13:55.600] Timer tick, asking Buildbucket for the build status
[18:14:04.420] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:04.420] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:76:0) after 1m0s
[18:15:04.437] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:76:0)
[18:15:04.437] Timer tick, asking Buildbucket for the build status
[18:15:04.518] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:04.518] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:77:0) after 1m0s
[18:16:04.580] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:77:0)
[18:16:04.580] Timer tick, asking Buildbucket for the build status
[18:16:04.746] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:04.746] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:78:0) after 1m0s
[18:17:04.766] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:78:0)
[18:17:04.766] Timer tick, asking Buildbucket for the build status
[18:17:05.011] Build 8920442157490554944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:05.011] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9085872219656198720:79:0) after 1m0s
[18:17:41.046] Received PubSub notification, asking Buildbucket for the build status
[18:17:41.105] Build 8920442157490554944: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:17:41.105] Buildbucket build:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "AUTO",
"completed_ts": "1551205060025182",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1551200445621809",
"id": "8920442157490554944",
"parameters_json": "{\"builder_name\": \"pkg-win-release\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk/\", \"revision\": \"385be0cf31938ebdadba92755bae8e049b840d9a\"}}",
"project": "dart",
"result": "SUCCESS",
"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\": [\"4129-0985e08\"], \"machine_type\": [\"n1-standard-8\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"integrity\": [\"high\"], \"id\": [\"win10-dart-fedce810-us-central1-c-jg4j\"], \"pool\": [\"dart.tests\", \"luci.dart.try\"], \"caches\": [\"builder_1c0ef31f5f8d1f18f7fd8c84ad96f89f648d151bb815f45fcb9371a45c954f04_v2\", \"git\", \"goma_v2\", \"swarming_module_cache_vpython\", \"vpython\"]}}, \"ui\": {\"info\": \"\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"buildnumber\": 4279, \"$recipe_engine/buildbucket\": {\"build\": {\"tags\": [{\"value\": \"pkg-win-release\", \"key\": \"builder\"}, {\"value\": \"commit/git/385be0cf31938ebdadba92755bae8e049b840d9a\", \"key\": \"buildset\"}, {\"value\": \"commit/gitiles/dart.googlesource.com/sdk/+/385be0cf31938ebdadba92755bae8e049b840d9a\", \"key\": \"buildset\"}, {\"value\": \"9085872219656198720\", \"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\": 4279, \"infra\": {\"buildbucket\": {\"serviceConfigRevision\": \"aed94bdb6fa0b2abb2bed1ef8ed7b1a334781d31\"}, \"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\": \"8920442157490554944\", \"input\": {\"gitilesCommit\": {\"project\": \"sdk\", \"host\": \"dart.googlesource.com\", \"ref\": \"refs/heads/master\", \"id\": \"385be0cf31938ebdadba92755bae8e049b840d9a\"}}, \"createTime\": \"2019-02-26T17:00:45.621809Z\"}}, \"repository\": \"https://dart.googlesource.com/sdk/\", \"buildername\": \"pkg-win-release\", \"new_workflow_enabled\": true, \"got_revision\": \"385be0cf31938ebdadba92755bae8e049b840d9a\", \"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\": 1551200445621809, \"tags\": [\"build_address:luci.dart.ci.sandbox/pkg-win-release/4279\", \"builder:pkg-win-release\", \"buildset:commit/git/385be0cf31938ebdadba92755bae8e049b840d9a\", \"buildset:commit/gitiles/dart.googlesource.com/sdk/+/385be0cf31938ebdadba92755bae8e049b840d9a\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9085872219656198720\", \"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\": \"8920442157490554944\"}}, \"branch\": \"refs/heads/master\", \"path_config\": \"generic\", \"revision\": \"385be0cf31938ebdadba92755bae8e049b840d9a\", \"bot_id\": \"win10-dart-fedce810-us-central1-c-jg4j\"}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"started_ts": "1551201435246714",
"status": "COMPLETED",
"status_changed_ts": "1551205060768724",
"tags": [
"build_address:luci.dart.ci.sandbox/pkg-win-release/4279",
"builder:pkg-win-release",
"buildset:commit/git/385be0cf31938ebdadba92755bae8e049b840d9a",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/385be0cf31938ebdadba92755bae8e049b840d9a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9085872219656198720",
"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/8920442157490554944/+/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:434391f00f6b4110",
"user_agent:luci-scheduler"
],
"updated_ts": "1551205060770468",
"url": "https://ci.chromium.org/b/8920442157490554944",
"utcnow_ts": "1551205061091862"
}
}
[18:17:41.105] Invocation finished in 1h16m56.932371384s with status SUCCEEDED