[08:40:38.188] New invocation is queued and will start shortly
[08:40:39.311] Starting the invocation (attempt 1)
[08:40:39.361] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:40:39.362] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:40:39.362] Buildbucket request:
{
"bucket": "luci.dart.ci.sandbox",
"client_operation_id": "9029189982272401216",
"parameters_json": "{\"builder_name\":\"gclient\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://dart.googlesource.com/sdk\",\"revision\":\"cda994ffc8c651539672e95dc76b1e48f6cf67d7\"},\"id\":\"https://dart.googlesource.com/sdk/+/refs/heads/master@cda994ffc8c651539672e95dc76b1e48f6cf67d7\",\"title\":\"cda994ffc8c651539672e95dc76b1e48f6cf67d7\",\"url\":\"https://dart.googlesource.com/sdk/+/cda994ffc8c651539672e95dc76b1e48f6cf67d7\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://dart.googlesource.com/sdk\",\"revision\":\"cda994ffc8c651539672e95dc76b1e48f6cf67d7\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:gclient",
"scheduler_invocation_id:9029189982272401216",
"scheduler_job_id:dart/gclient",
"user_agent:luci-scheduler",
"buildset:commit/git/cda994ffc8c651539672e95dc76b1e48f6cf67d7",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/cda994ffc8c651539672e95dc76b1e48f6cf67d7",
"gitiles_ref:refs/heads/master"
]
}
[08:40:40.954] Buildbucket response:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"created_by": "project:dart",
"created_ts": "1605256839531552",
"id": "8863759920190015088",
"parameters_json": "{\"builder_name\": \"gclient\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://dart.googlesource.com/sdk\", \"revision\": \"cda994ffc8c651539672e95dc76b1e48f6cf67d7\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@cda994ffc8c651539672e95dc76b1e48f6cf67d7\", \"title\": \"cda994ffc8c651539672e95dc76b1e48f6cf67d7\", \"url\": \"https://dart.googlesource.com/sdk/+/cda994ffc8c651539672e95dc76b1e48f6cf67d7\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk\", \"revision\": \"cda994ffc8c651539672e95dc76b1e48f6cf67d7\"}}",
"project": "dart",
"result_details_json": "{\"properties\": {}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605256840559540",
"tags": [
"build_address:luci.dart.ci.sandbox/gclient/10725",
"builder:gclient",
"buildset:commit/git/cda994ffc8c651539672e95dc76b1e48f6cf67d7",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/cda994ffc8c651539672e95dc76b1e48f6cf67d7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029189982272401216",
"scheduler_job_id:dart/gclient",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/dart/buildbucket/cr-buildbucket.appspot.com/8863759920190015088/+/annotations",
"swarming_tag:luci_project:dart",
"swarming_tag:recipe_name:dart/gclient",
"swarming_tag:recipe_package:dart/recipe_bundles/dart.googlesource.com/recipes",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1605256840559661",
"url": "https://ci.chromium.org/b/8863759920190015088",
"utcnow_ts": "1605256840924451"
}
}
[08:40:40.954] Task URL: https://ci.chromium.org/b/8863759920190015088
[08:40:40.954] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:2:0) after 1m0s
[08:41:41.086] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:2:0)
[08:41:41.086] Timer tick, asking Buildbucket for the build status
[08:41:41.326] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:41:41.326] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:3:0) after 1m0s
[08:42:41.388] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:3:0)
[08:42:41.388] Timer tick, asking Buildbucket for the build status
[08:42:41.864] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:42:41.864] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:4:0) after 1m0s
[08:43:41.998] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:4:0)
[08:43:41.998] Timer tick, asking Buildbucket for the build status
[08:43:42.094] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:43:42.094] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:5:0) after 1m0s
[08:44:42.241] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:5:0)
[08:44:42.241] Timer tick, asking Buildbucket for the build status
[08:44:42.331] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:44:42.331] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:6:0) after 1m0s
[08:45:42.432] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:6:0)
[08:45:42.432] Timer tick, asking Buildbucket for the build status
[08:45:42.625] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:45:42.625] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:7:0) after 1m0s
[08:46:42.741] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:7:0)
[08:46:42.741] Timer tick, asking Buildbucket for the build status
[08:46:43.266] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:46:43.266] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:8:0) after 1m0s
[08:47:43.409] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:8:0)
[08:47:43.409] Timer tick, asking Buildbucket for the build status
[08:47:43.646] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:47:43.646] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:9:0) after 1m0s
[08:48:43.720] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:9:0)
[08:48:43.720] Timer tick, asking Buildbucket for the build status
[08:48:43.801] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:48:43.801] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:10:0) after 1m0s
[08:49:43.864] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:10:0)
[08:49:43.864] Timer tick, asking Buildbucket for the build status
[08:49:43.962] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:49:43.962] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:11:0) after 1m0s
[08:50:44.006] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:11:0)
[08:50:44.006] Timer tick, asking Buildbucket for the build status
[08:50:44.292] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:50:44.292] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:12:0) after 1m0s
[08:51:44.318] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:12:0)
[08:51:44.318] Timer tick, asking Buildbucket for the build status
[08:51:44.499] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:51:44.499] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:13:0) after 1m0s
[08:52:44.493] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:13:0)
[08:52:44.494] Timer tick, asking Buildbucket for the build status
[08:52:44.582] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:52:44.582] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:14:0) after 1m0s
[08:53:44.646] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:14:0)
[08:53:44.646] Timer tick, asking Buildbucket for the build status
[08:53:44.744] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:53:44.744] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:15:0) after 1m0s
[08:54:44.901] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:15:0)
[08:54:44.901] Timer tick, asking Buildbucket for the build status
[08:54:44.970] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:54:44.971] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:16:0) after 1m0s
[08:55:45.031] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:16:0)
[08:55:45.031] Timer tick, asking Buildbucket for the build status
[08:55:45.162] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:55:45.162] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:17:0) after 1m0s
[08:56:45.245] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:17:0)
[08:56:45.245] Timer tick, asking Buildbucket for the build status
[08:56:45.492] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:56:45.492] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:18:0) after 1m0s
[08:57:45.474] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:18:0)
[08:57:45.474] Timer tick, asking Buildbucket for the build status
[08:57:45.549] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:57:45.549] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:19:0) after 1m0s
[08:58:45.600] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:19:0)
[08:58:45.600] Timer tick, asking Buildbucket for the build status
[08:58:45.815] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:58:45.815] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:20:0) after 1m0s
[08:59:45.836] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:20:0)
[08:59:45.836] Timer tick, asking Buildbucket for the build status
[08:59:45.948] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:59:45.948] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:21:0) after 1m0s
[09:00:46.168] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:21:0)
[09:00:46.168] Timer tick, asking Buildbucket for the build status
[09:00:47.842] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:00:47.842] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:22:0) after 1m0s
[09:01:48.162] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:22:0)
[09:01:48.162] Timer tick, asking Buildbucket for the build status
[09:01:48.268] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:01:48.268] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:23:0) after 1m0s
[09:02:48.411] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:23:0)
[09:02:48.411] Timer tick, asking Buildbucket for the build status
[09:02:48.524] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:02:48.524] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:24:0) after 1m0s
[09:03:48.767] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:24:0)
[09:03:48.767] Timer tick, asking Buildbucket for the build status
[09:03:49.192] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:03:49.192] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:25:0) after 1m0s
[09:04:49.276] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:25:0)
[09:04:49.276] Timer tick, asking Buildbucket for the build status
[09:04:49.357] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:04:49.357] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:26:0) after 1m0s
[09:05:49.405] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:26:0)
[09:05:49.405] Timer tick, asking Buildbucket for the build status
[09:05:49.517] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:05:49.517] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:27:0) after 1m0s
[09:06:49.580] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:27:0)
[09:06:49.580] Timer tick, asking Buildbucket for the build status
[09:06:49.659] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:06:49.659] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:28:0) after 1m0s
[09:07:49.768] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:28:0)
[09:07:49.768] Timer tick, asking Buildbucket for the build status
[09:07:49.969] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:07:49.969] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:29:0) after 1m0s
[09:08:50.009] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:29:0)
[09:08:50.009] Timer tick, asking Buildbucket for the build status
[09:08:50.154] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:08:50.154] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:30:0) after 1m0s
[09:09:50.241] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:30:0)
[09:09:50.241] Timer tick, asking Buildbucket for the build status
[09:09:50.326] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:09:50.326] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:31:0) after 1m0s
[09:10:50.356] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:31:0)
[09:10:50.356] Timer tick, asking Buildbucket for the build status
[09:10:50.825] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:10:50.825] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:32:0) after 1m0s
[09:11:51.119] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:32:0)
[09:11:51.119] Timer tick, asking Buildbucket for the build status
[09:11:51.235] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:11:51.235] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:33:0) after 1m0s
[09:12:51.544] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:33:0)
[09:12:51.544] Timer tick, asking Buildbucket for the build status
[09:12:51.628] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:12:51.628] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:34:0) after 1m0s
[09:13:51.814] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:34:0)
[09:13:51.814] Timer tick, asking Buildbucket for the build status
[09:13:52.036] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:13:52.036] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:35:0) after 1m0s
[09:14:52.597] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:35:0)
[09:14:52.597] Timer tick, asking Buildbucket for the build status
[09:14:52.862] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:14:52.862] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:36:0) after 1m0s
[09:15:52.980] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:36:0)
[09:15:52.980] Timer tick, asking Buildbucket for the build status
[09:15:53.425] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:15:53.425] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:37:0) after 1m0s
[09:16:53.497] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:37:0)
[09:16:53.497] Timer tick, asking Buildbucket for the build status
[09:16:53.568] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:16:53.568] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:38:0) after 1m0s
[09:17:53.658] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:38:0)
[09:17:53.658] Timer tick, asking Buildbucket for the build status
[09:17:55.484] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:17:55.484] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:39:0) after 1m0s
[09:18:55.495] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:39:0)
[09:18:55.495] Timer tick, asking Buildbucket for the build status
[09:18:55.629] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:18:55.629] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:40:0) after 1m0s
[09:19:56.768] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:40:0)
[09:19:56.768] Timer tick, asking Buildbucket for the build status
[09:19:56.860] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:19:56.860] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:41:0) after 1m0s
[09:20:57.258] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:41:0)
[09:20:57.258] Timer tick, asking Buildbucket for the build status
[09:20:57.372] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:20:57.372] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:42:0) after 1m0s
[09:21:57.638] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:42:0)
[09:21:57.638] Timer tick, asking Buildbucket for the build status
[09:21:57.727] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:21:57.727] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:43:0) after 1m0s
[09:22:58.045] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:43:0)
[09:22:58.045] Timer tick, asking Buildbucket for the build status
[09:22:58.139] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:22:58.139] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:44:0) after 1m0s
[09:23:58.330] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:44:0)
[09:23:58.330] Timer tick, asking Buildbucket for the build status
[09:23:58.467] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:23:58.467] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:45:0) after 1m0s
[09:24:58.490] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:45:0)
[09:24:58.490] Timer tick, asking Buildbucket for the build status
[09:24:58.586] Build 8863759920190015088: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:24:58.586] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:46:0) after 1m0s
[09:25:32.060] Received PubSub notification, asking Buildbucket for the build status
[09:25:32.377] Build 8863759920190015088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:58.646] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:46:0)
[09:25:58.646] Timer tick, asking Buildbucket for the build status
[09:25:59.231] Build 8863759920190015088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:59.231] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:48:0) after 1m0s
[09:26:59.295] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:48:0)
[09:26:59.295] Timer tick, asking Buildbucket for the build status
[09:26:59.410] Build 8863759920190015088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:59.410] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:49:0) after 1m0s
[09:27:59.515] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:49:0)
[09:27:59.515] Timer tick, asking Buildbucket for the build status
[09:27:59.576] Build 8863759920190015088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:59.576] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:50:0) after 1m0s
[09:28:59.627] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:50:0)
[09:28:59.627] Timer tick, asking Buildbucket for the build status
[09:28:59.714] Build 8863759920190015088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:59.714] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:51:0) after 1m0s
[09:29:59.775] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:51:0)
[09:29:59.775] Timer tick, asking Buildbucket for the build status
[09:29:59.849] Build 8863759920190015088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:59.849] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:52:0) after 1m0s
[09:30:59.933] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:52:0)
[09:30:59.933] Timer tick, asking Buildbucket for the build status
[09:31:00.338] Build 8863759920190015088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:00.338] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:53:0) after 1m0s
[09:32:00.961] Handling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:53:0)
[09:32:00.961] Timer tick, asking Buildbucket for the build status
[09:32:01.054] Build 8863759920190015088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:01.054] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9029189982272401216:54:0) after 1m0s
[09:32:40.915] Received PubSub notification, asking Buildbucket for the build status
[09:32:41.112] Build 8863759920190015088: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:32:41.112] Buildbucket build:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"completed_ts": "1605259959979879",
"created_by": "project:dart",
"created_ts": "1605256839531552",
"id": "8863759920190015088",
"parameters_json": "{\"builder_name\": \"gclient\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://dart.googlesource.com/sdk\", \"revision\": \"cda994ffc8c651539672e95dc76b1e48f6cf67d7\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@cda994ffc8c651539672e95dc76b1e48f6cf67d7\", \"title\": \"cda994ffc8c651539672e95dc76b1e48f6cf67d7\", \"url\": \"https://dart.googlesource.com/sdk/+/cda994ffc8c651539672e95dc76b1e48f6cf67d7\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk\", \"revision\": \"cda994ffc8c651539672e95dc76b1e48f6cf67d7\"}}",
"project": "dart",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://dart.googlesource.com/sdk\", \"revision\": \"cda994ffc8c651539672e95dc76b1e48f6cf67d7\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@cda994ffc8c651539672e95dc76b1e48f6cf67d7\", \"title\": \"cda994ffc8c651539672e95dc76b1e48f6cf67d7\", \"url\": \"https://dart.googlesource.com/sdk/+/cda994ffc8c651539672e95dc76b1e48f6cf67d7\"}]}, \"$recipe_engine/swarming\": {\"server\": \"https://chromium-swarm.appspot.com\"}, \"bot_id\": \"luci-dart-try-xenial-8-fzls\", \"branch\": \"refs/heads/master\", \"buildername\": \"gclient\", \"buildnumber\": 10725, \"clobber\": \"true\", \"path_config\": \"generic\", \"recipe\": \"dart/gclient\", \"repository\": \"https://dart.googlesource.com/sdk\", \"revision\": \"cda994ffc8c651539672e95dc76b1e48f6cf67d7\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"dart-ci\"], \"gpu\": [\"none\"], \"host_class\": [\"default\"], \"id\": [\"luci-dart-try-xenial-8-fzls\"], \"image\": [\"dart-xenial-20101000-265b45aa9e2\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"dart.tests\", \"luci.dart.try\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5626-39642e9\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"started_ts": "1605259530529770",
"status": "COMPLETED",
"status_changed_ts": "1605259960585245",
"tags": [
"build_address:luci.dart.ci.sandbox/gclient/10725",
"builder:gclient",
"buildset:commit/git/cda994ffc8c651539672e95dc76b1e48f6cf67d7",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/cda994ffc8c651539672e95dc76b1e48f6cf67d7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029189982272401216",
"scheduler_job_id:dart/gclient",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/dart/buildbucket/cr-buildbucket.appspot.com/8863759920190015088/+/annotations",
"swarming_tag:luci_project:dart",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:dart/gclient",
"swarming_tag:recipe_package:dart/recipe_bundles/dart.googlesource.com/recipes",
"swarming_task_id:4fd9950fedd1f610",
"user_agent:luci-scheduler"
],
"updated_ts": "1605259960595378",
"url": "https://ci.chromium.org/b/8863759920190015088",
"utcnow_ts": "1605259961095033"
}
}
[09:32:41.112] Invocation finished in 52m2.950022448s with status SUCCEEDED