[15:19:14.019] New invocation is queued and will start shortly
[15:19:15.205] Starting the invocation (attempt 1)
[15:19:15.250] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:19:15.250] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:19:15.250] Buildbucket request:
{
"bucket": "luci.dart.ci.sandbox",
"client_operation_id": "9045653552581006608",
"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\":\"667e6f96aebbbb1e6cdb77152294a63c2dec0990\"},\"id\":\"https://dart.googlesource.com/sdk/+/refs/heads/master@667e6f96aebbbb1e6cdb77152294a63c2dec0990\",\"title\":\"667e6f96aebbbb1e6cdb77152294a63c2dec0990\",\"url\":\"https://dart.googlesource.com/sdk/+/667e6f96aebbbb1e6cdb77152294a63c2dec0990\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://dart.googlesource.com/sdk\",\"revision\":\"667e6f96aebbbb1e6cdb77152294a63c2dec0990\"}}",
"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:9045653552581006608",
"scheduler_job_id:dart/vm-ffi-android-debug-arm",
"user_agent:luci-scheduler",
"buildset:commit/git/667e6f96aebbbb1e6cdb77152294a63c2dec0990",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/667e6f96aebbbb1e6cdb77152294a63c2dec0990",
"gitiles_ref:refs/heads/master"
]
}
[15:19:16.167] Buildbucket response:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"created_by": "project:dart",
"created_ts": "1589555955380746",
"id": "8880223490489341808",
"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\": \"667e6f96aebbbb1e6cdb77152294a63c2dec0990\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@667e6f96aebbbb1e6cdb77152294a63c2dec0990\", \"title\": \"667e6f96aebbbb1e6cdb77152294a63c2dec0990\", \"url\": \"https://dart.googlesource.com/sdk/+/667e6f96aebbbb1e6cdb77152294a63c2dec0990\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk\", \"revision\": \"667e6f96aebbbb1e6cdb77152294a63c2dec0990\"}}",
"project": "dart",
"result_details_json": "{\"properties\": {}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1589555955835107",
"tags": [
"build_address:luci.dart.ci.sandbox/vm-ffi-android-debug-arm/4333",
"builder:vm-ffi-android-debug-arm",
"buildset:commit/git/667e6f96aebbbb1e6cdb77152294a63c2dec0990",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/667e6f96aebbbb1e6cdb77152294a63c2dec0990",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9045653552581006608",
"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/8880223490489341808/+/annotations",
"swarming_tag:luci_project:dart",
"swarming_tag:recipe_name:dart/neo",
"swarming_tag:recipe_package:dart/recipe_bundles/dart.googlesource.com/recipes",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1589555955835250",
"url": "https://ci.chromium.org/b/8880223490489341808",
"utcnow_ts": "1589555956153979"
}
}
[15:19:16.167] Task URL: https://ci.chromium.org/b/8880223490489341808
[15:19:16.167] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:2:0) after 1m0s
[15:20:16.383] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:2:0)
[15:20:16.383] Timer tick, asking Buildbucket for the build status
[15:20:16.545] Build 8880223490489341808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:20:16.545] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:3:0) after 1m0s
[15:21:16.847] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:3:0)
[15:21:16.847] Timer tick, asking Buildbucket for the build status
[15:21:16.963] Build 8880223490489341808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:21:16.963] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:4:0) after 1m0s
[15:22:15.119] Received PubSub notification, asking Buildbucket for the build status
[15:22:15.367] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:17.212] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:4:0)
[15:22:17.212] Timer tick, asking Buildbucket for the build status
[15:22:17.481] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:17.481] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:6:0) after 1m0s
[15:23:17.706] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:6:0)
[15:23:17.706] Timer tick, asking Buildbucket for the build status
[15:23:18.103] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:18.103] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:7:0) after 1m0s
[15:24:18.241] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:7:0)
[15:24:18.241] Timer tick, asking Buildbucket for the build status
[15:24:18.401] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:18.401] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:8:0) after 1m0s
[15:25:18.578] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:8:0)
[15:25:18.578] Timer tick, asking Buildbucket for the build status
[15:25:18.816] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:18.816] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:9:0) after 1m0s
[15:26:18.796] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:9:0)
[15:26:18.796] Timer tick, asking Buildbucket for the build status
[15:26:18.962] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:18.962] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:10:0) after 1m0s
[15:27:18.962] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:10:0)
[15:27:18.962] Timer tick, asking Buildbucket for the build status
[15:27:19.102] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:19.102] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:11:0) after 1m0s
[15:28:19.334] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:11:0)
[15:28:19.334] Timer tick, asking Buildbucket for the build status
[15:28:19.749] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:19.749] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:12:0) after 1m0s
[15:29:19.810] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:12:0)
[15:29:19.810] Timer tick, asking Buildbucket for the build status
[15:29:19.934] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:19.934] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:13:0) after 1m0s
[15:30:19.954] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:13:0)
[15:30:19.954] Timer tick, asking Buildbucket for the build status
[15:30:20.312] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:20.312] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:14:0) after 1m0s
[15:31:20.349] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:14:0)
[15:31:20.349] Timer tick, asking Buildbucket for the build status
[15:31:20.566] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:20.566] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:15:0) after 1m0s
[15:32:20.660] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:15:0)
[15:32:20.660] Timer tick, asking Buildbucket for the build status
[15:32:20.808] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:20.808] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:16:0) after 1m0s
[15:33:20.929] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:16:0)
[15:33:20.929] Timer tick, asking Buildbucket for the build status
[15:33:21.158] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:21.158] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:17:0) after 1m0s
[15:34:21.321] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:17:0)
[15:34:21.321] Timer tick, asking Buildbucket for the build status
[15:34:21.518] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:21.518] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:18:0) after 1m0s
[15:35:21.542] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:18:0)
[15:35:21.542] Timer tick, asking Buildbucket for the build status
[15:35:21.699] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:21.699] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:19:0) after 1m0s
[15:36:21.735] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:19:0)
[15:36:21.735] Timer tick, asking Buildbucket for the build status
[15:36:21.853] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:21.853] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:20:0) after 1m0s
[15:37:21.942] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:20:0)
[15:37:21.942] Timer tick, asking Buildbucket for the build status
[15:37:22.429] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:22.429] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:21:0) after 1m0s
[15:38:22.508] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:21:0)
[15:38:22.508] Timer tick, asking Buildbucket for the build status
[15:38:22.692] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:22.692] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:22:0) after 1m0s
[15:39:22.726] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:22:0)
[15:39:22.726] Timer tick, asking Buildbucket for the build status
[15:39:23.240] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:23.240] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:23:0) after 1m0s
[15:40:23.320] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:23:0)
[15:40:23.320] Timer tick, asking Buildbucket for the build status
[15:40:23.441] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:23.441] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:24:0) after 1m0s
[15:41:23.532] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:24:0)
[15:41:23.532] Timer tick, asking Buildbucket for the build status
[15:41:23.648] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:23.648] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:25:0) after 1m0s
[15:42:23.695] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:25:0)
[15:42:23.695] Timer tick, asking Buildbucket for the build status
[15:42:23.810] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:23.810] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:26:0) after 1m0s
[15:43:23.928] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:26:0)
[15:43:23.928] Timer tick, asking Buildbucket for the build status
[15:43:24.124] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:24.124] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:27:0) after 1m0s
[15:44:24.164] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:27:0)
[15:44:24.165] Timer tick, asking Buildbucket for the build status
[15:44:24.307] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:24.307] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:28:0) after 1m0s
[15:45:24.546] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:28:0)
[15:45:24.546] Timer tick, asking Buildbucket for the build status
[15:45:25.104] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:25.104] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:29:0) after 1m0s
[15:46:25.310] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:29:0)
[15:46:25.311] Timer tick, asking Buildbucket for the build status
[15:46:25.517] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:25.517] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:30:0) after 1m0s
[15:47:25.536] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:30:0)
[15:47:25.536] Timer tick, asking Buildbucket for the build status
[15:47:25.978] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:25.978] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:31:0) after 1m0s
[15:48:25.953] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:31:0)
[15:48:25.953] Timer tick, asking Buildbucket for the build status
[15:48:26.339] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:26.339] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:32:0) after 1m0s
[15:49:26.399] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:32:0)
[15:49:26.399] Timer tick, asking Buildbucket for the build status
[15:49:26.500] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:26.500] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:33:0) after 1m0s
[15:50:26.573] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:33:0)
[15:50:26.573] Timer tick, asking Buildbucket for the build status
[15:50:26.686] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:26.686] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:34:0) after 1m0s
[15:51:26.814] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:34:0)
[15:51:26.814] Timer tick, asking Buildbucket for the build status
[15:51:27.053] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:27.053] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:35:0) after 1m0s
[15:52:27.181] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:35:0)
[15:52:27.181] Timer tick, asking Buildbucket for the build status
[15:52:27.356] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:27.356] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:36:0) after 1m0s
[15:53:27.415] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:36:0)
[15:53:27.415] Timer tick, asking Buildbucket for the build status
[15:53:28.325] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:28.325] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:37:0) after 1m0s
[15:54:28.476] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:37:0)
[15:54:28.476] Timer tick, asking Buildbucket for the build status
[15:54:28.841] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:28.841] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:38:0) after 1m0s
[15:55:28.975] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:38:0)
[15:55:28.975] Timer tick, asking Buildbucket for the build status
[15:55:29.440] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:29.440] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:39:0) after 1m0s
[15:56:29.501] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:39:0)
[15:56:29.501] Timer tick, asking Buildbucket for the build status
[15:56:29.747] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:29.747] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:40:0) after 1m0s
[15:57:29.781] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:40:0)
[15:57:29.781] Timer tick, asking Buildbucket for the build status
[15:57:29.919] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:29.919] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:41:0) after 1m0s
[15:58:30.107] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:41:0)
[15:58:30.107] Timer tick, asking Buildbucket for the build status
[15:58:30.261] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:30.261] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:42:0) after 1m0s
[15:59:30.344] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:42:0)
[15:59:30.344] Timer tick, asking Buildbucket for the build status
[15:59:30.493] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:30.493] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:43:0) after 1m0s
[16:00:30.621] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:43:0)
[16:00:30.621] Timer tick, asking Buildbucket for the build status
[16:00:31.203] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:31.204] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:44:0) after 1m0s
[16:01:31.263] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:44:0)
[16:01:31.263] Timer tick, asking Buildbucket for the build status
[16:01:32.089] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:32.089] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:45:0) after 1m0s
[16:02:32.137] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:45:0)
[16:02:32.137] Timer tick, asking Buildbucket for the build status
[16:02:32.505] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:32.505] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:46:0) after 1m0s
[16:03:32.567] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:46:0)
[16:03:32.567] Timer tick, asking Buildbucket for the build status
[16:03:32.812] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:32.812] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:47:0) after 1m0s
[16:04:32.842] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:47:0)
[16:04:32.842] Timer tick, asking Buildbucket for the build status
[16:04:33.032] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:33.032] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:48:0) after 1m0s
[16:05:33.109] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:48:0)
[16:05:33.109] Timer tick, asking Buildbucket for the build status
[16:05:33.498] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:33.498] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:49:0) after 1m0s
[16:06:33.519] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:49:0)
[16:06:33.519] Timer tick, asking Buildbucket for the build status
[16:06:33.893] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:33.893] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:50:0) after 1m0s
[16:07:33.926] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:50:0)
[16:07:33.926] Timer tick, asking Buildbucket for the build status
[16:07:34.067] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:34.067] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:51:0) after 1m0s
[16:08:34.182] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:51:0)
[16:08:34.182] Timer tick, asking Buildbucket for the build status
[16:08:34.321] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:34.321] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:52:0) after 1m0s
[16:09:34.346] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:52:0)
[16:09:34.346] Timer tick, asking Buildbucket for the build status
[16:09:34.477] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:34.477] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:53:0) after 1m0s
[16:10:34.460] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:53:0)
[16:10:34.460] Timer tick, asking Buildbucket for the build status
[16:10:34.585] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:34.585] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:54:0) after 1m0s
[16:11:34.605] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:54:0)
[16:11:34.605] Timer tick, asking Buildbucket for the build status
[16:11:35.107] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:35.107] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:55:0) after 1m0s
[16:12:35.199] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:55:0)
[16:12:35.199] Timer tick, asking Buildbucket for the build status
[16:12:35.295] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:35.295] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:56:0) after 1m0s
[16:13:35.315] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:56:0)
[16:13:35.315] Timer tick, asking Buildbucket for the build status
[16:13:35.623] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:35.623] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:57:0) after 1m0s
[16:14:35.644] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:57:0)
[16:14:35.644] Timer tick, asking Buildbucket for the build status
[16:14:35.765] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:35.765] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:58:0) after 1m0s
[16:15:35.838] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:58:0)
[16:15:35.838] Timer tick, asking Buildbucket for the build status
[16:15:35.952] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:35.952] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:59:0) after 1m0s
[16:16:36.014] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:59:0)
[16:16:36.014] Timer tick, asking Buildbucket for the build status
[16:16:36.372] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:36.372] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:60:0) after 1m0s
[16:17:36.465] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:60:0)
[16:17:36.465] Timer tick, asking Buildbucket for the build status
[16:17:37.134] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:37.134] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:61:0) after 1m0s
[16:18:37.201] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:61:0)
[16:18:37.201] Timer tick, asking Buildbucket for the build status
[16:18:37.341] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:37.341] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:62:0) after 1m0s
[16:19:37.523] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:62:0)
[16:19:37.523] Timer tick, asking Buildbucket for the build status
[16:19:38.110] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:38.110] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:63:0) after 1m0s
[16:20:38.309] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:63:0)
[16:20:38.309] Timer tick, asking Buildbucket for the build status
[16:20:38.592] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:38.592] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:64:0) after 1m0s
[16:21:38.992] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:64:0)
[16:21:38.992] Timer tick, asking Buildbucket for the build status
[16:21:39.197] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:39.197] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:65:0) after 1m0s
[16:22:39.285] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:65:0)
[16:22:39.285] Timer tick, asking Buildbucket for the build status
[16:22:39.413] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:39.413] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:66:0) after 1m0s
[16:23:39.517] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:66:0)
[16:23:39.517] Timer tick, asking Buildbucket for the build status
[16:23:39.879] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:39.879] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:67:0) after 1m0s
[16:24:39.995] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:67:0)
[16:24:39.995] Timer tick, asking Buildbucket for the build status
[16:24:40.155] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:40.155] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:68:0) after 1m0s
[16:25:40.318] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:68:0)
[16:25:40.318] Timer tick, asking Buildbucket for the build status
[16:25:40.442] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:40.442] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:69:0) after 1m0s
[16:26:40.475] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:69:0)
[16:26:40.476] Timer tick, asking Buildbucket for the build status
[16:26:42.358] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:42.358] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:70:0) after 1m0s
[16:27:42.471] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:70:0)
[16:27:42.471] Timer tick, asking Buildbucket for the build status
[16:27:43.060] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:43.061] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:71:0) after 1m0s
[16:28:43.084] Handling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:71:0)
[16:28:43.084] Timer tick, asking Buildbucket for the build status
[16:28:43.339] Build 8880223490489341808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:43.339] Scheduling timer "check-buildbucket-build-status" (dart/vm-ffi-android-debug-arm:9045653552581006608:72:0) after 1m0s
[16:29:38.033] Received PubSub notification, asking Buildbucket for the build status
[16:29:38.228] Build 8880223490489341808: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[16:29:38.228] Buildbucket build:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"completed_ts": "1589560176769284",
"created_by": "project:dart",
"created_ts": "1589555955380746",
"failure_reason": "INFRA_FAILURE",
"id": "8880223490489341808",
"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\": \"667e6f96aebbbb1e6cdb77152294a63c2dec0990\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@667e6f96aebbbb1e6cdb77152294a63c2dec0990\", \"title\": \"667e6f96aebbbb1e6cdb77152294a63c2dec0990\", \"url\": \"https://dart.googlesource.com/sdk/+/667e6f96aebbbb1e6cdb77152294a63c2dec0990\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://dart.googlesource.com/sdk\", \"revision\": \"667e6f96aebbbb1e6cdb77152294a63c2dec0990\"}}",
"project": "dart",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"recipe infra failure: 1 out of 3 aggregated steps failed: 1 out of 1 aggregated steps failed: Execution timeout: exceeded 3600 seconds.\\nOutput:\\n(\\u2026)\\n DART_CONFIGURATION=DebugAndroidARM /b/swarming/w/ir/pkg/vm/tool/gen_kernel --no-aot --platform=out/DebugAndroidARM/vm_platform_strong.dill -o /b/swarming/w/ir/out/DebugAndroidARM/generated_compilations/dartk/tests_ffi_2_function_test.dart_5/out.dill /b/swarming/w/ir/tests/ffi_2/function_test.dart --packages=/b/swarming/w/ir/.packages -Ddart.vm.product=false -Ddart.developer.causal_async_stacks=true\\n DART_CONFIGURATION=DebugAndroidARM /b/swarming/w/ir/pkg/vm/tool/gen_kernel --no-aot --platform=out/DebugAndroidARM/vm_platform_strong.dill -o /b/swarming/w/ir/out/DebugAndroidARM/generated_compilations/dartk/tests_ffi_2_function_test.dart_6/out.dill /b/swarming/w/ir/tests/ffi_2/function_test.dart --packages=/b/swarming/w/ir/.packages -Ddart.vm.product=false -Ddart.developer.causal_async_stacks=true\\n96 out of 190 completed\\nTests running for 50 minutes\\n96 out of 190 completed\\nTests running for 55 minutes\\n96 out of 190 completed\\nTests running for 60 minutes\"}, \"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\": \"667e6f96aebbbb1e6cdb77152294a63c2dec0990\"}, \"id\": \"https://dart.googlesource.com/sdk/+/refs/heads/master@667e6f96aebbbb1e6cdb77152294a63c2dec0990\", \"title\": \"667e6f96aebbbb1e6cdb77152294a63c2dec0990\", \"url\": \"https://dart.googlesource.com/sdk/+/667e6f96aebbbb1e6cdb77152294a63c2dec0990\"}]}, \"$recipe_engine/swarming\": {\"server\": \"https://chromium-swarm.appspot.com\"}, \"bot_id\": \"luci-dart-try-xenial-63-r6ki\", \"branch\": \"refs/heads/master\", \"buildername\": \"vm-ffi-android-debug-arm\", \"buildnumber\": 4333, \"clobber\": \"true\", \"got_revision\": \"667e6f96aebbbb1e6cdb77152294a63c2dec0990\", \"path_config\": \"generic\", \"recipe\": \"dart/neo\", \"repository\": \"https://dart.googlesource.com/sdk\", \"revision\": \"667e6f96aebbbb1e6cdb77152294a63c2dec0990\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_0261421798a5ede01ef10b82ae3ffba4860e44fa5cdf0b103b3f0e96a4c53361_v2\", \"builder_30de7a7fc7230d909ff3a964d8275829e053d480ae8385298581ccc54d96259b_v2\", \"builder_33a1618f16b024d21e5509670c1b9da205aa675340ae77e33c3092d35efc05be_v2\", \"builder_36c85ebda7bed74f4f047df6d39aba7f824e167a4ee669897e735d76b78f3755_v2\", \"builder_6cbd46bb7b85f2b5182064189e0144fd34df9d1a71ef5b4bc3ca003434985b44_v2\", \"builder_7aaef51bac21ec83e44fc04634df913dff477d9aca94f4beb2ca5f7a2dfbeb2e_v2\", \"builder_b86275ddf762361824bfc56cad1157933a73a38c01cde840f74c93e8651eb66a_v2\", \"builder_be27d8b138dfc387884512fad7facac1b0f67a4766cc008796394f7e6facbc61_v2\", \"builder_c762dd9ce592b3c0de5905eac1695e5c33a5cbbb648bd52fabdb48f7948d9041_v2\", \"builder_cdfb7e4c0be45bc1d321702c4190674b9bda32c6c4e50f46ac29be7962cacf17_v2\", \"builder_e79e4fa11f608afe27285a2b715d6709804d66f477bc0718d5cc55180bae5c37_v2\", \"builder_fcd5553c80c0fe47c1e9acdc263cdea287fa27a3074bc38511041845af68e022_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-63-r6ki\"], \"image\": [\"dart-xenial-20022300-4c0e34b5b5e\"], \"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\": [\"5088-a734129\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"recipe infra failure: 1 out of 3 aggregated steps failed: 1 out of 1 aggregated steps failed: Execution timeout: exceeded 3600 seconds.\\nOutput:\\n(\\u2026)\\n DART_CONFIGURATION=DebugAndroidARM /b/swarming/w/ir/pkg/vm/tool/gen_kernel --no-aot --platform=out/DebugAndroidARM/vm_platform_strong.dill -o /b/swarming/w/ir/out/DebugAndroidARM/generated_compilations/dartk/tests_ffi_2_function_test.dart_5/out.dill /b/swarming/w/ir/tests/ffi_2/function_test.dart --packages=/b/swarming/w/ir/.packages -Ddart.vm.product=false -Ddart.developer.causal_async_stacks=true\\n DART_CONFIGURATION=DebugAndroidARM /b/swarming/w/ir/pkg/vm/tool/gen_kernel --no-aot --platform=out/DebugAndroidARM/vm_platform_strong.dill -o /b/swarming/w/ir/out/DebugAndroidARM/generated_compilations/dartk/tests_ffi_2_function_test.dart_6/out.dill /b/swarming/w/ir/tests/ffi_2/function_test.dart --packages=/b/swarming/w/ir/.packages -Ddart.vm.product=false -Ddart.developer.causal_async_stacks=true\\n96 out of 190 completed\\nTests running for 50 minutes\\n96 out of 190 completed\\nTests running for 55 minutes\\n96 out of 190 completed\\nTests running for 60 minutes\"}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"started_ts": "1589556133847823",
"status": "COMPLETED",
"status_changed_ts": "1589556134452478",
"tags": [
"build_address:luci.dart.ci.sandbox/vm-ffi-android-debug-arm/4333",
"builder:vm-ffi-android-debug-arm",
"buildset:commit/git/667e6f96aebbbb1e6cdb77152294a63c2dec0990",
"buildset:commit/gitiles/dart.googlesource.com/sdk/+/667e6f96aebbbb1e6cdb77152294a63c2dec0990",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9045653552581006608",
"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/8880223490489341808/+/annotations",
"swarming_tag:luci_project:dart",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:dart/neo",
"swarming_tag:recipe_package:dart/recipe_bundles/dart.googlesource.com/recipes",
"swarming_task_id:4c31bc921928c110",
"user_agent:luci-scheduler"
],
"updated_ts": "1589560177055749",
"url": "https://ci.chromium.org/b/8880223490489341808",
"utcnow_ts": "1589560178201306"
}
}
[16:29:38.228] Invocation finished in 1h10m24.226005389s with status FAILED