[14:27:34.252] New invocation is queued and will start shortly
[14:27:35.327] Starting the invocation (attempt 1)
[14:27:35.402] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:27:35.402] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:27:35.402] Buildbucket request:
{
"bucket": "luci.dart.ci.sandbox",
"client_operation_id": "9063413808343247552",
"parameters_json": "{\"builder_name\":\"vm-ffi-android-debug-arm\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://dart.googlesource.com/sdk\",\"revision\":\"2ad5af1e13d8650d8221287223c27ed87c98d0c6\"},\"id\":\"https://dart.googlesource.com/sdk/+/refs/heads/master@2ad5af1e13d8650d8221287223c27ed87c98d0c6\",\"title\":\"2ad5af1e13d8650d8221287223c27ed87c98d0c6\",\"url\":\"https://dart.googlesource.com/sdk/+/2ad5af1e13d8650d8221287223c27ed87c98d0c6\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://dart.googlesource.com/sdk\",\"revision\":\"5965789b921a353b8f4a779025b39f2fe6e2b866\"},\"id\":\"https://dart.googlesource.com/sdk/+/refs/heads/master@5965789b921a353b8f4a779025b39f2fe6e2b866\",\"title\":\"5965789b921a353b8f4a779025b39f2fe6e2b866\",\"url\":\"https://dart.googlesource.com/sdk/+/5965789b921a353b8f4a779025b39f2fe6e2b866\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://dart.googlesource.com/sdk\",\"revision\":\"5965789b921a353b8f4a779025b39f2fe6e2b866\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:vm-ffi-android-debug-arm",
"scheduler_invocation_id:9063413808343247552",
"scheduler_job_id:dart/vm-ffi-android-debug-arm",
"user_agent:luci-scheduler",
"buildset:commit/git/5965789b921a353b8f4a779025b39f2fe6e2b866",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/5965789b921a353b8f4a779025b39f2fe6e2b866",
"gitiles_ref:refs/heads/master"
]
}
[14:27:36.948] Buildbucket response:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"created_by": "project:dart",
"created_ts": "1572618455752085",
"id": "8897983746099787664",
"parameters_json": "{\"builder_name\": \"vm-ffi-android-debug-arm\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://dart.googlesource.com/sdk\", \"revision\": \"2ad5af1e13d8650d8221287223c27ed87c98d0c6\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@2ad5af1e13d8650d8221287223c27ed87c98d0c6\", \"title\": \"2ad5af1e13d8650d8221287223c27ed87c98d0c6\", \"url\": \"https://dart.googlesource.com/sdk/+/2ad5af1e13d8650d8221287223c27ed87c98d0c6\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://dart.googlesource.com/sdk\", \"revision\": \"5965789b921a353b8f4a779025b39f2fe6e2b866\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@5965789b921a353b8f4a779025b39f2fe6e2b866\", \"title\": \"5965789b921a353b8f4a779025b39f2fe6e2b866\", \"url\": \"https://dart.googlesource.com/sdk/+/5965789b921a353b8f4a779025b39f2fe6e2b866\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk\", \"revision\": \"5965789b921a353b8f4a779025b39f2fe6e2b866\"}}",
"project": "dart",
"result_details_json": "{\"properties\": {}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1572618456607588",
"tags": [
"build_address:luci.dart.ci.sandbox/vm-ffi-android-debug-arm/2316",
"builder:vm-ffi-android-debug-arm",
"buildset:commit/git/5965789b921a353b8f4a779025b39f2fe6e2b866",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/5965789b921a353b8f4a779025b39f2fe6e2b866",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9063413808343247552",
"scheduler_job_id:dart/vm-ffi-android-debug-arm",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/dart/buildbucket/cr-buildbucket.appspot.com/8897983746099787664/+/annotations",
"swarming_tag:luci_project:dart",
"swarming_tag:recipe_name:dart/neo",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1572618456607712",
"url": "https://ci.chromium.org/b/8897983746099787664",
"utcnow_ts": "1572618456939869"
}
}
[14:27:36.948] Task URL: https://ci.chromium.org/b/8897983746099787664
[14:27:36.948] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:2:0) after 1m0s
[14:28:37.116] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:2:0)
[14:28:37.116] Timer tick, asking Buildbucket for the build status
[14:28:37.257] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:28:37.257] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:3:0) after 1m0s
[14:29:37.297] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:3:0)
[14:29:37.297] Timer tick, asking Buildbucket for the build status
[14:29:37.587] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:29:37.587] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:4:0) after 1m0s
[14:30:37.647] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:4:0)
[14:30:37.647] Timer tick, asking Buildbucket for the build status
[14:30:37.813] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:30:37.813] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:5:0) after 1m0s
[14:31:37.845] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:5:0)
[14:31:37.845] Timer tick, asking Buildbucket for the build status
[14:31:38.007] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:31:38.007] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:6:0) after 1m0s
[14:32:38.049] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:6:0)
[14:32:38.049] Timer tick, asking Buildbucket for the build status
[14:32:38.880] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:32:38.880] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:7:0) after 1m0s
[14:33:38.952] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:7:0)
[14:33:38.952] Timer tick, asking Buildbucket for the build status
[14:33:39.131] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:33:39.131] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:8:0) after 1m0s
[14:34:39.172] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:8:0)
[14:34:39.172] Timer tick, asking Buildbucket for the build status
[14:34:40.088] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:34:40.088] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:9:0) after 1m0s
[14:35:40.121] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:9:0)
[14:35:40.121] Timer tick, asking Buildbucket for the build status
[14:35:40.644] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:35:40.644] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:10:0) after 1m0s
[14:36:40.682] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:10:0)
[14:36:40.682] Timer tick, asking Buildbucket for the build status
[14:36:40.962] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:36:40.962] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:11:0) after 1m0s
[14:37:41.021] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:11:0)
[14:37:41.021] Timer tick, asking Buildbucket for the build status
[14:37:41.313] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:37:41.313] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:12:0) after 1m0s
[14:38:41.370] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:12:0)
[14:38:41.370] Timer tick, asking Buildbucket for the build status
[14:38:41.551] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:38:41.551] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:13:0) after 1m0s
[14:39:41.629] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:13:0)
[14:39:41.629] Timer tick, asking Buildbucket for the build status
[14:39:42.273] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:39:42.273] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:14:0) after 1m0s
[14:40:42.307] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:14:0)
[14:40:42.307] Timer tick, asking Buildbucket for the build status
[14:40:42.505] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:40:42.505] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:15:0) after 1m0s
[14:41:42.626] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:15:0)
[14:41:42.626] Timer tick, asking Buildbucket for the build status
[14:41:42.781] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:41:42.781] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:16:0) after 1m0s
[14:42:42.824] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:16:0)
[14:42:42.824] Timer tick, asking Buildbucket for the build status
[14:42:43.078] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:42:43.078] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:17:0) after 1m0s
[14:43:43.157] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:17:0)
[14:43:43.157] Timer tick, asking Buildbucket for the build status
[14:43:43.400] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:43:43.400] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:18:0) after 1m0s
[14:44:43.445] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:18:0)
[14:44:43.445] Timer tick, asking Buildbucket for the build status
[14:44:43.964] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:44:43.964] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:19:0) after 1m0s
[14:45:44.094] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:19:0)
[14:45:44.094] Timer tick, asking Buildbucket for the build status
[14:45:44.619] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:45:44.619] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:20:0) after 1m0s
[14:46:44.643] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:20:0)
[14:46:44.643] Timer tick, asking Buildbucket for the build status
[14:46:44.886] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:46:44.886] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:21:0) after 1m0s
[14:47:44.938] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:21:0)
[14:47:44.938] Timer tick, asking Buildbucket for the build status
[14:47:45.315] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:47:45.315] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:22:0) after 1m0s
[14:48:45.432] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:22:0)
[14:48:45.432] Timer tick, asking Buildbucket for the build status
[14:48:45.808] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:48:45.808] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:23:0) after 1m0s
[14:49:45.902] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:23:0)
[14:49:45.902] Timer tick, asking Buildbucket for the build status
[14:49:48.218] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:49:48.218] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:24:0) after 1m0s
[14:50:48.302] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:24:0)
[14:50:48.302] Timer tick, asking Buildbucket for the build status
[14:50:48.774] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:50:48.774] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:25:0) after 1m0s
[14:51:48.894] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:25:0)
[14:51:48.894] Timer tick, asking Buildbucket for the build status
[14:51:49.107] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:51:49.107] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:26:0) after 1m0s
[14:52:49.201] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:26:0)
[14:52:49.201] Timer tick, asking Buildbucket for the build status
[14:52:49.507] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:52:49.507] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:27:0) after 1m0s
[14:53:49.537] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:27:0)
[14:53:49.537] Timer tick, asking Buildbucket for the build status
[14:53:49.731] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:53:49.731] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:28:0) after 1m0s
[14:54:49.765] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:28:0)
[14:54:49.766] Timer tick, asking Buildbucket for the build status
[14:54:50.308] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:54:50.308] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:29:0) after 1m0s
[14:55:50.362] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:29:0)
[14:55:50.362] Timer tick, asking Buildbucket for the build status
[14:55:50.749] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:55:50.749] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:30:0) after 1m0s
[14:56:50.884] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:30:0)
[14:56:50.884] Timer tick, asking Buildbucket for the build status
[14:56:51.219] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:56:51.219] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:31:0) after 1m0s
[14:57:51.248] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:31:0)
[14:57:51.248] Timer tick, asking Buildbucket for the build status
[14:57:51.492] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:57:51.492] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:32:0) after 1m0s
[14:58:51.597] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:32:0)
[14:58:51.597] Timer tick, asking Buildbucket for the build status
[14:58:51.754] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:58:51.754] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:33:0) after 1m0s
[14:59:51.871] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:33:0)
[14:59:51.871] Timer tick, asking Buildbucket for the build status
[14:59:51.993] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:59:51.993] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:34:0) after 1m0s
[15:00:52.121] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:34:0)
[15:00:52.121] Timer tick, asking Buildbucket for the build status
[15:00:52.985] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:00:52.985] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:35:0) after 1m0s
[15:01:53.037] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:35:0)
[15:01:53.037] Timer tick, asking Buildbucket for the build status
[15:01:53.274] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:01:53.274] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:36:0) after 1m0s
[15:02:53.462] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:36:0)
[15:02:53.462] Timer tick, asking Buildbucket for the build status
[15:02:53.735] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:02:53.735] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:37:0) after 1m0s
[15:03:53.805] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:37:0)
[15:03:53.805] Timer tick, asking Buildbucket for the build status
[15:03:53.980] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:03:53.980] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:38:0) after 1m0s
[15:04:54.036] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:38:0)
[15:04:54.036] Timer tick, asking Buildbucket for the build status
[15:04:54.597] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:04:54.597] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:39:0) after 1m0s
[15:05:54.725] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:39:0)
[15:05:54.725] Timer tick, asking Buildbucket for the build status
[15:05:55.228] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:05:55.228] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:40:0) after 1m0s
[15:06:55.404] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:40:0)
[15:06:55.404] Timer tick, asking Buildbucket for the build status
[15:06:55.702] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:06:55.702] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:41:0) after 1m0s
[15:07:55.760] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:41:0)
[15:07:55.760] Timer tick, asking Buildbucket for the build status
[15:07:55.903] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:07:55.903] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:42:0) after 1m0s
[15:08:55.945] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:42:0)
[15:08:55.945] Timer tick, asking Buildbucket for the build status
[15:08:56.207] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:08:56.207] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:43:0) after 1m0s
[15:09:56.313] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:43:0)
[15:09:56.313] Timer tick, asking Buildbucket for the build status
[15:09:56.485] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:09:56.485] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:44:0) after 1m0s
[15:10:56.595] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:44:0)
[15:10:56.595] Timer tick, asking Buildbucket for the build status
[15:10:56.795] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:10:56.795] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:45:0) after 1m0s
[15:11:56.782] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:45:0)
[15:11:56.782] Timer tick, asking Buildbucket for the build status
[15:11:59.176] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:11:59.176] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:46:0) after 1m0s
[15:12:59.236] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:46:0)
[15:12:59.236] Timer tick, asking Buildbucket for the build status
[15:12:59.806] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:12:59.806] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:47:0) after 1m0s
[15:13:59.840] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:47:0)
[15:13:59.840] Timer tick, asking Buildbucket for the build status
[15:14:00.094] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:14:00.094] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:48:0) after 1m0s
[15:15:00.171] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:48:0)
[15:15:00.171] Timer tick, asking Buildbucket for the build status
[15:15:00.486] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:15:00.486] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:49:0) after 1m0s
[15:16:00.514] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:49:0)
[15:16:00.514] Timer tick, asking Buildbucket for the build status
[15:16:00.690] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:16:00.690] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:50:0) after 1m0s
[15:17:00.790] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:50:0)
[15:17:00.790] Timer tick, asking Buildbucket for the build status
[15:17:01.349] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:17:01.349] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:51:0) after 1m0s
[15:18:01.382] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:51:0)
[15:18:01.382] Timer tick, asking Buildbucket for the build status
[15:18:01.617] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:18:01.617] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:52:0) after 1m0s
[15:19:01.672] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:52:0)
[15:19:01.672] Timer tick, asking Buildbucket for the build status
[15:19:01.818] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:19:01.819] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:53:0) after 1m0s
[15:20:01.855] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:53:0)
[15:20:01.855] Timer tick, asking Buildbucket for the build status
[15:20:02.248] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:20:02.248] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:54:0) after 1m0s
[15:21:02.384] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:54:0)
[15:21:02.384] Timer tick, asking Buildbucket for the build status
[15:21:02.735] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:21:02.735] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:55:0) after 1m0s
[15:22:02.769] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:55:0)
[15:22:02.769] Timer tick, asking Buildbucket for the build status
[15:22:03.322] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:22:03.323] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:56:0) after 1m0s
[15:23:03.429] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:56:0)
[15:23:03.429] Timer tick, asking Buildbucket for the build status
[15:23:04.299] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:23:04.299] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:57:0) after 1m0s
[15:24:04.334] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:57:0)
[15:24:04.334] Timer tick, asking Buildbucket for the build status
[15:24:04.574] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:24:04.574] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:58:0) after 1m0s
[15:25:04.742] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:58:0)
[15:25:04.742] Timer tick, asking Buildbucket for the build status
[15:25:04.994] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:25:04.994] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:59:0) after 1m0s
[15:26:05.122] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:59:0)
[15:26:05.122] Timer tick, asking Buildbucket for the build status
[15:26:05.393] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:26:05.393] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:60:0) after 1m0s
[15:27:05.479] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:60:0)
[15:27:05.479] Timer tick, asking Buildbucket for the build status
[15:27:06.024] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:27:06.024] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:61:0) after 1m0s
[15:28:06.069] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:61:0)
[15:28:06.069] Timer tick, asking Buildbucket for the build status
[15:28:06.262] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:28:06.262] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:62:0) after 1m0s
[15:29:06.419] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:62:0)
[15:29:06.419] Timer tick, asking Buildbucket for the build status
[15:29:07.337] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:29:07.337] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:63:0) after 1m0s
[15:30:07.492] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:63:0)
[15:30:07.492] Timer tick, asking Buildbucket for the build status
[15:30:08.108] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:30:08.108] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:64:0) after 1m0s
[15:31:08.146] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:64:0)
[15:31:08.146] Timer tick, asking Buildbucket for the build status
[15:31:08.323] Build 8897983746099787664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:31:08.323] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:65:0) after 1m0s
[15:31:21.243] Received PubSub notification, asking Buildbucket for the build status
[15:31:21.398] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:08.313] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:65:0)
[15:32:08.313] Timer tick, asking Buildbucket for the build status
[15:32:08.609] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:08.609] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:67:0) after 1m0s
[15:33:08.612] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:67:0)
[15:33:08.612] Timer tick, asking Buildbucket for the build status
[15:33:08.904] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:08.904] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:68:0) after 1m0s
[15:34:08.886] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:68:0)
[15:34:08.886] Timer tick, asking Buildbucket for the build status
[15:34:09.101] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:09.101] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:69:0) after 1m0s
[15:35:09.132] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:69:0)
[15:35:09.132] Timer tick, asking Buildbucket for the build status
[15:35:09.375] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:09.375] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:70:0) after 1m0s
[15:36:09.445] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:70:0)
[15:36:09.445] Timer tick, asking Buildbucket for the build status
[15:36:09.900] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:09.900] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:71:0) after 1m0s
[15:37:09.932] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:71:0)
[15:37:09.932] Timer tick, asking Buildbucket for the build status
[15:37:10.369] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:10.369] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:72:0) after 1m0s
[15:38:10.475] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:72:0)
[15:38:10.475] Timer tick, asking Buildbucket for the build status
[15:38:10.668] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:10.668] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:73:0) after 1m0s
[15:39:10.753] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:73:0)
[15:39:10.753] Timer tick, asking Buildbucket for the build status
[15:39:10.944] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:10.944] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:74:0) after 1m0s
[15:40:10.992] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:74:0)
[15:40:10.992] Timer tick, asking Buildbucket for the build status
[15:40:11.168] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:11.168] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:75:0) after 1m0s
[15:41:11.270] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:75:0)
[15:41:11.270] Timer tick, asking Buildbucket for the build status
[15:41:11.570] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:11.570] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:76:0) after 1m0s
[15:42:11.693] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:76:0)
[15:42:11.693] Timer tick, asking Buildbucket for the build status
[15:42:11.920] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:11.920] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:77:0) after 1m0s
[15:43:11.957] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:77:0)
[15:43:11.957] Timer tick, asking Buildbucket for the build status
[15:43:12.078] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:12.078] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:78:0) after 1m0s
[15:44:12.307] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:78:0)
[15:44:12.307] Timer tick, asking Buildbucket for the build status
[15:44:12.672] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:12.672] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:79:0) after 1m0s
[15:45:12.733] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:79:0)
[15:45:12.733] Timer tick, asking Buildbucket for the build status
[15:45:13.012] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:13.012] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:80:0) after 1m0s
[15:46:13.117] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:80:0)
[15:46:13.117] Timer tick, asking Buildbucket for the build status
[15:46:13.367] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:13.367] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:81:0) after 1m0s
[15:47:13.358] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:81:0)
[15:47:13.358] Timer tick, asking Buildbucket for the build status
[15:47:14.019] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:14.019] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:82:0) after 1m0s
[15:48:14.275] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:82:0)
[15:48:14.275] Timer tick, asking Buildbucket for the build status
[15:48:15.938] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:15.938] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:83:0) after 1m0s
[15:49:15.983] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:83:0)
[15:49:15.983] Timer tick, asking Buildbucket for the build status
[15:49:18.165] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:18.165] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:84:0) after 1m0s
[15:50:18.250] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:84:0)
[15:50:18.250] Timer tick, asking Buildbucket for the build status
[15:50:18.360] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:18.360] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:85:0) after 1m0s
[15:51:18.499] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:85:0)
[15:51:18.499] Timer tick, asking Buildbucket for the build status
[15:51:19.278] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:19.278] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:86:0) after 1m0s
[15:52:19.353] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:86:0)
[15:52:19.354] Timer tick, asking Buildbucket for the build status
[15:52:19.881] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:19.882] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:87:0) after 1m0s
[15:53:19.941] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:87:0)
[15:53:19.941] Timer tick, asking Buildbucket for the build status
[15:53:20.213] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:20.213] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:88:0) after 1m0s
[15:54:20.269] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:88:0)
[15:54:20.269] Timer tick, asking Buildbucket for the build status
[15:54:20.751] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:20.751] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:89:0) after 1m0s
[15:55:20.813] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:89:0)
[15:55:20.813] Timer tick, asking Buildbucket for the build status
[15:55:21.043] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:21.043] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:90:0) after 1m0s
[15:56:21.078] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:90:0)
[15:56:21.078] Timer tick, asking Buildbucket for the build status
[15:56:22.437] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:22.437] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:91:0) after 1m0s
[15:57:22.591] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:91:0)
[15:57:22.591] Timer tick, asking Buildbucket for the build status
[15:57:23.444] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:23.444] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:92:0) after 1m0s
[15:58:23.484] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:92:0)
[15:58:23.484] Timer tick, asking Buildbucket for the build status
[15:58:23.597] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:23.597] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:93:0) after 1m0s
[15:59:23.600] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:93:0)
[15:59:23.600] Timer tick, asking Buildbucket for the build status
[15:59:23.854] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:23.854] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:94:0) after 1m0s
[16:00:23.879] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:94:0)
[16:00:23.879] Timer tick, asking Buildbucket for the build status
[16:00:24.107] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:24.108] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:95:0) after 1m0s
[16:01:24.216] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:95:0)
[16:01:24.216] Timer tick, asking Buildbucket for the build status
[16:01:24.364] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:24.364] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:96:0) after 1m0s
[16:02:24.496] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:96:0)
[16:02:24.496] Timer tick, asking Buildbucket for the build status
[16:02:24.725] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:24.725] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:97:0) after 1m0s
[16:03:24.889] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:97:0)
[16:03:24.889] Timer tick, asking Buildbucket for the build status
[16:03:25.183] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:25.183] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:98:0) after 1m0s
[16:04:25.231] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:98:0)
[16:04:25.231] Timer tick, asking Buildbucket for the build status
[16:04:27.301] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:27.301] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:99:0) after 1m0s
[16:05:27.397] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:99:0)
[16:05:27.397] Timer tick, asking Buildbucket for the build status
[16:05:28.158] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:28.158] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:100:0) after 1m0s
[16:06:28.349] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:100:0)
[16:06:28.349] Timer tick, asking Buildbucket for the build status
[16:06:28.807] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:28.807] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:101:0) after 1m0s
[16:07:28.839] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:101:0)
[16:07:28.839] Timer tick, asking Buildbucket for the build status
[16:07:29.345] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:29.345] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:102:0) after 1m0s
[16:08:29.401] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:102:0)
[16:08:29.401] Timer tick, asking Buildbucket for the build status
[16:08:29.596] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:29.596] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:103:0) after 1m0s
[16:09:29.632] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:103:0)
[16:09:29.632] Timer tick, asking Buildbucket for the build status
[16:09:29.785] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:29.785] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:104:0) after 1m0s
[16:10:29.815] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:104:0)
[16:10:29.815] Timer tick, asking Buildbucket for the build status
[16:10:30.057] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:30.057] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:105:0) after 1m0s
[16:11:30.174] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:105:0)
[16:11:30.174] Timer tick, asking Buildbucket for the build status
[16:11:30.319] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:30.319] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:106:0) after 1m0s
[16:12:30.395] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:106:0)
[16:12:30.395] Timer tick, asking Buildbucket for the build status
[16:12:30.703] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:30.703] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:107:0) after 1m0s
[16:13:30.739] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:107:0)
[16:13:30.739] Timer tick, asking Buildbucket for the build status
[16:13:31.589] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:31.589] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:108:0) after 1m0s
[16:14:31.670] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:108:0)
[16:14:31.670] Timer tick, asking Buildbucket for the build status
[16:14:31.860] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:31.860] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:109:0) after 1m0s
[16:15:31.941] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:109:0)
[16:15:31.941] Timer tick, asking Buildbucket for the build status
[16:15:32.148] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:32.148] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:110:0) after 1m0s
[16:16:32.141] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:110:0)
[16:16:32.141] Timer tick, asking Buildbucket for the build status
[16:16:32.275] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:32.275] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:111:0) after 1m0s
[16:17:32.315] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:111:0)
[16:17:32.315] Timer tick, asking Buildbucket for the build status
[16:17:32.578] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:32.578] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:112:0) after 1m0s
[16:18:32.630] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:112:0)
[16:18:32.630] Timer tick, asking Buildbucket for the build status
[16:18:32.990] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:32.990] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:113:0) after 1m0s
[16:19:33.009] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:113:0)
[16:19:33.009] Timer tick, asking Buildbucket for the build status
[16:19:34.951] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:34.951] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:114:0) after 1m0s
[16:20:35.055] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:114:0)
[16:20:35.055] Timer tick, asking Buildbucket for the build status
[16:20:35.342] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:35.342] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:115:0) after 1m0s
[16:21:35.393] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:115:0)
[16:21:35.393] Timer tick, asking Buildbucket for the build status
[16:21:36.146] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:36.146] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:116:0) after 1m0s
[16:22:36.359] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:116:0)
[16:22:36.359] Timer tick, asking Buildbucket for the build status
[16:22:36.570] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:36.570] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:117:0) after 1m0s
[16:23:36.571] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:117:0)
[16:23:36.571] Timer tick, asking Buildbucket for the build status
[16:23:37.225] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:37.225] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:118:0) after 1m0s
[16:24:37.292] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:118:0)
[16:24:37.292] Timer tick, asking Buildbucket for the build status
[16:24:37.438] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:37.438] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:119:0) after 1m0s
[16:25:37.566] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:119:0)
[16:25:37.566] Timer tick, asking Buildbucket for the build status
[16:25:37.718] Build 8897983746099787664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:37.718] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9063413808343247552:120:0) after 1m0s
[16:25:50.428] Received PubSub notification, asking Buildbucket for the build status
[16:25:50.567] Build 8897983746099787664: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:25:50.567] Buildbucket build:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"completed_ts": "1572625548623974",
"created_by": "project:dart",
"created_ts": "1572618455752085",
"id": "8897983746099787664",
"parameters_json": "{\"builder_name\": \"vm-ffi-android-debug-arm\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://dart.googlesource.com/sdk\", \"revision\": \"2ad5af1e13d8650d8221287223c27ed87c98d0c6\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@2ad5af1e13d8650d8221287223c27ed87c98d0c6\", \"title\": \"2ad5af1e13d8650d8221287223c27ed87c98d0c6\", \"url\": \"https://dart.googlesource.com/sdk/+/2ad5af1e13d8650d8221287223c27ed87c98d0c6\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://dart.googlesource.com/sdk\", \"revision\": \"5965789b921a353b8f4a779025b39f2fe6e2b866\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@5965789b921a353b8f4a779025b39f2fe6e2b866\", \"title\": \"5965789b921a353b8f4a779025b39f2fe6e2b866\", \"url\": \"https://dart.googlesource.com/sdk/+/5965789b921a353b8f4a779025b39f2fe6e2b866\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk\", \"revision\": \"5965789b921a353b8f4a779025b39f2fe6e2b866\"}}",
"project": "dart",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$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\": \"2ad5af1e13d8650d8221287223c27ed87c98d0c6\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@2ad5af1e13d8650d8221287223c27ed87c98d0c6\", \"title\": \"2ad5af1e13d8650d8221287223c27ed87c98d0c6\", \"url\": \"https://dart.googlesource.com/sdk/+/2ad5af1e13d8650d8221287223c27ed87c98d0c6\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://dart.googlesource.com/sdk\", \"revision\": \"5965789b921a353b8f4a779025b39f2fe6e2b866\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@5965789b921a353b8f4a779025b39f2fe6e2b866\", \"title\": \"5965789b921a353b8f4a779025b39f2fe6e2b866\", \"url\": \"https://dart.googlesource.com/sdk/+/5965789b921a353b8f4a779025b39f2fe6e2b866\"}]}, \"bot_id\": \"luci-dart-try-xenial-1-jwth\", \"branch\": \"refs/heads/master\", \"buildername\": \"vm-ffi-android-debug-arm\", \"buildnumber\": 2316, \"clobber\": \"true\", \"got_revision\": \"5965789b921a353b8f4a779025b39f2fe6e2b866\", \"new_workflow_enabled\": true, \"path_config\": \"generic\", \"recipe\": \"dart/neo\", \"repository\": \"https://dart.googlesource.com/sdk\", \"revision\": \"5965789b921a353b8f4a779025b39f2fe6e2b866\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_13eddc83ceddd09c8e67e0b7bf8bb3a132bac13962e52c6d1b1b73e9f43fc6bd_v2\", \"builder_2568cb5c143ed8cc40564df1a833ae4c1992befd94d0645f49c1ad521b08aa15_v2\", \"builder_2a98a8b518ca4a18ae82ffedef2eea93c4a884abc1d231637aa846a898cf2599_v2\", \"builder_3cd6ed73d0a1ca1ec60323b50b97cfde8325581dce07765c41a04f21400d31fd_v2\", \"builder_6cbd46bb7b85f2b5182064189e0144fd34df9d1a71ef5b4bc3ca003434985b44_v2\", \"builder_bcb474518f67c7cb70ce8bf9b0864cf257bd65b5ea90544e9642b63757276434_v2\", \"git\", \"goma_v2\", \"swarming_module_cache_vpython\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"host_class\": [\"default\"], \"id\": [\"luci-dart-try-xenial-1-jwth\"], \"image\": [\"chrome-xenial-19102400-d35fedf5a0d\"], \"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\": [\"4621-f8a5b1c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"started_ts": "1572622280265407",
"status": "COMPLETED",
"status_changed_ts": "1572625549904148",
"tags": [
"build_address:luci.dart.ci.sandbox/vm-ffi-android-debug-arm/2316",
"builder:vm-ffi-android-debug-arm",
"buildset:commit/git/5965789b921a353b8f4a779025b39f2fe6e2b866",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/5965789b921a353b8f4a779025b39f2fe6e2b866",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9063413808343247552",
"scheduler_job_id:dart/vm-ffi-android-debug-arm",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/dart/buildbucket/cr-buildbucket.appspot.com/8897983746099787664/+/annotations",
"swarming_tag:luci_project:dart",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:dart/neo",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:48402f1680dfcd10",
"user_agent:luci-scheduler"
],
"updated_ts": "1572625549918614",
"url": "https://ci.chromium.org/b/8897983746099787664",
"utcnow_ts": "1572625550547249"
}
}
[16:25:50.567] Invocation finished in 1h58m16.337609179s with status SUCCEEDED