[03:00:02.715] New invocation is queued and will start shortly
[03:00:04.135] Starting the invocation (attempt 1)
[03:00:04.194] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:00:04.194] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:00:04.194] Buildbucket request:
{
"bucket": "luci.dart.ci.sandbox",
"client_operation_id": "9021782459167829856",
"parameters_json": "{\"builder_name\":\"fuzz-linux\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"cron\":{\"generation\":\"4143\"},\"id\":\"cron:v1:4143\"}]}}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:fuzz-linux",
"scheduler_invocation_id:9021782459167829856",
"scheduler_job_id:dart/fuzz-linux",
"user_agent:luci-scheduler"
]
}
[03:00:06.975] Buildbucket response:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"created_by": "project:dart",
"created_ts": "1612321204448595",
"id": "8856352396682526416",
"parameters_json": "{\"builder_name\": \"fuzz-linux\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"cron\": {\"generation\": \"4143\"}, \"id\": \"cron:v1:4143\"}]}}}",
"project": "dart",
"result_details_json": "{\"properties\": {}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612321206626402",
"tags": [
"build_address:luci.dart.ci.sandbox/fuzz-linux/1382",
"builder:fuzz-linux",
"scheduler_invocation_id:9021782459167829856",
"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/8856352396682526416/+/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": "1612321206626525",
"url": "https://ci.chromium.org/b/8856352396682526416",
"utcnow_ts": "1612321206963527"
}
}
[03:00:06.975] Task URL: https://ci.chromium.org/b/8856352396682526416
[03:00:06.975] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:2:0) after 1m0s
[03:01:07.038] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:2:0)
[03:01:07.038] Timer tick, asking Buildbucket for the build status
[03:01:07.153] Build 8856352396682526416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:01:07.153] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:3:0) after 1m0s
[03:02:07.258] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:3:0)
[03:02:07.258] Timer tick, asking Buildbucket for the build status
[03:02:07.419] Build 8856352396682526416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:02:07.419] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:4:0) after 1m0s
[03:03:07.407] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:4:0)
[03:03:07.407] Timer tick, asking Buildbucket for the build status
[03:03:07.484] Build 8856352396682526416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:03:07.484] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:5:0) after 1m0s
[03:04:07.506] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:5:0)
[03:04:07.506] Timer tick, asking Buildbucket for the build status
[03:04:07.580] Build 8856352396682526416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:04:07.580] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:6:0) after 1m0s
[03:05:04.024] Received PubSub notification, asking Buildbucket for the build status
[03:05:04.087] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:07.680] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:6:0)
[03:05:07.680] Timer tick, asking Buildbucket for the build status
[03:05:07.760] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:07.760] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:8:0) after 1m0s
[03:06:07.923] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:8:0)
[03:06:07.923] Timer tick, asking Buildbucket for the build status
[03:06:08.095] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:08.095] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:9:0) after 1m0s
[03:07:08.151] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:9:0)
[03:07:08.151] Timer tick, asking Buildbucket for the build status
[03:07:08.560] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:08.560] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:10:0) after 1m0s
[03:08:08.607] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:10:0)
[03:08:08.607] Timer tick, asking Buildbucket for the build status
[03:08:08.682] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:08.682] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:11:0) after 1m0s
[03:09:08.718] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:11:0)
[03:09:08.718] Timer tick, asking Buildbucket for the build status
[03:09:08.882] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:08.882] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:12:0) after 1m0s
[03:10:08.931] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:12:0)
[03:10:08.931] Timer tick, asking Buildbucket for the build status
[03:10:09.715] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:09.715] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:13:0) after 1m0s
[03:11:09.807] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:13:0)
[03:11:09.807] Timer tick, asking Buildbucket for the build status
[03:11:10.168] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:10.168] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:14:0) after 1m0s
[03:12:10.162] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:14:0)
[03:12:10.162] Timer tick, asking Buildbucket for the build status
[03:12:10.335] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:10.335] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:15:0) after 1m0s
[03:13:10.370] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:15:0)
[03:13:10.370] Timer tick, asking Buildbucket for the build status
[03:13:10.436] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:10.436] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:16:0) after 1m0s
[03:14:10.476] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:16:0)
[03:14:10.476] Timer tick, asking Buildbucket for the build status
[03:14:10.551] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:10.551] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:17:0) after 1m0s
[03:15:10.597] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:17:0)
[03:15:10.597] Timer tick, asking Buildbucket for the build status
[03:15:10.661] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:10.661] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:18:0) after 1m0s
[03:16:10.676] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:18:0)
[03:16:10.676] Timer tick, asking Buildbucket for the build status
[03:16:10.781] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:10.781] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:19:0) after 1m0s
[03:17:10.860] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:19:0)
[03:17:10.860] Timer tick, asking Buildbucket for the build status
[03:17:10.962] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:10.962] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:20:0) after 1m0s
[03:18:11.095] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:20:0)
[03:18:11.095] Timer tick, asking Buildbucket for the build status
[03:18:11.452] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:11.452] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:21:0) after 1m0s
[03:19:11.436] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:21:0)
[03:19:11.436] Timer tick, asking Buildbucket for the build status
[03:19:11.767] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:11.767] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:22:0) after 1m0s
[03:20:11.793] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:22:0)
[03:20:11.793] Timer tick, asking Buildbucket for the build status
[03:20:11.907] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:11.907] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:23:0) after 1m0s
[03:21:11.949] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:23:0)
[03:21:11.949] Timer tick, asking Buildbucket for the build status
[03:21:12.090] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:12.090] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:24:0) after 1m0s
[03:22:12.134] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:24:0)
[03:22:12.134] Timer tick, asking Buildbucket for the build status
[03:22:12.234] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:12.234] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:25:0) after 1m0s
[03:23:12.325] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:25:0)
[03:23:12.325] Timer tick, asking Buildbucket for the build status
[03:23:12.523] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:12.523] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:26:0) after 1m0s
[03:24:12.555] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:26:0)
[03:24:12.555] Timer tick, asking Buildbucket for the build status
[03:24:12.828] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:12.828] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:27:0) after 1m0s
[03:25:12.842] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:27:0)
[03:25:12.842] Timer tick, asking Buildbucket for the build status
[03:25:12.944] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:12.944] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:28:0) after 1m0s
[03:26:12.916] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:28:0)
[03:26:12.916] Timer tick, asking Buildbucket for the build status
[03:26:12.988] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:12.988] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:29:0) after 1m0s
[03:27:13.006] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:29:0)
[03:27:13.006] Timer tick, asking Buildbucket for the build status
[03:27:13.095] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:13.095] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:30:0) after 1m0s
[03:28:13.199] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:30:0)
[03:28:13.199] Timer tick, asking Buildbucket for the build status
[03:28:13.408] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:13.408] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:31:0) after 1m0s
[03:29:13.479] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:31:0)
[03:29:13.479] Timer tick, asking Buildbucket for the build status
[03:29:13.561] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:13.561] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:32:0) after 1m0s
[03:30:13.614] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:32:0)
[03:30:13.614] Timer tick, asking Buildbucket for the build status
[03:30:13.821] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:13.821] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:33:0) after 1m0s
[03:31:13.849] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:33:0)
[03:31:13.849] Timer tick, asking Buildbucket for the build status
[03:31:13.959] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:13.959] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:34:0) after 1m0s
[03:32:14.035] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:34:0)
[03:32:14.035] Timer tick, asking Buildbucket for the build status
[03:32:14.105] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:14.105] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:35:0) after 1m0s
[03:33:14.174] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:35:0)
[03:33:14.174] Timer tick, asking Buildbucket for the build status
[03:33:14.237] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:14.237] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:36:0) after 1m0s
[03:34:14.376] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:36:0)
[03:34:14.376] Timer tick, asking Buildbucket for the build status
[03:34:14.536] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:14.536] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:37:0) after 1m0s
[03:35:14.619] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:37:0)
[03:35:14.619] Timer tick, asking Buildbucket for the build status
[03:35:14.808] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:14.808] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:38:0) after 1m0s
[03:36:14.918] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:38:0)
[03:36:14.918] Timer tick, asking Buildbucket for the build status
[03:36:14.989] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:14.989] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:39:0) after 1m0s
[03:37:15.062] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:39:0)
[03:37:15.062] Timer tick, asking Buildbucket for the build status
[03:37:15.122] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:15.122] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:40:0) after 1m0s
[03:38:15.324] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:40:0)
[03:38:15.324] Timer tick, asking Buildbucket for the build status
[03:38:15.527] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:15.527] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:41:0) after 1m0s
[03:39:15.640] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:41:0)
[03:39:15.640] Timer tick, asking Buildbucket for the build status
[03:39:15.961] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:15.961] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:42:0) after 1m0s
[03:40:15.989] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:42:0)
[03:40:15.989] Timer tick, asking Buildbucket for the build status
[03:40:16.408] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:16.408] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:43:0) after 1m0s
[03:41:16.545] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:43:0)
[03:41:16.545] Timer tick, asking Buildbucket for the build status
[03:41:16.642] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:16.642] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:44:0) after 1m0s
[03:42:16.643] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:44:0)
[03:42:16.643] Timer tick, asking Buildbucket for the build status
[03:42:16.751] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:16.752] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:45:0) after 1m0s
[03:43:16.834] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:45:0)
[03:43:16.834] Timer tick, asking Buildbucket for the build status
[03:43:16.937] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:16.937] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:46:0) after 1m0s
[03:44:17.088] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:46:0)
[03:44:17.088] Timer tick, asking Buildbucket for the build status
[03:44:17.177] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:17.177] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:47:0) after 1m0s
[03:45:17.296] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:47:0)
[03:45:17.296] Timer tick, asking Buildbucket for the build status
[03:45:17.470] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:17.470] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:48:0) after 1m0s
[03:46:17.506] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:48:0)
[03:46:17.506] Timer tick, asking Buildbucket for the build status
[03:46:17.625] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:17.625] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:49:0) after 1m0s
[03:47:17.654] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:49:0)
[03:47:17.654] Timer tick, asking Buildbucket for the build status
[03:47:17.744] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:17.744] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:50:0) after 1m0s
[03:48:17.817] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:50:0)
[03:48:17.817] Timer tick, asking Buildbucket for the build status
[03:48:17.892] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:17.892] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:51:0) after 1m0s
[03:49:18.068] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:51:0)
[03:49:18.068] Timer tick, asking Buildbucket for the build status
[03:49:18.547] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:18.547] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:52:0) after 1m0s
[03:50:18.560] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:52:0)
[03:50:18.560] Timer tick, asking Buildbucket for the build status
[03:50:19.309] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:19.309] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:53:0) after 1m0s
[03:51:19.288] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:53:0)
[03:51:19.288] Timer tick, asking Buildbucket for the build status
[03:51:19.373] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:19.373] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:54:0) after 1m0s
[03:52:19.557] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:54:0)
[03:52:19.557] Timer tick, asking Buildbucket for the build status
[03:52:19.710] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:19.710] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:55:0) after 1m0s
[03:53:19.777] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:55:0)
[03:53:19.777] Timer tick, asking Buildbucket for the build status
[03:53:19.843] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:19.843] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:56:0) after 1m0s
[03:54:20.050] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:56:0)
[03:54:20.050] Timer tick, asking Buildbucket for the build status
[03:54:20.124] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:20.125] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:57:0) after 1m0s
[03:55:20.175] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:57:0)
[03:55:20.175] Timer tick, asking Buildbucket for the build status
[03:55:20.281] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:20.281] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:58:0) after 1m0s
[03:56:20.623] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:58:0)
[03:56:20.623] Timer tick, asking Buildbucket for the build status
[03:56:20.798] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:20.798] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:59:0) after 1m0s
[03:57:20.866] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:59:0)
[03:57:20.866] Timer tick, asking Buildbucket for the build status
[03:57:21.414] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:21.414] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:60:0) after 1m0s
[03:58:21.503] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:60:0)
[03:58:21.503] Timer tick, asking Buildbucket for the build status
[03:58:21.572] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:21.572] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:61:0) after 1m0s
[03:59:21.626] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:61:0)
[03:59:21.626] Timer tick, asking Buildbucket for the build status
[03:59:21.832] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:21.832] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:62:0) after 1m0s
[04:00:21.902] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:62:0)
[04:00:21.902] Timer tick, asking Buildbucket for the build status
[04:00:22.264] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:22.264] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:63:0) after 1m0s
[04:01:22.313] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:63:0)
[04:01:22.313] Timer tick, asking Buildbucket for the build status
[04:01:22.372] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:22.372] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:64:0) after 1m0s
[04:02:22.462] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:64:0)
[04:02:22.462] Timer tick, asking Buildbucket for the build status
[04:02:22.534] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:22.534] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:65:0) after 1m0s
[04:03:22.594] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:65:0)
[04:03:22.594] Timer tick, asking Buildbucket for the build status
[04:03:22.657] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:22.657] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:66:0) after 1m0s
[04:04:22.856] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:66:0)
[04:04:22.856] Timer tick, asking Buildbucket for the build status
[04:04:22.994] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:22.994] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:67:0) after 1m0s
[04:05:23.198] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:67:0)
[04:05:23.198] Timer tick, asking Buildbucket for the build status
[04:05:23.311] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:23.311] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:68:0) after 1m0s
[04:06:23.459] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:68:0)
[04:06:23.459] Timer tick, asking Buildbucket for the build status
[04:06:23.568] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:23.568] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:69:0) after 1m0s
[04:07:23.612] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:69:0)
[04:07:23.612] Timer tick, asking Buildbucket for the build status
[04:07:23.709] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:23.709] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:70:0) after 1m0s
[04:08:23.837] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:70:0)
[04:08:23.837] Timer tick, asking Buildbucket for the build status
[04:08:24.246] Build 8856352396682526416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:24.246] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9021782459167829856:71:0) after 1m0s
[04:08:53.325] Received PubSub notification, asking Buildbucket for the build status
[04:08:53.399] Build 8856352396682526416: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:08:53.399] Buildbucket build:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"completed_ts": "1612325332376585",
"created_by": "project:dart",
"created_ts": "1612321204448595",
"id": "8856352396682526416",
"parameters_json": "{\"builder_name\": \"fuzz-linux\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"cron\": {\"generation\": \"4143\"}, \"id\": \"cron:v1:4143\"}]}}}",
"project": "dart",
"result": "SUCCESS",
"result_details_json": "{\"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\": \"4143\"}, \"id\": \"cron:v1:4143\"}]}, \"$recipe_engine/swarming\": {\"server\": \"https://chromium-swarm.appspot.com\"}, \"bot_id\": \"luci-dart-try-xenial-56-qpf2\", \"buildername\": \"fuzz-linux\", \"buildnumber\": 1382, \"clobber\": true, \"got_revision\": \"cfa35be6f03d7bca902d66f1497cc7f71edb3c3f\", \"path_config\": \"generic\", \"recipe\": \"dart/neo\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"browsers\", \"builder_0a8bbbf82ad80fe09c07c6a167e90508e267474280805a5952a3bc651b136427_v2\", \"builder_1b6044665c11ac21b76b5174316f99e877d7b36fecbed431d80353fc00e6db12_v2\", \"builder_36c85ebda7bed74f4f047df6d39aba7f824e167a4ee669897e735d76b78f3755_v2\", \"builder_51b593ded8badb9f1a3c8ac8207abb3ced1333a97ea732bca9bc14b93e1e73ed_v2\", \"builder_b19ea4ce286701e444ef847fe2456548cc4417021e320a5270dd8f9c6f7f773d_v2\", \"builder_b2f80d810ec7b8afc62ddd33a5836317e975dc6f593fa6e468f70e2e107c01fe_v2\", \"builder_b86275ddf762361824bfc56cad1157933a73a38c01cde840f74c93e8651eb66a_v2\", \"builder_bd0aeeff25083302d696872dcdd603716a137be4cc0518e81e5a086e0737b58c_v2\", \"builder_be75a7a188276dd8d86a6ac882e15402dfd3926d71be94e5d820a9fe6db4d5aa_v2\", \"builder_c762dd9ce592b3c0de5905eac1695e5c33a5cbbb648bd52fabdb48f7948d9041_v2\", \"builder_f9219a911dfbeb4ff836ddef0b336af22f54bd9ecdbeeae68c2671e10bb80306_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"dart-ci\"], \"gpu\": [\"none\"], \"host_class\": [\"default\"], \"id\": [\"luci-dart-try-xenial-56-qpf2\"], \"image\": [\"dart-xenial-20101000-265b45aa9e2\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-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\": [\"5676-c76598c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"started_ts": "1612321503356015",
"status": "COMPLETED",
"status_changed_ts": "1612325332980458",
"tags": [
"build_address:luci.dart.ci.sandbox/fuzz-linux/1382",
"builder:fuzz-linux",
"scheduler_invocation_id:9021782459167829856",
"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/8856352396682526416/+/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:517ea6c1d2d68810",
"user_agent:luci-scheduler"
],
"updated_ts": "1612325332996799",
"url": "https://ci.chromium.org/b/8856352396682526416",
"utcnow_ts": "1612325333388877"
}
}
[04:08:53.399] Invocation finished in 1h8m50.703990783s with status SUCCEEDED