[15:30:28.701] New invocation is queued and will start shortly
[15:30:30.117] Starting the invocation (attempt 1)
[15:30:30.239] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:30:30.239] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:30:30.239] Buildbucket request:
{
"bucket": "luci.dart.ci.sandbox",
"client_operation_id": "9056524481111880080",
"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\":\"be1ddc8a647442a5ca312386db22bd32cf500efe\"},\"id\":\"https://dart.googlesource.com/sdk/+/refs/heads/master@be1ddc8a647442a5ca312386db22bd32cf500efe\",\"title\":\"be1ddc8a647442a5ca312386db22bd32cf500efe\",\"url\":\"https://dart.googlesource.com/sdk/+/be1ddc8a647442a5ca312386db22bd32cf500efe\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://dart.googlesource.com/sdk\",\"revision\":\"8f382d13857017da2d09eef1bc8196ffa628be2f\"},\"id\":\"https://dart.googlesource.com/sdk/+/refs/heads/master@8f382d13857017da2d09eef1bc8196ffa628be2f\",\"title\":\"8f382d13857017da2d09eef1bc8196ffa628be2f\",\"url\":\"https://dart.googlesource.com/sdk/+/8f382d13857017da2d09eef1bc8196ffa628be2f\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://dart.googlesource.com/sdk\",\"revision\":\"8f382d13857017da2d09eef1bc8196ffa628be2f\"}}",
"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:9056524481111880080",
"scheduler_job_id:dart/vm-ffi-android-debug-arm",
"user_agent:luci-scheduler",
"buildset:commit/git/8f382d13857017da2d09eef1bc8196ffa628be2f",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/8f382d13857017da2d09eef1bc8196ffa628be2f",
"gitiles_ref:refs/heads/master"
]
}
[15:30:32.958] Buildbucket response:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"created_by": "project:dart",
"created_ts": "1579188630886284",
"id": "8891094418138072960",
"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\": \"be1ddc8a647442a5ca312386db22bd32cf500efe\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@be1ddc8a647442a5ca312386db22bd32cf500efe\", \"title\": \"be1ddc8a647442a5ca312386db22bd32cf500efe\", \"url\": \"https://dart.googlesource.com/sdk/+/be1ddc8a647442a5ca312386db22bd32cf500efe\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://dart.googlesource.com/sdk\", \"revision\": \"8f382d13857017da2d09eef1bc8196ffa628be2f\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@8f382d13857017da2d09eef1bc8196ffa628be2f\", \"title\": \"8f382d13857017da2d09eef1bc8196ffa628be2f\", \"url\": \"https://dart.googlesource.com/sdk/+/8f382d13857017da2d09eef1bc8196ffa628be2f\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk\", \"revision\": \"8f382d13857017da2d09eef1bc8196ffa628be2f\"}}",
"project": "dart",
"result_details_json": "{\"properties\": {}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1579188631645052",
"tags": [
"build_address:luci.dart.ci.sandbox/vm-ffi-android-debug-arm/2977",
"builder:vm-ffi-android-debug-arm",
"buildset:commit/git/8f382d13857017da2d09eef1bc8196ffa628be2f",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/8f382d13857017da2d09eef1bc8196ffa628be2f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9056524481111880080",
"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/8891094418138072960/+/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": "1579188631645162",
"url": "https://ci.chromium.org/b/8891094418138072960",
"utcnow_ts": "1579188632938444"
}
}
[15:30:32.958] Task URL: https://ci.chromium.org/b/8891094418138072960
[15:30:32.958] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:2:0) after 1m0s
[15:31:33.048] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:2:0)
[15:31:33.048] Timer tick, asking Buildbucket for the build status
[15:31:33.646] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:31:33.646] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:3:0) after 1m0s
[15:32:33.646] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:3:0)
[15:32:33.646] Timer tick, asking Buildbucket for the build status
[15:32:33.777] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:32:33.777] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:4:0) after 1m0s
[15:33:33.834] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:4:0)
[15:33:33.834] Timer tick, asking Buildbucket for the build status
[15:33:33.970] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:33:33.970] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:5:0) after 1m0s
[15:34:34.049] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:5:0)
[15:34:34.049] Timer tick, asking Buildbucket for the build status
[15:34:34.210] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:34:34.210] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:6:0) after 1m0s
[15:35:34.289] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:6:0)
[15:35:34.289] Timer tick, asking Buildbucket for the build status
[15:35:34.459] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:35:34.459] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:7:0) after 1m0s
[15:36:34.576] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:7:0)
[15:36:34.577] Timer tick, asking Buildbucket for the build status
[15:36:34.792] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:36:34.792] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:8:0) after 1m0s
[15:37:34.938] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:8:0)
[15:37:34.938] Timer tick, asking Buildbucket for the build status
[15:37:35.068] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:37:35.069] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:9:0) after 1m0s
[15:38:35.092] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:9:0)
[15:38:35.092] Timer tick, asking Buildbucket for the build status
[15:38:35.268] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:38:35.268] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:10:0) after 1m0s
[15:39:35.309] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:10:0)
[15:39:35.309] Timer tick, asking Buildbucket for the build status
[15:39:35.451] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:39:35.451] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:11:0) after 1m0s
[15:40:35.515] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:11:0)
[15:40:35.516] Timer tick, asking Buildbucket for the build status
[15:40:35.744] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:40:35.744] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:12:0) after 1m0s
[15:41:35.767] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:12:0)
[15:41:35.767] Timer tick, asking Buildbucket for the build status
[15:41:36.140] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:41:36.140] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:13:0) after 1m0s
[15:42:36.276] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:13:0)
[15:42:36.276] Timer tick, asking Buildbucket for the build status
[15:42:37.633] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:42:37.633] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:14:0) after 1m0s
[15:43:37.747] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:14:0)
[15:43:37.747] Timer tick, asking Buildbucket for the build status
[15:43:38.190] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:43:38.190] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:15:0) after 1m0s
[15:44:38.334] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:15:0)
[15:44:38.334] Timer tick, asking Buildbucket for the build status
[15:44:38.479] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:44:38.479] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:16:0) after 1m0s
[15:45:38.725] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:16:0)
[15:45:38.725] Timer tick, asking Buildbucket for the build status
[15:45:38.864] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:45:38.864] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:17:0) after 1m0s
[15:46:39.077] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:17:0)
[15:46:39.077] Timer tick, asking Buildbucket for the build status
[15:46:39.232] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:46:39.232] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:18:0) after 1m0s
[15:47:39.347] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:18:0)
[15:47:39.347] Timer tick, asking Buildbucket for the build status
[15:47:39.657] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:47:39.657] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:19:0) after 1m0s
[15:48:39.866] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:19:0)
[15:48:39.866] Timer tick, asking Buildbucket for the build status
[15:48:39.997] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:48:39.997] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:20:0) after 1m0s
[15:49:40.060] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:20:0)
[15:49:40.060] Timer tick, asking Buildbucket for the build status
[15:49:40.674] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:49:40.674] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:21:0) after 1m0s
[15:50:40.698] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:21:0)
[15:50:40.698] Timer tick, asking Buildbucket for the build status
[15:50:40.864] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:50:40.864] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:22:0) after 1m0s
[15:51:40.903] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:22:0)
[15:51:40.903] Timer tick, asking Buildbucket for the build status
[15:51:41.027] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:51:41.027] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:23:0) after 1m0s
[15:52:41.089] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:23:0)
[15:52:41.089] Timer tick, asking Buildbucket for the build status
[15:52:41.253] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:52:41.253] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:24:0) after 1m0s
[15:53:41.312] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:24:0)
[15:53:41.312] Timer tick, asking Buildbucket for the build status
[15:53:41.512] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:53:41.512] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:25:0) after 1m0s
[15:54:41.595] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:25:0)
[15:54:41.595] Timer tick, asking Buildbucket for the build status
[15:54:41.742] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:54:41.742] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:26:0) after 1m0s
[15:55:41.977] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:26:0)
[15:55:41.977] Timer tick, asking Buildbucket for the build status
[15:55:42.191] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:55:42.191] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:27:0) after 1m0s
[15:56:42.251] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:27:0)
[15:56:42.251] Timer tick, asking Buildbucket for the build status
[15:56:42.528] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:56:42.528] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:28:0) after 1m0s
[15:57:42.645] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:28:0)
[15:57:42.645] Timer tick, asking Buildbucket for the build status
[15:57:43.003] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:57:43.003] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:29:0) after 1m0s
[15:58:43.128] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:29:0)
[15:58:43.128] Timer tick, asking Buildbucket for the build status
[15:58:44.749] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:58:44.749] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:30:0) after 1m0s
[15:59:45.152] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:30:0)
[15:59:45.152] Timer tick, asking Buildbucket for the build status
[15:59:45.330] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:59:45.330] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:31:0) after 1m0s
[16:00:45.526] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:31:0)
[16:00:45.526] Timer tick, asking Buildbucket for the build status
[16:00:46.126] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:00:46.126] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:32:0) after 1m0s
[16:01:46.217] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:32:0)
[16:01:46.217] Timer tick, asking Buildbucket for the build status
[16:01:46.361] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:01:46.361] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:33:0) after 1m0s
[16:02:46.404] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:33:0)
[16:02:46.404] Timer tick, asking Buildbucket for the build status
[16:02:46.625] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:02:46.625] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:34:0) after 1m0s
[16:03:46.703] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:34:0)
[16:03:46.703] Timer tick, asking Buildbucket for the build status
[16:03:46.905] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:03:46.905] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:35:0) after 1m0s
[16:04:47.041] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:35:0)
[16:04:47.041] Timer tick, asking Buildbucket for the build status
[16:04:47.194] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:04:47.194] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:36:0) after 1m0s
[16:05:47.282] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:36:0)
[16:05:47.282] Timer tick, asking Buildbucket for the build status
[16:05:47.832] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:05:47.832] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:37:0) after 1m0s
[16:06:47.901] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:37:0)
[16:06:47.901] Timer tick, asking Buildbucket for the build status
[16:06:49.858] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:06:49.858] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:38:0) after 1m0s
[16:07:49.993] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:38:0)
[16:07:49.993] Timer tick, asking Buildbucket for the build status
[16:07:50.832] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:07:50.832] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:39:0) after 1m0s
[16:08:51.063] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:39:0)
[16:08:51.063] Timer tick, asking Buildbucket for the build status
[16:08:51.907] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:08:51.907] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:40:0) after 1m0s
[16:09:52.228] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:40:0)
[16:09:52.228] Timer tick, asking Buildbucket for the build status
[16:09:52.358] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:09:52.358] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:41:0) after 1m0s
[16:10:52.379] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:41:0)
[16:10:52.379] Timer tick, asking Buildbucket for the build status
[16:10:52.554] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:10:52.554] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:42:0) after 1m0s
[16:11:52.574] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:42:0)
[16:11:52.574] Timer tick, asking Buildbucket for the build status
[16:11:52.787] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:11:52.787] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:43:0) after 1m0s
[16:12:52.830] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:43:0)
[16:12:52.830] Timer tick, asking Buildbucket for the build status
[16:12:53.536] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:12:53.536] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:44:0) after 1m0s
[16:13:53.684] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:44:0)
[16:13:53.684] Timer tick, asking Buildbucket for the build status
[16:13:53.830] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:13:53.830] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:45:0) after 1m0s
[16:14:53.951] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:45:0)
[16:14:53.951] Timer tick, asking Buildbucket for the build status
[16:14:54.102] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:14:54.102] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:46:0) after 1m0s
[16:15:54.192] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:46:0)
[16:15:54.192] Timer tick, asking Buildbucket for the build status
[16:15:55.299] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:15:55.299] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:47:0) after 1m0s
[16:16:55.296] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:47:0)
[16:16:55.296] Timer tick, asking Buildbucket for the build status
[16:16:55.521] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:16:55.521] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:48:0) after 1m0s
[16:17:55.718] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:48:0)
[16:17:55.718] Timer tick, asking Buildbucket for the build status
[16:17:55.895] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:17:55.895] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:49:0) after 1m0s
[16:18:56.325] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:49:0)
[16:18:56.325] Timer tick, asking Buildbucket for the build status
[16:18:56.515] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:18:56.515] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:50:0) after 1m0s
[16:19:56.600] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:50:0)
[16:19:56.600] Timer tick, asking Buildbucket for the build status
[16:19:56.778] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:19:56.778] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:51:0) after 1m0s
[16:20:57.091] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:51:0)
[16:20:57.091] Timer tick, asking Buildbucket for the build status
[16:20:57.253] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:20:57.253] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:52:0) after 1m0s
[16:21:57.541] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:52:0)
[16:21:57.541] Timer tick, asking Buildbucket for the build status
[16:21:57.679] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:21:57.679] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:53:0) after 1m0s
[16:22:57.751] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:53:0)
[16:22:57.751] Timer tick, asking Buildbucket for the build status
[16:22:58.081] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:22:58.081] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:54:0) after 1m0s
[16:23:58.290] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:54:0)
[16:23:58.290] Timer tick, asking Buildbucket for the build status
[16:23:59.126] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:23:59.126] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:55:0) after 1m0s
[16:24:59.217] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:55:0)
[16:24:59.217] Timer tick, asking Buildbucket for the build status
[16:25:00.508] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:25:00.508] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:56:0) after 1m0s
[16:26:00.543] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:56:0)
[16:26:00.543] Timer tick, asking Buildbucket for the build status
[16:26:00.831] Build 8891094418138072960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:26:00.832] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:57:0) after 1m0s
[16:26:47.399] Received PubSub notification, asking Buildbucket for the build status
[16:26:47.568] Build 8891094418138072960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:00.917] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:57:0)
[16:27:00.917] Timer tick, asking Buildbucket for the build status
[16:27:01.600] Build 8891094418138072960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:01.600] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:59:0) after 1m0s
[16:28:01.658] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:59:0)
[16:28:01.658] Timer tick, asking Buildbucket for the build status
[16:28:02.176] Build 8891094418138072960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:02.176] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:60:0) after 1m0s
[16:29:02.197] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:60:0)
[16:29:02.197] Timer tick, asking Buildbucket for the build status
[16:29:02.844] Build 8891094418138072960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:02.844] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:61:0) after 1m0s
[16:30:02.870] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:61:0)
[16:30:02.870] Timer tick, asking Buildbucket for the build status
[16:30:03.069] Build 8891094418138072960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:03.069] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:62:0) after 1m0s
[16:31:03.110] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:62:0)
[16:31:03.111] Timer tick, asking Buildbucket for the build status
[16:31:03.862] Build 8891094418138072960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:03.862] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:63:0) after 1m0s
[16:32:03.887] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:63:0)
[16:32:03.887] Timer tick, asking Buildbucket for the build status
[16:32:04.637] Build 8891094418138072960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:04.637] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:64:0) after 1m0s
[16:33:04.713] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:64:0)
[16:33:04.713] Timer tick, asking Buildbucket for the build status
[16:33:05.322] Build 8891094418138072960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:05.322] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:65:0) after 1m0s
[16:34:05.398] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:65:0)
[16:34:05.398] Timer tick, asking Buildbucket for the build status
[16:34:05.988] Build 8891094418138072960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:05.988] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:66:0) after 1m0s
[16:35:06.065] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:66:0)
[16:35:06.066] Timer tick, asking Buildbucket for the build status
[16:35:06.524] Build 8891094418138072960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:06.524] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:67:0) after 1m0s
[16:36:06.546] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:67:0)
[16:36:06.546] Timer tick, asking Buildbucket for the build status
[16:36:06.809] Build 8891094418138072960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:06.809] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:68:0) after 1m0s
[16:37:06.860] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:68:0)
[16:37:06.860] Timer tick, asking Buildbucket for the build status
[16:37:07.090] Build 8891094418138072960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:07.090] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:69:0) after 1m0s
[16:38:07.174] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:69:0)
[16:38:07.174] Timer tick, asking Buildbucket for the build status
[16:38:07.413] Build 8891094418138072960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:07.414] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:70:0) after 1m0s
[16:39:07.499] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:70:0)
[16:39:07.499] Timer tick, asking Buildbucket for the build status
[16:39:07.631] Build 8891094418138072960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:07.631] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:71:0) after 1m0s
[16:40:07.747] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:71:0)
[16:40:07.747] Timer tick, asking Buildbucket for the build status
[16:40:08.437] Build 8891094418138072960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:08.437] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9056524481111880080:72:0) after 1m0s
[16:41:02.819] Received PubSub notification, asking Buildbucket for the build status
[16:41:04.087] Build 8891094418138072960: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:41:04.087] Buildbucket build:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"completed_ts": "1579192861937314",
"created_by": "project:dart",
"created_ts": "1579188630886284",
"id": "8891094418138072960",
"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\": \"be1ddc8a647442a5ca312386db22bd32cf500efe\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@be1ddc8a647442a5ca312386db22bd32cf500efe\", \"title\": \"be1ddc8a647442a5ca312386db22bd32cf500efe\", \"url\": \"https://dart.googlesource.com/sdk/+/be1ddc8a647442a5ca312386db22bd32cf500efe\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://dart.googlesource.com/sdk\", \"revision\": \"8f382d13857017da2d09eef1bc8196ffa628be2f\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@8f382d13857017da2d09eef1bc8196ffa628be2f\", \"title\": \"8f382d13857017da2d09eef1bc8196ffa628be2f\", \"url\": \"https://dart.googlesource.com/sdk/+/8f382d13857017da2d09eef1bc8196ffa628be2f\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk\", \"revision\": \"8f382d13857017da2d09eef1bc8196ffa628be2f\"}}",
"project": "dart",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://dart.googlesource.com/sdk\", \"revision\": \"be1ddc8a647442a5ca312386db22bd32cf500efe\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@be1ddc8a647442a5ca312386db22bd32cf500efe\", \"title\": \"be1ddc8a647442a5ca312386db22bd32cf500efe\", \"url\": \"https://dart.googlesource.com/sdk/+/be1ddc8a647442a5ca312386db22bd32cf500efe\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://dart.googlesource.com/sdk\", \"revision\": \"8f382d13857017da2d09eef1bc8196ffa628be2f\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@8f382d13857017da2d09eef1bc8196ffa628be2f\", \"title\": \"8f382d13857017da2d09eef1bc8196ffa628be2f\", \"url\": \"https://dart.googlesource.com/sdk/+/8f382d13857017da2d09eef1bc8196ffa628be2f\"}]}, \"$recipe_engine/swarming\": {\"server\": \"https://chromium-swarm.appspot.com\"}, \"bot_id\": \"luci-dart-try-xenial-4-zjwl\", \"branch\": \"refs/heads/master\", \"buildername\": \"vm-ffi-android-debug-arm\", \"buildnumber\": 2977, \"clobber\": \"true\", \"got_revision\": \"8f382d13857017da2d09eef1bc8196ffa628be2f\", \"new_workflow_enabled\": true, \"path_config\": \"generic\", \"recipe\": \"dart/neo\", \"repository\": \"https://dart.googlesource.com/sdk\", \"revision\": \"8f382d13857017da2d09eef1bc8196ffa628be2f\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_058218ec2409192fce169b7339b9cb8c4de115d8266846d32f10a1ad24305866_v2\", \"builder_252280c55c022a23a36eed1d9766143b8cedacf263fac7d67e5bf33fb68ceeca_v2\", \"builder_2c7d6ce28ef8579cea1301dda0f793dd7a5beb5efe16b3122cdf5ae235edacf5_v2\", \"builder_6338d689ff18380497e6d49b70969182788102900bfead3e0bda28409897d599_v2\", \"builder_b076a5b5387968aada53d33ff1c7f4b89b6a73c49ce0ebd5ac6a7185fd3656ba_v2\", \"builder_fba3098cd6ebf0fa9b6ceb9261e967d3a5465901e964d3b2e6a6d01431eb4310_v2\", \"builder_fc87d8b756f6ef6f58af66318edbeaca820eb4af106a8048351c27566d7fbe87_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-4-zjwl\"], \"image\": [\"chrome-xenial-19121500-b03549ec744\"], \"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\": [\"4760-d9a0e6d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"started_ts": "1579192006297534",
"status": "COMPLETED",
"status_changed_ts": "1579192862370728",
"tags": [
"build_address:luci.dart.ci.sandbox/vm-ffi-android-debug-arm/2977",
"builder:vm-ffi-android-debug-arm",
"buildset:commit/git/8f382d13857017da2d09eef1bc8196ffa628be2f",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/8f382d13857017da2d09eef1bc8196ffa628be2f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9056524481111880080",
"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/8891094418138072960/+/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:49c7cbc1f4ab1e10",
"user_agent:luci-scheduler"
],
"updated_ts": "1579192862382698",
"url": "https://ci.chromium.org/b/8891094418138072960",
"utcnow_ts": "1579192863991492"
}
}
[16:41:04.087] Invocation finished in 1h10m35.419426771s with status SUCCEEDED