[03:00:05.348] New invocation is queued and will start shortly
[03:00:06.827] Starting the invocation (attempt 1)
[03:00:06.873] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:00:06.874] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:00:06.874] Buildbucket request:
{
"bucket": "luci.dart.ci.sandbox",
"client_operation_id": "9058836615666976896",
"parameters_json": "{\"builder_name\":\"fuzz-linux\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"cron\":{\"generation\":\"1689\"},\"id\":\"cron:v1:1689\"}]}}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:fuzz-linux",
"scheduler_invocation_id:9058836615666976896",
"scheduler_job_id:dart/fuzz-linux",
"user_agent:luci-scheduler"
]
}
[03:00:07.665] Buildbucket response:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"created_by": "project:dart",
"created_ts": "1576983607031893",
"id": "8893406553231666992",
"parameters_json": "{\"builder_name\": \"fuzz-linux\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"cron\": {\"generation\": \"1689\"}, \"id\": \"cron:v1:1689\"}]}}}",
"project": "dart",
"result_details_json": "{\"properties\": {}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1576983607513157",
"tags": [
"build_address:luci.dart.ci.sandbox/fuzz-linux/564",
"builder:fuzz-linux",
"scheduler_invocation_id:9058836615666976896",
"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/8893406553231666992/+/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": "1576983607513260",
"url": "https://ci.chromium.org/b/8893406553231666992",
"utcnow_ts": "1576983607656650"
}
}
[03:00:07.665] Task URL: https://ci.chromium.org/b/8893406553231666992
[03:00:07.665] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:2:0) after 1m0s
[03:00:12.024] Received PubSub notification, asking Buildbucket for the build status
[03:00:12.148] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:12.072] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:2:0)
[03:01:12.072] Timer tick, asking Buildbucket for the build status
[03:01:12.223] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:12.223] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:4:0) after 1m0s
[03:02:12.472] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:4:0)
[03:02:12.472] Timer tick, asking Buildbucket for the build status
[03:02:12.605] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:12.605] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:5:0) after 1m0s
[03:03:19.812] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:5:0)
[03:03:19.812] Timer tick, asking Buildbucket for the build status
[03:03:20.021] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:20.021] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:6:0) after 1m0s
[03:04:20.178] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:6:0)
[03:04:20.178] Timer tick, asking Buildbucket for the build status
[03:04:20.371] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:20.371] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:7:0) after 1m0s
[03:05:20.434] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:7:0)
[03:05:20.434] Timer tick, asking Buildbucket for the build status
[03:05:20.643] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:20.643] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:8:0) after 1m0s
[03:06:20.759] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:8:0)
[03:06:20.759] Timer tick, asking Buildbucket for the build status
[03:06:20.926] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:20.926] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:9:0) after 1m0s
[03:07:20.947] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:9:0)
[03:07:20.947] Timer tick, asking Buildbucket for the build status
[03:07:21.111] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:21.111] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:10:0) after 1m0s
[03:08:21.209] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:10:0)
[03:08:21.209] Timer tick, asking Buildbucket for the build status
[03:08:22.084] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:22.084] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:11:0) after 1m0s
[03:09:22.342] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:11:0)
[03:09:22.342] Timer tick, asking Buildbucket for the build status
[03:09:22.739] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:22.739] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:12:0) after 1m0s
[03:10:22.758] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:12:0)
[03:10:22.758] Timer tick, asking Buildbucket for the build status
[03:10:22.901] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:22.901] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:13:0) after 1m0s
[03:11:22.922] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:13:0)
[03:11:22.922] Timer tick, asking Buildbucket for the build status
[03:11:23.131] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:23.131] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:14:0) after 1m0s
[03:12:23.151] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:14:0)
[03:12:23.151] Timer tick, asking Buildbucket for the build status
[03:12:23.291] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:23.291] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:15:0) after 1m0s
[03:13:23.414] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:15:0)
[03:13:23.414] Timer tick, asking Buildbucket for the build status
[03:13:23.873] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:23.873] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:16:0) after 1m0s
[03:14:23.894] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:16:0)
[03:14:23.894] Timer tick, asking Buildbucket for the build status
[03:14:24.307] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:24.307] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:17:0) after 1m0s
[03:15:24.435] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:17:0)
[03:15:24.435] Timer tick, asking Buildbucket for the build status
[03:15:24.597] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:24.597] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:18:0) after 1m0s
[03:16:24.626] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:18:0)
[03:16:24.626] Timer tick, asking Buildbucket for the build status
[03:16:24.830] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:24.830] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:19:0) after 1m0s
[03:17:24.984] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:19:0)
[03:17:24.984] Timer tick, asking Buildbucket for the build status
[03:17:25.120] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:25.120] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:20:0) after 1m0s
[03:18:25.138] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:20:0)
[03:18:25.138] Timer tick, asking Buildbucket for the build status
[03:18:25.284] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:25.284] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:21:0) after 1m0s
[03:19:25.266] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:21:0)
[03:19:25.266] Timer tick, asking Buildbucket for the build status
[03:19:25.463] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:25.463] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:22:0) after 1m0s
[03:20:25.483] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:22:0)
[03:20:25.483] Timer tick, asking Buildbucket for the build status
[03:20:25.677] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:25.677] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:23:0) after 1m0s
[03:21:25.704] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:23:0)
[03:21:25.704] Timer tick, asking Buildbucket for the build status
[03:21:25.871] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:25.871] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:24:0) after 1m0s
[03:22:25.891] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:24:0)
[03:22:25.892] Timer tick, asking Buildbucket for the build status
[03:22:26.051] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:26.051] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:25:0) after 1m0s
[03:23:26.088] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:25:0)
[03:23:26.088] Timer tick, asking Buildbucket for the build status
[03:23:26.471] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:26.471] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:26:0) after 1m0s
[03:24:26.491] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:26:0)
[03:24:26.491] Timer tick, asking Buildbucket for the build status
[03:24:26.624] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:26.624] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:27:0) after 1m0s
[03:25:26.643] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:27:0)
[03:25:26.643] Timer tick, asking Buildbucket for the build status
[03:25:26.797] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:26.797] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:28:0) after 1m0s
[03:26:26.825] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:28:0)
[03:26:26.825] Timer tick, asking Buildbucket for the build status
[03:26:27.121] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:27.121] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:29:0) after 1m0s
[03:27:27.146] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:29:0)
[03:27:27.146] Timer tick, asking Buildbucket for the build status
[03:27:28.184] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:28.184] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:30:0) after 1m0s
[03:28:28.212] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:30:0)
[03:28:28.212] Timer tick, asking Buildbucket for the build status
[03:28:28.414] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:28.414] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:31:0) after 1m0s
[03:29:28.450] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:31:0)
[03:29:28.450] Timer tick, asking Buildbucket for the build status
[03:29:28.609] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:28.609] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:32:0) after 1m0s
[03:30:28.631] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:32:0)
[03:30:28.631] Timer tick, asking Buildbucket for the build status
[03:30:28.800] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:28.800] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:33:0) after 1m0s
[03:31:28.827] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:33:0)
[03:31:28.827] Timer tick, asking Buildbucket for the build status
[03:31:29.460] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:29.460] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:34:0) after 1m0s
[03:32:29.485] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:34:0)
[03:32:29.485] Timer tick, asking Buildbucket for the build status
[03:32:30.193] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:30.193] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:35:0) after 1m0s
[03:33:30.214] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:35:0)
[03:33:30.214] Timer tick, asking Buildbucket for the build status
[03:33:30.349] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:30.349] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:36:0) after 1m0s
[03:34:30.383] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:36:0)
[03:34:30.383] Timer tick, asking Buildbucket for the build status
[03:34:30.943] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:30.943] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:37:0) after 1m0s
[03:35:30.983] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:37:0)
[03:35:30.983] Timer tick, asking Buildbucket for the build status
[03:35:31.118] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:31.118] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:38:0) after 1m0s
[03:36:31.139] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:38:0)
[03:36:31.139] Timer tick, asking Buildbucket for the build status
[03:36:31.804] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:31.804] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:39:0) after 1m0s
[03:37:31.829] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:39:0)
[03:37:31.829] Timer tick, asking Buildbucket for the build status
[03:37:31.987] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:31.987] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:40:0) after 1m0s
[03:38:32.009] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:40:0)
[03:38:32.009] Timer tick, asking Buildbucket for the build status
[03:38:32.287] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:32.287] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:41:0) after 1m0s
[03:39:32.326] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:41:0)
[03:39:32.326] Timer tick, asking Buildbucket for the build status
[03:39:32.826] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:32.826] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:42:0) after 1m0s
[03:40:32.887] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:42:0)
[03:40:32.887] Timer tick, asking Buildbucket for the build status
[03:40:33.287] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:33.287] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:43:0) after 1m0s
[03:41:33.313] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:43:0)
[03:41:33.313] Timer tick, asking Buildbucket for the build status
[03:41:33.805] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:33.805] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:44:0) after 1m0s
[03:42:33.850] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:44:0)
[03:42:33.850] Timer tick, asking Buildbucket for the build status
[03:42:33.995] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:33.995] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:45:0) after 1m0s
[03:43:34.029] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:45:0)
[03:43:34.029] Timer tick, asking Buildbucket for the build status
[03:43:34.420] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:34.420] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:46:0) after 1m0s
[03:44:34.491] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:46:0)
[03:44:34.491] Timer tick, asking Buildbucket for the build status
[03:44:34.643] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:34.643] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:47:0) after 1m0s
[03:45:34.663] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:47:0)
[03:45:34.663] Timer tick, asking Buildbucket for the build status
[03:45:35.011] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:35.011] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:48:0) after 1m0s
[03:46:35.038] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:48:0)
[03:46:35.038] Timer tick, asking Buildbucket for the build status
[03:46:35.951] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:35.951] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:49:0) after 1m0s
[03:47:35.972] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:49:0)
[03:47:35.972] Timer tick, asking Buildbucket for the build status
[03:47:36.422] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:36.422] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:50:0) after 1m0s
[03:48:36.449] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:50:0)
[03:48:36.449] Timer tick, asking Buildbucket for the build status
[03:48:36.598] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:36.598] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:51:0) after 1m0s
[03:49:36.638] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:51:0)
[03:49:36.638] Timer tick, asking Buildbucket for the build status
[03:49:36.766] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:36.766] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:52:0) after 1m0s
[03:50:36.818] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:52:0)
[03:50:36.818] Timer tick, asking Buildbucket for the build status
[03:50:37.259] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:37.259] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:53:0) after 1m0s
[03:51:37.270] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:53:0)
[03:51:37.270] Timer tick, asking Buildbucket for the build status
[03:51:37.959] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:37.959] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:54:0) after 1m0s
[03:52:38.317] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:54:0)
[03:52:38.317] Timer tick, asking Buildbucket for the build status
[03:52:38.439] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:38.439] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:55:0) after 1m0s
[03:53:38.774] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:55:0)
[03:53:38.774] Timer tick, asking Buildbucket for the build status
[03:53:39.229] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:39.229] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:56:0) after 1m0s
[03:54:40.106] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:56:0)
[03:54:40.106] Timer tick, asking Buildbucket for the build status
[03:54:40.420] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:40.420] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:57:0) after 1m0s
[03:55:40.895] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:57:0)
[03:55:40.895] Timer tick, asking Buildbucket for the build status
[03:55:41.044] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:41.044] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:58:0) after 1m0s
[03:56:41.526] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:58:0)
[03:56:41.526] Timer tick, asking Buildbucket for the build status
[03:56:42.331] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:42.331] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:59:0) after 1m0s
[03:57:42.527] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:59:0)
[03:57:42.527] Timer tick, asking Buildbucket for the build status
[03:57:42.715] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:42.715] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:60:0) after 1m0s
[03:58:43.759] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:60:0)
[03:58:43.759] Timer tick, asking Buildbucket for the build status
[03:58:44.372] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:44.372] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:61:0) after 1m0s
[03:59:48.038] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:61:0)
[03:59:48.038] Timer tick, asking Buildbucket for the build status
[03:59:48.174] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:48.174] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:62:0) after 1m0s
[04:00:51.495] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:62:0)
[04:00:51.495] Timer tick, asking Buildbucket for the build status
[04:00:51.669] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:51.669] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:63:0) after 1m0s
[04:01:52.053] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:63:0)
[04:01:52.053] Timer tick, asking Buildbucket for the build status
[04:01:52.301] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:52.301] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:64:0) after 1m0s
[04:02:52.489] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:64:0)
[04:02:52.489] Timer tick, asking Buildbucket for the build status
[04:02:52.664] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:52.664] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:65:0) after 1m0s
[04:03:52.711] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:65:0)
[04:03:52.711] Timer tick, asking Buildbucket for the build status
[04:03:52.872] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:52.872] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:66:0) after 1m0s
[04:04:52.916] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:66:0)
[04:04:52.916] Timer tick, asking Buildbucket for the build status
[04:04:53.779] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:53.779] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:67:0) after 1m0s
[04:05:53.989] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:67:0)
[04:05:53.989] Timer tick, asking Buildbucket for the build status
[04:05:54.370] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:54.370] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:68:0) after 1m0s
[04:06:54.411] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:68:0)
[04:06:54.411] Timer tick, asking Buildbucket for the build status
[04:06:55.683] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:55.683] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:69:0) after 1m0s
[04:07:55.850] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:69:0)
[04:07:55.850] Timer tick, asking Buildbucket for the build status
[04:07:55.998] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:55.998] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:70:0) after 1m0s
[04:08:56.021] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:70:0)
[04:08:56.021] Timer tick, asking Buildbucket for the build status
[04:08:56.154] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:56.154] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:71:0) after 1m0s
[04:09:56.397] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:71:0)
[04:09:56.397] Timer tick, asking Buildbucket for the build status
[04:09:56.563] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:56.563] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:72:0) after 1m0s
[04:10:56.589] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:72:0)
[04:10:56.589] Timer tick, asking Buildbucket for the build status
[04:10:56.780] Build 8893406553231666992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:56.780] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9058836615666976896:73:0) after 1m0s
[04:11:07.005] Received PubSub notification, asking Buildbucket for the build status
[04:11:07.097] Build 8893406553231666992: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[04:11:07.097] Buildbucket build:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"completed_ts": "1576987866055886",
"created_by": "project:dart",
"created_ts": "1576983607031893",
"failure_reason": "BUILD_FAILURE",
"id": "8893406553231666992",
"parameters_json": "{\"builder_name\": \"fuzz-linux\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"cron\": {\"generation\": \"1689\"}, \"id\": \"cron:v1:1689\"}]}}}",
"project": "dart",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 out of 2 aggregated steps failed: 1 out of 5 aggregated steps failed: 21 out of 99 aggregated steps failed: Step(\\\"['shard #0 (failed) (46m 49s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 32s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (47m 58s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 15s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 22s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 36s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 33s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (48m 8s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 37s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 23s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 20s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 25s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 37s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (47m 39s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (47m 43s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 33s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 28s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 28s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 35s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 26s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 23s)']\\\") (retcode: 0)\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"cron\": {\"generation\": \"1689\"}, \"id\": \"cron:v1:1689\"}]}, \"bot_id\": \"luci-dart-try-xenial-27-v4oh\", \"buildername\": \"fuzz-linux\", \"buildnumber\": 564, \"clobber\": \"true\", \"got_revision\": \"4a639e8df2616623cf683d40e15181debcf5a140\", \"path_config\": \"generic\", \"recipe\": \"dart/neo\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"swarming_module_cache_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-27-v4oh\"], \"image\": [\"chrome-xenial-19121500-b03549ec744\"], \"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\": [\"4733-6bd8c41\"], \"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: 21 out of 99 aggregated steps failed: Step(\\\"['shard #0 (failed) (46m 49s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 32s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (47m 58s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 15s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 22s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 36s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 33s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (48m 8s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 37s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 23s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 20s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 25s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 37s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (47m 39s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (47m 43s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 33s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 28s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 28s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 35s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 26s)']\\\") (retcode: 0), Step(\\\"['shard #0 (failed) (46m 23s)']\\\") (retcode: 0)\"}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"started_ts": "1576983608869425",
"status": "COMPLETED",
"status_changed_ts": "1576983609350678",
"tags": [
"build_address:luci.dart.ci.sandbox/fuzz-linux/564",
"builder:fuzz-linux",
"scheduler_invocation_id:9058836615666976896",
"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/8893406553231666992/+/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:49445dc234d90d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1576987866473572",
"url": "https://ci.chromium.org/b/8893406553231666992",
"utcnow_ts": "1576987867086827"
}
}
[04:11:07.097] Invocation finished in 1h11m1.771918509s with status FAILED