[14:59:49.338] New invocation is queued and will start shortly
[14:59:52.425] Starting the invocation (attempt 1)
[14:59:52.467] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:59:52.467] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:59:52.467] Buildbucket request:
{
"bucket": "luci.dart.ci.sandbox",
"client_operation_id": "9054623873557170352",
"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\":\"4a76bafa5aa900e4c07ffa8166010c74c3af03e2\"},\"id\":\"https://dart.googlesource.com/sdk/+/refs/heads/master@4a76bafa5aa900e4c07ffa8166010c74c3af03e2\",\"title\":\"4a76bafa5aa900e4c07ffa8166010c74c3af03e2\",\"url\":\"https://dart.googlesource.com/sdk/+/4a76bafa5aa900e4c07ffa8166010c74c3af03e2\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://dart.googlesource.com/sdk\",\"revision\":\"4a76bafa5aa900e4c07ffa8166010c74c3af03e2\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:gclient",
"scheduler_invocation_id:9054623873557170352",
"scheduler_job_id:dart/gclient",
"user_agent:luci-scheduler",
"buildset:commit/git/4a76bafa5aa900e4c07ffa8166010c74c3af03e2",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/4a76bafa5aa900e4c07ffa8166010c74c3af03e2",
"gitiles_ref:refs/heads/master"
]
}
[14:59:53.472] Buildbucket response:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"created_by": "project:dart",
"created_ts": "1581001192663830",
"id": "8889193809360449680",
"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\": \"4a76bafa5aa900e4c07ffa8166010c74c3af03e2\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@4a76bafa5aa900e4c07ffa8166010c74c3af03e2\", \"title\": \"4a76bafa5aa900e4c07ffa8166010c74c3af03e2\", \"url\": \"https://dart.googlesource.com/sdk/+/4a76bafa5aa900e4c07ffa8166010c74c3af03e2\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk\", \"revision\": \"4a76bafa5aa900e4c07ffa8166010c74c3af03e2\"}}",
"project": "dart",
"result_details_json": "{\"properties\": {}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1581001193322457",
"tags": [
"build_address:luci.dart.ci.sandbox/gclient/6336",
"builder:gclient",
"buildset:commit/git/4a76bafa5aa900e4c07ffa8166010c74c3af03e2",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/4a76bafa5aa900e4c07ffa8166010c74c3af03e2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054623873557170352",
"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/8889193809360449680/+/annotations",
"swarming_tag:luci_project:dart",
"swarming_tag:recipe_name:dart/gclient",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1581001193322582",
"url": "https://ci.chromium.org/b/8889193809360449680",
"utcnow_ts": "1581001193462218"
}
}
[14:59:53.472] Task URL: https://ci.chromium.org/b/8889193809360449680
[14:59:53.472] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:2:0) after 1m0s
[15:00:54.176] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:2:0)
[15:00:54.176] Timer tick, asking Buildbucket for the build status
[15:00:54.351] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:00:54.351] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:3:0) after 1m0s
[15:01:54.613] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:3:0)
[15:01:54.613] Timer tick, asking Buildbucket for the build status
[15:01:54.727] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:01:54.727] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:4:0) after 1m0s
[15:02:54.862] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:4:0)
[15:02:54.862] Timer tick, asking Buildbucket for the build status
[15:02:55.150] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:02:55.150] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:5:0) after 1m0s
[15:03:55.203] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:5:0)
[15:03:55.204] Timer tick, asking Buildbucket for the build status
[15:03:55.341] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:03:55.341] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:6:0) after 1m0s
[15:04:55.407] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:6:0)
[15:04:55.407] Timer tick, asking Buildbucket for the build status
[15:04:56.583] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:04:56.583] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:7:0) after 1m0s
[15:05:56.632] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:7:0)
[15:05:56.632] Timer tick, asking Buildbucket for the build status
[15:05:56.758] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:05:56.758] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:8:0) after 1m0s
[15:06:56.994] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:8:0)
[15:06:56.994] Timer tick, asking Buildbucket for the build status
[15:06:57.247] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:06:57.247] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:9:0) after 1m0s
[15:07:57.304] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:9:0)
[15:07:57.304] Timer tick, asking Buildbucket for the build status
[15:07:57.643] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:07:57.643] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:10:0) after 1m0s
[15:08:57.638] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:10:0)
[15:08:57.638] Timer tick, asking Buildbucket for the build status
[15:08:57.939] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:08:57.939] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:11:0) after 1m0s
[15:09:58.181] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:11:0)
[15:09:58.181] Timer tick, asking Buildbucket for the build status
[15:09:58.385] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:09:58.385] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:12:0) after 1m0s
[15:10:58.475] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:12:0)
[15:10:58.475] Timer tick, asking Buildbucket for the build status
[15:10:58.715] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:10:58.715] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:13:0) after 1m0s
[15:11:58.858] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:13:0)
[15:11:58.858] Timer tick, asking Buildbucket for the build status
[15:11:59.065] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:11:59.065] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:14:0) after 1m0s
[15:12:59.295] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:14:0)
[15:12:59.295] Timer tick, asking Buildbucket for the build status
[15:12:59.595] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:12:59.595] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:15:0) after 1m0s
[15:13:59.672] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:15:0)
[15:13:59.672] Timer tick, asking Buildbucket for the build status
[15:14:00.875] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:14:00.875] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:16:0) after 1m0s
[15:15:01.591] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:16:0)
[15:15:01.591] Timer tick, asking Buildbucket for the build status
[15:15:01.816] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:15:01.816] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:17:0) after 1m0s
[15:16:02.130] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:17:0)
[15:16:02.130] Timer tick, asking Buildbucket for the build status
[15:16:02.333] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:16:02.333] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:18:0) after 1m0s
[15:17:02.553] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:18:0)
[15:17:02.553] Timer tick, asking Buildbucket for the build status
[15:17:02.684] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:17:02.684] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:19:0) after 1m0s
[15:18:02.828] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:19:0)
[15:18:02.828] Timer tick, asking Buildbucket for the build status
[15:18:03.023] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:18:03.023] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:20:0) after 1m0s
[15:19:03.112] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:20:0)
[15:19:03.112] Timer tick, asking Buildbucket for the build status
[15:19:03.264] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:19:03.264] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:21:0) after 1m0s
[15:20:03.407] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:21:0)
[15:20:03.407] Timer tick, asking Buildbucket for the build status
[15:20:04.776] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:20:04.776] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:22:0) after 1m0s
[15:21:05.192] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:22:0)
[15:21:05.192] Timer tick, asking Buildbucket for the build status
[15:21:05.371] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:21:05.371] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:23:0) after 1m0s
[15:22:05.527] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:23:0)
[15:22:05.528] Timer tick, asking Buildbucket for the build status
[15:22:05.763] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:22:05.764] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:24:0) after 1m0s
[15:23:05.844] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:24:0)
[15:23:05.844] Timer tick, asking Buildbucket for the build status
[15:23:06.089] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:23:06.089] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:25:0) after 1m0s
[15:24:06.135] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:25:0)
[15:24:06.135] Timer tick, asking Buildbucket for the build status
[15:24:06.297] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:24:06.297] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:26:0) after 1m0s
[15:25:06.437] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:26:0)
[15:25:06.437] Timer tick, asking Buildbucket for the build status
[15:25:06.581] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:25:06.581] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:27:0) after 1m0s
[15:26:06.671] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:27:0)
[15:26:06.671] Timer tick, asking Buildbucket for the build status
[15:26:06.837] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:26:06.837] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:28:0) after 1m0s
[15:27:06.971] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:28:0)
[15:27:06.971] Timer tick, asking Buildbucket for the build status
[15:27:07.226] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:27:07.226] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:29:0) after 1m0s
[15:28:07.310] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:29:0)
[15:28:07.310] Timer tick, asking Buildbucket for the build status
[15:28:07.656] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:28:07.656] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:30:0) after 1m0s
[15:29:07.903] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:30:0)
[15:29:07.903] Timer tick, asking Buildbucket for the build status
[15:29:08.045] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:29:08.045] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:31:0) after 1m0s
[15:30:08.161] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:31:0)
[15:30:08.161] Timer tick, asking Buildbucket for the build status
[15:30:08.294] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:30:08.294] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:32:0) after 1m0s
[15:31:08.386] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:32:0)
[15:31:08.386] Timer tick, asking Buildbucket for the build status
[15:31:08.556] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:31:08.556] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:33:0) after 1m0s
[15:32:08.654] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:33:0)
[15:32:08.654] Timer tick, asking Buildbucket for the build status
[15:32:09.266] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:32:09.266] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:34:0) after 1m0s
[15:33:09.301] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:34:0)
[15:33:09.301] Timer tick, asking Buildbucket for the build status
[15:33:09.583] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:33:09.583] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:35:0) after 1m0s
[15:34:09.662] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:35:0)
[15:34:09.662] Timer tick, asking Buildbucket for the build status
[15:34:09.872] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:34:09.872] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:36:0) after 1m0s
[15:35:10.003] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:36:0)
[15:35:10.003] Timer tick, asking Buildbucket for the build status
[15:35:10.148] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:35:10.148] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:37:0) after 1m0s
[15:36:10.248] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:37:0)
[15:36:10.248] Timer tick, asking Buildbucket for the build status
[15:36:10.722] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:36:10.722] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:38:0) after 1m0s
[15:37:10.741] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:38:0)
[15:37:10.741] Timer tick, asking Buildbucket for the build status
[15:37:10.983] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:37:10.983] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:39:0) after 1m0s
[15:38:11.108] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:39:0)
[15:38:11.108] Timer tick, asking Buildbucket for the build status
[15:38:11.505] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:38:11.505] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:40:0) after 1m0s
[15:39:11.521] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:40:0)
[15:39:11.521] Timer tick, asking Buildbucket for the build status
[15:39:11.927] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:39:11.927] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:41:0) after 1m0s
[15:40:11.973] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:41:0)
[15:40:11.973] Timer tick, asking Buildbucket for the build status
[15:40:12.104] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:40:12.104] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:42:0) after 1m0s
[15:41:12.152] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:42:0)
[15:41:12.152] Timer tick, asking Buildbucket for the build status
[15:41:12.293] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:41:12.293] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:43:0) after 1m0s
[15:42:12.388] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:43:0)
[15:42:12.388] Timer tick, asking Buildbucket for the build status
[15:42:12.908] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:42:12.908] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:44:0) after 1m0s
[15:43:13.080] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:44:0)
[15:43:13.080] Timer tick, asking Buildbucket for the build status
[15:43:13.278] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:43:13.278] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:45:0) after 1m0s
[15:44:13.388] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:45:0)
[15:44:13.388] Timer tick, asking Buildbucket for the build status
[15:44:14.272] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:44:14.272] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:46:0) after 1m0s
[15:45:14.374] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:46:0)
[15:45:14.374] Timer tick, asking Buildbucket for the build status
[15:45:14.529] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:45:14.529] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:47:0) after 1m0s
[15:46:14.744] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:47:0)
[15:46:14.744] Timer tick, asking Buildbucket for the build status
[15:46:14.858] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:46:14.858] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:48:0) after 1m0s
[15:47:14.910] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:48:0)
[15:47:14.911] Timer tick, asking Buildbucket for the build status
[15:47:17.202] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:47:17.202] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:49:0) after 1m0s
[15:48:17.485] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:49:0)
[15:48:17.485] Timer tick, asking Buildbucket for the build status
[15:48:17.615] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:48:17.615] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:50:0) after 1m0s
[15:49:17.704] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:50:0)
[15:49:17.704] Timer tick, asking Buildbucket for the build status
[15:49:18.117] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:49:18.117] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:51:0) after 1m0s
[15:50:18.108] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:51:0)
[15:50:18.108] Timer tick, asking Buildbucket for the build status
[15:50:18.278] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:50:18.278] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:52:0) after 1m0s
[15:51:18.310] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:52:0)
[15:51:18.310] Timer tick, asking Buildbucket for the build status
[15:51:18.448] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:51:18.448] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:53:0) after 1m0s
[15:52:18.448] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:53:0)
[15:52:18.449] Timer tick, asking Buildbucket for the build status
[15:52:18.955] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:52:18.955] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:54:0) after 1m0s
[15:53:19.013] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:54:0)
[15:53:19.013] Timer tick, asking Buildbucket for the build status
[15:53:19.451] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:53:19.451] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:55:0) after 1m0s
[15:54:19.504] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:55:0)
[15:54:19.504] Timer tick, asking Buildbucket for the build status
[15:54:20.076] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:54:20.076] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:56:0) after 1m0s
[15:55:20.121] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:56:0)
[15:55:20.121] Timer tick, asking Buildbucket for the build status
[15:55:20.573] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:55:20.573] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:57:0) after 1m0s
[15:56:20.667] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:57:0)
[15:56:20.667] Timer tick, asking Buildbucket for the build status
[15:56:21.166] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:56:21.167] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:58:0) after 1m0s
[15:57:21.204] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:58:0)
[15:57:21.204] Timer tick, asking Buildbucket for the build status
[15:57:21.355] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:57:21.355] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:59:0) after 1m0s
[15:58:21.484] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:59:0)
[15:58:21.484] Timer tick, asking Buildbucket for the build status
[15:58:21.639] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:58:21.639] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:60:0) after 1m0s
[15:59:21.666] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:60:0)
[15:59:21.666] Timer tick, asking Buildbucket for the build status
[15:59:21.828] Build 8889193809360449680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:59:21.828] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:61:0) after 1m0s
[15:59:34.053] Received PubSub notification, asking Buildbucket for the build status
[15:59:34.193] Build 8889193809360449680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:21.905] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:61:0)
[16:00:21.905] Timer tick, asking Buildbucket for the build status
[16:00:22.062] Build 8889193809360449680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:22.062] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:63:0) after 1m0s
[16:01:22.106] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:63:0)
[16:01:22.106] Timer tick, asking Buildbucket for the build status
[16:01:22.245] Build 8889193809360449680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:22.245] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:64:0) after 1m0s
[16:02:22.462] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:64:0)
[16:02:22.462] Timer tick, asking Buildbucket for the build status
[16:02:22.993] Build 8889193809360449680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:22.993] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:65:0) after 1m0s
[16:03:23.118] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:65:0)
[16:03:23.118] Timer tick, asking Buildbucket for the build status
[16:03:23.337] Build 8889193809360449680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:23.337] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:66:0) after 1m0s
[16:04:23.360] Handling timer "check-buildbucket-build-status" (dart/gclient:9054623873557170352:66:0)
[16:04:23.360] Timer tick, asking Buildbucket for the build status
[16:04:23.556] Build 8889193809360449680: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:04:23.556] Buildbucket build:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"completed_ts": "1581005062276773",
"created_by": "project:dart",
"created_ts": "1581001192663830",
"id": "8889193809360449680",
"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\": \"4a76bafa5aa900e4c07ffa8166010c74c3af03e2\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@4a76bafa5aa900e4c07ffa8166010c74c3af03e2\", \"title\": \"4a76bafa5aa900e4c07ffa8166010c74c3af03e2\", \"url\": \"https://dart.googlesource.com/sdk/+/4a76bafa5aa900e4c07ffa8166010c74c3af03e2\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk\", \"revision\": \"4a76bafa5aa900e4c07ffa8166010c74c3af03e2\"}}",
"project": "dart",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$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\": \"4a76bafa5aa900e4c07ffa8166010c74c3af03e2\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@4a76bafa5aa900e4c07ffa8166010c74c3af03e2\", \"title\": \"4a76bafa5aa900e4c07ffa8166010c74c3af03e2\", \"url\": \"https://dart.googlesource.com/sdk/+/4a76bafa5aa900e4c07ffa8166010c74c3af03e2\"}]}, \"$recipe_engine/swarming\": {\"server\": \"https://chromium-swarm.appspot.com\"}, \"bot_id\": \"luci-dart-try-xenial-6-tvhj\", \"branch\": \"refs/heads/master\", \"buildername\": \"gclient\", \"buildnumber\": 6336, \"clobber\": \"true\", \"path_config\": \"generic\", \"recipe\": \"dart/gclient\", \"repository\": \"https://dart.googlesource.com/sdk\", \"revision\": \"4a76bafa5aa900e4c07ffa8166010c74c3af03e2\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_0a8bbbf82ad80fe09c07c6a167e90508e267474280805a5952a3bc651b136427_v2\", \"builder_141fed3fd1b6eac6a5f57870f785929ff8995cdd04b6204e20d5213720c7cdf8_v2\", \"builder_31ad43919ef2492e048ad29a6b0c22b0c395502d0b65b56fb9263d6f77774de4_v2\", \"builder_6338d689ff18380497e6d49b70969182788102900bfead3e0bda28409897d599_v2\", \"builder_bc510e7460cd360bdaafeba95be813037cc6e9a1b51dd3fb5b57eb2199968634_v2\", \"builder_d3f605031f0359b6be14171ddfffe0504bd58d556715fd9df0e268e1f74d422e_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"dart-ci\"], \"gpu\": [\"none\"], \"host_class\": [\"default\"], \"id\": [\"luci-dart-try-xenial-6-tvhj\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"dart.tests\", \"luci.dart.try\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4809-bb2013c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"started_ts": "1581004772963203",
"status": "COMPLETED",
"status_changed_ts": "1581005063123064",
"tags": [
"build_address:luci.dart.ci.sandbox/gclient/6336",
"builder:gclient",
"buildset:commit/git/4a76bafa5aa900e4c07ffa8166010c74c3af03e2",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/4a76bafa5aa900e4c07ffa8166010c74c3af03e2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054623873557170352",
"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/8889193809360449680/+/annotations",
"swarming_tag:luci_project:dart",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:dart/gclient",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4a33d540adca0f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1581005063133763",
"url": "https://ci.chromium.org/b/8889193809360449680",
"utcnow_ts": "1581005063544263"
}
}
[16:04:23.556] Invocation finished in 1h4m34.279092083s with status SUCCEEDED