[03:00:04.557] New invocation is queued and will start shortly
[03:00:06.244] Starting the invocation (attempt 1)
[03:00:06.285] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:00:06.285] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:00:06.285] Buildbucket request:
{
"bucket": "luci.dart.ci.sandbox",
"client_operation_id": "9037999314233366496",
"parameters_json": "{\"builder_name\":\"fuzz-linux\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"cron\":{\"generation\":\"3069\"},\"id\":\"cron:v1:3069\"}]}}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:fuzz-linux",
"scheduler_invocation_id:9037999314233366496",
"scheduler_job_id:dart/fuzz-linux",
"user_agent:luci-scheduler"
]
}
[03:00:06.997] Buildbucket response:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"created_by": "project:dart",
"created_ts": "1596855606394097",
"id": "8872569251627533392",
"parameters_json": "{\"builder_name\": \"fuzz-linux\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"cron\": {\"generation\": \"3069\"}, \"id\": \"cron:v1:3069\"}]}}}",
"project": "dart",
"result_details_json": "{\"properties\": {}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1596855606822668",
"tags": [
"build_address:luci.dart.ci.sandbox/fuzz-linux/1024",
"builder:fuzz-linux",
"scheduler_invocation_id:9037999314233366496",
"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/8872569251627533392/+/annotations",
"swarming_tag:luci_project:dart",
"swarming_tag:recipe_name:dart/neo",
"swarming_tag:recipe_package:dart/recipe_bundles/dart.googlesource.com/recipes",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1596855606822848",
"url": "https://ci.chromium.org/b/8872569251627533392",
"utcnow_ts": "1596855606987794"
}
}
[03:00:06.997] Task URL: https://ci.chromium.org/b/8872569251627533392
[03:00:06.997] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:2:0) after 1m0s
[03:00:10.219] Received PubSub notification, asking Buildbucket for the build status
[03:00:10.284] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:07.481] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:2:0)
[03:01:07.481] Timer tick, asking Buildbucket for the build status
[03:01:07.614] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:07.614] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:4:0) after 1m0s
[03:02:07.686] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:4:0)
[03:02:07.686] Timer tick, asking Buildbucket for the build status
[03:02:07.906] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:07.906] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:5:0) after 1m0s
[03:03:07.975] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:5:0)
[03:03:07.975] Timer tick, asking Buildbucket for the build status
[03:03:08.178] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:08.178] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:6:0) after 1m0s
[03:04:08.212] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:6:0)
[03:04:08.212] Timer tick, asking Buildbucket for the build status
[03:04:08.291] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:08.291] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:7:0) after 1m0s
[03:05:08.399] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:7:0)
[03:05:08.399] Timer tick, asking Buildbucket for the build status
[03:05:08.514] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:08.514] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:8:0) after 1m0s
[03:06:08.614] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:8:0)
[03:06:08.614] Timer tick, asking Buildbucket for the build status
[03:06:09.058] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:09.058] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:9:0) after 1m0s
[03:07:09.236] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:9:0)
[03:07:09.236] Timer tick, asking Buildbucket for the build status
[03:07:09.583] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:09.583] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:10:0) after 1m0s
[03:08:09.671] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:10:0)
[03:08:09.671] Timer tick, asking Buildbucket for the build status
[03:08:09.896] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:09.896] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:11:0) after 1m0s
[03:09:10.012] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:11:0)
[03:09:10.012] Timer tick, asking Buildbucket for the build status
[03:09:10.328] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:10.328] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:12:0) after 1m0s
[03:10:10.438] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:12:0)
[03:10:10.438] Timer tick, asking Buildbucket for the build status
[03:10:11.253] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:11.253] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:13:0) after 1m0s
[03:11:11.412] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:13:0)
[03:11:11.412] Timer tick, asking Buildbucket for the build status
[03:11:12.215] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:12.215] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:14:0) after 1m0s
[03:12:12.264] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:14:0)
[03:12:12.264] Timer tick, asking Buildbucket for the build status
[03:12:12.343] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:12.343] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:15:0) after 1m0s
[03:13:12.366] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:15:0)
[03:13:12.366] Timer tick, asking Buildbucket for the build status
[03:13:12.451] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:12.451] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:16:0) after 1m0s
[03:14:12.550] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:16:0)
[03:14:12.550] Timer tick, asking Buildbucket for the build status
[03:14:12.709] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:12.709] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:17:0) after 1m0s
[03:15:12.782] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:17:0)
[03:15:12.782] Timer tick, asking Buildbucket for the build status
[03:15:13.204] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:13.205] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:18:0) after 1m0s
[03:16:13.215] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:18:0)
[03:16:13.215] Timer tick, asking Buildbucket for the build status
[03:16:13.530] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:13.530] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:19:0) after 1m0s
[03:17:13.574] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:19:0)
[03:17:13.574] Timer tick, asking Buildbucket for the build status
[03:17:13.650] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:13.650] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:20:0) after 1m0s
[03:18:13.736] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:20:0)
[03:18:13.736] Timer tick, asking Buildbucket for the build status
[03:18:14.174] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:14.174] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:21:0) after 1m0s
[03:19:14.204] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:21:0)
[03:19:14.204] Timer tick, asking Buildbucket for the build status
[03:19:14.348] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:14.348] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:22:0) after 1m0s
[03:20:14.409] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:22:0)
[03:20:14.409] Timer tick, asking Buildbucket for the build status
[03:20:14.591] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:14.591] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:23:0) after 1m0s
[03:21:14.612] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:23:0)
[03:21:14.612] Timer tick, asking Buildbucket for the build status
[03:21:14.705] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:14.705] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:24:0) after 1m0s
[03:22:14.731] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:24:0)
[03:22:14.731] Timer tick, asking Buildbucket for the build status
[03:22:14.849] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:14.849] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:25:0) after 1m0s
[03:23:14.954] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:25:0)
[03:23:14.954] Timer tick, asking Buildbucket for the build status
[03:23:15.120] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:15.120] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:26:0) after 1m0s
[03:24:15.188] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:26:0)
[03:24:15.188] Timer tick, asking Buildbucket for the build status
[03:24:15.343] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:15.343] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:27:0) after 1m0s
[03:25:15.378] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:27:0)
[03:25:15.378] Timer tick, asking Buildbucket for the build status
[03:25:15.548] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:15.548] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:28:0) after 1m0s
[03:26:15.552] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:28:0)
[03:26:15.552] Timer tick, asking Buildbucket for the build status
[03:26:15.894] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:15.894] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:29:0) after 1m0s
[03:27:15.947] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:29:0)
[03:27:15.947] Timer tick, asking Buildbucket for the build status
[03:27:16.032] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:16.032] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:30:0) after 1m0s
[03:28:16.051] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:30:0)
[03:28:16.051] Timer tick, asking Buildbucket for the build status
[03:28:16.166] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:16.166] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:31:0) after 1m0s
[03:29:16.169] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:31:0)
[03:29:16.169] Timer tick, asking Buildbucket for the build status
[03:29:16.385] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:16.385] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:32:0) after 1m0s
[03:30:16.416] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:32:0)
[03:30:16.416] Timer tick, asking Buildbucket for the build status
[03:30:16.625] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:16.625] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:33:0) after 1m0s
[03:31:16.649] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:33:0)
[03:31:16.649] Timer tick, asking Buildbucket for the build status
[03:31:16.796] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:16.796] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:34:0) after 1m0s
[03:32:16.869] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:34:0)
[03:32:16.869] Timer tick, asking Buildbucket for the build status
[03:32:17.128] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:17.129] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:35:0) after 1m0s
[03:33:17.185] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:35:0)
[03:33:17.185] Timer tick, asking Buildbucket for the build status
[03:33:17.301] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:17.301] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:36:0) after 1m0s
[03:34:17.375] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:36:0)
[03:34:17.375] Timer tick, asking Buildbucket for the build status
[03:34:17.476] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:17.476] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:37:0) after 1m0s
[03:35:17.513] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:37:0)
[03:35:17.513] Timer tick, asking Buildbucket for the build status
[03:35:17.604] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:17.604] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:38:0) after 1m0s
[03:36:17.624] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:38:0)
[03:36:17.624] Timer tick, asking Buildbucket for the build status
[03:36:18.929] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:18.929] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:39:0) after 1m0s
[03:37:18.978] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:39:0)
[03:37:18.978] Timer tick, asking Buildbucket for the build status
[03:37:19.112] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:19.112] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:40:0) after 1m0s
[03:38:19.164] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:40:0)
[03:38:19.164] Timer tick, asking Buildbucket for the build status
[03:38:19.500] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:19.500] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:41:0) after 1m0s
[03:39:19.575] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:41:0)
[03:39:19.575] Timer tick, asking Buildbucket for the build status
[03:39:19.878] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:19.878] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:42:0) after 1m0s
[03:40:19.967] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:42:0)
[03:40:19.967] Timer tick, asking Buildbucket for the build status
[03:40:20.096] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:20.096] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:43:0) after 1m0s
[03:41:20.128] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:43:0)
[03:41:20.128] Timer tick, asking Buildbucket for the build status
[03:41:20.204] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:20.204] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:44:0) after 1m0s
[03:42:20.237] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:44:0)
[03:42:20.237] Timer tick, asking Buildbucket for the build status
[03:42:20.478] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:20.478] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:45:0) after 1m0s
[03:43:20.552] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:45:0)
[03:43:20.552] Timer tick, asking Buildbucket for the build status
[03:43:20.621] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:20.621] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:46:0) after 1m0s
[03:44:20.656] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:46:0)
[03:44:20.656] Timer tick, asking Buildbucket for the build status
[03:44:20.815] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:20.815] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:47:0) after 1m0s
[03:45:20.872] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:47:0)
[03:45:20.872] Timer tick, asking Buildbucket for the build status
[03:45:21.058] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:21.058] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:48:0) after 1m0s
[03:46:21.082] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:48:0)
[03:46:21.082] Timer tick, asking Buildbucket for the build status
[03:46:21.150] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:21.150] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:49:0) after 1m0s
[03:47:21.176] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:49:0)
[03:47:21.176] Timer tick, asking Buildbucket for the build status
[03:47:21.281] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:21.281] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:50:0) after 1m0s
[03:48:21.403] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:50:0)
[03:48:21.403] Timer tick, asking Buildbucket for the build status
[03:48:21.474] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:21.474] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:51:0) after 1m0s
[03:49:21.481] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:51:0)
[03:49:21.481] Timer tick, asking Buildbucket for the build status
[03:49:21.691] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:21.691] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:52:0) after 1m0s
[03:50:21.739] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:52:0)
[03:50:21.739] Timer tick, asking Buildbucket for the build status
[03:50:21.902] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:21.902] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:53:0) after 1m0s
[03:51:21.925] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:53:0)
[03:51:21.925] Timer tick, asking Buildbucket for the build status
[03:51:22.002] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:22.002] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:54:0) after 1m0s
[03:52:22.059] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:54:0)
[03:52:22.059] Timer tick, asking Buildbucket for the build status
[03:52:22.128] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:22.128] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:55:0) after 1m0s
[03:53:22.176] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:55:0)
[03:53:22.176] Timer tick, asking Buildbucket for the build status
[03:53:22.262] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:22.262] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:56:0) after 1m0s
[03:54:22.267] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:56:0)
[03:54:22.267] Timer tick, asking Buildbucket for the build status
[03:54:22.446] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:22.446] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:57:0) after 1m0s
[03:55:22.469] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:57:0)
[03:55:22.469] Timer tick, asking Buildbucket for the build status
[03:55:22.855] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:22.855] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:58:0) after 1m0s
[03:56:22.929] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:58:0)
[03:56:22.929] Timer tick, asking Buildbucket for the build status
[03:56:23.046] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:23.046] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:59:0) after 1m0s
[03:57:23.112] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:59:0)
[03:57:23.112] Timer tick, asking Buildbucket for the build status
[03:57:23.322] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:23.322] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:60:0) after 1m0s
[03:58:23.348] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:60:0)
[03:58:23.348] Timer tick, asking Buildbucket for the build status
[03:58:23.431] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:23.431] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:61:0) after 1m0s
[03:59:23.456] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:61:0)
[03:59:23.456] Timer tick, asking Buildbucket for the build status
[03:59:23.564] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:23.564] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:62:0) after 1m0s
[04:00:23.659] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:62:0)
[04:00:23.659] Timer tick, asking Buildbucket for the build status
[04:00:25.693] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:25.693] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:63:0) after 1m0s
[04:01:25.760] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:63:0)
[04:01:25.760] Timer tick, asking Buildbucket for the build status
[04:01:26.036] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:26.036] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:64:0) after 1m0s
[04:02:26.097] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:64:0)
[04:02:26.097] Timer tick, asking Buildbucket for the build status
[04:02:26.688] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:26.688] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:65:0) after 1m0s
[04:03:26.754] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:65:0)
[04:03:26.754] Timer tick, asking Buildbucket for the build status
[04:03:26.868] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:26.868] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:66:0) after 1m0s
[04:04:26.875] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:66:0)
[04:04:26.875] Timer tick, asking Buildbucket for the build status
[04:04:27.280] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:27.280] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:67:0) after 1m0s
[04:05:27.336] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:67:0)
[04:05:27.336] Timer tick, asking Buildbucket for the build status
[04:05:28.266] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:28.266] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:68:0) after 1m0s
[04:06:28.287] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:68:0)
[04:06:28.287] Timer tick, asking Buildbucket for the build status
[04:06:28.393] Build 8872569251627533392: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:28.393] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9037999314233366496:69:0) after 1m0s
[04:06:34.392] Received PubSub notification, asking Buildbucket for the build status
[04:06:34.560] Build 8872569251627533392: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[04:06:34.560] Buildbucket build:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"completed_ts": "1596859593336162",
"created_by": "project:dart",
"created_ts": "1596855606394097",
"failure_reason": "BUILD_FAILURE",
"id": "8872569251627533392",
"parameters_json": "{\"builder_name\": \"fuzz-linux\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"cron\": {\"generation\": \"3069\"}, \"id\": \"cron:v1:3069\"}]}}}",
"project": "dart",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 out of 5 aggregated steps failed: 2 out of 99 aggregated steps failed: Swarming task failed:\\n(\\u2026)\\n\\n\\nIsolate (/b/s/w/itgdPvoK/dart_fuzzUZLWPH) NO-FP NO-FFI FLAT : KBC-CMP-O3-SLOWPATH-DebugIA32 - KBC-INT-SRC-O3-ReleaseSIMARM: done\\n\\rTests: 50 Success: 47 (Rerun: 0) Skipped: 0 Timeout: 3 Divergences: 0\\n\\nIsolate (/b/s/w/itgdPvoK/dart_fuzzUZLWPH) NO-FP NO-FFI FLAT : KBC-CMP-O3-SLOWPATH-DebugIA32 - KBC-INT-SRC-O3-ReleaseSIMARM timeout: 139363003, 3839198304, 2918563118\\n\\n\\nIsolate (/b/s/w/itgdPvoK/dart_fuzzFLWUNK) NO-FP NO-FFI FLAT : AOT-SLOWPATH-DebugX64 - KBC-MIX-DET-DebugSIMARM: done\\n\\rTests: 39 Success: 39 (Rerun: 0) Skipped: 0 Timeout: 0 Divergences: 0\\n\\nIsolate (/b/s/w/itgdPvoK/dart_fuzzBGLXQW) NO-FP NO-FFI FLAT : KBC-MIX-ReleaseSIMARM64 - AOT-O3-DebugX64: done\\n\\rTests: 36 Success: 35 (Rerun: 0) Skipped: 0 Timeout: 0 Divergences: 1\\n\\nIsolate (/b/s/w/itgdPvoK/dart_fuzzYJVITC) NO-FP NO-FFI FLAT : KBC-INT-SLOWPATH-ReleaseSIMARM64 - KBC-INT-SRC-SLOWPATH-DET-ReleaseSIMARM: done\\n\\rTests: 55 Success: 55 (Rerun: 0) Skipped: 0 Timeout: 0 Divergences: 0\\n\\nfailure (1 divergences), Swarming task failed:\\n(\\u2026)\\n\\nIsolate (/b/s/w/itn3F0fd/dart_fuzzTGEEKF) FP NO-FFI NO-FLAT : JIT-ReleaseX64 - AOT-ReleaseX64: done\\n\\rTests: 37 Success: 10 (Rerun: 0) Skipped: 0 Timeout: 27 Divergences: 0\\n\\nIsolate (/b/s/w/itn3F0fd/dart_fuzzTGEEKF) FP NO-FFI NO-FLAT : JIT-ReleaseX64 - AOT-ReleaseX64 timeout: 1294405957, 1145896277, 3946595430, 1945876977, 2147733541, 1715223648, 811899525, 3446340543, 613391559, 1452260086, 2604984990, 4040761371, 980709725, 2148600409, 962600575, 4176849830, 385580022, 1507392326, 3994737325, 681399512, 4146056584, 321388392, 1230897055, 597391693, 3565792752, 3721256153, 2926074461\\n\\n\\nIsolate (/b/s/w/itn3F0fd/dart_fuzzMUMFEX) NO-FP NO-FFI FLAT : KBC-INT-SRC-DET-ReleaseIA32 - JIT-DebugSIMARM64: done\\n\\rTests: 46 Success: 42 (Rerun: 0) Skipped: 0 Timeout: 4 Divergences: 0\\n\\nIsolate (/b/s/w/itn3F0fd/dart_fuzzMUMFEX) NO-FP NO-FFI FLAT : KBC-INT-SRC-DET-ReleaseIA32 - JIT-DebugSIMARM64 timeout: 3503201786, 3241367308, 3695028959, 2146360373\\n\\n\\nfailure (1 divergences)\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"cron\": {\"generation\": \"3069\"}, \"id\": \"cron:v1:3069\"}]}, \"$recipe_engine/swarming\": {\"server\": \"https://chromium-swarm.appspot.com\"}, \"bot_id\": \"luci-dart-try-xenial-70-ais2\", \"buildername\": \"fuzz-linux\", \"buildnumber\": 1024, \"clobber\": \"true\", \"got_revision\": \"0aa5b0f019b9fb3d2894040107062f650ccb2c9e\", \"path_config\": \"generic\", \"recipe\": \"dart/neo\"}, \"swarming\": {\"bot_dimensions\": {\"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"dart-ci\"], \"gpu\": [\"none\"], \"host_class\": [\"default\"], \"id\": [\"luci-dart-try-xenial-70-ais2\"], \"image\": [\"dart-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"dart.tests\", \"luci.dart.try\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5472-d0af7f3\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 out of 5 aggregated steps failed: 2 out of 99 aggregated steps failed: Swarming task failed:\\n(\\u2026)\\n\\n\\nIsolate (/b/s/w/itgdPvoK/dart_fuzzUZLWPH) NO-FP NO-FFI FLAT : KBC-CMP-O3-SLOWPATH-DebugIA32 - KBC-INT-SRC-O3-ReleaseSIMARM: done\\n\\rTests: 50 Success: 47 (Rerun: 0) Skipped: 0 Timeout: 3 Divergences: 0\\n\\nIsolate (/b/s/w/itgdPvoK/dart_fuzzUZLWPH) NO-FP NO-FFI FLAT : KBC-CMP-O3-SLOWPATH-DebugIA32 - KBC-INT-SRC-O3-ReleaseSIMARM timeout: 139363003, 3839198304, 2918563118\\n\\n\\nIsolate (/b/s/w/itgdPvoK/dart_fuzzFLWUNK) NO-FP NO-FFI FLAT : AOT-SLOWPATH-DebugX64 - KBC-MIX-DET-DebugSIMARM: done\\n\\rTests: 39 Success: 39 (Rerun: 0) Skipped: 0 Timeout: 0 Divergences: 0\\n\\nIsolate (/b/s/w/itgdPvoK/dart_fuzzBGLXQW) NO-FP NO-FFI FLAT : KBC-MIX-ReleaseSIMARM64 - AOT-O3-DebugX64: done\\n\\rTests: 36 Success: 35 (Rerun: 0) Skipped: 0 Timeout: 0 Divergences: 1\\n\\nIsolate (/b/s/w/itgdPvoK/dart_fuzzYJVITC) NO-FP NO-FFI FLAT : KBC-INT-SLOWPATH-ReleaseSIMARM64 - KBC-INT-SRC-SLOWPATH-DET-ReleaseSIMARM: done\\n\\rTests: 55 Success: 55 (Rerun: 0) Skipped: 0 Timeout: 0 Divergences: 0\\n\\nfailure (1 divergences), Swarming task failed:\\n(\\u2026)\\n\\nIsolate (/b/s/w/itn3F0fd/dart_fuzzTGEEKF) FP NO-FFI NO-FLAT : JIT-ReleaseX64 - AOT-ReleaseX64: done\\n\\rTests: 37 Success: 10 (Rerun: 0) Skipped: 0 Timeout: 27 Divergences: 0\\n\\nIsolate (/b/s/w/itn3F0fd/dart_fuzzTGEEKF) FP NO-FFI NO-FLAT : JIT-ReleaseX64 - AOT-ReleaseX64 timeout: 1294405957, 1145896277, 3946595430, 1945876977, 2147733541, 1715223648, 811899525, 3446340543, 613391559, 1452260086, 2604984990, 4040761371, 980709725, 2148600409, 962600575, 4176849830, 385580022, 1507392326, 3994737325, 681399512, 4146056584, 321388392, 1230897055, 597391693, 3565792752, 3721256153, 2926074461\\n\\n\\nIsolate (/b/s/w/itn3F0fd/dart_fuzzMUMFEX) NO-FP NO-FFI FLAT : KBC-INT-SRC-DET-ReleaseIA32 - JIT-DebugSIMARM64: done\\n\\rTests: 46 Success: 42 (Rerun: 0) Skipped: 0 Timeout: 4 Divergences: 0\\n\\nIsolate (/b/s/w/itn3F0fd/dart_fuzzMUMFEX) NO-FP NO-FFI FLAT : KBC-INT-SRC-DET-ReleaseIA32 - JIT-DebugSIMARM64 timeout: 3503201786, 3241367308, 3695028959, 2146360373\\n\\n\\nfailure (1 divergences)\"}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"started_ts": "1596855609234420",
"status": "COMPLETED",
"status_changed_ts": "1596855609703643",
"tags": [
"build_address:luci.dart.ci.sandbox/fuzz-linux/1024",
"builder:fuzz-linux",
"scheduler_invocation_id:9037999314233366496",
"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/8872569251627533392/+/annotations",
"swarming_tag:luci_project:dart",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:dart/neo",
"swarming_tag:recipe_package:dart/recipe_bundles/dart.googlesource.com/recipes",
"swarming_task_id:4de4d46d6085c710",
"user_agent:luci-scheduler"
],
"updated_ts": "1596859593977656",
"url": "https://ci.chromium.org/b/8872569251627533392",
"utcnow_ts": "1596859594542949"
}
}
[04:06:34.560] Invocation finished in 1h6m30.034129631s with status FAILED