[21:54:22.591] New invocation is queued and will start shortly
[21:54:23.814] Starting the invocation (attempt 1)
[21:54:23.844] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:54:23.844] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:54:23.844] Buildbucket request:
{
"bucket": "luci.dart.ci.sandbox",
"client_operation_id": "9096634784424079216",
"parameters_json": "{\"builder_name\":\"pkg-win-release\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://dart.googlesource.com/sdk/\",\"revision\":\"2085277771bb91d488edb6e6e55552ba7116dd72\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:pkg-win-release",
"scheduler_invocation_id:9096634784424079216",
"scheduler_job_id:dart/pkg-win-release",
"user_agent:luci-scheduler",
"buildset:commit/git/2085277771bb91d488edb6e6e55552ba7116dd72",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/2085277771bb91d488edb6e6e55552ba7116dd72",
"gitiles_ref:refs/heads/master"
]
}
[21:54:25.390] Buildbucket response:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary": true,
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1540936463918672",
"id": "8931204722369267776",
"lease_expiration_ts": "1541055265015416",
"lease_key": "129377123",
"parameters_json": "{\"builder_name\": \"pkg-win-release\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk/\", \"revision\": \"2085277771bb91d488edb6e6e55552ba7116dd72\"}}",
"project": "dart",
"result_details_json": "null",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1540936465202303",
"tags": [
"build_address:luci.dart.ci.sandbox/pkg-win-release/2903",
"builder:pkg-win-release",
"buildset:commit/git/2085277771bb91d488edb6e6e55552ba7116dd72",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/2085277771bb91d488edb6e6e55552ba7116dd72",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9096634784424079216",
"scheduler_job_id:dart/pkg-win-release",
"swarming_dimension:caches:builder_25ee1422577e844c44bbdff63b591f09ef27a58893168e9dc9dc636d175a9801_v2",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Windows",
"swarming_dimension:pool:luci.dart.try",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.dart.ci.sandbox/pkg-win-release/2903",
"swarming_tag:buildbucket_bucket:dart/ci.sandbox",
"swarming_tag:buildbucket_build_id:8931204722369267776",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:1",
"swarming_tag:buildbucket_template_revision:c1e4e074f3337ff2dbbfb9aa3b0475a61adb09a6",
"swarming_tag:builder:pkg-win-release",
"swarming_tag:buildset:commit/git/2085277771bb91d488edb6e6e55552ba7116dd72",
"swarming_tag:buildset:commit/gitiles/dart.googlesource.com/sdk/+/2085277771bb91d488edb6e6e55552ba7116dd72",
"swarming_tag:caches:builder_25ee1422577e844c44bbdff63b591f09ef27a58893168e9dc9dc636d175a9801_v2",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/dart/buildbucket/cr-buildbucket.appspot.com/8931204722369267776/+/annotations",
"swarming_tag:luci_project:dart",
"swarming_tag:os:Windows",
"swarming_tag:pool:luci.dart.try",
"swarming_tag:priority:50",
"swarming_tag:recipe_name:dart/neo",
"swarming_tag:recipe_repository:https://chromium.googlesource.com/chromium/tools/build.git",
"swarming_tag:scheduler_invocation_id:9096634784424079216",
"swarming_tag:scheduler_job_id:dart/pkg-win-release",
"swarming_tag:service_account:dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:05895502a6de3e2faf76f11c447b7bb79e2bbee4",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:40dfca004317ea10",
"user_agent:luci-scheduler"
],
"updated_ts": "1540936465202413",
"url": "https://ci.chromium.org/b/8931204722369267776",
"utcnow_ts": "1540936465349132"
}
}
[21:54:25.390] Task URL: https://ci.chromium.org/b/8931204722369267776
[21:54:25.390] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:2:0) after 1m0s
[21:55:25.410] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:2:0)
[21:55:25.410] Timer tick, asking Buildbucket for the build status
[21:55:25.474] Build 8931204722369267776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:55:25.474] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:3:0) after 1m0s
[21:56:25.573] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:3:0)
[21:56:25.573] Timer tick, asking Buildbucket for the build status
[21:56:25.637] Build 8931204722369267776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:56:25.637] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:4:0) after 1m0s
[21:57:25.655] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:4:0)
[21:57:25.656] Timer tick, asking Buildbucket for the build status
[21:57:25.778] Build 8931204722369267776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:57:25.778] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:5:0) after 1m0s
[21:58:25.794] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:5:0)
[21:58:25.794] Timer tick, asking Buildbucket for the build status
[21:58:25.862] Build 8931204722369267776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:58:25.862] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:6:0) after 1m0s
[21:59:25.882] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:6:0)
[21:59:25.882] Timer tick, asking Buildbucket for the build status
[21:59:25.984] Build 8931204722369267776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:59:25.984] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:7:0) after 1m0s
[22:00:26.000] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:7:0)
[22:00:26.000] Timer tick, asking Buildbucket for the build status
[22:00:26.075] Build 8931204722369267776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:00:26.075] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:8:0) after 1m0s
[22:00:47.889] Received PubSub notification, asking Buildbucket for the build status
[22:00:47.986] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:26.098] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:8:0)
[22:01:26.098] Timer tick, asking Buildbucket for the build status
[22:01:26.162] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:26.162] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:10:0) after 1m0s
[22:02:26.189] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:10:0)
[22:02:26.189] Timer tick, asking Buildbucket for the build status
[22:02:26.247] Build 8931204722369267776: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:02:26.247] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:11:0) after 1m0s
[22:03:08.776] Received PubSub notification, asking Buildbucket for the build status
[22:03:08.813] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:26.271] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:11:0)
[22:03:26.272] Timer tick, asking Buildbucket for the build status
[22:03:26.375] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:26.375] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:13:0) after 1m0s
[22:04:26.389] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:13:0)
[22:04:26.389] Timer tick, asking Buildbucket for the build status
[22:04:26.534] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:26.534] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:14:0) after 1m0s
[22:05:26.551] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:14:0)
[22:05:26.551] Timer tick, asking Buildbucket for the build status
[22:05:26.633] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:26.633] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:15:0) after 1m0s
[22:06:26.657] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:15:0)
[22:06:26.657] Timer tick, asking Buildbucket for the build status
[22:06:26.886] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:26.886] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:16:0) after 1m0s
[22:07:26.903] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:16:0)
[22:07:26.903] Timer tick, asking Buildbucket for the build status
[22:07:27.052] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:27.052] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:17:0) after 1m0s
[22:08:27.096] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:17:0)
[22:08:27.096] Timer tick, asking Buildbucket for the build status
[22:08:27.303] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:27.303] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:18:0) after 1m0s
[22:09:27.383] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:18:0)
[22:09:27.383] Timer tick, asking Buildbucket for the build status
[22:09:27.447] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:27.447] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:19:0) after 1m0s
[22:10:27.471] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:19:0)
[22:10:27.471] Timer tick, asking Buildbucket for the build status
[22:10:27.647] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:27.647] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:20:0) after 1m0s
[22:11:27.689] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:20:0)
[22:11:27.689] Timer tick, asking Buildbucket for the build status
[22:11:27.889] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:27.889] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:21:0) after 1m0s
[22:12:27.907] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:21:0)
[22:12:27.907] Timer tick, asking Buildbucket for the build status
[22:12:27.998] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:27.999] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:22:0) after 1m0s
[22:13:28.045] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:22:0)
[22:13:28.045] Timer tick, asking Buildbucket for the build status
[22:13:28.188] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:28.188] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:23:0) after 1m0s
[22:14:28.217] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:23:0)
[22:14:28.217] Timer tick, asking Buildbucket for the build status
[22:14:28.304] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:28.304] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:24:0) after 1m0s
[22:15:28.319] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:24:0)
[22:15:28.319] Timer tick, asking Buildbucket for the build status
[22:15:28.416] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:28.416] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:25:0) after 1m0s
[22:16:28.442] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:25:0)
[22:16:28.442] Timer tick, asking Buildbucket for the build status
[22:16:28.510] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:28.510] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:26:0) after 1m0s
[22:17:28.527] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:26:0)
[22:17:28.527] Timer tick, asking Buildbucket for the build status
[22:17:28.788] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:28.788] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:27:0) after 1m0s
[22:18:28.805] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:27:0)
[22:18:28.805] Timer tick, asking Buildbucket for the build status
[22:18:28.874] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:28.874] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:28:0) after 1m0s
[22:19:28.896] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:28:0)
[22:19:28.896] Timer tick, asking Buildbucket for the build status
[22:19:28.990] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:28.990] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:29:0) after 1m0s
[22:20:29.008] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:29:0)
[22:20:29.008] Timer tick, asking Buildbucket for the build status
[22:20:29.161] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:29.161] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:30:0) after 1m0s
[22:21:29.192] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:30:0)
[22:21:29.192] Timer tick, asking Buildbucket for the build status
[22:21:29.321] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:29.321] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:31:0) after 1m0s
[22:22:29.339] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:31:0)
[22:22:29.339] Timer tick, asking Buildbucket for the build status
[22:22:29.403] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:29.403] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:32:0) after 1m0s
[22:23:29.425] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:32:0)
[22:23:29.425] Timer tick, asking Buildbucket for the build status
[22:23:29.527] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:29.527] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:33:0) after 1m0s
[22:24:29.544] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:33:0)
[22:24:29.544] Timer tick, asking Buildbucket for the build status
[22:24:29.673] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:29.673] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:34:0) after 1m0s
[22:25:29.692] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:34:0)
[22:25:29.692] Timer tick, asking Buildbucket for the build status
[22:25:29.799] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:29.800] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:35:0) after 1m0s
[22:26:29.816] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:35:0)
[22:26:29.816] Timer tick, asking Buildbucket for the build status
[22:26:29.878] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:29.878] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:36:0) after 1m0s
[22:27:29.900] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:36:0)
[22:27:29.900] Timer tick, asking Buildbucket for the build status
[22:27:29.949] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:29.949] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:37:0) after 1m0s
[22:28:29.968] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:37:0)
[22:28:29.968] Timer tick, asking Buildbucket for the build status
[22:28:30.096] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:30.096] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:38:0) after 1m0s
[22:29:30.120] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:38:0)
[22:29:30.120] Timer tick, asking Buildbucket for the build status
[22:29:30.177] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:30.177] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:39:0) after 1m0s
[22:30:30.203] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:39:0)
[22:30:30.203] Timer tick, asking Buildbucket for the build status
[22:30:30.267] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:30.267] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:40:0) after 1m0s
[22:31:30.289] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:40:0)
[22:31:30.289] Timer tick, asking Buildbucket for the build status
[22:31:30.373] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:30.373] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:41:0) after 1m0s
[22:32:30.401] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:41:0)
[22:32:30.401] Timer tick, asking Buildbucket for the build status
[22:32:30.591] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:30.591] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:42:0) after 1m0s
[22:33:30.614] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:42:0)
[22:33:30.614] Timer tick, asking Buildbucket for the build status
[22:33:32.124] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:32.124] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:43:0) after 1m0s
[22:34:32.221] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:43:0)
[22:34:32.221] Timer tick, asking Buildbucket for the build status
[22:34:32.321] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:32.321] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:44:0) after 1m0s
[22:35:32.408] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:44:0)
[22:35:32.408] Timer tick, asking Buildbucket for the build status
[22:35:32.618] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:32.618] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:45:0) after 1m0s
[22:36:32.636] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:45:0)
[22:36:32.636] Timer tick, asking Buildbucket for the build status
[22:36:32.699] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:32.699] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:46:0) after 1m0s
[22:37:32.782] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:46:0)
[22:37:32.782] Timer tick, asking Buildbucket for the build status
[22:37:32.844] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:32.844] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:47:0) after 1m0s
[22:38:32.864] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:47:0)
[22:38:32.864] Timer tick, asking Buildbucket for the build status
[22:38:32.962] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:32.962] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:48:0) after 1m0s
[22:39:32.980] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:48:0)
[22:39:32.980] Timer tick, asking Buildbucket for the build status
[22:39:33.058] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:33.058] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:49:0) after 1m0s
[22:40:33.082] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:49:0)
[22:40:33.082] Timer tick, asking Buildbucket for the build status
[22:40:33.162] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:33.162] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:50:0) after 1m0s
[22:41:33.203] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:50:0)
[22:41:33.203] Timer tick, asking Buildbucket for the build status
[22:41:33.370] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:33.370] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:51:0) after 1m0s
[22:42:33.401] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:51:0)
[22:42:33.401] Timer tick, asking Buildbucket for the build status
[22:42:33.600] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:33.600] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:52:0) after 1m0s
[22:43:33.618] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:52:0)
[22:43:33.618] Timer tick, asking Buildbucket for the build status
[22:43:33.673] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:33.673] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:53:0) after 1m0s
[22:44:33.694] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:53:0)
[22:44:33.694] Timer tick, asking Buildbucket for the build status
[22:44:33.846] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:33.846] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:54:0) after 1m0s
[22:45:33.883] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:54:0)
[22:45:33.883] Timer tick, asking Buildbucket for the build status
[22:45:34.000] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:34.000] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:55:0) after 1m0s
[22:46:34.019] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:55:0)
[22:46:34.019] Timer tick, asking Buildbucket for the build status
[22:46:34.087] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:34.087] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:56:0) after 1m0s
[22:47:34.111] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:56:0)
[22:47:34.111] Timer tick, asking Buildbucket for the build status
[22:47:34.449] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:34.449] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:57:0) after 1m0s
[22:48:34.481] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:57:0)
[22:48:34.481] Timer tick, asking Buildbucket for the build status
[22:48:34.568] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:34.568] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:58:0) after 1m0s
[22:49:34.601] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:58:0)
[22:49:34.601] Timer tick, asking Buildbucket for the build status
[22:49:34.684] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:34.684] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:59:0) after 1m0s
[22:50:34.705] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:59:0)
[22:50:34.705] Timer tick, asking Buildbucket for the build status
[22:50:34.834] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:34.835] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:60:0) after 1m0s
[22:51:34.866] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:60:0)
[22:51:34.866] Timer tick, asking Buildbucket for the build status
[22:51:35.038] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:35.038] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:61:0) after 1m0s
[22:52:35.076] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:61:0)
[22:52:35.076] Timer tick, asking Buildbucket for the build status
[22:52:35.225] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:35.225] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:62:0) after 1m0s
[22:53:35.272] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:62:0)
[22:53:35.272] Timer tick, asking Buildbucket for the build status
[22:53:35.562] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:35.562] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:63:0) after 1m0s
[22:54:35.583] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:63:0)
[22:54:35.583] Timer tick, asking Buildbucket for the build status
[22:54:36.666] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:36.666] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:64:0) after 1m0s
[22:55:36.687] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:64:0)
[22:55:36.687] Timer tick, asking Buildbucket for the build status
[22:55:37.670] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:37.670] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:65:0) after 1m0s
[22:56:37.714] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:65:0)
[22:56:37.714] Timer tick, asking Buildbucket for the build status
[22:56:37.882] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:37.882] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:66:0) after 1m0s
[22:57:37.953] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:66:0)
[22:57:37.953] Timer tick, asking Buildbucket for the build status
[22:57:38.118] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:38.118] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:67:0) after 1m0s
[22:58:38.204] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:67:0)
[22:58:38.204] Timer tick, asking Buildbucket for the build status
[22:58:38.262] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:38.262] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:68:0) after 1m0s
[22:59:38.283] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:68:0)
[22:59:38.283] Timer tick, asking Buildbucket for the build status
[22:59:38.363] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:38.363] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:69:0) after 1m0s
[23:00:38.384] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:69:0)
[23:00:38.384] Timer tick, asking Buildbucket for the build status
[23:00:38.456] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:38.456] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:70:0) after 1m0s
[23:01:38.492] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:70:0)
[23:01:38.492] Timer tick, asking Buildbucket for the build status
[23:01:38.565] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:38.565] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:71:0) after 1m0s
[23:02:38.599] Handling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:71:0)
[23:02:38.599] Timer tick, asking Buildbucket for the build status
[23:02:38.705] Build 8931204722369267776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:38.706] Scheduling timer "check-buildbucket-build-status" (dart/pkg-win-release:9096634784424079216:72:0) after 1m0s
[23:02:58.510] Received PubSub notification, asking Buildbucket for the build status
[23:02:58.589] Build 8931204722369267776: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:02:58.589] Buildbucket build:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary": true,
"canary_preference": "AUTO",
"completed_ts": "1540940577689193",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1540936463918672",
"id": "8931204722369267776",
"parameters_json": "{\"builder_name\": \"pkg-win-release\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk/\", \"revision\": \"2085277771bb91d488edb6e6e55552ba7116dd72\"}}",
"project": "dart",
"result": "SUCCESS",
"result_details_json": "{\"ui\": {\"info\": \"\"}, \"swarming\": {\"bot_dimensions\": {\"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-c\"], \"locale\": [\"en_US.cp1252\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"python\": [\"2.7.13\"], \"server_version\": [\"3817-6aedaff\"], \"machine_type\": [\"n1-standard-8\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"integrity\": [\"high\"], \"id\": [\"win10-dart-fedce810-us-central1-c-15vl\"], \"pool\": [\"dart.tests\", \"luci.dart.try\"], \"caches\": [\"swarming_module_cache_vpython\"]}}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"buildnumber\": 2903, \"repository\": \"https://dart.googlesource.com/sdk/\", \"buildername\": \"pkg-win-release\", \"got_revision\": \"2085277771bb91d488edb6e6e55552ba7116dd72\", \"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\": 1540936463918672, \"tags\": [\"builder:pkg-win-release\", \"buildset:commit/git/2085277771bb91d488edb6e6e55552ba7116dd72\", \"buildset:commit/gitiles/dart.googlesource.com/sdk/+/2085277771bb91d488edb6e6e55552ba7116dd72\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9096634784424079216\", \"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\": \"8931204722369267776\"}}, \"branch\": \"refs/heads/master\", \"path_config\": \"generic\", \"revision\": \"2085277771bb91d488edb6e6e55552ba7116dd72\", \"bot_id\": \"win10-dart-fedce810-us-central1-c-15vl\"}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"started_ts": "1540936846906045",
"status": "COMPLETED",
"status_changed_ts": "1540940578130087",
"tags": [
"build_address:luci.dart.ci.sandbox/pkg-win-release/2903",
"builder:pkg-win-release",
"buildset:commit/git/2085277771bb91d488edb6e6e55552ba7116dd72",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/2085277771bb91d488edb6e6e55552ba7116dd72",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9096634784424079216",
"scheduler_job_id:dart/pkg-win-release",
"swarming_dimension:caches:builder_25ee1422577e844c44bbdff63b591f09ef27a58893168e9dc9dc636d175a9801_v2",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Windows",
"swarming_dimension:pool:luci.dart.try",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.dart.ci.sandbox/pkg-win-release/2903",
"swarming_tag:buildbucket_bucket:dart/ci.sandbox",
"swarming_tag:buildbucket_build_id:8931204722369267776",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:1",
"swarming_tag:buildbucket_template_revision:c1e4e074f3337ff2dbbfb9aa3b0475a61adb09a6",
"swarming_tag:builder:pkg-win-release",
"swarming_tag:buildset:commit/git/2085277771bb91d488edb6e6e55552ba7116dd72",
"swarming_tag:buildset:commit/gitiles/dart.googlesource.com/sdk/+/2085277771bb91d488edb6e6e55552ba7116dd72",
"swarming_tag:caches:builder_25ee1422577e844c44bbdff63b591f09ef27a58893168e9dc9dc636d175a9801_v2",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/dart/buildbucket/cr-buildbucket.appspot.com/8931204722369267776/+/annotations",
"swarming_tag:luci_project:dart",
"swarming_tag:os:Windows",
"swarming_tag:pool:luci.dart.try",
"swarming_tag:priority:50",
"swarming_tag:recipe_name:dart/neo",
"swarming_tag:recipe_repository:https://chromium.googlesource.com/chromium/tools/build.git",
"swarming_tag:scheduler_invocation_id:9096634784424079216",
"swarming_tag:scheduler_job_id:dart/pkg-win-release",
"swarming_tag:service_account:dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:05895502a6de3e2faf76f11c447b7bb79e2bbee4",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:40dfca004317ea10",
"user_agent:luci-scheduler"
],
"updated_ts": "1540940578131423",
"url": "https://ci.chromium.org/b/8931204722369267776",
"utcnow_ts": "1540940578574655"
}
}
[23:02:58.589] Invocation finished in 1h8m36.01406542s with status SUCCEEDED