[18:47:30.251] New invocation is queued and will start shortly
[18:47:35.413] Starting the invocation (attempt 1)
[18:47:35.508] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:47:35.508] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:47:35.509] Buildbucket request:
{
"bucket": "luci.dart.ci.sandbox",
"client_operation_id": "9036127767870726320",
"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\":\"2ca30d8d19cc248a6fac238ca110ab36bee07aa1\"},\"id\":\"https://dart.googlesource.com/sdk/+/refs/heads/master@2ca30d8d19cc248a6fac238ca110ab36bee07aa1\",\"title\":\"2ca30d8d19cc248a6fac238ca110ab36bee07aa1\",\"url\":\"https://dart.googlesource.com/sdk/+/2ca30d8d19cc248a6fac238ca110ab36bee07aa1\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://dart.googlesource.com/sdk\",\"revision\":\"8812673f1b4dbc15578af147af89965956168bdd\"},\"id\":\"https://dart.googlesource.com/sdk/+/refs/heads/master@8812673f1b4dbc15578af147af89965956168bdd\",\"title\":\"8812673f1b4dbc15578af147af89965956168bdd\",\"url\":\"https://dart.googlesource.com/sdk/+/8812673f1b4dbc15578af147af89965956168bdd\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://dart.googlesource.com/sdk\",\"revision\":\"8812673f1b4dbc15578af147af89965956168bdd\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:gclient",
"scheduler_invocation_id:9036127767870726320",
"scheduler_job_id:dart/gclient",
"user_agent:luci-scheduler",
"buildset:commit/git/8812673f1b4dbc15578af147af89965956168bdd",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/8812673f1b4dbc15578af147af89965956168bdd",
"gitiles_ref:refs/heads/master"
]
}
[18:47:36.983] Buildbucket response:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"created_by": "project:dart",
"created_ts": "1598640455636460",
"id": "8870697701548960896",
"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\": \"2ca30d8d19cc248a6fac238ca110ab36bee07aa1\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@2ca30d8d19cc248a6fac238ca110ab36bee07aa1\", \"title\": \"2ca30d8d19cc248a6fac238ca110ab36bee07aa1\", \"url\": \"https://dart.googlesource.com/sdk/+/2ca30d8d19cc248a6fac238ca110ab36bee07aa1\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://dart.googlesource.com/sdk\", \"revision\": \"8812673f1b4dbc15578af147af89965956168bdd\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@8812673f1b4dbc15578af147af89965956168bdd\", \"title\": \"8812673f1b4dbc15578af147af89965956168bdd\", \"url\": \"https://dart.googlesource.com/sdk/+/8812673f1b4dbc15578af147af89965956168bdd\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk\", \"revision\": \"8812673f1b4dbc15578af147af89965956168bdd\"}}",
"project": "dart",
"result_details_json": "{\"properties\": {}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1598640456801961",
"tags": [
"build_address:luci.dart.ci.sandbox/gclient/9722",
"builder:gclient",
"buildset:commit/git/8812673f1b4dbc15578af147af89965956168bdd",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/8812673f1b4dbc15578af147af89965956168bdd",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9036127767870726320",
"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/8870697701548960896/+/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": "1598640456802147",
"url": "https://ci.chromium.org/b/8870697701548960896",
"utcnow_ts": "1598640456967951"
}
}
[18:47:36.983] Task URL: https://ci.chromium.org/b/8870697701548960896
[18:47:36.983] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:2:0) after 1m0s
[18:48:37.016] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:2:0)
[18:48:37.016] Timer tick, asking Buildbucket for the build status
[18:48:37.199] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:48:37.199] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:3:0) after 1m0s
[18:49:37.287] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:3:0)
[18:49:37.287] Timer tick, asking Buildbucket for the build status
[18:49:37.521] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:49:37.521] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:4:0) after 1m0s
[18:50:37.600] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:4:0)
[18:50:37.600] Timer tick, asking Buildbucket for the build status
[18:50:37.905] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:50:37.905] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:5:0) after 1m0s
[18:51:37.912] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:5:0)
[18:51:37.912] Timer tick, asking Buildbucket for the build status
[18:51:38.014] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:51:38.014] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:6:0) after 1m0s
[18:52:38.096] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:6:0)
[18:52:38.096] Timer tick, asking Buildbucket for the build status
[18:52:38.420] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:52:38.420] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:7:0) after 1m0s
[18:53:38.456] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:7:0)
[18:53:38.456] Timer tick, asking Buildbucket for the build status
[18:53:38.565] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:53:38.565] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:8:0) after 1m0s
[18:54:38.604] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:8:0)
[18:54:38.604] Timer tick, asking Buildbucket for the build status
[18:54:38.708] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:54:38.708] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:9:0) after 1m0s
[18:55:38.730] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:9:0)
[18:55:38.730] Timer tick, asking Buildbucket for the build status
[18:55:39.099] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:55:39.099] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:10:0) after 1m0s
[18:56:39.117] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:10:0)
[18:56:39.117] Timer tick, asking Buildbucket for the build status
[18:56:39.226] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:56:39.226] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:11:0) after 1m0s
[18:57:39.279] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:11:0)
[18:57:39.279] Timer tick, asking Buildbucket for the build status
[18:57:39.725] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:57:39.725] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:12:0) after 1m0s
[18:58:39.756] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:12:0)
[18:58:39.756] Timer tick, asking Buildbucket for the build status
[18:58:39.848] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:58:39.848] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:13:0) after 1m0s
[18:59:39.862] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:13:0)
[18:59:39.862] Timer tick, asking Buildbucket for the build status
[18:59:39.996] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:59:39.996] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:14:0) after 1m0s
[19:00:40.075] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:14:0)
[19:00:40.075] Timer tick, asking Buildbucket for the build status
[19:00:40.149] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:00:40.149] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:15:0) after 1m0s
[19:01:40.176] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:15:0)
[19:01:40.176] Timer tick, asking Buildbucket for the build status
[19:01:40.277] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:01:40.277] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:16:0) after 1m0s
[19:02:40.307] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:16:0)
[19:02:40.307] Timer tick, asking Buildbucket for the build status
[19:02:40.565] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:02:40.565] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:17:0) after 1m0s
[19:03:40.548] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:17:0)
[19:03:40.548] Timer tick, asking Buildbucket for the build status
[19:03:40.765] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:03:40.765] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:18:0) after 1m0s
[19:04:40.791] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:18:0)
[19:04:40.791] Timer tick, asking Buildbucket for the build status
[19:04:40.872] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:04:40.872] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:19:0) after 1m0s
[19:05:40.920] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:19:0)
[19:05:40.920] Timer tick, asking Buildbucket for the build status
[19:05:41.038] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:05:41.038] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:20:0) after 1m0s
[19:06:41.124] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:20:0)
[19:06:41.124] Timer tick, asking Buildbucket for the build status
[19:06:41.206] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:06:41.206] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:21:0) after 1m0s
[19:07:41.291] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:21:0)
[19:07:41.291] Timer tick, asking Buildbucket for the build status
[19:07:41.491] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:07:41.491] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:22:0) after 1m0s
[19:08:41.559] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:22:0)
[19:08:41.559] Timer tick, asking Buildbucket for the build status
[19:08:41.660] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:08:41.660] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:23:0) after 1m0s
[19:09:41.776] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:23:0)
[19:09:41.776] Timer tick, asking Buildbucket for the build status
[19:09:41.976] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:09:41.976] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:24:0) after 1m0s
[19:10:42.027] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:24:0)
[19:10:42.027] Timer tick, asking Buildbucket for the build status
[19:10:42.214] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:10:42.214] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:25:0) after 1m0s
[19:11:42.265] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:25:0)
[19:11:42.265] Timer tick, asking Buildbucket for the build status
[19:11:42.338] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:11:42.338] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:26:0) after 1m0s
[19:12:42.329] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:26:0)
[19:12:42.329] Timer tick, asking Buildbucket for the build status
[19:12:42.908] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:12:42.908] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:27:0) after 1m0s
[19:13:43.001] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:27:0)
[19:13:43.001] Timer tick, asking Buildbucket for the build status
[19:13:43.111] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:13:43.111] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:28:0) after 1m0s
[19:14:43.167] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:28:0)
[19:14:43.167] Timer tick, asking Buildbucket for the build status
[19:14:43.280] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:14:43.280] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:29:0) after 1m0s
[19:15:43.309] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:29:0)
[19:15:43.309] Timer tick, asking Buildbucket for the build status
[19:15:43.583] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:15:43.583] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:30:0) after 1m0s
[19:16:43.608] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:30:0)
[19:16:43.608] Timer tick, asking Buildbucket for the build status
[19:16:43.687] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:16:43.687] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:31:0) after 1m0s
[19:17:43.764] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:31:0)
[19:17:43.764] Timer tick, asking Buildbucket for the build status
[19:17:44.038] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:17:44.038] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:32:0) after 1m0s
[19:18:44.115] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:32:0)
[19:18:44.115] Timer tick, asking Buildbucket for the build status
[19:18:44.226] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:18:44.226] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:33:0) after 1m0s
[19:19:44.251] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:33:0)
[19:19:44.251] Timer tick, asking Buildbucket for the build status
[19:19:44.341] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:19:44.341] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:34:0) after 1m0s
[19:20:44.386] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:34:0)
[19:20:44.386] Timer tick, asking Buildbucket for the build status
[19:20:44.501] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:20:44.501] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:35:0) after 1m0s
[19:21:44.566] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:35:0)
[19:21:44.566] Timer tick, asking Buildbucket for the build status
[19:21:44.657] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:21:44.657] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:36:0) after 1m0s
[19:22:44.710] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:36:0)
[19:22:44.710] Timer tick, asking Buildbucket for the build status
[19:22:44.938] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:22:44.938] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:37:0) after 1m0s
[19:23:44.979] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:37:0)
[19:23:44.979] Timer tick, asking Buildbucket for the build status
[19:23:45.100] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:23:45.100] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:38:0) after 1m0s
[19:24:45.286] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:38:0)
[19:24:45.286] Timer tick, asking Buildbucket for the build status
[19:24:45.504] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:24:45.504] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:39:0) after 1m0s
[19:25:45.576] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:39:0)
[19:25:45.576] Timer tick, asking Buildbucket for the build status
[19:25:45.919] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:25:45.919] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:40:0) after 1m0s
[19:26:45.921] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:40:0)
[19:26:45.921] Timer tick, asking Buildbucket for the build status
[19:26:46.185] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:26:46.185] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:41:0) after 1m0s
[19:27:46.234] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:41:0)
[19:27:46.234] Timer tick, asking Buildbucket for the build status
[19:27:46.399] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:27:46.399] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:42:0) after 1m0s
[19:28:46.642] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:42:0)
[19:28:46.642] Timer tick, asking Buildbucket for the build status
[19:28:46.765] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:28:46.765] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:43:0) after 1m0s
[19:29:46.846] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:43:0)
[19:29:46.846] Timer tick, asking Buildbucket for the build status
[19:29:47.119] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:29:47.119] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:44:0) after 1m0s
[19:30:47.239] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:44:0)
[19:30:47.239] Timer tick, asking Buildbucket for the build status
[19:30:47.521] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:30:47.521] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:45:0) after 1m0s
[19:31:47.634] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:45:0)
[19:31:47.634] Timer tick, asking Buildbucket for the build status
[19:31:47.795] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:31:47.795] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:46:0) after 1m0s
[19:32:47.824] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:46:0)
[19:32:47.824] Timer tick, asking Buildbucket for the build status
[19:32:47.942] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:32:47.942] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:47:0) after 1m0s
[19:33:47.963] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:47:0)
[19:33:47.963] Timer tick, asking Buildbucket for the build status
[19:33:48.072] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:33:48.072] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:48:0) after 1m0s
[19:34:48.142] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:48:0)
[19:34:48.142] Timer tick, asking Buildbucket for the build status
[19:34:48.303] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:34:48.303] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:49:0) after 1m0s
[19:35:48.362] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:49:0)
[19:35:48.362] Timer tick, asking Buildbucket for the build status
[19:35:48.550] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:35:48.550] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:50:0) after 1m0s
[19:36:48.607] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:50:0)
[19:36:48.607] Timer tick, asking Buildbucket for the build status
[19:36:48.689] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:36:48.689] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:51:0) after 1m0s
[19:37:48.706] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:51:0)
[19:37:48.706] Timer tick, asking Buildbucket for the build status
[19:37:48.847] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:37:48.847] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:52:0) after 1m0s
[19:38:48.870] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:52:0)
[19:38:48.871] Timer tick, asking Buildbucket for the build status
[19:38:48.963] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:38:48.963] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:53:0) after 1m0s
[19:39:49.084] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:53:0)
[19:39:49.084] Timer tick, asking Buildbucket for the build status
[19:39:49.215] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:39:49.215] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:54:0) after 1m0s
[19:40:49.255] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:54:0)
[19:40:49.255] Timer tick, asking Buildbucket for the build status
[19:40:49.491] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:40:49.491] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:55:0) after 1m0s
[19:41:49.536] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:55:0)
[19:41:49.537] Timer tick, asking Buildbucket for the build status
[19:41:49.652] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:41:49.652] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:56:0) after 1m0s
[19:42:49.735] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:56:0)
[19:42:49.735] Timer tick, asking Buildbucket for the build status
[19:42:49.856] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:42:49.857] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:57:0) after 1m0s
[19:43:49.916] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:57:0)
[19:43:49.917] Timer tick, asking Buildbucket for the build status
[19:43:50.032] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:43:50.032] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:58:0) after 1m0s
[19:44:50.114] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:58:0)
[19:44:50.114] Timer tick, asking Buildbucket for the build status
[19:44:50.339] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:44:50.339] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:59:0) after 1m0s
[19:45:50.457] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:59:0)
[19:45:50.457] Timer tick, asking Buildbucket for the build status
[19:45:50.571] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:45:50.571] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:60:0) after 1m0s
[19:46:50.696] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:60:0)
[19:46:50.696] Timer tick, asking Buildbucket for the build status
[19:46:50.822] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:46:50.822] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:61:0) after 1m0s
[19:47:51.024] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:61:0)
[19:47:51.024] Timer tick, asking Buildbucket for the build status
[19:47:51.152] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:47:51.152] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:62:0) after 1m0s
[19:48:51.210] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:62:0)
[19:48:51.210] Timer tick, asking Buildbucket for the build status
[19:48:51.328] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:48:51.328] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:63:0) after 1m0s
[19:49:51.496] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:63:0)
[19:49:51.496] Timer tick, asking Buildbucket for the build status
[19:49:51.570] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:49:51.570] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:64:0) after 1m0s
[19:50:51.624] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:64:0)
[19:50:51.624] Timer tick, asking Buildbucket for the build status
[19:50:51.730] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:50:51.730] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:65:0) after 1m0s
[19:51:51.736] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:65:0)
[19:51:51.736] Timer tick, asking Buildbucket for the build status
[19:51:51.811] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:51:51.811] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:66:0) after 1m0s
[19:52:51.861] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:66:0)
[19:52:51.861] Timer tick, asking Buildbucket for the build status
[19:52:52.013] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:52:52.013] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:67:0) after 1m0s
[19:53:52.041] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:67:0)
[19:53:52.041] Timer tick, asking Buildbucket for the build status
[19:53:52.243] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:53:52.243] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:68:0) after 1m0s
[19:54:52.273] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:68:0)
[19:54:52.273] Timer tick, asking Buildbucket for the build status
[19:54:52.372] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:54:52.372] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:69:0) after 1m0s
[19:55:52.444] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:69:0)
[19:55:52.444] Timer tick, asking Buildbucket for the build status
[19:55:52.526] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:55:52.526] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:70:0) after 1m0s
[19:56:52.539] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:70:0)
[19:56:52.539] Timer tick, asking Buildbucket for the build status
[19:56:52.621] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:56:52.621] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:71:0) after 1m0s
[19:57:52.695] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:71:0)
[19:57:52.695] Timer tick, asking Buildbucket for the build status
[19:57:52.843] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:57:52.843] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:72:0) after 1m0s
[19:58:52.893] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:72:0)
[19:58:52.893] Timer tick, asking Buildbucket for the build status
[19:58:53.291] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:58:53.291] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:73:0) after 1m0s
[19:59:53.341] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:73:0)
[19:59:53.341] Timer tick, asking Buildbucket for the build status
[19:59:53.421] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:59:53.421] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:74:0) after 1m0s
[20:00:53.438] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:74:0)
[20:00:53.438] Timer tick, asking Buildbucket for the build status
[20:00:53.834] Build 8870697701548960896: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:00:53.834] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:75:0) after 1m0s
[20:01:06.182] Received PubSub notification, asking Buildbucket for the build status
[20:01:06.521] Build 8870697701548960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:53.916] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:75:0)
[20:01:53.916] Timer tick, asking Buildbucket for the build status
[20:01:54.062] Build 8870697701548960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:54.062] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:77:0) after 1m0s
[20:02:54.094] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:77:0)
[20:02:54.094] Timer tick, asking Buildbucket for the build status
[20:02:54.321] Build 8870697701548960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:54.321] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:78:0) after 1m0s
[20:03:54.347] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:78:0)
[20:03:54.347] Timer tick, asking Buildbucket for the build status
[20:03:54.431] Build 8870697701548960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:54.431] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:79:0) after 1m0s
[20:04:54.510] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:79:0)
[20:04:54.510] Timer tick, asking Buildbucket for the build status
[20:04:54.841] Build 8870697701548960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:54.841] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:80:0) after 1m0s
[20:05:54.895] Handling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:80:0)
[20:05:54.895] Timer tick, asking Buildbucket for the build status
[20:05:55.011] Build 8870697701548960896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:55.011] Scheduling timer "check-buildbucket-build-status" (dart/gclient:9036127767870726320:81:0) after 1m0s
[20:06:17.504] Received PubSub notification, asking Buildbucket for the build status
[20:06:17.682] Build 8870697701548960896: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:06:17.682] Buildbucket build:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"completed_ts": "1598645176380149",
"created_by": "project:dart",
"created_ts": "1598640455636460",
"id": "8870697701548960896",
"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\": \"2ca30d8d19cc248a6fac238ca110ab36bee07aa1\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@2ca30d8d19cc248a6fac238ca110ab36bee07aa1\", \"title\": \"2ca30d8d19cc248a6fac238ca110ab36bee07aa1\", \"url\": \"https://dart.googlesource.com/sdk/+/2ca30d8d19cc248a6fac238ca110ab36bee07aa1\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://dart.googlesource.com/sdk\", \"revision\": \"8812673f1b4dbc15578af147af89965956168bdd\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@8812673f1b4dbc15578af147af89965956168bdd\", \"title\": \"8812673f1b4dbc15578af147af89965956168bdd\", \"url\": \"https://dart.googlesource.com/sdk/+/8812673f1b4dbc15578af147af89965956168bdd\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk\", \"revision\": \"8812673f1b4dbc15578af147af89965956168bdd\"}}",
"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\": \"2ca30d8d19cc248a6fac238ca110ab36bee07aa1\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@2ca30d8d19cc248a6fac238ca110ab36bee07aa1\", \"title\": \"2ca30d8d19cc248a6fac238ca110ab36bee07aa1\", \"url\": \"https://dart.googlesource.com/sdk/+/2ca30d8d19cc248a6fac238ca110ab36bee07aa1\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://dart.googlesource.com/sdk\", \"revision\": \"8812673f1b4dbc15578af147af89965956168bdd\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@8812673f1b4dbc15578af147af89965956168bdd\", \"title\": \"8812673f1b4dbc15578af147af89965956168bdd\", \"url\": \"https://dart.googlesource.com/sdk/+/8812673f1b4dbc15578af147af89965956168bdd\"}]}, \"$recipe_engine/swarming\": {\"server\": \"https://chromium-swarm.appspot.com\"}, \"bot_id\": \"luci-dart-try-xenial-33-o866\", \"branch\": \"refs/heads/master\", \"buildername\": \"gclient\", \"buildnumber\": 9722, \"clobber\": \"true\", \"path_config\": \"generic\", \"recipe\": \"dart/gclient\", \"repository\": \"https://dart.googlesource.com/sdk\", \"revision\": \"8812673f1b4dbc15578af147af89965956168bdd\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"browsers\", \"builder_1b6044665c11ac21b76b5174316f99e877d7b36fecbed431d80353fc00e6db12_v2\", \"builder_2053f9ecd38f9ae86e842d80573e928bbbe7c3feabf239fc3b5d879c51b04bed_v2\", \"builder_36049698105b9ee76887ea0cb605bc8a0c32197f72b741356411d9ee8cd1afdd_v2\", \"builder_4465b96f8363613b9fe8383db9c6c683aa0e555919da7f05b6c34e1093f4e002_v2\", \"builder_7c092f355162517ba3f3faf5758c5a96a6ca1a0ae6bd2fae973bc5d8c217d827_v2\", \"builder_7c3609552306ff7d5ad4bfd63effb4ceea2e1a541618e71c97ae514f24ede29b_v2\", \"builder_820fa8e7d7ff17b94bd2f041ec0b46ce0171183f181a810f5631c5d703141cd3_v2\", \"builder_a086cdb2dcae9c5643aaefe9213cd5a7f818b11965a91b6321d0b5cd872ceca3_v2\", \"builder_b4903f1f4f72e5aba35fcf81c8aa2a39a5c11d06b874553a5e6743c0759f1672_v2\", \"builder_cf7a17acfa01d57c643d2bdefb7854698e942c4aa16549b8cedc7c843fe11d1f_v2\", \"builder_e3ee2c8538bb506a0a204be44e8f0f03f96db7b7b70c008de3c4bb2bda345da9_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-33-o866\"], \"image\": [\"dart-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-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\": [\"5498-3454aa6\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"started_ts": "1598644864645995",
"status": "COMPLETED",
"status_changed_ts": "1598645176812948",
"tags": [
"build_address:luci.dart.ci.sandbox/gclient/9722",
"builder:gclient",
"buildset:commit/git/8812673f1b4dbc15578af147af89965956168bdd",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/8812673f1b4dbc15578af147af89965956168bdd",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9036127767870726320",
"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/8870697701548960896/+/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:4e4f370f9e845910",
"user_agent:luci-scheduler"
],
"updated_ts": "1598645176970126",
"url": "https://ci.chromium.org/b/8870697701548960896",
"utcnow_ts": "1598645177673162"
}
}
[20:06:17.683] Invocation finished in 1h18m47.458833046s with status SUCCEEDED