[03:00:02.708] New invocation is queued and will start shortly
[03:00:03.819] Starting the invocation (attempt 1)
[03:00:03.864] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:00:03.864] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:00:03.864] Buildbucket request:
{
"bucket": "luci.dart.ci.sandbox",
"client_operation_id": "9034375437508570096",
"parameters_json": "{\"builder_name\":\"fuzz-linux\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"cron\":{\"generation\":\"3309\"},\"id\":\"cron:v1:3309\"}]}}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:fuzz-linux",
"scheduler_invocation_id:9034375437508570096",
"scheduler_job_id:dart/fuzz-linux",
"user_agent:luci-scheduler"
]
}
[03:00:04.851] Buildbucket response:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"created_by": "project:dart",
"created_ts": "1600311603999364",
"id": "8868945375483795536",
"parameters_json": "{\"builder_name\": \"fuzz-linux\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"cron\": {\"generation\": \"3309\"}, \"id\": \"cron:v1:3309\"}]}}}",
"project": "dart",
"result_details_json": "{\"properties\": {}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1600311604612220",
"tags": [
"build_address:luci.dart.ci.sandbox/fuzz-linux/1104",
"builder:fuzz-linux",
"scheduler_invocation_id:9034375437508570096",
"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/8868945375483795536/+/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": "1600311604612335",
"url": "https://ci.chromium.org/b/8868945375483795536",
"utcnow_ts": "1600311604822772"
}
}
[03:00:04.851] Task URL: https://ci.chromium.org/b/8868945375483795536
[03:00:04.851] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:2:0) after 1m0s
[03:00:10.741] Received PubSub notification, asking Buildbucket for the build status
[03:00:11.619] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:05.204] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:2:0)
[03:01:05.204] Timer tick, asking Buildbucket for the build status
[03:01:05.326] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:05.327] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:4:0) after 1m0s
[03:02:05.353] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:4:0)
[03:02:05.353] Timer tick, asking Buildbucket for the build status
[03:02:05.556] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:05.556] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:5:0) after 1m0s
[03:03:05.649] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:5:0)
[03:03:05.649] Timer tick, asking Buildbucket for the build status
[03:03:05.773] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:05.773] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:6:0) after 1m0s
[03:04:05.778] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:6:0)
[03:04:05.778] Timer tick, asking Buildbucket for the build status
[03:04:06.421] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:06.421] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:7:0) after 1m0s
[03:05:06.546] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:7:0)
[03:05:06.546] Timer tick, asking Buildbucket for the build status
[03:05:06.891] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:06.891] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:8:0) after 1m0s
[03:06:06.963] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:8:0)
[03:06:06.963] Timer tick, asking Buildbucket for the build status
[03:06:07.266] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:07.266] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:9:0) after 1m0s
[03:07:07.260] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:9:0)
[03:07:07.260] Timer tick, asking Buildbucket for the build status
[03:07:07.491] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:07.491] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:10:0) after 1m0s
[03:08:07.580] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:10:0)
[03:08:07.580] Timer tick, asking Buildbucket for the build status
[03:08:07.661] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:07.661] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:11:0) after 1m0s
[03:09:07.710] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:11:0)
[03:09:07.710] Timer tick, asking Buildbucket for the build status
[03:09:07.818] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:07.818] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:12:0) after 1m0s
[03:10:07.878] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:12:0)
[03:10:07.878] Timer tick, asking Buildbucket for the build status
[03:10:08.037] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:08.037] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:13:0) after 1m0s
[03:11:08.076] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:13:0)
[03:11:08.076] Timer tick, asking Buildbucket for the build status
[03:11:08.261] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:08.261] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:14:0) after 1m0s
[03:12:08.246] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:14:0)
[03:12:08.246] Timer tick, asking Buildbucket for the build status
[03:12:08.334] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:08.334] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:15:0) after 1m0s
[03:13:08.409] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:15:0)
[03:13:08.409] Timer tick, asking Buildbucket for the build status
[03:13:08.515] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:08.515] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:16:0) after 1m0s
[03:14:08.657] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:16:0)
[03:14:08.657] Timer tick, asking Buildbucket for the build status
[03:14:08.775] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:08.775] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:17:0) after 1m0s
[03:15:08.865] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:17:0)
[03:15:08.865] Timer tick, asking Buildbucket for the build status
[03:15:08.984] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:08.984] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:18:0) after 1m0s
[03:16:09.047] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:18:0)
[03:16:09.047] Timer tick, asking Buildbucket for the build status
[03:16:09.211] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:09.211] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:19:0) after 1m0s
[03:17:09.240] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:19:0)
[03:17:09.240] Timer tick, asking Buildbucket for the build status
[03:17:09.331] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:09.331] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:20:0) after 1m0s
[03:18:09.372] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:20:0)
[03:18:09.372] Timer tick, asking Buildbucket for the build status
[03:18:09.448] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:09.448] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:21:0) after 1m0s
[03:19:09.470] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:21:0)
[03:19:09.470] Timer tick, asking Buildbucket for the build status
[03:19:09.552] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:09.552] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:22:0) after 1m0s
[03:20:09.752] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:22:0)
[03:20:09.752] Timer tick, asking Buildbucket for the build status
[03:20:09.869] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:09.869] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:23:0) after 1m0s
[03:21:09.900] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:23:0)
[03:21:09.900] Timer tick, asking Buildbucket for the build status
[03:21:09.972] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:09.972] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:24:0) after 1m0s
[03:22:10.078] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:24:0)
[03:22:10.079] Timer tick, asking Buildbucket for the build status
[03:22:10.166] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:10.166] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:25:0) after 1m0s
[03:23:10.325] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:25:0)
[03:23:10.325] Timer tick, asking Buildbucket for the build status
[03:23:11.069] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:11.069] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:26:0) after 1m0s
[03:24:11.163] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:26:0)
[03:24:11.163] Timer tick, asking Buildbucket for the build status
[03:24:11.245] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:11.245] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:27:0) after 1m0s
[03:25:11.339] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:27:0)
[03:25:11.339] Timer tick, asking Buildbucket for the build status
[03:25:12.113] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:12.113] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:28:0) after 1m0s
[03:26:12.134] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:28:0)
[03:26:12.134] Timer tick, asking Buildbucket for the build status
[03:26:12.218] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:12.218] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:29:0) after 1m0s
[03:27:12.274] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:29:0)
[03:27:12.274] Timer tick, asking Buildbucket for the build status
[03:27:12.601] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:12.601] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:30:0) after 1m0s
[03:28:12.761] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:30:0)
[03:28:12.761] Timer tick, asking Buildbucket for the build status
[03:28:12.874] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:12.874] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:31:0) after 1m0s
[03:29:13.037] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:31:0)
[03:29:13.037] Timer tick, asking Buildbucket for the build status
[03:29:13.121] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:13.121] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:32:0) after 1m0s
[03:30:13.208] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:32:0)
[03:30:13.208] Timer tick, asking Buildbucket for the build status
[03:30:13.637] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:13.637] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:33:0) after 1m0s
[03:31:13.720] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:33:0)
[03:31:13.720] Timer tick, asking Buildbucket for the build status
[03:31:13.789] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:13.789] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:34:0) after 1m0s
[03:32:13.911] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:34:0)
[03:32:13.911] Timer tick, asking Buildbucket for the build status
[03:32:18.185] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:18.185] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:35:0) after 1m0s
[03:33:18.388] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:35:0)
[03:33:18.388] Timer tick, asking Buildbucket for the build status
[03:33:18.486] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:18.486] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:36:0) after 1m0s
[03:34:18.617] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:36:0)
[03:34:18.617] Timer tick, asking Buildbucket for the build status
[03:34:18.905] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:18.905] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:37:0) after 1m0s
[03:35:19.036] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:37:0)
[03:35:19.036] Timer tick, asking Buildbucket for the build status
[03:35:19.194] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:19.194] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:38:0) after 1m0s
[03:36:19.397] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:38:0)
[03:36:19.397] Timer tick, asking Buildbucket for the build status
[03:36:20.595] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:20.595] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:39:0) after 1m0s
[03:37:20.669] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:39:0)
[03:37:20.669] Timer tick, asking Buildbucket for the build status
[03:37:20.753] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:20.753] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:40:0) after 1m0s
[03:38:20.946] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:40:0)
[03:38:20.946] Timer tick, asking Buildbucket for the build status
[03:38:21.048] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:21.048] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:41:0) after 1m0s
[03:39:21.082] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:41:0)
[03:39:21.082] Timer tick, asking Buildbucket for the build status
[03:39:21.157] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:21.157] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:42:0) after 1m0s
[03:40:21.193] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:42:0)
[03:40:21.193] Timer tick, asking Buildbucket for the build status
[03:40:21.746] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:21.746] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:43:0) after 1m0s
[03:41:21.794] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:43:0)
[03:41:21.794] Timer tick, asking Buildbucket for the build status
[03:41:22.023] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:22.023] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:44:0) after 1m0s
[03:42:22.102] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:44:0)
[03:42:22.102] Timer tick, asking Buildbucket for the build status
[03:42:22.166] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:22.167] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:45:0) after 1m0s
[03:43:22.194] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:45:0)
[03:43:22.194] Timer tick, asking Buildbucket for the build status
[03:43:22.285] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:22.285] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:46:0) after 1m0s
[03:44:22.328] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:46:0)
[03:44:22.328] Timer tick, asking Buildbucket for the build status
[03:44:22.517] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:22.517] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:47:0) after 1m0s
[03:45:22.653] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:47:0)
[03:45:22.653] Timer tick, asking Buildbucket for the build status
[03:45:22.820] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:22.820] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:48:0) after 1m0s
[03:46:22.980] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:48:0)
[03:46:22.980] Timer tick, asking Buildbucket for the build status
[03:46:23.132] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:23.132] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:49:0) after 1m0s
[03:47:23.352] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:49:0)
[03:47:23.352] Timer tick, asking Buildbucket for the build status
[03:47:23.424] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:23.424] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:50:0) after 1m0s
[03:48:23.594] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:50:0)
[03:48:23.594] Timer tick, asking Buildbucket for the build status
[03:48:23.704] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:23.704] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:51:0) after 1m0s
[03:49:23.772] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:51:0)
[03:49:23.772] Timer tick, asking Buildbucket for the build status
[03:49:23.881] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:23.881] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:52:0) after 1m0s
[03:50:24.045] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:52:0)
[03:50:24.045] Timer tick, asking Buildbucket for the build status
[03:50:24.228] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:24.228] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:53:0) after 1m0s
[03:51:24.413] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:53:0)
[03:51:24.413] Timer tick, asking Buildbucket for the build status
[03:51:24.717] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:24.717] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:54:0) after 1m0s
[03:52:24.873] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:54:0)
[03:52:24.873] Timer tick, asking Buildbucket for the build status
[03:52:24.951] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:24.951] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:55:0) after 1m0s
[03:53:25.853] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:55:0)
[03:53:25.853] Timer tick, asking Buildbucket for the build status
[03:53:25.931] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:25.931] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:56:0) after 1m0s
[03:54:26.297] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:56:0)
[03:54:26.297] Timer tick, asking Buildbucket for the build status
[03:54:26.433] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:26.434] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:57:0) after 1m0s
[03:55:26.450] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:57:0)
[03:55:26.450] Timer tick, asking Buildbucket for the build status
[03:55:26.723] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:26.723] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:58:0) after 1m0s
[03:56:26.816] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:58:0)
[03:56:26.816] Timer tick, asking Buildbucket for the build status
[03:56:26.979] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:26.981] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:59:0) after 1m0s
[03:57:27.016] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:59:0)
[03:57:27.016] Timer tick, asking Buildbucket for the build status
[03:57:27.120] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:27.120] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:60:0) after 1m0s
[03:58:27.198] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:60:0)
[03:58:27.198] Timer tick, asking Buildbucket for the build status
[03:58:27.316] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:27.317] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:61:0) after 1m0s
[03:59:27.353] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:61:0)
[03:59:27.353] Timer tick, asking Buildbucket for the build status
[03:59:27.469] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:27.469] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:62:0) after 1m0s
[04:00:27.530] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:62:0)
[04:00:27.530] Timer tick, asking Buildbucket for the build status
[04:00:27.681] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:27.681] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:63:0) after 1m0s
[04:01:27.824] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:63:0)
[04:01:27.824] Timer tick, asking Buildbucket for the build status
[04:01:28.725] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:28.725] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:64:0) after 1m0s
[04:02:28.837] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:64:0)
[04:02:28.837] Timer tick, asking Buildbucket for the build status
[04:02:29.200] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:29.200] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:65:0) after 1m0s
[04:03:29.256] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:65:0)
[04:03:29.256] Timer tick, asking Buildbucket for the build status
[04:03:29.381] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:29.381] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:66:0) after 1m0s
[04:04:29.551] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:66:0)
[04:04:29.551] Timer tick, asking Buildbucket for the build status
[04:04:29.704] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:29.704] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:67:0) after 1m0s
[04:05:29.835] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:67:0)
[04:05:29.835] Timer tick, asking Buildbucket for the build status
[04:05:29.937] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:29.937] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:68:0) after 1m0s
[04:06:29.957] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:68:0)
[04:06:29.957] Timer tick, asking Buildbucket for the build status
[04:06:30.096] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:30.097] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:69:0) after 1m0s
[04:07:30.242] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:69:0)
[04:07:30.242] Timer tick, asking Buildbucket for the build status
[04:07:30.322] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:30.322] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:70:0) after 1m0s
[04:08:30.544] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:70:0)
[04:08:30.544] Timer tick, asking Buildbucket for the build status
[04:08:30.624] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:30.624] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:71:0) after 1m0s
[04:09:30.728] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:71:0)
[04:09:30.728] Timer tick, asking Buildbucket for the build status
[04:09:31.089] Build 8868945375483795536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:31.089] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9034375437508570096:72:0) after 1m0s
[04:09:37.844] Received PubSub notification, asking Buildbucket for the build status
[04:09:37.994] Build 8868945375483795536: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[04:09:37.994] Buildbucket build:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"completed_ts": "1600315777287841",
"created_by": "project:dart",
"created_ts": "1600311603999364",
"failure_reason": "BUILD_FAILURE",
"id": "8868945375483795536",
"parameters_json": "{\"builder_name\": \"fuzz-linux\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"cron\": {\"generation\": \"3309\"}, \"id\": \"cron:v1:3309\"}]}}}",
"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/itBm4_nA/dart_fuzzQCSCSY) FP NO-FFI FLAT : KBC-CMP-O3-DebugSIMARM64 - KBC-CMP-ReleaseSIMARM64: done\\n\\rTests: 57 Success: 56 (Rerun: 0) Skipped: 0 Timeout: 1 Divergences: 0\\n\\nIsolate (/b/s/w/itBm4_nA/dart_fuzzQCSCSY) FP NO-FFI FLAT : KBC-CMP-O3-DebugSIMARM64 - KBC-CMP-ReleaseSIMARM64 timeout: 254819619\\n\\n\\nIsolate (/b/s/w/itBm4_nA/dart_fuzzBWPJNV) NO-FP NO-FFI FLAT : KBC-MIX-DebugSIMARM - KBC-CMP-O3-DET-ReleaseX64: done\\n\\rTests: 58 Success: 56 (Rerun: 0) Skipped: 0 Timeout: 1 Divergences: 1\\n\\nIsolate (/b/s/w/itBm4_nA/dart_fuzzBWPJNV) NO-FP NO-FFI FLAT : KBC-MIX-DebugSIMARM - KBC-CMP-O3-DET-ReleaseX64 timeout: 2556854064\\n\\n\\nIsolate (/b/s/w/itBm4_nA/dart_fuzzMDQVUE) FP NO-FFI NO-FLAT : KBC-INT-DET-DebugIA32 - JIT-O3-DET-ReleaseIA32: done\\n\\rTests: 53 Success: 52 (Rerun: 0) Skipped: 0 Timeout: 1 Divergences: 0\\n\\nIsolate (/b/s/w/itBm4_nA/dart_fuzzMDQVUE) FP NO-FFI NO-FLAT : KBC-INT-DET-DebugIA32 - JIT-O3-DET-ReleaseIA32 timeout: 4004756679\\n\\n\\nfailure (1 divergences), Swarming task failed:\\n(\\u2026)\\n\\rTests: 52 Success: 52 (Rerun: 0) Skipped: 0 Timeout: 0 Divergences: 0\\n\\nIsolate (/b/s/w/itHxEpVW/dart_fuzzKHBPRT) NO-FP NO-FFI FLAT : JIT-SLOWPATH-ReleaseSIMARM64 - JIT-DebugX64: done\\n\\rTests: 63 Success: 62 (Rerun: 0) Skipped: 0 Timeout: 1 Divergences: 0\\n\\nIsolate (/b/s/w/itHxEpVW/dart_fuzzKHBPRT) NO-FP NO-FFI FLAT : JIT-SLOWPATH-ReleaseSIMARM64 - JIT-DebugX64 timeout: 4187790572\\n\\n\\nIsolate (/b/s/w/itHxEpVW/dart_fuzzTSKRHQ) NO-FP NO-FFI FLAT : AOT-DebugX64 - KBC-CMP-DebugSIMARM: done\\n\\rTests: 44 Success: 43 (Rerun: 0) Skipped: 0 Timeout: 0 Divergences: 1\\n\\nIsolate (/b/s/w/itHxEpVW/dart_fuzzVHOJRB) NO-FP NO-FFI FLAT : KBC-INT-ReleaseX64 - KBC-MIX-SRC-SLOWPATH-ReleaseSIMARM64: done\\n\\rTests: 40 Success: 39 (Rerun: 0) Skipped: 0 Timeout: 1 Divergences: 0\\n\\nIsolate (/b/s/w/itHxEpVW/dart_fuzzVHOJRB) NO-FP NO-FFI FLAT : KBC-INT-ReleaseX64 - KBC-MIX-SRC-SLOWPATH-ReleaseSIMARM64 timeout: 377574300\\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\": \"3309\"}, \"id\": \"cron:v1:3309\"}]}, \"$recipe_engine/swarming\": {\"server\": \"https://chromium-swarm.appspot.com\"}, \"bot_id\": \"luci-dart-try-xenial-87-wfpy\", \"buildername\": \"fuzz-linux\", \"buildnumber\": 1104, \"clobber\": \"true\", \"got_revision\": \"122f07c7bb1ae8e7076de09e1deab9f7fd7ab85a\", \"path_config\": \"generic\", \"recipe\": \"dart/neo\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"browsers\", \"builder_2568cb5c143ed8cc40564df1a833ae4c1992befd94d0645f49c1ad521b08aa15_v2\", \"builder_2a98a8b518ca4a18ae82ffedef2eea93c4a884abc1d231637aa846a898cf2599_v2\", \"builder_738f1c7f1ce6d834ebb8feee87f41e2a54ba0d995ed9750a8b067ca0f62bde69_v2\", \"builder_b86275ddf762361824bfc56cad1157933a73a38c01cde840f74c93e8651eb66a_v2\", \"builder_d12c26ea02592d766fa897b3a9f1968750a07bd9a90f9cf17f0bdf313cb29dcb_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"dart-ci\"], \"gpu\": [\"none\"], \"host_class\": [\"default\"], \"id\": [\"luci-dart-try-xenial-87-wfpy\"], \"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\": [\"5522-67570db\"], \"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/itBm4_nA/dart_fuzzQCSCSY) FP NO-FFI FLAT : KBC-CMP-O3-DebugSIMARM64 - KBC-CMP-ReleaseSIMARM64: done\\n\\rTests: 57 Success: 56 (Rerun: 0) Skipped: 0 Timeout: 1 Divergences: 0\\n\\nIsolate (/b/s/w/itBm4_nA/dart_fuzzQCSCSY) FP NO-FFI FLAT : KBC-CMP-O3-DebugSIMARM64 - KBC-CMP-ReleaseSIMARM64 timeout: 254819619\\n\\n\\nIsolate (/b/s/w/itBm4_nA/dart_fuzzBWPJNV) NO-FP NO-FFI FLAT : KBC-MIX-DebugSIMARM - KBC-CMP-O3-DET-ReleaseX64: done\\n\\rTests: 58 Success: 56 (Rerun: 0) Skipped: 0 Timeout: 1 Divergences: 1\\n\\nIsolate (/b/s/w/itBm4_nA/dart_fuzzBWPJNV) NO-FP NO-FFI FLAT : KBC-MIX-DebugSIMARM - KBC-CMP-O3-DET-ReleaseX64 timeout: 2556854064\\n\\n\\nIsolate (/b/s/w/itBm4_nA/dart_fuzzMDQVUE) FP NO-FFI NO-FLAT : KBC-INT-DET-DebugIA32 - JIT-O3-DET-ReleaseIA32: done\\n\\rTests: 53 Success: 52 (Rerun: 0) Skipped: 0 Timeout: 1 Divergences: 0\\n\\nIsolate (/b/s/w/itBm4_nA/dart_fuzzMDQVUE) FP NO-FFI NO-FLAT : KBC-INT-DET-DebugIA32 - JIT-O3-DET-ReleaseIA32 timeout: 4004756679\\n\\n\\nfailure (1 divergences), Swarming task failed:\\n(\\u2026)\\n\\rTests: 52 Success: 52 (Rerun: 0) Skipped: 0 Timeout: 0 Divergences: 0\\n\\nIsolate (/b/s/w/itHxEpVW/dart_fuzzKHBPRT) NO-FP NO-FFI FLAT : JIT-SLOWPATH-ReleaseSIMARM64 - JIT-DebugX64: done\\n\\rTests: 63 Success: 62 (Rerun: 0) Skipped: 0 Timeout: 1 Divergences: 0\\n\\nIsolate (/b/s/w/itHxEpVW/dart_fuzzKHBPRT) NO-FP NO-FFI FLAT : JIT-SLOWPATH-ReleaseSIMARM64 - JIT-DebugX64 timeout: 4187790572\\n\\n\\nIsolate (/b/s/w/itHxEpVW/dart_fuzzTSKRHQ) NO-FP NO-FFI FLAT : AOT-DebugX64 - KBC-CMP-DebugSIMARM: done\\n\\rTests: 44 Success: 43 (Rerun: 0) Skipped: 0 Timeout: 0 Divergences: 1\\n\\nIsolate (/b/s/w/itHxEpVW/dart_fuzzVHOJRB) NO-FP NO-FFI FLAT : KBC-INT-ReleaseX64 - KBC-MIX-SRC-SLOWPATH-ReleaseSIMARM64: done\\n\\rTests: 40 Success: 39 (Rerun: 0) Skipped: 0 Timeout: 1 Divergences: 0\\n\\nIsolate (/b/s/w/itHxEpVW/dart_fuzzVHOJRB) NO-FP NO-FFI FLAT : KBC-INT-ReleaseX64 - KBC-MIX-SRC-SLOWPATH-ReleaseSIMARM64 timeout: 377574300\\n\\n\\nfailure (1 divergences)\"}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"started_ts": "1600311610082130",
"status": "COMPLETED",
"status_changed_ts": "1600311610396870",
"tags": [
"build_address:luci.dart.ci.sandbox/fuzz-linux/1104",
"builder:fuzz-linux",
"scheduler_invocation_id:9034375437508570096",
"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/8868945375483795536/+/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:4eb2d2cae7345710",
"user_agent:luci-scheduler"
],
"updated_ts": "1600315777415259",
"url": "https://ci.chromium.org/b/8868945375483795536",
"utcnow_ts": "1600315777982430"
}
}
[04:09:37.994] Invocation finished in 1h9m35.310759575s with status FAILED