[04:31:42.817] New invocation is queued and will start shortly
[04:31:44.059] Starting the invocation (attempt 1)
[04:31:44.099] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:31:44.099] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:31:44.099] Buildbucket request:
{
"bucket": "luci.dart.ci.sandbox",
"client_operation_id": "9031923552126407152",
"parameters_json": "{\"builder_name\":\"fuzz-linux\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"cron\":{\"generation\":\"3474\"},\"id\":\"cron:v1:3474\"}]}}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:fuzz-linux",
"scheduler_invocation_id:9031923552126407152",
"scheduler_job_id:dart/fuzz-linux",
"user_agent:luci-scheduler"
]
}
[04:31:44.723] Buildbucket response:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"created_by": "project:dart",
"created_ts": "1602649904270534",
"id": "8866493489938668208",
"parameters_json": "{\"builder_name\": \"fuzz-linux\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"cron\": {\"generation\": \"3474\"}, \"id\": \"cron:v1:3474\"}]}}}",
"project": "dart",
"result_details_json": "{\"properties\": {}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1602649904621153",
"tags": [
"build_address:luci.dart.ci.sandbox/fuzz-linux/1159",
"builder:fuzz-linux",
"scheduler_invocation_id:9031923552126407152",
"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/8866493489938668208/+/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": "1602649904621331",
"url": "https://ci.chromium.org/b/8866493489938668208",
"utcnow_ts": "1602649904716732"
}
}
[04:31:44.723] Task URL: https://ci.chromium.org/b/8866493489938668208
[04:31:44.723] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:2:0) after 1m0s
[04:31:46.597] Received PubSub notification, asking Buildbucket for the build status
[04:31:46.680] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:44.748] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:2:0)
[04:32:44.748] Timer tick, asking Buildbucket for the build status
[04:32:44.863] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:44.864] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:4:0) after 1m0s
[04:33:44.883] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:4:0)
[04:33:44.883] Timer tick, asking Buildbucket for the build status
[04:33:45.200] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:45.200] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:5:0) after 1m0s
[04:34:45.327] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:5:0)
[04:34:45.327] Timer tick, asking Buildbucket for the build status
[04:34:45.893] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:45.893] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:6:0) after 1m0s
[04:35:45.929] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:6:0)
[04:35:45.929] Timer tick, asking Buildbucket for the build status
[04:35:46.038] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:46.038] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:7:0) after 1m0s
[04:36:46.058] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:7:0)
[04:36:46.058] Timer tick, asking Buildbucket for the build status
[04:36:46.180] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:46.180] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:8:0) after 1m0s
[04:37:46.232] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:8:0)
[04:37:46.232] Timer tick, asking Buildbucket for the build status
[04:37:46.296] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:46.296] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:9:0) after 1m0s
[04:38:46.317] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:9:0)
[04:38:46.317] Timer tick, asking Buildbucket for the build status
[04:38:46.377] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:46.377] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:10:0) after 1m0s
[04:39:46.407] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:10:0)
[04:39:46.407] Timer tick, asking Buildbucket for the build status
[04:39:46.605] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:46.605] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:11:0) after 1m0s
[04:40:46.599] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:11:0)
[04:40:46.599] Timer tick, asking Buildbucket for the build status
[04:40:46.713] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:46.713] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:12:0) after 1m0s
[04:41:46.734] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:12:0)
[04:41:46.734] Timer tick, asking Buildbucket for the build status
[04:41:46.834] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:46.834] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:13:0) after 1m0s
[04:42:46.856] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:13:0)
[04:42:46.856] Timer tick, asking Buildbucket for the build status
[04:42:46.967] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:46.967] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:14:0) after 1m0s
[04:43:48.233] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:14:0)
[04:43:48.233] Timer tick, asking Buildbucket for the build status
[04:43:48.298] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:48.298] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:15:0) after 1m0s
[04:44:48.358] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:15:0)
[04:44:48.358] Timer tick, asking Buildbucket for the build status
[04:44:48.506] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:48.506] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:16:0) after 1m0s
[04:45:48.537] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:16:0)
[04:45:48.537] Timer tick, asking Buildbucket for the build status
[04:45:48.611] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:48.611] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:17:0) after 1m0s
[04:46:48.645] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:17:0)
[04:46:48.645] Timer tick, asking Buildbucket for the build status
[04:46:48.828] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:48.828] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:18:0) after 1m0s
[04:47:48.850] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:18:0)
[04:47:48.850] Timer tick, asking Buildbucket for the build status
[04:47:49.112] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:49.112] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:19:0) after 1m0s
[04:48:49.138] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:19:0)
[04:48:49.139] Timer tick, asking Buildbucket for the build status
[04:48:49.261] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:49.261] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:20:0) after 1m0s
[04:49:49.348] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:20:0)
[04:49:49.348] Timer tick, asking Buildbucket for the build status
[04:49:49.411] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:49.411] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:21:0) after 1m0s
[04:50:49.440] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:21:0)
[04:50:49.440] Timer tick, asking Buildbucket for the build status
[04:50:49.516] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:49.516] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:22:0) after 1m0s
[04:51:49.546] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:22:0)
[04:51:49.546] Timer tick, asking Buildbucket for the build status
[04:51:49.666] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:49.666] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:23:0) after 1m0s
[04:52:49.685] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:23:0)
[04:52:49.685] Timer tick, asking Buildbucket for the build status
[04:52:49.787] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:49.787] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:24:0) after 1m0s
[04:53:49.757] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:24:0)
[04:53:49.757] Timer tick, asking Buildbucket for the build status
[04:53:49.835] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:49.835] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:25:0) after 1m0s
[04:54:49.877] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:25:0)
[04:54:49.877] Timer tick, asking Buildbucket for the build status
[04:54:49.944] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:49.944] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:26:0) after 1m0s
[04:55:49.963] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:26:0)
[04:55:49.963] Timer tick, asking Buildbucket for the build status
[04:55:50.024] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:50.024] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:27:0) after 1m0s
[04:56:50.045] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:27:0)
[04:56:50.045] Timer tick, asking Buildbucket for the build status
[04:56:50.160] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:50.160] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:28:0) after 1m0s
[04:57:50.190] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:28:0)
[04:57:50.190] Timer tick, asking Buildbucket for the build status
[04:57:50.257] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:50.257] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:29:0) after 1m0s
[04:58:50.283] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:29:0)
[04:58:50.283] Timer tick, asking Buildbucket for the build status
[04:58:50.363] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:50.363] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:30:0) after 1m0s
[04:59:50.389] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:30:0)
[04:59:50.389] Timer tick, asking Buildbucket for the build status
[04:59:50.540] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:50.540] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:31:0) after 1m0s
[05:00:50.602] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:31:0)
[05:00:50.602] Timer tick, asking Buildbucket for the build status
[05:00:50.662] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:50.662] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:32:0) after 1m0s
[05:01:50.686] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:32:0)
[05:01:50.686] Timer tick, asking Buildbucket for the build status
[05:01:50.796] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:50.796] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:33:0) after 1m0s
[05:02:50.857] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:33:0)
[05:02:50.857] Timer tick, asking Buildbucket for the build status
[05:02:51.114] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:51.114] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:34:0) after 1m0s
[05:03:51.177] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:34:0)
[05:03:51.177] Timer tick, asking Buildbucket for the build status
[05:03:51.261] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:51.261] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:35:0) after 1m0s
[05:04:51.264] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:35:0)
[05:04:51.264] Timer tick, asking Buildbucket for the build status
[05:04:51.483] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:51.483] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:36:0) after 1m0s
[05:05:51.832] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:36:0)
[05:05:51.832] Timer tick, asking Buildbucket for the build status
[05:05:51.903] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:51.903] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:37:0) after 1m0s
[05:06:52.067] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:37:0)
[05:06:52.067] Timer tick, asking Buildbucket for the build status
[05:06:52.178] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:52.178] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:38:0) after 1m0s
[05:07:52.228] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:38:0)
[05:07:52.228] Timer tick, asking Buildbucket for the build status
[05:07:52.285] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:52.285] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:39:0) after 1m0s
[05:08:52.422] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:39:0)
[05:08:52.422] Timer tick, asking Buildbucket for the build status
[05:08:52.477] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:52.477] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:40:0) after 1m0s
[05:09:52.501] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:40:0)
[05:09:52.501] Timer tick, asking Buildbucket for the build status
[05:09:52.556] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:52.556] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:41:0) after 1m0s
[05:10:52.610] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:41:0)
[05:10:52.610] Timer tick, asking Buildbucket for the build status
[05:10:52.829] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:52.829] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:42:0) after 1m0s
[05:11:52.883] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:42:0)
[05:11:52.883] Timer tick, asking Buildbucket for the build status
[05:11:53.295] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:53.295] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:43:0) after 1m0s
[05:12:53.323] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:43:0)
[05:12:53.323] Timer tick, asking Buildbucket for the build status
[05:12:53.376] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:53.376] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:44:0) after 1m0s
[05:13:53.399] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:44:0)
[05:13:53.399] Timer tick, asking Buildbucket for the build status
[05:13:53.468] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:53.468] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:45:0) after 1m0s
[05:14:53.491] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:45:0)
[05:14:53.491] Timer tick, asking Buildbucket for the build status
[05:14:53.625] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:53.625] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:46:0) after 1m0s
[05:15:53.614] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:46:0)
[05:15:53.614] Timer tick, asking Buildbucket for the build status
[05:15:53.668] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:53.668] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:47:0) after 1m0s
[05:16:53.697] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:47:0)
[05:16:53.698] Timer tick, asking Buildbucket for the build status
[05:16:53.936] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:53.936] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:48:0) after 1m0s
[05:17:53.961] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:48:0)
[05:17:53.961] Timer tick, asking Buildbucket for the build status
[05:17:54.058] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:54.058] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:49:0) after 1m0s
[05:18:54.117] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:49:0)
[05:18:54.117] Timer tick, asking Buildbucket for the build status
[05:18:54.165] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:54.165] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:50:0) after 1m0s
[05:19:54.229] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:50:0)
[05:19:54.229] Timer tick, asking Buildbucket for the build status
[05:19:54.334] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:54.334] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:51:0) after 1m0s
[05:20:54.356] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:51:0)
[05:20:54.356] Timer tick, asking Buildbucket for the build status
[05:20:54.417] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:54.417] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:52:0) after 1m0s
[05:21:54.418] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:52:0)
[05:21:54.418] Timer tick, asking Buildbucket for the build status
[05:21:54.562] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:54.562] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:53:0) after 1m0s
[05:22:54.586] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:53:0)
[05:22:54.586] Timer tick, asking Buildbucket for the build status
[05:22:54.668] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:54.668] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:54:0) after 1m0s
[05:23:54.721] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:54:0)
[05:23:54.721] Timer tick, asking Buildbucket for the build status
[05:23:54.780] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:54.780] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:55:0) after 1m0s
[05:24:54.931] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:55:0)
[05:24:54.931] Timer tick, asking Buildbucket for the build status
[05:24:55.027] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:55.027] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:56:0) after 1m0s
[05:25:55.110] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:56:0)
[05:25:55.110] Timer tick, asking Buildbucket for the build status
[05:25:55.173] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:55.173] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:57:0) after 1m0s
[05:26:55.263] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:57:0)
[05:26:55.263] Timer tick, asking Buildbucket for the build status
[05:26:55.371] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:55.371] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:58:0) after 1m0s
[05:27:55.484] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:58:0)
[05:27:55.484] Timer tick, asking Buildbucket for the build status
[05:27:55.546] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:55.546] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:59:0) after 1m0s
[05:28:55.638] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:59:0)
[05:28:55.638] Timer tick, asking Buildbucket for the build status
[05:28:55.757] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:55.757] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:60:0) after 1m0s
[05:29:55.783] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:60:0)
[05:29:55.783] Timer tick, asking Buildbucket for the build status
[05:29:55.840] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:55.840] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:61:0) after 1m0s
[05:30:55.899] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:61:0)
[05:30:55.899] Timer tick, asking Buildbucket for the build status
[05:30:55.980] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:55.980] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:62:0) after 1m0s
[05:31:56.033] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:62:0)
[05:31:56.033] Timer tick, asking Buildbucket for the build status
[05:31:56.157] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:56.157] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:63:0) after 1m0s
[05:32:56.185] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:63:0)
[05:32:56.185] Timer tick, asking Buildbucket for the build status
[05:32:56.491] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:56.491] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:64:0) after 1m0s
[05:33:56.562] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:64:0)
[05:33:56.562] Timer tick, asking Buildbucket for the build status
[05:33:56.692] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:56.692] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:65:0) after 1m0s
[05:34:56.756] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:65:0)
[05:34:56.756] Timer tick, asking Buildbucket for the build status
[05:34:56.862] Build 8866493489938668208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:56.862] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9031923552126407152:66:0) after 1m0s
[05:35:32.304] Received PubSub notification, asking Buildbucket for the build status
[05:35:32.392] Build 8866493489938668208: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[05:35:32.392] Buildbucket build:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary_preference": "PROD",
"completed_ts": "1602653731501699",
"created_by": "project:dart",
"created_ts": "1602649904270534",
"failure_reason": "BUILD_FAILURE",
"id": "8866493489938668208",
"parameters_json": "{\"builder_name\": \"fuzz-linux\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"cron\": {\"generation\": \"3474\"}, \"id\": \"cron:v1:3474\"}]}}}",
"project": "dart",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 out of 5 aggregated steps failed: 1 out of 99 aggregated steps failed: Swarming task failed:\\n(\\u2026)\\n\\nIsolate (/b/s/w/itMvm5oP/dart_fuzzGZGLQY) NO-FP NO-FFI NO-FLAT : AOT-DebugX64 - KBC-INT-ReleaseIA32: done\\n\\rTests: 31 Success: 0 (Rerun: 0) Skipped: 0 Timeout: 31 Divergences: 0\\n\\nIsolate (/b/s/w/itMvm5oP/dart_fuzzGZGLQY) NO-FP NO-FFI NO-FLAT : AOT-DebugX64 - KBC-INT-ReleaseIA32 timeout: 1493437817, 722068307, 805621975, 2782729335, 935321823, 1244665494, 815670148, 1020651699, 2099295794, 3408886964, 1838951426, 617856922, 4083603777, 445408721, 729564077, 580278392, 4115788481, 3969558659, 2800236118, 2995148884, 1521687971, 2046707419, 3582420810, 1224170487, 3281680000, 2028419006, 1089488063, 1773983833, 1231093485, 3517330076, 232192320\\n\\n\\nIsolate (/b/s/w/itMvm5oP/dart_fuzzIALHNQ) NO-FP NO-FFI FLAT : AOT-O3-ReleaseX64 - KBC-CMP-DET-DebugSIMARM: done\\n\\rTests: 51 Success: 48 (Rerun: 0) Skipped: 0 Timeout: 2 Divergences: 1\\n\\nIsolate (/b/s/w/itMvm5oP/dart_fuzzIALHNQ) NO-FP NO-FFI FLAT : AOT-O3-ReleaseX64 - KBC-CMP-DET-DebugSIMARM timeout: 4184385626, 1130042416\\n\\n\\nfailure (1 divergences)\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"cron\": {\"generation\": \"3474\"}, \"id\": \"cron:v1:3474\"}]}, \"$recipe_engine/swarming\": {\"server\": \"https://chromium-swarm.appspot.com\"}, \"bot_id\": \"luci-dart-try-xenial-3-k078\", \"buildername\": \"fuzz-linux\", \"buildnumber\": 1159, \"clobber\": \"true\", \"got_revision\": \"6a4fa8b4ac079738b21e44dc9f27e65d1c7fadd4\", \"path_config\": \"generic\", \"recipe\": \"dart/neo\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"browsers\", \"builder_656e81d5e1c6527e1d3b1cbc84562eec0aa93fce767529697b9fbd1ea2d54f0d_v2\", \"builder_fce62558b7e1d6cb7b1df352b81125a8f2541bc160cdf615c88e1b641acc82d0_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-3-k078\"], \"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\": [\"5570-fa4adf0\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 out of 5 aggregated steps failed: 1 out of 99 aggregated steps failed: Swarming task failed:\\n(\\u2026)\\n\\nIsolate (/b/s/w/itMvm5oP/dart_fuzzGZGLQY) NO-FP NO-FFI NO-FLAT : AOT-DebugX64 - KBC-INT-ReleaseIA32: done\\n\\rTests: 31 Success: 0 (Rerun: 0) Skipped: 0 Timeout: 31 Divergences: 0\\n\\nIsolate (/b/s/w/itMvm5oP/dart_fuzzGZGLQY) NO-FP NO-FFI NO-FLAT : AOT-DebugX64 - KBC-INT-ReleaseIA32 timeout: 1493437817, 722068307, 805621975, 2782729335, 935321823, 1244665494, 815670148, 1020651699, 2099295794, 3408886964, 1838951426, 617856922, 4083603777, 445408721, 729564077, 580278392, 4115788481, 3969558659, 2800236118, 2995148884, 1521687971, 2046707419, 3582420810, 1224170487, 3281680000, 2028419006, 1089488063, 1773983833, 1231093485, 3517330076, 232192320\\n\\n\\nIsolate (/b/s/w/itMvm5oP/dart_fuzzIALHNQ) NO-FP NO-FFI FLAT : AOT-O3-ReleaseX64 - KBC-CMP-DET-DebugSIMARM: done\\n\\rTests: 51 Success: 48 (Rerun: 0) Skipped: 0 Timeout: 2 Divergences: 1\\n\\nIsolate (/b/s/w/itMvm5oP/dart_fuzzIALHNQ) NO-FP NO-FFI FLAT : AOT-O3-ReleaseX64 - KBC-CMP-DET-DebugSIMARM timeout: 4184385626, 1130042416\\n\\n\\nfailure (1 divergences)\"}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"started_ts": "1602649905706015",
"status": "COMPLETED",
"status_changed_ts": "1602649906082545",
"tags": [
"build_address:luci.dart.ci.sandbox/fuzz-linux/1159",
"builder:fuzz-linux",
"scheduler_invocation_id:9031923552126407152",
"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/8866493489938668208/+/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:4f3e325f275e6510",
"user_agent:luci-scheduler"
],
"updated_ts": "1602653731613698",
"url": "https://ci.chromium.org/b/8866493489938668208",
"utcnow_ts": "1602653732379896"
}
}
[05:35:32.392] Invocation finished in 1h3m49.591447306s with status FAILED