[01:07:56.196] New invocation is queued and will start shortly
[01:07:57.572] Starting the invocation (attempt 1)
[01:07:57.654] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:07:57.654] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:07:57.654] Buildbucket request:
{
"bucket": "luci.dart.ci.sandbox",
"client_operation_id": "9086475746440944624",
"parameters_json": "{\"builder_name\":\"analyzer-win-release\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://dart.googlesource.com/sdk/\",\"revision\":\"b83bcf59f27abae54dd69134a320db02b3e76748\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:analyzer-win-release",
"scheduler_invocation_id:9086475746440944624",
"scheduler_job_id:dart/analyzer-win-release",
"user_agent:luci-scheduler",
"buildset:commit/git/b83bcf59f27abae54dd69134a320db02b3e76748",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/b83bcf59f27abae54dd69134a320db02b3e76748",
"gitiles_ref:refs/heads/master"
]
}
[01:07:58.918] Buildbucket response:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1550624877753177",
"id": "8921045684143509712",
"lease_expiration_ts": "1550743678650563",
"lease_key": "659123689",
"parameters_json": "{\"builder_name\": \"analyzer-win-release\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk/\", \"revision\": \"b83bcf59f27abae54dd69134a320db02b3e76748\"}}",
"project": "dart",
"result_details_json": "{\"properties\": {}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1550624878812305",
"tags": [
"build_address:luci.dart.ci.sandbox/analyzer-win-release/4428",
"builder:analyzer-win-release",
"buildset:commit/git/b83bcf59f27abae54dd69134a320db02b3e76748",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/b83bcf59f27abae54dd69134a320db02b3e76748",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9086475746440944624",
"scheduler_job_id:dart/analyzer-win-release",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/dart/buildbucket/cr-buildbucket.appspot.com/8921045684143509712/+/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:432143774ef8b210",
"user_agent:luci-scheduler"
],
"updated_ts": "1550624878812412",
"url": "https://ci.chromium.org/b/8921045684143509712",
"utcnow_ts": "1550624878907608"
}
}
[01:07:58.918] Task URL: https://ci.chromium.org/b/8921045684143509712
[01:07:58.918] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:2:0) after 1m0s
[01:08:58.943] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:2:0)
[01:08:58.943] Timer tick, asking Buildbucket for the build status
[01:08:59.019] Build 8921045684143509712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:08:59.019] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:3:0) after 1m0s
[01:09:59.038] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:3:0)
[01:09:59.038] Timer tick, asking Buildbucket for the build status
[01:09:59.126] Build 8921045684143509712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:09:59.126] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:4:0) after 1m0s
[01:10:59.146] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:4:0)
[01:10:59.146] Timer tick, asking Buildbucket for the build status
[01:10:59.319] Build 8921045684143509712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:10:59.319] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:5:0) after 1m0s
[01:11:59.336] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:5:0)
[01:11:59.336] Timer tick, asking Buildbucket for the build status
[01:11:59.382] Build 8921045684143509712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:11:59.382] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:6:0) after 1m0s
[01:12:59.400] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:6:0)
[01:12:59.400] Timer tick, asking Buildbucket for the build status
[01:12:59.451] Build 8921045684143509712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:12:59.451] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:7:0) after 1m0s
[01:13:59.467] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:7:0)
[01:13:59.467] Timer tick, asking Buildbucket for the build status
[01:13:59.549] Build 8921045684143509712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:13:59.549] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:8:0) after 1m0s
[01:14:59.566] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:8:0)
[01:14:59.566] Timer tick, asking Buildbucket for the build status
[01:14:59.642] Build 8921045684143509712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:14:59.642] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:9:0) after 1m0s
[01:15:59.670] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:9:0)
[01:15:59.670] Timer tick, asking Buildbucket for the build status
[01:15:59.722] Build 8921045684143509712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:15:59.722] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:10:0) after 1m0s
[01:16:59.787] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:10:0)
[01:16:59.787] Timer tick, asking Buildbucket for the build status
[01:16:59.838] Build 8921045684143509712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:16:59.838] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:11:0) after 1m0s
[01:17:59.857] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:11:0)
[01:17:59.857] Timer tick, asking Buildbucket for the build status
[01:17:59.928] Build 8921045684143509712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:17:59.928] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:12:0) after 1m0s
[01:18:59.948] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:12:0)
[01:18:59.948] Timer tick, asking Buildbucket for the build status
[01:19:00.017] Build 8921045684143509712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:19:00.017] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:13:0) after 1m0s
[01:20:00.045] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:13:0)
[01:20:00.045] Timer tick, asking Buildbucket for the build status
[01:20:00.121] Build 8921045684143509712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:20:00.121] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:14:0) after 1m0s
[01:21:00.140] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:14:0)
[01:21:00.140] Timer tick, asking Buildbucket for the build status
[01:21:00.269] Build 8921045684143509712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:21:00.269] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:15:0) after 1m0s
[01:22:00.311] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:15:0)
[01:22:00.311] Timer tick, asking Buildbucket for the build status
[01:22:00.383] Build 8921045684143509712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:22:00.383] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:16:0) after 1m0s
[01:22:01.081] Received PubSub notification, asking Buildbucket for the build status
[01:22:01.146] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:00.408] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:16:0)
[01:23:00.408] Timer tick, asking Buildbucket for the build status
[01:23:00.491] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:00.491] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:18:0) after 1m0s
[01:24:00.511] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:18:0)
[01:24:00.511] Timer tick, asking Buildbucket for the build status
[01:24:00.611] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:00.611] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:19:0) after 1m0s
[01:25:00.632] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:19:0)
[01:25:00.632] Timer tick, asking Buildbucket for the build status
[01:25:00.732] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:00.732] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:20:0) after 1m0s
[01:26:00.749] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:20:0)
[01:26:00.749] Timer tick, asking Buildbucket for the build status
[01:26:00.902] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:00.902] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:21:0) after 1m0s
[01:27:00.929] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:21:0)
[01:27:00.929] Timer tick, asking Buildbucket for the build status
[01:27:01.002] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:01.002] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:22:0) after 1m0s
[01:28:01.027] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:22:0)
[01:28:01.027] Timer tick, asking Buildbucket for the build status
[01:28:01.087] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:01.087] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:23:0) after 1m0s
[01:29:01.106] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:23:0)
[01:29:01.106] Timer tick, asking Buildbucket for the build status
[01:29:01.211] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:01.211] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:24:0) after 1m0s
[01:30:01.288] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:24:0)
[01:30:01.288] Timer tick, asking Buildbucket for the build status
[01:30:01.475] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:01.475] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:25:0) after 1m0s
[01:31:01.494] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:25:0)
[01:31:01.494] Timer tick, asking Buildbucket for the build status
[01:31:02.117] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:02.117] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:26:0) after 1m0s
[01:32:02.150] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:26:0)
[01:32:02.150] Timer tick, asking Buildbucket for the build status
[01:32:02.405] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:02.405] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:27:0) after 1m0s
[01:33:02.425] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:27:0)
[01:33:02.425] Timer tick, asking Buildbucket for the build status
[01:33:02.472] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:02.473] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:28:0) after 1m0s
[01:34:02.499] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:28:0)
[01:34:02.499] Timer tick, asking Buildbucket for the build status
[01:34:02.541] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:02.541] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:29:0) after 1m0s
[01:35:02.559] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:29:0)
[01:35:02.559] Timer tick, asking Buildbucket for the build status
[01:35:02.631] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:02.631] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:30:0) after 1m0s
[01:36:02.651] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:30:0)
[01:36:02.652] Timer tick, asking Buildbucket for the build status
[01:36:02.742] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:02.742] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:31:0) after 1m0s
[01:37:02.764] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:31:0)
[01:37:02.764] Timer tick, asking Buildbucket for the build status
[01:37:03.089] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:03.089] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:32:0) after 1m0s
[01:38:03.108] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:32:0)
[01:38:03.108] Timer tick, asking Buildbucket for the build status
[01:38:03.473] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:03.473] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:33:0) after 1m0s
[01:39:03.492] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:33:0)
[01:39:03.492] Timer tick, asking Buildbucket for the build status
[01:39:03.590] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:03.590] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:34:0) after 1m0s
[01:40:03.609] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:34:0)
[01:40:03.609] Timer tick, asking Buildbucket for the build status
[01:40:03.730] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:03.730] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:35:0) after 1m0s
[01:41:03.749] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:35:0)
[01:41:03.749] Timer tick, asking Buildbucket for the build status
[01:41:04.574] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:04.574] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:36:0) after 1m0s
[01:42:04.592] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:36:0)
[01:42:04.592] Timer tick, asking Buildbucket for the build status
[01:42:04.759] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:04.759] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:37:0) after 1m0s
[01:43:04.788] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:37:0)
[01:43:04.788] Timer tick, asking Buildbucket for the build status
[01:43:05.135] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:05.135] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:38:0) after 1m0s
[01:44:05.153] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:38:0)
[01:44:05.153] Timer tick, asking Buildbucket for the build status
[01:44:05.293] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:05.293] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:39:0) after 1m0s
[01:45:05.312] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:39:0)
[01:45:05.312] Timer tick, asking Buildbucket for the build status
[01:45:05.682] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:05.682] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:40:0) after 1m0s
[01:46:05.699] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:40:0)
[01:46:05.699] Timer tick, asking Buildbucket for the build status
[01:46:05.748] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:05.748] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:41:0) after 1m0s
[01:47:05.767] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:41:0)
[01:47:05.767] Timer tick, asking Buildbucket for the build status
[01:47:05.828] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:05.828] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:42:0) after 1m0s
[01:48:05.845] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:42:0)
[01:48:05.845] Timer tick, asking Buildbucket for the build status
[01:48:05.976] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:05.976] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:43:0) after 1m0s
[01:49:05.999] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:43:0)
[01:49:05.999] Timer tick, asking Buildbucket for the build status
[01:49:06.037] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:06.037] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:44:0) after 1m0s
[01:50:06.057] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:44:0)
[01:50:06.057] Timer tick, asking Buildbucket for the build status
[01:50:06.199] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:06.199] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:45:0) after 1m0s
[01:51:06.219] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:45:0)
[01:51:06.219] Timer tick, asking Buildbucket for the build status
[01:51:06.266] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:06.266] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:46:0) after 1m0s
[01:52:06.342] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:46:0)
[01:52:06.342] Timer tick, asking Buildbucket for the build status
[01:52:06.413] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:06.413] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:47:0) after 1m0s
[01:53:06.434] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:47:0)
[01:53:06.434] Timer tick, asking Buildbucket for the build status
[01:53:06.475] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:06.476] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:48:0) after 1m0s
[01:54:06.505] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:48:0)
[01:54:06.505] Timer tick, asking Buildbucket for the build status
[01:54:06.564] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:06.564] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:49:0) after 1m0s
[01:55:06.585] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:49:0)
[01:55:06.585] Timer tick, asking Buildbucket for the build status
[01:55:06.648] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:06.648] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:50:0) after 1m0s
[01:56:06.668] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:50:0)
[01:56:06.668] Timer tick, asking Buildbucket for the build status
[01:56:06.783] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:06.783] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:51:0) after 1m0s
[01:57:06.807] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:51:0)
[01:57:06.807] Timer tick, asking Buildbucket for the build status
[01:57:06.859] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:06.859] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:52:0) after 1m0s
[01:58:06.885] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:52:0)
[01:58:06.885] Timer tick, asking Buildbucket for the build status
[01:58:07.104] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:07.104] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:53:0) after 1m0s
[01:59:07.123] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:53:0)
[01:59:07.123] Timer tick, asking Buildbucket for the build status
[01:59:07.307] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:07.307] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:54:0) after 1m0s
[02:00:07.326] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:54:0)
[02:00:07.326] Timer tick, asking Buildbucket for the build status
[02:00:07.381] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:07.381] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:55:0) after 1m0s
[02:01:07.401] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:55:0)
[02:01:07.401] Timer tick, asking Buildbucket for the build status
[02:01:07.471] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:07.471] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:56:0) after 1m0s
[02:02:07.507] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:56:0)
[02:02:07.507] Timer tick, asking Buildbucket for the build status
[02:02:08.350] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:08.350] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:57:0) after 1m0s
[02:03:08.395] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:57:0)
[02:03:08.395] Timer tick, asking Buildbucket for the build status
[02:03:08.435] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:08.435] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:58:0) after 1m0s
[02:04:08.472] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:58:0)
[02:04:08.472] Timer tick, asking Buildbucket for the build status
[02:04:08.525] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:08.525] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:59:0) after 1m0s
[02:05:08.550] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:59:0)
[02:05:08.550] Timer tick, asking Buildbucket for the build status
[02:05:08.595] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:08.595] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:60:0) after 1m0s
[02:06:08.615] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:60:0)
[02:06:08.615] Timer tick, asking Buildbucket for the build status
[02:06:08.709] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:08.709] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:61:0) after 1m0s
[02:07:08.728] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:61:0)
[02:07:08.728] Timer tick, asking Buildbucket for the build status
[02:07:08.975] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:08.975] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:62:0) after 1m0s
[02:08:08.994] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:62:0)
[02:08:08.994] Timer tick, asking Buildbucket for the build status
[02:08:09.035] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:09.035] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:63:0) after 1m0s
[02:09:09.057] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:63:0)
[02:09:09.057] Timer tick, asking Buildbucket for the build status
[02:09:09.200] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:09.200] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:64:0) after 1m0s
[02:10:09.235] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:64:0)
[02:10:09.235] Timer tick, asking Buildbucket for the build status
[02:10:09.314] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:09.314] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:65:0) after 1m0s
[02:11:09.386] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:65:0)
[02:11:09.386] Timer tick, asking Buildbucket for the build status
[02:11:09.461] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:09.461] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:66:0) after 1m0s
[02:12:09.479] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:66:0)
[02:12:09.479] Timer tick, asking Buildbucket for the build status
[02:12:09.640] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:09.640] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:67:0) after 1m0s
[02:13:09.659] Handling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:67:0)
[02:13:09.660] Timer tick, asking Buildbucket for the build status
[02:13:09.740] Build 8921045684143509712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:09.740] Scheduling timer "check-buildbucket-build-status" (dart/analyzer-win-release:9086475746440944624:68:0) after 1m0s
[02:13:36.836] Received PubSub notification, asking Buildbucket for the build status
[02:13:36.878] Build 8921045684143509712: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:13:36.878] Buildbucket build:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "AUTO",
"completed_ts": "1550628814475767",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1550624877753177",
"id": "8921045684143509712",
"parameters_json": "{\"builder_name\": \"analyzer-win-release\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk/\", \"revision\": \"b83bcf59f27abae54dd69134a320db02b3e76748\"}}",
"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\": [\"4113-bca9810\"], \"machine_type\": [\"n1-standard-8\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"integrity\": [\"high\"], \"id\": [\"win10-dart-fedce810-us-central1-c-g1z5\"], \"pool\": [\"dart.tests\", \"luci.dart.try\"], \"caches\": [\"swarming_module_cache_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\": 4428, \"$recipe_engine/buildbucket\": {\"build\": {\"tags\": [{\"value\": \"analyzer-win-release\", \"key\": \"builder\"}, {\"value\": \"commit/git/b83bcf59f27abae54dd69134a320db02b3e76748\", \"key\": \"buildset\"}, {\"value\": \"commit/gitiles/dart.googlesource.com/sdk/+/b83bcf59f27abae54dd69134a320db02b3e76748\", \"key\": \"buildset\"}, {\"value\": \"9086475746440944624\", \"key\": \"scheduler_invocation_id\"}, {\"value\": \"dart/analyzer-win-release\", \"key\": \"scheduler_job_id\"}, {\"value\": \"luci-scheduler\", \"key\": \"user_agent\"}], \"builder\": {\"project\": \"dart\", \"builder\": \"analyzer-win-release\", \"bucket\": \"ci.sandbox\"}, \"number\": 4428, \"infra\": {\"buildbucket\": {\"serviceConfigRevision\": \"3dab7a70bce848a6486670afc32d65ade65b8058\"}, \"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\": \"8921045684143509712\", \"input\": {\"gitilesCommit\": {\"project\": \"sdk\", \"host\": \"dart.googlesource.com\", \"ref\": \"refs/heads/master\", \"id\": \"b83bcf59f27abae54dd69134a320db02b3e76748\"}}, \"createTime\": \"2019-02-20T01:07:57.753177Z\"}}, \"repository\": \"https://dart.googlesource.com/sdk/\", \"buildername\": \"analyzer-win-release\", \"new_workflow_enabled\": true, \"got_revision\": \"b83bcf59f27abae54dd69134a320db02b3e76748\", \"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\": 1550624877753177, \"tags\": [\"build_address:luci.dart.ci.sandbox/analyzer-win-release/4428\", \"builder:analyzer-win-release\", \"buildset:commit/git/b83bcf59f27abae54dd69134a320db02b3e76748\", \"buildset:commit/gitiles/dart.googlesource.com/sdk/+/b83bcf59f27abae54dd69134a320db02b3e76748\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9086475746440944624\", \"scheduler_job_id:dart/analyzer-win-release\", \"user_agent:luci-scheduler\"], \"bucket\": \"luci.dart.ci.sandbox\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"dart\", \"id\": \"8921045684143509712\"}}, \"branch\": \"refs/heads/master\", \"path_config\": \"generic\", \"revision\": \"b83bcf59f27abae54dd69134a320db02b3e76748\", \"bot_id\": \"win10-dart-fedce810-us-central1-c-g1z5\"}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"started_ts": "1550625720168771",
"status": "COMPLETED",
"status_changed_ts": "1550628815099224",
"tags": [
"build_address:luci.dart.ci.sandbox/analyzer-win-release/4428",
"builder:analyzer-win-release",
"buildset:commit/git/b83bcf59f27abae54dd69134a320db02b3e76748",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/b83bcf59f27abae54dd69134a320db02b3e76748",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9086475746440944624",
"scheduler_job_id:dart/analyzer-win-release",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/dart/buildbucket/cr-buildbucket.appspot.com/8921045684143509712/+/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:432143774ef8b210",
"user_agent:luci-scheduler"
],
"updated_ts": "1550628815100719",
"url": "https://ci.chromium.org/b/8921045684143509712",
"utcnow_ts": "1550628816866416"
}
}
[02:13:36.878] Invocation finished in 1h5m40.700103712s with status SUCCEEDED