[04:05:58.904] New invocation is queued and will start shortly
[04:06:00.110] Starting the invocation (attempt 1)
[04:06:00.153] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:06:00.153] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:06:00.153] Buildbucket request:
{
"bucket": "luci.dart.ci.sandbox",
"client_operation_id": "9065083660744780704",
"parameters_json": "{\"builder_name\":\"fuzz-linux\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"cron\":{\"generation\":\"1278\"},\"id\":\"cron:v1:1278\"}]}}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:fuzz-linux",
"scheduler_invocation_id:9065083660744780704",
"scheduler_job_id:dart/fuzz-linux",
"user_agent:luci-scheduler"
]
}
[04:06:01.552] Buildbucket response:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"created_by": "project:dart",
"created_ts": "1571025960453943",
"id": "8899653598450358320",
"parameters_json": "{\"builder_name\": \"fuzz-linux\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"cron\": {\"generation\": \"1278\"}, \"id\": \"cron:v1:1278\"}]}}}",
"project": "dart",
"result_details_json": "{\"properties\": {}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1571025961312008",
"tags": [
"build_address:luci.dart.ci.sandbox/fuzz-linux/427",
"builder:fuzz-linux",
"scheduler_invocation_id:9065083660744780704",
"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/8899653598450358320/+/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": "1571025961312177",
"url": "https://ci.chromium.org/b/8899653598450358320",
"utcnow_ts": "1571025961532897"
}
}
[04:06:01.552] Task URL: https://ci.chromium.org/b/8899653598450358320
[04:06:01.552] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:2:0) after 1m0s
[04:07:01.612] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:2:0)
[04:07:01.612] Timer tick, asking Buildbucket for the build status
[04:07:02.522] Build 8899653598450358320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:07:02.522] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:3:0) after 1m0s
[04:08:02.623] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:3:0)
[04:08:02.623] Timer tick, asking Buildbucket for the build status
[04:08:03.112] Build 8899653598450358320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:08:03.112] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:4:0) after 1m0s
[04:09:03.133] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:4:0)
[04:09:03.133] Timer tick, asking Buildbucket for the build status
[04:09:03.344] Build 8899653598450358320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:09:03.344] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:5:0) after 1m0s
[04:10:03.377] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:5:0)
[04:10:03.377] Timer tick, asking Buildbucket for the build status
[04:10:04.067] Build 8899653598450358320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:10:04.067] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:6:0) after 1m0s
[04:11:03.663] Received PubSub notification, asking Buildbucket for the build status
[04:11:04.257] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:04.620] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:6:0)
[04:11:04.620] Timer tick, asking Buildbucket for the build status
[04:11:05.019] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:05.019] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:8:0) after 1m0s
[04:12:05.131] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:8:0)
[04:12:05.131] Timer tick, asking Buildbucket for the build status
[04:12:05.721] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:05.721] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:9:0) after 1m0s
[04:13:06.017] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:9:0)
[04:13:06.017] Timer tick, asking Buildbucket for the build status
[04:13:06.261] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:06.261] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:10:0) after 1m0s
[04:14:06.447] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:10:0)
[04:14:06.447] Timer tick, asking Buildbucket for the build status
[04:14:07.323] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:07.323] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:11:0) after 1m0s
[04:15:07.411] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:11:0)
[04:15:07.411] Timer tick, asking Buildbucket for the build status
[04:15:07.673] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:07.673] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:12:0) after 1m0s
[04:16:07.744] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:12:0)
[04:16:07.744] Timer tick, asking Buildbucket for the build status
[04:16:08.158] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:08.158] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:13:0) after 1m0s
[04:17:08.217] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:13:0)
[04:17:08.217] Timer tick, asking Buildbucket for the build status
[04:17:08.565] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:08.565] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:14:0) after 1m0s
[04:18:08.603] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:14:0)
[04:18:08.603] Timer tick, asking Buildbucket for the build status
[04:18:09.316] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:09.316] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:15:0) after 1m0s
[04:19:09.337] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:15:0)
[04:19:09.337] Timer tick, asking Buildbucket for the build status
[04:19:09.833] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:09.833] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:16:0) after 1m0s
[04:20:09.924] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:16:0)
[04:20:09.924] Timer tick, asking Buildbucket for the build status
[04:20:10.161] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:10.161] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:17:0) after 1m0s
[04:21:10.229] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:17:0)
[04:21:10.229] Timer tick, asking Buildbucket for the build status
[04:21:10.400] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:10.400] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:18:0) after 1m0s
[04:22:10.462] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:18:0)
[04:22:10.462] Timer tick, asking Buildbucket for the build status
[04:22:11.469] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:11.469] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:19:0) after 1m0s
[04:23:11.497] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:19:0)
[04:23:11.497] Timer tick, asking Buildbucket for the build status
[04:23:11.767] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:11.767] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:20:0) after 1m0s
[04:24:11.887] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:20:0)
[04:24:11.887] Timer tick, asking Buildbucket for the build status
[04:24:12.221] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:12.221] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:21:0) after 1m0s
[04:25:12.225] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:21:0)
[04:25:12.225] Timer tick, asking Buildbucket for the build status
[04:25:12.410] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:12.410] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:22:0) after 1m0s
[04:26:12.411] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:22:0)
[04:26:12.411] Timer tick, asking Buildbucket for the build status
[04:26:14.087] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:14.087] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:23:0) after 1m0s
[04:27:14.131] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:23:0)
[04:27:14.131] Timer tick, asking Buildbucket for the build status
[04:27:14.387] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:14.387] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:24:0) after 1m0s
[04:28:14.626] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:24:0)
[04:28:14.626] Timer tick, asking Buildbucket for the build status
[04:28:14.962] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:14.962] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:25:0) after 1m0s
[04:29:15.119] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:25:0)
[04:29:15.119] Timer tick, asking Buildbucket for the build status
[04:29:15.558] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:15.558] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:26:0) after 1m0s
[04:30:15.673] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:26:0)
[04:30:15.673] Timer tick, asking Buildbucket for the build status
[04:30:18.049] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:18.049] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:27:0) after 1m0s
[04:31:18.137] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:27:0)
[04:31:18.137] Timer tick, asking Buildbucket for the build status
[04:31:18.750] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:18.750] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:28:0) after 1m0s
[04:32:18.782] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:28:0)
[04:32:18.782] Timer tick, asking Buildbucket for the build status
[04:32:19.038] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:19.038] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:29:0) after 1m0s
[04:33:19.059] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:29:0)
[04:33:19.059] Timer tick, asking Buildbucket for the build status
[04:33:19.477] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:19.477] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:30:0) after 1m0s
[04:34:19.582] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:30:0)
[04:34:19.582] Timer tick, asking Buildbucket for the build status
[04:34:19.877] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:19.878] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:31:0) after 1m0s
[04:35:20.387] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:31:0)
[04:35:20.387] Timer tick, asking Buildbucket for the build status
[04:35:22.385] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:22.385] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:32:0) after 1m0s
[04:36:22.431] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:32:0)
[04:36:22.431] Timer tick, asking Buildbucket for the build status
[04:36:22.640] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:22.640] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:33:0) after 1m0s
[04:37:22.711] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:33:0)
[04:37:22.711] Timer tick, asking Buildbucket for the build status
[04:37:22.873] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:22.873] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:34:0) after 1m0s
[04:38:22.987] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:34:0)
[04:38:22.987] Timer tick, asking Buildbucket for the build status
[04:38:23.370] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:23.370] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:35:0) after 1m0s
[04:39:23.444] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:35:0)
[04:39:23.444] Timer tick, asking Buildbucket for the build status
[04:39:24.072] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:24.072] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:36:0) after 1m0s
[04:40:24.105] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:36:0)
[04:40:24.105] Timer tick, asking Buildbucket for the build status
[04:40:24.529] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:24.529] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:37:0) after 1m0s
[04:41:24.617] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:37:0)
[04:41:24.617] Timer tick, asking Buildbucket for the build status
[04:41:24.800] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:24.800] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:38:0) after 1m0s
[04:42:24.891] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:38:0)
[04:42:24.891] Timer tick, asking Buildbucket for the build status
[04:42:26.761] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:26.761] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:39:0) after 1m0s
[04:43:26.808] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:39:0)
[04:43:26.808] Timer tick, asking Buildbucket for the build status
[04:43:28.956] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:28.956] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:40:0) after 1m0s
[04:44:28.986] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:40:0)
[04:44:28.986] Timer tick, asking Buildbucket for the build status
[04:44:29.195] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:29.195] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:41:0) after 1m0s
[04:45:29.197] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:41:0)
[04:45:29.197] Timer tick, asking Buildbucket for the build status
[04:45:31.618] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:31.618] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:42:0) after 1m0s
[04:46:31.641] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:42:0)
[04:46:31.641] Timer tick, asking Buildbucket for the build status
[04:46:32.101] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:32.101] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:43:0) after 1m0s
[04:47:32.207] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:43:0)
[04:47:32.207] Timer tick, asking Buildbucket for the build status
[04:47:32.997] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:32.997] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:44:0) after 1m0s
[04:48:33.054] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:44:0)
[04:48:33.054] Timer tick, asking Buildbucket for the build status
[04:48:33.284] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:33.284] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:45:0) after 1m0s
[04:49:33.430] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:45:0)
[04:49:33.430] Timer tick, asking Buildbucket for the build status
[04:49:33.602] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:33.602] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:46:0) after 1m0s
[04:50:33.610] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:46:0)
[04:50:33.610] Timer tick, asking Buildbucket for the build status
[04:50:33.746] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:33.746] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:47:0) after 1m0s
[04:51:33.851] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:47:0)
[04:51:33.851] Timer tick, asking Buildbucket for the build status
[04:51:34.077] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:34.077] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:48:0) after 1m0s
[04:52:34.170] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:48:0)
[04:52:34.170] Timer tick, asking Buildbucket for the build status
[04:52:34.323] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:34.323] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:49:0) after 1m0s
[04:53:34.537] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:49:0)
[04:53:34.537] Timer tick, asking Buildbucket for the build status
[04:53:34.672] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:34.672] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:50:0) after 1m0s
[04:54:34.836] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:50:0)
[04:54:34.836] Timer tick, asking Buildbucket for the build status
[04:54:34.971] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:34.971] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:51:0) after 1m0s
[04:55:35.042] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:51:0)
[04:55:35.042] Timer tick, asking Buildbucket for the build status
[04:55:35.745] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:35.745] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:52:0) after 1m0s
[04:56:35.794] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:52:0)
[04:56:35.794] Timer tick, asking Buildbucket for the build status
[04:56:36.323] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:36.323] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:53:0) after 1m0s
[04:57:36.422] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:53:0)
[04:57:36.422] Timer tick, asking Buildbucket for the build status
[04:57:36.650] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:36.650] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:54:0) after 1m0s
[04:58:36.806] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:54:0)
[04:58:36.806] Timer tick, asking Buildbucket for the build status
[04:58:37.219] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:37.219] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:55:0) after 1m0s
[04:59:37.309] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:55:0)
[04:59:37.309] Timer tick, asking Buildbucket for the build status
[04:59:37.483] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:37.483] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:56:0) after 1m0s
[05:00:37.536] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:56:0)
[05:00:37.536] Timer tick, asking Buildbucket for the build status
[05:00:37.817] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:37.817] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:57:0) after 1m0s
[05:01:37.899] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:57:0)
[05:01:37.899] Timer tick, asking Buildbucket for the build status
[05:01:38.070] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:38.070] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:58:0) after 1m0s
[05:02:38.206] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:58:0)
[05:02:38.206] Timer tick, asking Buildbucket for the build status
[05:02:38.403] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:38.403] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:59:0) after 1m0s
[05:03:38.535] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:59:0)
[05:03:38.535] Timer tick, asking Buildbucket for the build status
[05:03:38.785] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:38.785] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:60:0) after 1m0s
[05:04:38.913] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:60:0)
[05:04:38.913] Timer tick, asking Buildbucket for the build status
[05:04:39.227] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:39.227] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:61:0) after 1m0s
[05:05:39.236] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:61:0)
[05:05:39.236] Timer tick, asking Buildbucket for the build status
[05:05:39.832] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:39.832] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:62:0) after 1m0s
[05:06:39.858] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:62:0)
[05:06:39.858] Timer tick, asking Buildbucket for the build status
[05:06:40.214] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:40.214] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:63:0) after 1m0s
[05:07:40.290] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:63:0)
[05:07:40.290] Timer tick, asking Buildbucket for the build status
[05:07:40.860] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:40.860] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:64:0) after 1m0s
[05:08:40.948] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:64:0)
[05:08:40.948] Timer tick, asking Buildbucket for the build status
[05:08:41.638] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:41.638] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:65:0) after 1m0s
[05:09:41.911] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:65:0)
[05:09:41.911] Timer tick, asking Buildbucket for the build status
[05:09:42.097] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:42.097] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:66:0) after 1m0s
[05:10:42.400] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:66:0)
[05:10:42.400] Timer tick, asking Buildbucket for the build status
[05:10:42.586] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:42.586] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:67:0) after 1m0s
[05:11:42.927] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:67:0)
[05:11:42.927] Timer tick, asking Buildbucket for the build status
[05:11:43.201] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:43.201] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:68:0) after 1m0s
[05:12:43.288] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:68:0)
[05:12:43.288] Timer tick, asking Buildbucket for the build status
[05:12:44.865] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:44.865] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:69:0) after 1m0s
[05:13:44.903] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:69:0)
[05:13:44.903] Timer tick, asking Buildbucket for the build status
[05:13:45.460] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:45.460] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:70:0) after 1m0s
[05:14:45.626] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:70:0)
[05:14:45.626] Timer tick, asking Buildbucket for the build status
[05:14:46.244] Build 8899653598450358320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:46.245] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9065083660744780704:71:0) after 1m0s
[05:15:27.271] Received PubSub notification, asking Buildbucket for the build status
[05:15:27.637] Build 8899653598450358320: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[05:15:27.637] Buildbucket build:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"completed_ts": "1571030126094332",
"created_by": "project:dart",
"created_ts": "1571025960453943",
"failure_reason": "BUILD_FAILURE",
"id": "8899653598450358320",
"parameters_json": "{\"builder_name\": \"fuzz-linux\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"cron\": {\"generation\": \"1278\"}, \"id\": \"cron:v1:1278\"}]}}}",
"project": "dart",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 out of 2 aggregated steps failed: 1 out of 5 aggregated steps failed: 1 out of 99 aggregated steps failed: Step(\\\"['shard #0 (failed) (47m 36s)']\\\") (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\": \"1278\"}, \"id\": \"cron:v1:1278\"}]}, \"bot_id\": \"luci-dart-try-xenial-63-cby8\", \"buildername\": \"fuzz-linux\", \"buildnumber\": 427, \"clobber\": \"true\", \"got_revision\": \"545a06b19e6957c9edb227d83b31c6622881fda1\", \"path_config\": \"generic\", \"recipe\": \"dart/neo\"}, \"swarming\": {\"bot_dimensions\": {\"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-63-cby8\"], \"image\": [\"chrome-xenial-19100400-6cc5b08ab04\"], \"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\": [\"4501-487d554\"], \"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: 1 out of 99 aggregated steps failed: Step(\\\"['shard #0 (failed) (47m 36s)']\\\") (retcode: 0)\"}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"started_ts": "1571026262240694",
"status": "COMPLETED",
"status_changed_ts": "1571026263222742",
"tags": [
"build_address:luci.dart.ci.sandbox/fuzz-linux/427",
"builder:fuzz-linux",
"scheduler_invocation_id:9065083660744780704",
"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/8899653598450358320/+/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:47e14356eb472610",
"user_agent:luci-scheduler"
],
"updated_ts": "1571030126546302",
"url": "https://ci.chromium.org/b/8899653598450358320",
"utcnow_ts": "1571030127625366"
}
}
[05:15:27.637] Invocation finished in 1h9m28.756345942s with status FAILED