[03:00:02.427] New invocation is queued and will start shortly
[03:00:03.919] Starting the invocation (attempt 1)
[03:00:03.957] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:00:03.957] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:00:03.957] Buildbucket request:
{
"bucket": "luci.dart.ci.sandbox",
"client_operation_id": "9074781684812932304",
"parameters_json": "{\"builder_name\":\"fuzz-linux\",\"properties\":{}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:fuzz-linux",
"scheduler_invocation_id:9074781684812932304",
"scheduler_job_id:dart/fuzz-linux",
"user_agent:luci-scheduler"
]
}
[03:00:04.888] Buildbucket response:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"created_by": "project:dart",
"created_ts": "1561777204118565",
"id": "8909351622373301648",
"parameters_json": "{\"builder_name\": \"fuzz-linux\", \"properties\": {}}",
"project": "dart",
"result_details_json": "{\"properties\": {}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1561777204573374",
"tags": [
"build_address:luci.dart.ci.sandbox/fuzz-linux/271",
"builder:fuzz-linux",
"scheduler_invocation_id:9074781684812932304",
"scheduler_job_id:dart/fuzz-linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/dart/buildbucket/cr-buildbucket.appspot.com/8909351622373301648/+/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": "1561777204573877",
"url": "https://ci.chromium.org/b/8909351622373301648",
"utcnow_ts": "1561777204874092"
}
}
[03:00:04.888] Task URL: https://ci.chromium.org/b/8909351622373301648
[03:00:04.888] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:2:0) after 1m0s
[03:01:04.993] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:2:0)
[03:01:04.993] Timer tick, asking Buildbucket for the build status
[03:01:05.844] Build 8909351622373301648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:01:05.844] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:3:0) after 1m0s
[03:02:05.864] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:3:0)
[03:02:05.864] Timer tick, asking Buildbucket for the build status
[03:02:06.002] Build 8909351622373301648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:02:06.002] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:4:0) after 1m0s
[03:03:06.015] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:4:0)
[03:03:06.015] Timer tick, asking Buildbucket for the build status
[03:03:06.158] Build 8909351622373301648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:03:06.159] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:5:0) after 1m0s
[03:04:06.374] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:5:0)
[03:04:06.374] Timer tick, asking Buildbucket for the build status
[03:04:06.888] Build 8909351622373301648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:04:06.888] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:6:0) after 1m0s
[03:05:07.006] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:6:0)
[03:05:07.006] Timer tick, asking Buildbucket for the build status
[03:05:07.384] Build 8909351622373301648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:05:07.384] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:7:0) after 1m0s
[03:06:07.394] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:7:0)
[03:06:07.394] Timer tick, asking Buildbucket for the build status
[03:06:07.626] Build 8909351622373301648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:06:07.626] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:8:0) after 1m0s
[03:07:07.709] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:8:0)
[03:07:07.709] Timer tick, asking Buildbucket for the build status
[03:07:07.838] Build 8909351622373301648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:07:07.838] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:9:0) after 1m0s
[03:08:07.942] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:9:0)
[03:08:07.942] Timer tick, asking Buildbucket for the build status
[03:08:08.292] Build 8909351622373301648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:08:08.292] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:10:0) after 1m0s
[03:09:08.501] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:10:0)
[03:09:08.501] Timer tick, asking Buildbucket for the build status
[03:09:14.062] Build 8909351622373301648: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:09:14.062] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:11:0) after 1m0s
[03:09:27.769] Received PubSub notification, asking Buildbucket for the build status
[03:09:28.250] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:14.087] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:11:0)
[03:10:14.087] Timer tick, asking Buildbucket for the build status
[03:10:14.306] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:14.306] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:13:0) after 1m0s
[03:11:14.327] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:13:0)
[03:11:14.327] Timer tick, asking Buildbucket for the build status
[03:11:14.800] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:14.800] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:14:0) after 1m0s
[03:12:14.835] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:14:0)
[03:12:14.835] Timer tick, asking Buildbucket for the build status
[03:12:15.303] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:15.303] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:15:0) after 1m0s
[03:13:15.333] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:15:0)
[03:13:15.333] Timer tick, asking Buildbucket for the build status
[03:13:15.587] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:15.587] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:16:0) after 1m0s
[03:14:15.669] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:16:0)
[03:14:15.669] Timer tick, asking Buildbucket for the build status
[03:14:15.897] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:15.897] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:17:0) after 1m0s
[03:15:15.918] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:17:0)
[03:15:15.918] Timer tick, asking Buildbucket for the build status
[03:15:16.878] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:16.878] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:18:0) after 1m0s
[03:16:16.982] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:18:0)
[03:16:16.982] Timer tick, asking Buildbucket for the build status
[03:16:17.427] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:17.427] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:19:0) after 1m0s
[03:17:17.445] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:19:0)
[03:17:17.445] Timer tick, asking Buildbucket for the build status
[03:17:17.590] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:17.590] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:20:0) after 1m0s
[03:18:17.688] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:20:0)
[03:18:17.688] Timer tick, asking Buildbucket for the build status
[03:18:18.715] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:18.715] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:21:0) after 1m0s
[03:19:18.835] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:21:0)
[03:19:18.835] Timer tick, asking Buildbucket for the build status
[03:19:19.415] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:19.416] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:22:0) after 1m0s
[03:20:19.535] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:22:0)
[03:20:19.535] Timer tick, asking Buildbucket for the build status
[03:20:20.236] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:20.236] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:23:0) after 1m0s
[03:21:20.312] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:23:0)
[03:21:20.312] Timer tick, asking Buildbucket for the build status
[03:21:20.944] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:20.944] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:24:0) after 1m0s
[03:22:21.009] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:24:0)
[03:22:21.009] Timer tick, asking Buildbucket for the build status
[03:22:21.372] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:21.372] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:25:0) after 1m0s
[03:23:21.413] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:25:0)
[03:23:21.413] Timer tick, asking Buildbucket for the build status
[03:23:22.109] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:22.110] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:26:0) after 1m0s
[03:24:22.178] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:26:0)
[03:24:22.178] Timer tick, asking Buildbucket for the build status
[03:24:22.364] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:22.364] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:27:0) after 1m0s
[03:25:22.481] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:27:0)
[03:25:22.481] Timer tick, asking Buildbucket for the build status
[03:25:22.575] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:22.575] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:28:0) after 1m0s
[03:26:22.598] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:28:0)
[03:26:22.598] Timer tick, asking Buildbucket for the build status
[03:26:22.769] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:22.769] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:29:0) after 1m0s
[03:27:22.783] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:29:0)
[03:27:22.783] Timer tick, asking Buildbucket for the build status
[03:27:22.959] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:22.959] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:30:0) after 1m0s
[03:28:22.936] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:30:0)
[03:28:22.936] Timer tick, asking Buildbucket for the build status
[03:28:23.126] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:23.126] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:31:0) after 1m0s
[03:29:23.150] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:31:0)
[03:29:23.150] Timer tick, asking Buildbucket for the build status
[03:29:23.465] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:23.465] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:32:0) after 1m0s
[03:30:23.489] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:32:0)
[03:30:23.489] Timer tick, asking Buildbucket for the build status
[03:30:23.711] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:23.711] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:33:0) after 1m0s
[03:31:23.732] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:33:0)
[03:31:23.732] Timer tick, asking Buildbucket for the build status
[03:31:23.893] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:23.893] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:34:0) after 1m0s
[03:32:23.876] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:34:0)
[03:32:23.876] Timer tick, asking Buildbucket for the build status
[03:32:24.104] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:24.104] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:35:0) after 1m0s
[03:33:24.133] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:35:0)
[03:33:24.133] Timer tick, asking Buildbucket for the build status
[03:33:24.330] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:24.330] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:36:0) after 1m0s
[03:34:24.393] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:36:0)
[03:34:24.393] Timer tick, asking Buildbucket for the build status
[03:34:25.696] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:25.696] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:37:0) after 1m0s
[03:35:25.747] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:37:0)
[03:35:25.747] Timer tick, asking Buildbucket for the build status
[03:35:26.341] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:26.341] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:38:0) after 1m0s
[03:36:26.490] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:38:0)
[03:36:26.490] Timer tick, asking Buildbucket for the build status
[03:36:27.065] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:27.065] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:39:0) after 1m0s
[03:37:27.181] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:39:0)
[03:37:27.181] Timer tick, asking Buildbucket for the build status
[03:37:28.337] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:28.337] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:40:0) after 1m0s
[03:38:28.382] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:40:0)
[03:38:28.382] Timer tick, asking Buildbucket for the build status
[03:38:29.018] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:29.018] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:41:0) after 1m0s
[03:39:29.104] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:41:0)
[03:39:29.104] Timer tick, asking Buildbucket for the build status
[03:39:29.290] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:29.290] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:42:0) after 1m0s
[03:40:29.348] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:42:0)
[03:40:29.348] Timer tick, asking Buildbucket for the build status
[03:40:29.471] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:29.471] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:43:0) after 1m0s
[03:41:29.528] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:43:0)
[03:41:29.528] Timer tick, asking Buildbucket for the build status
[03:41:29.641] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:29.641] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:44:0) after 1m0s
[03:42:29.815] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:44:0)
[03:42:29.815] Timer tick, asking Buildbucket for the build status
[03:42:30.215] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:30.215] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:45:0) after 1m0s
[03:43:30.214] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:45:0)
[03:43:30.214] Timer tick, asking Buildbucket for the build status
[03:43:30.968] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:30.968] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:46:0) after 1m0s
[03:44:31.038] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:46:0)
[03:44:31.038] Timer tick, asking Buildbucket for the build status
[03:44:31.427] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:31.427] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:47:0) after 1m0s
[03:45:31.447] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:47:0)
[03:45:31.447] Timer tick, asking Buildbucket for the build status
[03:45:31.647] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:31.647] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:48:0) after 1m0s
[03:46:31.719] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:48:0)
[03:46:31.719] Timer tick, asking Buildbucket for the build status
[03:46:31.831] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:31.831] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:49:0) after 1m0s
[03:47:32.059] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:49:0)
[03:47:32.059] Timer tick, asking Buildbucket for the build status
[03:47:32.347] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:32.347] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:50:0) after 1m0s
[03:48:32.399] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:50:0)
[03:48:32.399] Timer tick, asking Buildbucket for the build status
[03:48:32.583] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:32.583] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:51:0) after 1m0s
[03:49:32.723] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:51:0)
[03:49:32.723] Timer tick, asking Buildbucket for the build status
[03:49:33.304] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:33.304] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:52:0) after 1m0s
[03:50:33.385] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:52:0)
[03:50:33.385] Timer tick, asking Buildbucket for the build status
[03:50:33.793] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:33.793] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:53:0) after 1m0s
[03:51:33.937] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:53:0)
[03:51:33.937] Timer tick, asking Buildbucket for the build status
[03:51:34.083] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:34.084] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:54:0) after 1m0s
[03:52:34.172] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:54:0)
[03:52:34.172] Timer tick, asking Buildbucket for the build status
[03:52:34.315] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:34.315] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:55:0) after 1m0s
[03:53:34.364] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:55:0)
[03:53:34.364] Timer tick, asking Buildbucket for the build status
[03:53:34.480] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:34.480] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:56:0) after 1m0s
[03:54:34.688] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:56:0)
[03:54:34.688] Timer tick, asking Buildbucket for the build status
[03:54:35.119] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:35.119] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:57:0) after 1m0s
[03:55:35.215] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:57:0)
[03:55:35.215] Timer tick, asking Buildbucket for the build status
[03:55:35.329] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:35.329] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:58:0) after 1m0s
[03:56:35.350] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:58:0)
[03:56:35.350] Timer tick, asking Buildbucket for the build status
[03:56:35.576] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:35.576] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:59:0) after 1m0s
[03:57:35.600] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:59:0)
[03:57:35.600] Timer tick, asking Buildbucket for the build status
[03:57:36.434] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:36.434] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:60:0) after 1m0s
[03:58:36.461] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:60:0)
[03:58:36.461] Timer tick, asking Buildbucket for the build status
[03:58:36.909] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:36.909] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:61:0) after 1m0s
[03:59:37.193] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:61:0)
[03:59:37.193] Timer tick, asking Buildbucket for the build status
[03:59:37.318] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:37.318] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:62:0) after 1m0s
[04:00:37.345] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:62:0)
[04:00:37.345] Timer tick, asking Buildbucket for the build status
[04:00:37.449] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:37.449] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:63:0) after 1m0s
[04:01:37.521] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:63:0)
[04:01:37.521] Timer tick, asking Buildbucket for the build status
[04:01:37.631] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:37.631] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:64:0) after 1m0s
[04:02:38.240] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:64:0)
[04:02:38.240] Timer tick, asking Buildbucket for the build status
[04:02:39.220] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:39.220] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:65:0) after 1m0s
[04:03:39.314] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:65:0)
[04:03:39.314] Timer tick, asking Buildbucket for the build status
[04:03:39.472] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:39.472] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:66:0) after 1m0s
[04:04:39.691] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:66:0)
[04:04:39.691] Timer tick, asking Buildbucket for the build status
[04:04:40.101] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:40.102] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:67:0) after 1m0s
[04:05:40.360] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:67:0)
[04:05:40.360] Timer tick, asking Buildbucket for the build status
[04:05:40.919] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:40.919] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:68:0) after 1m0s
[04:06:41.047] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:68:0)
[04:06:41.047] Timer tick, asking Buildbucket for the build status
[04:06:41.301] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:41.301] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:69:0) after 1m0s
[04:07:41.569] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:69:0)
[04:07:41.569] Timer tick, asking Buildbucket for the build status
[04:07:42.510] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:42.510] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:70:0) after 1m0s
[04:08:42.692] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:70:0)
[04:08:42.692] Timer tick, asking Buildbucket for the build status
[04:08:42.946] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:42.946] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:71:0) after 1m0s
[04:09:43.214] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:71:0)
[04:09:43.214] Timer tick, asking Buildbucket for the build status
[04:09:43.792] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:43.792] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:72:0) after 1m0s
[04:10:43.889] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:72:0)
[04:10:43.889] Timer tick, asking Buildbucket for the build status
[04:10:44.033] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:44.033] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:73:0) after 1m0s
[04:11:44.221] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:73:0)
[04:11:44.221] Timer tick, asking Buildbucket for the build status
[04:11:44.358] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:44.358] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:74:0) after 1m0s
[04:12:44.419] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:74:0)
[04:12:44.419] Timer tick, asking Buildbucket for the build status
[04:12:44.846] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:44.846] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:75:0) after 1m0s
[04:13:44.976] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:75:0)
[04:13:44.976] Timer tick, asking Buildbucket for the build status
[04:13:46.756] Build 8909351622373301648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:46.756] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9074781684812932304:76:0) after 1m0s
[04:14:14.945] Received PubSub notification, asking Buildbucket for the build status
[04:14:15.103] Build 8909351622373301648: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[04:14:15.103] Buildbucket build:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"completed_ts": "1561781653836533",
"created_by": "project:dart",
"created_ts": "1561777204118565",
"failure_reason": "BUILD_FAILURE",
"id": "8909351622373301648",
"parameters_json": "{\"builder_name\": \"fuzz-linux\", \"properties\": {}}",
"project": "dart",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 out of 2 aggregated steps failed: 1 out of 5 aggregated steps failed: 4 out of 99 aggregated steps failed: Step(\\\"['shard #0 (failed) (2706.7 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2667.3 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2672.7 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2656.0 sec)']\\\") (retcode: 0)\"}, \"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}, \"bot_id\": \"luci-dart-try-xenial-72-fkjb\", \"buildername\": \"fuzz-linux\", \"buildnumber\": 271, \"clobber\": \"true\", \"got_revision\": \"a108bef7fb761f94fe8fb04634627237de630117\", \"path_config\": \"generic\", \"recipe\": \"dart/neo\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_119aaf6c4399d80013bfd00bffe181b9743937ac619b49e8c904969673215a92_v2\", \"builder_2e36e579c998612eea75fc905d4068327d94f6b368813aa69fc6ff4aa671301e_v2\", \"builder_36c85ebda7bed74f4f047df6d39aba7f824e167a4ee669897e735d76b78f3755_v2\", \"builder_390c115de1588aa44715b0a51be737386537dace0abbffb181966fe58d365023_v2\", \"builder_b19ea4ce286701e444ef847fe2456548cc4417021e320a5270dd8f9c6f7f773d_v2\", \"builder_c762dd9ce592b3c0de5905eac1695e5c33a5cbbb648bd52fabdb48f7948d9041_v2\", \"builder_cda10aa7162c8cba0757242440cdc0117e569dc31ad7d660ecb0cff356c802d7_v2\", \"builder_cfc41125433723a4f71b510cc66bc0632e5ea874813117b5ee92d59712ad2e87_v2\", \"builder_e79e4fa11f608afe27285a2b715d6709804d66f477bc0718d5cc55180bae5c37_v2\", \"builder_f9219a911dfbeb4ff836ddef0b336af22f54bd9ecdbeeae68c2671e10bb80306_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-72-fkjb\"], \"image\": [\"chrome-xenial-19052201-9cb74617499\"], \"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\": [\"4351-b85b41c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 out of 2 aggregated steps failed: 1 out of 5 aggregated steps failed: 4 out of 99 aggregated steps failed: Step(\\\"['shard #0 (failed) (2706.7 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2667.3 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2672.7 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2656.0 sec)']\\\") (retcode: 0)\"}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"started_ts": "1561777766480324",
"status": "COMPLETED",
"status_changed_ts": "1561777767221886",
"tags": [
"build_address:luci.dart.ci.sandbox/fuzz-linux/271",
"builder:fuzz-linux",
"scheduler_invocation_id:9074781684812932304",
"scheduler_job_id:dart/fuzz-linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/dart/buildbucket/cr-buildbucket.appspot.com/8909351622373301648/+/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:45b9fe81e4df7810",
"user_agent:luci-scheduler"
],
"updated_ts": "1561781654471196",
"url": "https://ci.chromium.org/b/8909351622373301648",
"utcnow_ts": "1561781655095516"
}
}
[04:14:15.103] Invocation finished in 1h14m12.695595078s with status FAILED