[04:06:12.870] New invocation is queued and will start shortly
[04:06:14.201] Starting the invocation (attempt 1)
[04:06:14.254] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:06:14.254] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:06:14.254] Buildbucket request:
{
"bucket": "luci.dart.ci.sandbox",
"client_operation_id": "9060553797775600688",
"parameters_json": "{\"builder_name\":\"fuzz-linux\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"cron\":{\"generation\":\"1578\"},\"id\":\"cron:v1:1578\"}]}}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:fuzz-linux",
"scheduler_invocation_id:9060553797775600688",
"scheduler_job_id:dart/fuzz-linux",
"user_agent:luci-scheduler"
]
}
[04:06:15.104] Buildbucket response:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"created_by": "project:dart",
"created_ts": "1575345974398912",
"id": "8895123735508292160",
"parameters_json": "{\"builder_name\": \"fuzz-linux\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"cron\": {\"generation\": \"1578\"}, \"id\": \"cron:v1:1578\"}]}}}",
"project": "dart",
"result_details_json": "{\"properties\": {}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1575345974869272",
"tags": [
"build_address:luci.dart.ci.sandbox/fuzz-linux/527",
"builder:fuzz-linux",
"scheduler_invocation_id:9060553797775600688",
"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/8895123735508292160/+/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": "1575345974871581",
"url": "https://ci.chromium.org/b/8895123735508292160",
"utcnow_ts": "1575345975079559"
}
}
[04:06:15.104] Task URL: https://ci.chromium.org/b/8895123735508292160
[04:06:15.104] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:2:0) after 1m0s
[04:06:16.962] Received PubSub notification, asking Buildbucket for the build status
[04:06:17.159] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:15.121] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:2:0)
[04:07:15.121] Timer tick, asking Buildbucket for the build status
[04:07:15.300] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:15.300] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:4:0) after 1m0s
[04:08:15.359] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:4:0)
[04:08:15.359] Timer tick, asking Buildbucket for the build status
[04:08:15.858] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:15.858] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:5:0) after 1m0s
[04:09:15.882] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:5:0)
[04:09:15.882] Timer tick, asking Buildbucket for the build status
[04:09:16.054] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:16.054] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:6:0) after 1m0s
[04:10:16.076] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:6:0)
[04:10:16.076] Timer tick, asking Buildbucket for the build status
[04:10:16.484] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:16.484] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:7:0) after 1m0s
[04:11:16.537] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:7:0)
[04:11:16.537] Timer tick, asking Buildbucket for the build status
[04:11:17.264] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:17.264] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:8:0) after 1m0s
[04:12:17.330] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:8:0)
[04:12:17.330] Timer tick, asking Buildbucket for the build status
[04:12:17.831] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:17.831] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:9:0) after 1m0s
[04:13:17.888] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:9:0)
[04:13:17.888] Timer tick, asking Buildbucket for the build status
[04:13:18.415] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:18.415] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:10:0) after 1m0s
[04:14:18.481] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:10:0)
[04:14:18.481] Timer tick, asking Buildbucket for the build status
[04:14:18.758] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:18.758] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:11:0) after 1m0s
[04:15:18.814] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:11:0)
[04:15:18.814] Timer tick, asking Buildbucket for the build status
[04:15:19.391] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:19.391] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:12:0) after 1m0s
[04:16:19.421] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:12:0)
[04:16:19.421] Timer tick, asking Buildbucket for the build status
[04:16:19.756] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:19.756] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:13:0) after 1m0s
[04:17:19.813] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:13:0)
[04:17:19.813] Timer tick, asking Buildbucket for the build status
[04:17:20.664] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:20.664] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:14:0) after 1m0s
[04:18:20.717] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:14:0)
[04:18:20.717] Timer tick, asking Buildbucket for the build status
[04:18:21.101] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:21.101] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:15:0) after 1m0s
[04:19:21.121] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:15:0)
[04:19:21.121] Timer tick, asking Buildbucket for the build status
[04:19:21.625] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:21.625] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:16:0) after 1m0s
[04:20:21.767] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:16:0)
[04:20:21.767] Timer tick, asking Buildbucket for the build status
[04:20:21.974] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:21.974] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:17:0) after 1m0s
[04:21:22.123] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:17:0)
[04:21:22.123] Timer tick, asking Buildbucket for the build status
[04:21:22.469] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:22.469] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:18:0) after 1m0s
[04:22:22.505] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:18:0)
[04:22:22.505] Timer tick, asking Buildbucket for the build status
[04:22:22.818] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:22.818] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:19:0) after 1m0s
[04:23:22.839] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:19:0)
[04:23:22.839] Timer tick, asking Buildbucket for the build status
[04:23:23.046] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:23.046] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:20:0) after 1m0s
[04:24:23.072] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:20:0)
[04:24:23.072] Timer tick, asking Buildbucket for the build status
[04:24:23.468] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:23.468] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:21:0) after 1m0s
[04:25:23.486] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:21:0)
[04:25:23.486] Timer tick, asking Buildbucket for the build status
[04:25:23.799] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:23.799] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:22:0) after 1m0s
[04:26:23.809] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:22:0)
[04:26:23.809] Timer tick, asking Buildbucket for the build status
[04:26:24.243] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:24.243] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:23:0) after 1m0s
[04:27:24.303] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:23:0)
[04:27:24.303] Timer tick, asking Buildbucket for the build status
[04:27:24.518] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:24.518] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:24:0) after 1m0s
[04:28:24.561] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:24:0)
[04:28:24.561] Timer tick, asking Buildbucket for the build status
[04:28:24.804] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:24.804] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:25:0) after 1m0s
[04:29:24.825] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:25:0)
[04:29:24.825] Timer tick, asking Buildbucket for the build status
[04:29:25.083] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:25.083] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:26:0) after 1m0s
[04:30:25.129] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:26:0)
[04:30:25.129] Timer tick, asking Buildbucket for the build status
[04:30:25.588] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:25.588] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:27:0) after 1m0s
[04:31:25.686] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:27:0)
[04:31:25.686] Timer tick, asking Buildbucket for the build status
[04:31:25.927] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:25.927] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:28:0) after 1m0s
[04:32:25.959] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:28:0)
[04:32:25.959] Timer tick, asking Buildbucket for the build status
[04:32:26.594] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:26.594] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:29:0) after 1m0s
[04:33:26.661] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:29:0)
[04:33:26.661] Timer tick, asking Buildbucket for the build status
[04:33:26.843] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:26.843] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:30:0) after 1m0s
[04:34:26.888] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:30:0)
[04:34:26.888] Timer tick, asking Buildbucket for the build status
[04:34:27.017] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:27.017] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:31:0) after 1m0s
[04:35:27.097] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:31:0)
[04:35:27.097] Timer tick, asking Buildbucket for the build status
[04:35:27.509] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:27.509] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:32:0) after 1m0s
[04:36:27.534] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:32:0)
[04:36:27.535] Timer tick, asking Buildbucket for the build status
[04:36:27.725] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:27.725] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:33:0) after 1m0s
[04:37:27.760] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:33:0)
[04:37:27.760] Timer tick, asking Buildbucket for the build status
[04:37:28.409] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:28.409] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:34:0) after 1m0s
[04:38:28.652] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:34:0)
[04:38:28.652] Timer tick, asking Buildbucket for the build status
[04:38:29.175] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:29.175] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:35:0) after 1m0s
[04:39:29.268] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:35:0)
[04:39:29.268] Timer tick, asking Buildbucket for the build status
[04:39:29.853] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:29.853] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:36:0) after 1m0s
[04:40:29.952] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:36:0)
[04:40:29.952] Timer tick, asking Buildbucket for the build status
[04:40:32.132] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:32.132] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:37:0) after 1m0s
[04:41:32.203] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:37:0)
[04:41:32.203] Timer tick, asking Buildbucket for the build status
[04:41:32.696] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:32.696] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:38:0) after 1m0s
[04:42:32.804] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:38:0)
[04:42:32.804] Timer tick, asking Buildbucket for the build status
[04:42:33.356] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:33.356] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:39:0) after 1m0s
[04:43:33.489] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:39:0)
[04:43:33.489] Timer tick, asking Buildbucket for the build status
[04:43:34.871] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:34.871] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:40:0) after 1m0s
[04:44:35.017] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:40:0)
[04:44:35.017] Timer tick, asking Buildbucket for the build status
[04:44:35.187] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:35.187] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:41:0) after 1m0s
[04:45:35.325] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:41:0)
[04:45:35.325] Timer tick, asking Buildbucket for the build status
[04:45:35.582] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:35.582] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:42:0) after 1m0s
[04:46:35.602] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:42:0)
[04:46:35.602] Timer tick, asking Buildbucket for the build status
[04:46:35.746] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:35.746] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:43:0) after 1m0s
[04:47:35.790] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:43:0)
[04:47:35.790] Timer tick, asking Buildbucket for the build status
[04:47:35.929] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:35.929] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:44:0) after 1m0s
[04:48:35.963] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:44:0)
[04:48:35.963] Timer tick, asking Buildbucket for the build status
[04:48:36.251] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:36.251] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:45:0) after 1m0s
[04:49:36.289] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:45:0)
[04:49:36.289] Timer tick, asking Buildbucket for the build status
[04:49:36.423] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:36.423] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:46:0) after 1m0s
[04:50:36.478] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:46:0)
[04:50:36.478] Timer tick, asking Buildbucket for the build status
[04:50:36.658] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:36.658] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:47:0) after 1m0s
[04:51:36.719] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:47:0)
[04:51:36.719] Timer tick, asking Buildbucket for the build status
[04:51:37.186] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:37.186] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:48:0) after 1m0s
[04:52:37.314] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:48:0)
[04:52:37.314] Timer tick, asking Buildbucket for the build status
[04:52:37.463] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:37.463] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:49:0) after 1m0s
[04:53:37.477] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:49:0)
[04:53:37.477] Timer tick, asking Buildbucket for the build status
[04:53:37.597] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:37.597] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:50:0) after 1m0s
[04:54:37.653] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:50:0)
[04:54:37.653] Timer tick, asking Buildbucket for the build status
[04:54:37.813] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:37.813] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:51:0) after 1m0s
[04:55:37.911] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:51:0)
[04:55:37.911] Timer tick, asking Buildbucket for the build status
[04:55:38.068] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:38.068] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:52:0) after 1m0s
[04:56:38.163] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:52:0)
[04:56:38.164] Timer tick, asking Buildbucket for the build status
[04:56:38.754] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:38.754] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:53:0) after 1m0s
[04:57:38.811] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:53:0)
[04:57:38.811] Timer tick, asking Buildbucket for the build status
[04:57:39.052] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:39.052] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:54:0) after 1m0s
[04:58:39.107] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:54:0)
[04:58:39.107] Timer tick, asking Buildbucket for the build status
[04:58:39.928] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:39.928] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:55:0) after 1m0s
[04:59:39.997] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:55:0)
[04:59:39.997] Timer tick, asking Buildbucket for the build status
[04:59:40.164] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:40.164] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:56:0) after 1m0s
[05:00:40.277] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:56:0)
[05:00:40.277] Timer tick, asking Buildbucket for the build status
[05:00:40.535] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:40.535] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:57:0) after 1m0s
[05:01:40.736] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:57:0)
[05:01:40.736] Timer tick, asking Buildbucket for the build status
[05:01:40.975] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:40.975] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:58:0) after 1m0s
[05:02:41.144] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:58:0)
[05:02:41.144] Timer tick, asking Buildbucket for the build status
[05:02:41.524] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:41.524] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:59:0) after 1m0s
[05:03:41.526] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:59:0)
[05:03:41.526] Timer tick, asking Buildbucket for the build status
[05:03:43.215] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:43.215] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:60:0) after 1m0s
[05:04:43.339] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:60:0)
[05:04:43.339] Timer tick, asking Buildbucket for the build status
[05:04:43.569] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:43.569] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:61:0) after 1m0s
[05:05:43.660] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:61:0)
[05:05:43.660] Timer tick, asking Buildbucket for the build status
[05:05:43.854] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:43.854] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:62:0) after 1m0s
[05:06:43.915] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:62:0)
[05:06:43.915] Timer tick, asking Buildbucket for the build status
[05:06:45.033] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:45.033] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:63:0) after 1m0s
[05:07:45.203] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:63:0)
[05:07:45.203] Timer tick, asking Buildbucket for the build status
[05:07:45.562] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:45.562] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:64:0) after 1m0s
[05:08:45.684] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:64:0)
[05:08:45.684] Timer tick, asking Buildbucket for the build status
[05:08:45.885] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:45.885] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:65:0) after 1m0s
[05:09:46.034] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:65:0)
[05:09:46.034] Timer tick, asking Buildbucket for the build status
[05:09:46.187] Build 8895123735508292160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:46.187] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9060553797775600688:66:0) after 1m0s
[05:10:34.381] Received PubSub notification, asking Buildbucket for the build status
[05:10:34.577] Build 8895123735508292160: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[05:10:34.577] Buildbucket build:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"completed_ts": "1575349833406953",
"created_by": "project:dart",
"created_ts": "1575345974398912",
"failure_reason": "BUILD_FAILURE",
"id": "8895123735508292160",
"parameters_json": "{\"builder_name\": \"fuzz-linux\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"cron\": {\"generation\": \"1578\"}, \"id\": \"cron:v1:1578\"}]}}}",
"project": "dart",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 out of 2 aggregated steps failed: 1 out of 5 aggregated steps failed: 65 out of 99 aggregated steps failed: Step(\\\"['shard #0 (failed) (46m 33s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 33s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 56s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 43s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (47m 48s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 42s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 40s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 38s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 26s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (47m 52s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 13s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 31s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 33s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (45m 58s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 43s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 33s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 40s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 17s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 29s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 0s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 19s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 18s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 22s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 14s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (47m 36s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 12s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 42s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (45m 57s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 14s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (45m 53s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 19s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 37s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 5s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 48s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 1s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 5s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 52s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 34s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 46s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 47s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 37s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 38s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 38s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 34s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (47m 0s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 17s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 31s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 47s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 36s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (47m 36s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 26s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (45m 58s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 38s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 46s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 4s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 38s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 5s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 10s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 14s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 4s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 48s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (45m 58s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 5s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 1s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 15s)']\\\") (retcode: 0)\"}, \"properties\": {\"$depot_tools/osx_sdk\": {\"sdk_version\": \"9c40b\"}, \"$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\": \"1578\"}, \"id\": \"cron:v1:1578\"}]}, \"bot_id\": \"luci-dart-try-xenial-2-618n\", \"buildername\": \"fuzz-linux\", \"buildnumber\": 527, \"clobber\": \"true\", \"got_revision\": \"2de9b45c8f1e7eeb8a1612282e26bcc0af7cfb6c\", \"path_config\": \"generic\", \"recipe\": \"dart/neo\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_2e0968c16ee8da8bae0d8992863ca0007fdda5dcfcd5a70c165f9dfc4b29e1ab_v2\", \"builder_3dd0192df5a1c095bdd5ee9744289eb97c0d0c054c9e0ed4989cfaa42db0ee80_v2\", \"builder_55ecf7dd0689ec3737c70fdf73c6d0fcdbf0a011adbff1794f7d76bde329a729_v2\", \"builder_57bffe7aa36ae5e94221e6cd004157defcf160dbdea386297f1e7bca83d17d66_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-2-618n\"], \"image\": [\"chrome-xenial-19112404-1fe53dcaaf2\"], \"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\": [\"4679-6acb960\"], \"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: 65 out of 99 aggregated steps failed: Step(\\\"['shard #0 (failed) (46m 33s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 33s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 56s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 43s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (47m 48s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 42s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 40s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 38s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 26s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (47m 52s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 13s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 31s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 33s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (45m 58s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 43s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 33s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 40s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 17s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 29s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 0s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 19s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 18s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 22s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 14s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (47m 36s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 12s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 42s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (45m 57s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 14s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (45m 53s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 19s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 37s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 5s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 48s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 1s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 5s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 52s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 34s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 46s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 47s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 37s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 38s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 38s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 34s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (47m 0s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 17s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 31s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 47s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 36s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (47m 36s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 26s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (45m 58s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 38s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 46s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 4s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 38s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 5s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 10s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 14s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 4s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 48s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (45m 58s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 5s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 1s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 15s)']\\\") (retcode: 0)\"}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"started_ts": "1575345975930858",
"status": "COMPLETED",
"status_changed_ts": "1575345976579120",
"tags": [
"build_address:luci.dart.ci.sandbox/fuzz-linux/527",
"builder:fuzz-linux",
"scheduler_invocation_id:9060553797775600688",
"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/8895123735508292160/+/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:48e2c177d7b50410",
"user_agent:luci-scheduler"
],
"updated_ts": "1575349833813380",
"url": "https://ci.chromium.org/b/8895123735508292160",
"utcnow_ts": "1575349834553154"
}
}
[05:10:34.577] Invocation finished in 1h4m21.725589253s with status FAILED