[03:00:03.153] New invocation is queued and will start shortly
[03:00:05.003] Starting the invocation (attempt 1)
[03:00:05.069] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:00:05.069] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:00:05.069] Buildbucket request:
{
"bucket": "luci.dart.ci.sandbox",
"client_operation_id": "9068711687301194240",
"parameters_json": "{\"builder_name\":\"fuzz-linux\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"cron\":{\"generation\":\"1035\"},\"id\":\"cron:v1:1035\"}]}}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:fuzz-linux",
"scheduler_invocation_id:9068711687301194240",
"scheduler_job_id:dart/fuzz-linux",
"user_agent:luci-scheduler"
]
}
[03:00:05.779] Buildbucket response:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"created_by": "project:dart",
"created_ts": "1567566005221772",
"id": "8903281624467692592",
"parameters_json": "{\"builder_name\": \"fuzz-linux\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"cron\": {\"generation\": \"1035\"}, \"id\": \"cron:v1:1035\"}]}}}",
"project": "dart",
"result_details_json": "{\"properties\": {}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1567566005644949",
"tags": [
"build_address:luci.dart.ci.sandbox/fuzz-linux/346",
"builder:fuzz-linux",
"scheduler_invocation_id:9068711687301194240",
"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/8903281624467692592/+/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": "1567566005645055",
"url": "https://ci.chromium.org/b/8903281624467692592",
"utcnow_ts": "1567566005769535"
}
}
[03:00:05.779] Task URL: https://ci.chromium.org/b/8903281624467692592
[03:00:05.779] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:2:0) after 1m0s
[03:00:10.188] Received PubSub notification, asking Buildbucket for the build status
[03:00:10.478] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:06.121] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:2:0)
[03:01:06.121] Timer tick, asking Buildbucket for the build status
[03:01:07.422] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:07.422] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:4:0) after 1m0s
[03:02:07.476] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:4:0)
[03:02:07.476] Timer tick, asking Buildbucket for the build status
[03:02:07.723] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:07.723] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:5:0) after 1m0s
[03:03:07.747] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:5:0)
[03:03:07.747] Timer tick, asking Buildbucket for the build status
[03:03:08.021] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:08.021] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:6:0) after 1m0s
[03:04:08.068] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:6:0)
[03:04:08.068] Timer tick, asking Buildbucket for the build status
[03:04:08.438] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:08.438] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:7:0) after 1m0s
[03:05:08.463] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:7:0)
[03:05:08.463] Timer tick, asking Buildbucket for the build status
[03:05:08.800] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:08.800] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:8:0) after 1m0s
[03:06:08.852] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:8:0)
[03:06:08.852] Timer tick, asking Buildbucket for the build status
[03:06:09.138] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:09.138] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:9:0) after 1m0s
[03:07:09.232] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:9:0)
[03:07:09.232] Timer tick, asking Buildbucket for the build status
[03:07:09.821] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:09.821] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:10:0) after 1m0s
[03:08:09.930] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:10:0)
[03:08:09.930] Timer tick, asking Buildbucket for the build status
[03:08:10.242] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:10.242] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:11:0) after 1m0s
[03:09:10.335] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:11:0)
[03:09:10.335] Timer tick, asking Buildbucket for the build status
[03:09:10.541] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:10.541] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:12:0) after 1m0s
[03:10:10.560] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:12:0)
[03:10:10.560] Timer tick, asking Buildbucket for the build status
[03:10:10.734] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:10.734] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:13:0) after 1m0s
[03:11:10.759] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:13:0)
[03:11:10.759] Timer tick, asking Buildbucket for the build status
[03:11:11.143] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:11.143] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:14:0) after 1m0s
[03:12:11.241] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:14:0)
[03:12:11.241] Timer tick, asking Buildbucket for the build status
[03:12:11.416] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:11.416] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:15:0) after 1m0s
[03:13:11.465] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:15:0)
[03:13:11.465] Timer tick, asking Buildbucket for the build status
[03:13:12.826] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:12.826] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:16:0) after 1m0s
[03:14:12.991] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:16:0)
[03:14:12.991] Timer tick, asking Buildbucket for the build status
[03:14:13.172] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:13.172] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:17:0) after 1m0s
[03:15:13.334] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:17:0)
[03:15:13.334] Timer tick, asking Buildbucket for the build status
[03:15:13.600] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:13.600] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:18:0) after 1m0s
[03:16:13.689] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:18:0)
[03:16:13.689] Timer tick, asking Buildbucket for the build status
[03:16:13.883] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:13.883] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:19:0) after 1m0s
[03:17:13.969] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:19:0)
[03:17:13.969] Timer tick, asking Buildbucket for the build status
[03:17:14.189] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:14.189] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:20:0) after 1m0s
[03:18:14.221] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:20:0)
[03:18:14.221] Timer tick, asking Buildbucket for the build status
[03:18:14.603] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:14.603] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:21:0) after 1m0s
[03:19:14.656] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:21:0)
[03:19:14.656] Timer tick, asking Buildbucket for the build status
[03:19:14.858] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:14.858] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:22:0) after 1m0s
[03:20:14.885] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:22:0)
[03:20:14.885] Timer tick, asking Buildbucket for the build status
[03:20:15.036] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:15.036] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:23:0) after 1m0s
[03:21:15.123] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:23:0)
[03:21:15.123] Timer tick, asking Buildbucket for the build status
[03:21:15.480] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:15.480] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:24:0) after 1m0s
[03:22:15.603] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:24:0)
[03:22:15.603] Timer tick, asking Buildbucket for the build status
[03:22:15.764] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:15.764] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:25:0) after 1m0s
[03:23:16.005] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:25:0)
[03:23:16.005] Timer tick, asking Buildbucket for the build status
[03:23:16.239] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:16.239] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:26:0) after 1m0s
[03:24:16.267] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:26:0)
[03:24:16.267] Timer tick, asking Buildbucket for the build status
[03:24:16.725] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:16.725] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:27:0) after 1m0s
[03:25:16.794] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:27:0)
[03:25:16.794] Timer tick, asking Buildbucket for the build status
[03:25:16.966] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:16.966] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:28:0) after 1m0s
[03:26:17.117] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:28:0)
[03:26:17.117] Timer tick, asking Buildbucket for the build status
[03:26:17.493] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:17.493] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:29:0) after 1m0s
[03:27:17.525] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:29:0)
[03:27:17.525] Timer tick, asking Buildbucket for the build status
[03:27:18.100] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:18.100] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:30:0) after 1m0s
[03:28:18.211] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:30:0)
[03:28:18.211] Timer tick, asking Buildbucket for the build status
[03:28:18.412] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:18.412] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:31:0) after 1m0s
[03:29:18.438] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:31:0)
[03:29:18.438] Timer tick, asking Buildbucket for the build status
[03:29:18.668] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:18.668] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:32:0) after 1m0s
[03:30:18.686] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:32:0)
[03:30:18.686] Timer tick, asking Buildbucket for the build status
[03:30:19.276] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:19.276] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:33:0) after 1m0s
[03:31:19.532] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:33:0)
[03:31:19.532] Timer tick, asking Buildbucket for the build status
[03:31:20.032] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:20.032] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:34:0) after 1m0s
[03:32:20.057] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:34:0)
[03:32:20.057] Timer tick, asking Buildbucket for the build status
[03:32:20.684] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:20.684] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:35:0) after 1m0s
[03:33:20.829] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:35:0)
[03:33:20.829] Timer tick, asking Buildbucket for the build status
[03:33:21.264] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:21.264] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:36:0) after 1m0s
[03:34:21.405] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:36:0)
[03:34:21.405] Timer tick, asking Buildbucket for the build status
[03:34:21.622] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:21.622] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:37:0) after 1m0s
[03:35:21.701] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:37:0)
[03:35:21.701] Timer tick, asking Buildbucket for the build status
[03:35:22.233] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:22.233] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:38:0) after 1m0s
[03:36:22.262] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:38:0)
[03:36:22.262] Timer tick, asking Buildbucket for the build status
[03:36:22.496] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:22.496] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:39:0) after 1m0s
[03:37:22.521] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:39:0)
[03:37:22.521] Timer tick, asking Buildbucket for the build status
[03:37:22.641] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:22.641] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:40:0) after 1m0s
[03:38:22.621] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:40:0)
[03:38:22.621] Timer tick, asking Buildbucket for the build status
[03:38:22.783] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:22.783] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:41:0) after 1m0s
[03:39:22.804] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:41:0)
[03:39:22.804] Timer tick, asking Buildbucket for the build status
[03:39:23.149] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:23.149] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:42:0) after 1m0s
[03:40:23.370] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:42:0)
[03:40:23.370] Timer tick, asking Buildbucket for the build status
[03:40:23.735] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:23.735] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:43:0) after 1m0s
[03:41:23.757] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:43:0)
[03:41:23.757] Timer tick, asking Buildbucket for the build status
[03:41:29.617] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:29.617] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:44:0) after 1m0s
[03:42:29.766] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:44:0)
[03:42:29.766] Timer tick, asking Buildbucket for the build status
[03:42:30.290] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:30.290] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:45:0) after 1m0s
[03:43:30.311] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:45:0)
[03:43:30.311] Timer tick, asking Buildbucket for the build status
[03:43:31.011] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:31.011] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:46:0) after 1m0s
[03:44:31.060] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:46:0)
[03:44:31.060] Timer tick, asking Buildbucket for the build status
[03:44:31.343] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:31.343] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:47:0) after 1m0s
[03:45:31.359] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:47:0)
[03:45:31.359] Timer tick, asking Buildbucket for the build status
[03:45:31.501] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:31.501] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:48:0) after 1m0s
[03:46:31.529] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:48:0)
[03:46:31.529] Timer tick, asking Buildbucket for the build status
[03:46:32.364] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:32.364] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:49:0) after 1m0s
[03:47:32.417] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:49:0)
[03:47:32.417] Timer tick, asking Buildbucket for the build status
[03:47:32.606] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:32.606] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:50:0) after 1m0s
[03:48:32.708] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:50:0)
[03:48:32.708] Timer tick, asking Buildbucket for the build status
[03:48:33.642] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:33.642] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:51:0) after 1m0s
[03:49:33.657] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:51:0)
[03:49:33.657] Timer tick, asking Buildbucket for the build status
[03:49:34.619] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:34.619] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:52:0) after 1m0s
[03:50:34.735] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:52:0)
[03:50:34.735] Timer tick, asking Buildbucket for the build status
[03:50:34.944] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:34.944] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:53:0) after 1m0s
[03:51:34.968] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:53:0)
[03:51:34.968] Timer tick, asking Buildbucket for the build status
[03:51:35.425] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:35.425] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:54:0) after 1m0s
[03:52:35.463] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:54:0)
[03:52:35.463] Timer tick, asking Buildbucket for the build status
[03:52:35.635] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:35.635] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:55:0) after 1m0s
[03:53:35.706] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:55:0)
[03:53:35.706] Timer tick, asking Buildbucket for the build status
[03:53:35.849] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:35.849] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:56:0) after 1m0s
[03:54:35.872] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:56:0)
[03:54:35.872] Timer tick, asking Buildbucket for the build status
[03:54:36.185] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:36.185] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:57:0) after 1m0s
[03:55:36.258] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:57:0)
[03:55:36.258] Timer tick, asking Buildbucket for the build status
[03:55:36.407] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:36.407] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:58:0) after 1m0s
[03:56:36.429] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:58:0)
[03:56:36.429] Timer tick, asking Buildbucket for the build status
[03:56:36.884] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:36.884] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:59:0) after 1m0s
[03:57:36.923] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:59:0)
[03:57:36.923] Timer tick, asking Buildbucket for the build status
[03:57:37.363] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:37.363] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:60:0) after 1m0s
[03:58:37.423] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:60:0)
[03:58:37.423] Timer tick, asking Buildbucket for the build status
[03:58:37.918] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:37.918] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:61:0) after 1m0s
[03:59:38.034] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:61:0)
[03:59:38.034] Timer tick, asking Buildbucket for the build status
[03:59:38.173] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:38.173] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:62:0) after 1m0s
[04:00:38.709] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:62:0)
[04:00:38.709] Timer tick, asking Buildbucket for the build status
[04:00:39.128] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:39.128] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:63:0) after 1m0s
[04:01:39.752] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:63:0)
[04:01:39.752] Timer tick, asking Buildbucket for the build status
[04:01:40.003] Build 8903281624467692592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:40.003] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9068711687301194240:64:0) after 1m0s
[04:02:03.640] Received PubSub notification, asking Buildbucket for the build status
[04:02:03.757] Build 8903281624467692592: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[04:02:03.757] Buildbucket build:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"completed_ts": "1567569722773465",
"created_by": "project:dart",
"created_ts": "1567566005221772",
"failure_reason": "BUILD_FAILURE",
"id": "8903281624467692592",
"parameters_json": "{\"builder_name\": \"fuzz-linux\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"cron\": {\"generation\": \"1035\"}, \"id\": \"cron:v1:1035\"}]}}}",
"project": "dart",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 out of 2 aggregated steps failed: 1 out of 5 aggregated steps failed: 43 out of 99 aggregated steps failed: Step(\\\"['shard #0 (failed) (2663.0 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2659.4 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2674.8 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2682.9 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2666.9 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2687.4 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2662.8 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2659.9 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2705.6 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2654.7 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2667.5 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2663.2 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2659.2 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2668.1 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2671.5 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2657.5 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2661.8 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2668.7 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2665.5 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2666.0 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2662.4 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2676.2 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2659.0 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2720.1 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2664.6 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2676.6 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2669.1 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2667.5 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2661.1 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2663.9 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2670.4 sec)']\\\") (retcode: 0), Step(\\\"[(0, 'Internal swarming failure')]\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2663.5 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2690.4 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2686.2 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2670.4 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2657.8 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2671.0 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2674.3 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2668.9 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2661.4 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2660.5 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2673.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}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"cron\": {\"generation\": \"1035\"}, \"id\": \"cron:v1:1035\"}]}, \"bot_id\": \"luci-dart-try-xenial-22-rdfx\", \"buildername\": \"fuzz-linux\", \"buildnumber\": 346, \"clobber\": \"true\", \"got_revision\": \"622747502e32f578e097e79d5bee34b55d87c9c6\", \"path_config\": \"generic\", \"recipe\": \"dart/neo\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_0dbbfc059f435d35179dd47113812f21e47ad8b3688802891d6abaa993d93b2a_v2\", \"builder_2053f9ecd38f9ae86e842d80573e928bbbe7c3feabf239fc3b5d879c51b04bed_v2\", \"builder_2a98a8b518ca4a18ae82ffedef2eea93c4a884abc1d231637aa846a898cf2599_v2\", \"builder_3dd0192df5a1c095bdd5ee9744289eb97c0d0c054c9e0ed4989cfaa42db0ee80_v2\", \"builder_67aa90b220d9a45fc7499f7276d79b02b81db23806326247e82f90ae3ee1882a_v2\", \"builder_b24b9e9c7bdcc8c15b82ff72de3c9e4817df38aeec4906b757083d6c2a012484_v2\", \"builder_b4903f1f4f72e5aba35fcf81c8aa2a39a5c11d06b874553a5e6743c0759f1672_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-22-rdfx\"], \"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\": [\"4397-8786906\"], \"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: 43 out of 99 aggregated steps failed: Step(\\\"['shard #0 (failed) (2663.0 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2659.4 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2674.8 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2682.9 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2666.9 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2687.4 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2662.8 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2659.9 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2705.6 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2654.7 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2667.5 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2663.2 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2659.2 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2668.1 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2671.5 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2657.5 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2661.8 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2668.7 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2665.5 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2666.0 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2662.4 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2676.2 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2659.0 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2720.1 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2664.6 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2676.6 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2669.1 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2667.5 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2661.1 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2663.9 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2670.4 sec)']\\\") (retcode: 0), Step(\\\"[(0, 'Internal swarming failure')]\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2663.5 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2690.4 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2686.2 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2670.4 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2657.8 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2671.0 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2674.3 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2668.9 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2661.4 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2660.5 sec)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (2673.0 sec)']\\\") (retcode: 0)\"}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"started_ts": "1567566007572488",
"status": "COMPLETED",
"status_changed_ts": "1567566009773421",
"tags": [
"build_address:luci.dart.ci.sandbox/fuzz-linux/346",
"builder:fuzz-linux",
"scheduler_invocation_id:9068711687301194240",
"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/8903281624467692592/+/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:4713088fad4de210",
"user_agent:luci-scheduler"
],
"updated_ts": "1567569723246571",
"url": "https://ci.chromium.org/b/8903281624467692592",
"utcnow_ts": "1567569723748485"
}
}
[04:02:03.757] Invocation finished in 1h2m0.621845095s with status FAILED