[03:00:04.570] New invocation is queued and will start shortly
[03:00:06.554] Starting the invocation (attempt 1)
[03:00:06.599] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:00:06.599] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:00:06.599] Buildbucket request:
{
"bucket": "luci.dart.ci.sandbox",
"client_operation_id": "9036187374878052512",
"parameters_json": "{\"builder_name\":\"fuzz-linux\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"cron\":{\"generation\":\"3189\"},\"id\":\"cron:v1:3189\"}]}}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:fuzz-linux",
"scheduler_invocation_id:9036187374878052512",
"scheduler_job_id:dart/fuzz-linux",
"user_agent:luci-scheduler"
]
}
[03:00:07.712] Buildbucket response:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:dart",
"created_ts": "1598583606783441",
"id": "8870757311892614688",
"parameters_json": "{\"builder_name\": \"fuzz-linux\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"cron\": {\"generation\": \"3189\"}, \"id\": \"cron:v1:3189\"}]}}}",
"project": "dart",
"result_details_json": "{\"properties\": {}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1598583607414556",
"tags": [
"build_address:luci.dart.ci.sandbox/fuzz-linux/1064",
"builder:fuzz-linux",
"scheduler_invocation_id:9036187374878052512",
"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/8870757311892614688/+/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": "1598583607414698",
"url": "https://ci.chromium.org/b/8870757311892614688",
"utcnow_ts": "1598583607692527"
}
}
[03:00:07.712] Task URL: https://ci.chromium.org/b/8870757311892614688
[03:00:07.712] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:2:0) after 1m0s
[03:01:08.414] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:2:0)
[03:01:08.414] Timer tick, asking Buildbucket for the build status
[03:01:08.524] Build 8870757311892614688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:01:08.525] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:3:0) after 1m0s
[03:02:08.615] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:3:0)
[03:02:08.615] Timer tick, asking Buildbucket for the build status
[03:02:08.802] Build 8870757311892614688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:02:08.802] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:4:0) after 1m0s
[03:03:08.853] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:4:0)
[03:03:08.853] Timer tick, asking Buildbucket for the build status
[03:03:09.023] Build 8870757311892614688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:03:09.023] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:5:0) after 1m0s
[03:04:09.111] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:5:0)
[03:04:09.111] Timer tick, asking Buildbucket for the build status
[03:04:09.211] Build 8870757311892614688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:04:09.211] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:6:0) after 1m0s
[03:05:09.266] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:6:0)
[03:05:09.266] Timer tick, asking Buildbucket for the build status
[03:05:10.043] Build 8870757311892614688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:05:10.043] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:7:0) after 1m0s
[03:06:10.032] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:7:0)
[03:06:10.032] Timer tick, asking Buildbucket for the build status
[03:06:10.235] Build 8870757311892614688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:06:10.235] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:8:0) after 1m0s
[03:07:10.286] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:8:0)
[03:07:10.286] Timer tick, asking Buildbucket for the build status
[03:07:10.604] Build 8870757311892614688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:07:10.604] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:9:0) after 1m0s
[03:08:10.662] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:9:0)
[03:08:10.662] Timer tick, asking Buildbucket for the build status
[03:08:10.793] Build 8870757311892614688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:08:10.793] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:10:0) after 1m0s
[03:09:10.809] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:10:0)
[03:09:10.809] Timer tick, asking Buildbucket for the build status
[03:09:10.903] Build 8870757311892614688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:09:10.903] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:11:0) after 1m0s
[03:10:10.937] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:11:0)
[03:10:10.937] Timer tick, asking Buildbucket for the build status
[03:10:11.445] Build 8870757311892614688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:10:11.445] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:12:0) after 1m0s
[03:11:11.480] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:12:0)
[03:11:11.480] Timer tick, asking Buildbucket for the build status
[03:11:11.557] Build 8870757311892614688: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:11:11.557] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:13:0) after 1m0s
[03:11:53.195] Received PubSub notification, asking Buildbucket for the build status
[03:11:53.297] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:11.607] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:13:0)
[03:12:11.607] Timer tick, asking Buildbucket for the build status
[03:12:12.544] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:12.544] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:15:0) after 1m0s
[03:13:12.611] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:15:0)
[03:13:12.611] Timer tick, asking Buildbucket for the build status
[03:13:13.037] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:13.042] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:16:0) after 1m0s
[03:14:13.078] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:16:0)
[03:14:13.078] Timer tick, asking Buildbucket for the build status
[03:14:13.181] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:13.181] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:17:0) after 1m0s
[03:15:13.218] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:17:0)
[03:15:13.218] Timer tick, asking Buildbucket for the build status
[03:15:13.566] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:13.566] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:18:0) after 1m0s
[03:16:13.553] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:18:0)
[03:16:13.553] Timer tick, asking Buildbucket for the build status
[03:16:13.619] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:13.619] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:19:0) after 1m0s
[03:17:13.688] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:19:0)
[03:17:13.688] Timer tick, asking Buildbucket for the build status
[03:17:13.761] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:13.761] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:20:0) after 1m0s
[03:18:13.819] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:20:0)
[03:18:13.819] Timer tick, asking Buildbucket for the build status
[03:18:13.903] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:13.903] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:21:0) after 1m0s
[03:19:13.886] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:21:0)
[03:19:13.886] Timer tick, asking Buildbucket for the build status
[03:19:13.953] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:13.953] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:22:0) after 1m0s
[03:20:14.015] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:22:0)
[03:20:14.015] Timer tick, asking Buildbucket for the build status
[03:20:16.349] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:16.349] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:23:0) after 1m0s
[03:21:16.452] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:23:0)
[03:21:16.452] Timer tick, asking Buildbucket for the build status
[03:21:16.769] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:16.769] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:24:0) after 1m0s
[03:22:16.985] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:24:0)
[03:22:16.985] Timer tick, asking Buildbucket for the build status
[03:22:17.310] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:17.310] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:25:0) after 1m0s
[03:23:17.502] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:25:0)
[03:23:17.502] Timer tick, asking Buildbucket for the build status
[03:23:18.585] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:18.585] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:26:0) after 1m0s
[03:24:18.709] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:26:0)
[03:24:18.709] Timer tick, asking Buildbucket for the build status
[03:24:18.780] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:18.780] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:27:0) after 1m0s
[03:25:19.163] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:27:0)
[03:25:19.163] Timer tick, asking Buildbucket for the build status
[03:25:19.287] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:19.287] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:28:0) after 1m0s
[03:26:19.558] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:28:0)
[03:26:19.558] Timer tick, asking Buildbucket for the build status
[03:26:19.637] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:19.637] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:29:0) after 1m0s
[03:27:19.778] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:29:0)
[03:27:19.778] Timer tick, asking Buildbucket for the build status
[03:27:19.900] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:19.900] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:30:0) after 1m0s
[03:28:20.115] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:30:0)
[03:28:20.115] Timer tick, asking Buildbucket for the build status
[03:28:20.258] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:20.258] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:31:0) after 1m0s
[03:29:20.372] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:31:0)
[03:29:20.372] Timer tick, asking Buildbucket for the build status
[03:29:20.443] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:20.443] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:32:0) after 1m0s
[03:30:20.862] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:32:0)
[03:30:20.862] Timer tick, asking Buildbucket for the build status
[03:30:21.165] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:21.165] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:33:0) after 1m0s
[03:31:21.773] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:33:0)
[03:31:21.773] Timer tick, asking Buildbucket for the build status
[03:31:21.947] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:21.947] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:34:0) after 1m0s
[03:32:22.038] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:34:0)
[03:32:22.038] Timer tick, asking Buildbucket for the build status
[03:32:22.111] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:22.112] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:35:0) after 1m0s
[03:33:22.292] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:35:0)
[03:33:22.292] Timer tick, asking Buildbucket for the build status
[03:33:22.466] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:22.466] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:36:0) after 1m0s
[03:34:22.585] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:36:0)
[03:34:22.585] Timer tick, asking Buildbucket for the build status
[03:34:22.665] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:22.665] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:37:0) after 1m0s
[03:35:22.722] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:37:0)
[03:35:22.722] Timer tick, asking Buildbucket for the build status
[03:35:23.392] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:23.392] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:38:0) after 1m0s
[03:36:23.508] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:38:0)
[03:36:23.508] Timer tick, asking Buildbucket for the build status
[03:36:23.859] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:23.859] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:39:0) after 1m0s
[03:37:23.939] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:39:0)
[03:37:23.939] Timer tick, asking Buildbucket for the build status
[03:37:24.011] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:24.011] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:40:0) after 1m0s
[03:38:24.108] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:40:0)
[03:38:24.108] Timer tick, asking Buildbucket for the build status
[03:38:24.296] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:24.296] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:41:0) after 1m0s
[03:39:24.421] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:41:0)
[03:39:24.421] Timer tick, asking Buildbucket for the build status
[03:39:24.500] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:24.500] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:42:0) after 1m0s
[03:40:24.674] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:42:0)
[03:40:24.674] Timer tick, asking Buildbucket for the build status
[03:40:24.933] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:24.933] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:43:0) after 1m0s
[03:41:24.941] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:43:0)
[03:41:24.941] Timer tick, asking Buildbucket for the build status
[03:41:25.007] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:25.007] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:44:0) after 1m0s
[03:42:25.017] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:44:0)
[03:42:25.017] Timer tick, asking Buildbucket for the build status
[03:42:25.095] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:25.095] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:45:0) after 1m0s
[03:43:25.229] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:45:0)
[03:43:25.229] Timer tick, asking Buildbucket for the build status
[03:43:25.362] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:25.362] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:46:0) after 1m0s
[03:44:25.492] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:46:0)
[03:44:25.492] Timer tick, asking Buildbucket for the build status
[03:44:25.566] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:25.566] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:47:0) after 1m0s
[03:45:25.575] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:47:0)
[03:45:25.575] Timer tick, asking Buildbucket for the build status
[03:45:26.058] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:26.058] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:48:0) after 1m0s
[03:46:26.221] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:48:0)
[03:46:26.221] Timer tick, asking Buildbucket for the build status
[03:46:26.501] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:26.502] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:49:0) after 1m0s
[03:47:26.651] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:49:0)
[03:47:26.651] Timer tick, asking Buildbucket for the build status
[03:47:26.779] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:26.779] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:50:0) after 1m0s
[03:48:26.848] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:50:0)
[03:48:26.848] Timer tick, asking Buildbucket for the build status
[03:48:26.918] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:26.918] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:51:0) after 1m0s
[03:49:26.962] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:51:0)
[03:49:26.962] Timer tick, asking Buildbucket for the build status
[03:49:27.146] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:27.146] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:52:0) after 1m0s
[03:50:27.284] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:52:0)
[03:50:27.284] Timer tick, asking Buildbucket for the build status
[03:50:27.469] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:27.469] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:53:0) after 1m0s
[03:51:28.867] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:53:0)
[03:51:28.867] Timer tick, asking Buildbucket for the build status
[03:51:28.941] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:28.941] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:54:0) after 1m0s
[03:52:29.021] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:54:0)
[03:52:29.021] Timer tick, asking Buildbucket for the build status
[03:52:29.105] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:29.105] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:55:0) after 1m0s
[03:53:29.183] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:55:0)
[03:53:29.183] Timer tick, asking Buildbucket for the build status
[03:53:29.249] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:29.249] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:56:0) after 1m0s
[03:54:29.308] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:56:0)
[03:54:29.309] Timer tick, asking Buildbucket for the build status
[03:54:29.384] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:29.384] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:57:0) after 1m0s
[03:55:29.409] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:57:0)
[03:55:29.409] Timer tick, asking Buildbucket for the build status
[03:55:29.652] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:29.652] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:58:0) after 1m0s
[03:56:29.701] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:58:0)
[03:56:29.701] Timer tick, asking Buildbucket for the build status
[03:56:29.799] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:29.799] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:59:0) after 1m0s
[03:57:29.801] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:59:0)
[03:57:29.801] Timer tick, asking Buildbucket for the build status
[03:57:30.022] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:30.022] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:60:0) after 1m0s
[03:58:30.057] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:60:0)
[03:58:30.057] Timer tick, asking Buildbucket for the build status
[03:58:30.147] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:30.147] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:61:0) after 1m0s
[03:59:30.495] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:61:0)
[03:59:30.495] Timer tick, asking Buildbucket for the build status
[03:59:30.556] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:30.556] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:62:0) after 1m0s
[04:00:30.741] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:62:0)
[04:00:30.741] Timer tick, asking Buildbucket for the build status
[04:00:31.122] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:31.122] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:63:0) after 1m0s
[04:01:31.322] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:63:0)
[04:01:31.322] Timer tick, asking Buildbucket for the build status
[04:01:31.422] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:31.422] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:64:0) after 1m0s
[04:02:31.601] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:64:0)
[04:02:31.601] Timer tick, asking Buildbucket for the build status
[04:02:31.672] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:31.672] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:65:0) after 1m0s
[04:03:31.775] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:65:0)
[04:03:31.776] Timer tick, asking Buildbucket for the build status
[04:03:32.021] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:32.021] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:66:0) after 1m0s
[04:04:32.197] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:66:0)
[04:04:32.197] Timer tick, asking Buildbucket for the build status
[04:04:32.258] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:32.258] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:67:0) after 1m0s
[04:05:32.455] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:67:0)
[04:05:32.455] Timer tick, asking Buildbucket for the build status
[04:05:32.589] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:32.589] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:68:0) after 1m0s
[04:06:32.614] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:68:0)
[04:06:32.614] Timer tick, asking Buildbucket for the build status
[04:06:32.753] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:32.754] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:69:0) after 1m0s
[04:07:32.897] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:69:0)
[04:07:32.897] Timer tick, asking Buildbucket for the build status
[04:07:33.093] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:33.093] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:70:0) after 1m0s
[04:08:33.220] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:70:0)
[04:08:33.220] Timer tick, asking Buildbucket for the build status
[04:08:33.280] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:33.280] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:71:0) after 1m0s
[04:09:33.345] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:71:0)
[04:09:33.345] Timer tick, asking Buildbucket for the build status
[04:09:33.407] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:33.407] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:72:0) after 1m0s
[04:10:33.448] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:72:0)
[04:10:33.448] Timer tick, asking Buildbucket for the build status
[04:10:33.571] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:33.571] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:73:0) after 1m0s
[04:11:33.628] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:73:0)
[04:11:33.628] Timer tick, asking Buildbucket for the build status
[04:11:33.703] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:33.703] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:74:0) after 1m0s
[04:12:33.749] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:74:0)
[04:12:33.749] Timer tick, asking Buildbucket for the build status
[04:12:33.914] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:33.914] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:75:0) after 1m0s
[04:13:33.942] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:75:0)
[04:13:33.942] Timer tick, asking Buildbucket for the build status
[04:13:34.221] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:34.221] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:76:0) after 1m0s
[04:14:34.274] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:76:0)
[04:14:34.274] Timer tick, asking Buildbucket for the build status
[04:14:34.364] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:34.364] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:77:0) after 1m0s
[04:15:34.399] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:77:0)
[04:15:34.399] Timer tick, asking Buildbucket for the build status
[04:15:34.559] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:34.559] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:78:0) after 1m0s
[04:16:34.586] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:78:0)
[04:16:34.586] Timer tick, asking Buildbucket for the build status
[04:16:35.060] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:35.060] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:79:0) after 1m0s
[04:17:35.118] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:79:0)
[04:17:35.118] Timer tick, asking Buildbucket for the build status
[04:17:35.422] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:35.422] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:80:0) after 1m0s
[04:18:35.493] Handling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:80:0)
[04:18:35.493] Timer tick, asking Buildbucket for the build status
[04:18:35.697] Build 8870757311892614688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:35.697] Scheduling timer "check-buildbucket-build-status" (dart/fuzz-linux:9036187374878052512:81:0) after 1m0s
[04:18:59.856] Received PubSub notification, asking Buildbucket for the build status
[04:18:59.932] Build 8870757311892614688: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[04:18:59.932] Buildbucket build:
{
"build": {
"bucket": "luci.dart.ci.sandbox",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1598588338340743",
"created_by": "project:dart",
"created_ts": "1598583606783441",
"failure_reason": "BUILD_FAILURE",
"id": "8870757311892614688",
"parameters_json": "{\"builder_name\": \"fuzz-linux\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"cron\": {\"generation\": \"3189\"}, \"id\": \"cron:v1:3189\"}]}}}",
"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\\rTests: 36 Success: 33 (Rerun: 0) Skipped: 0 Timeout: 2 Divergences: 1\\n\\nIsolate (/b/s/w/itg_9AO2/dart_fuzzVWZIGG) NO-FP NO-FFI FLAT : AOT-DebugX64 - JIT-STACKTRACEEVERY-130-SLOWPATH-DET-ReleaseSIMARM timeout: 2383252413, 1179492812\\n\\n\\nIsolate (/b/s/w/itg_9AO2/dart_fuzzZDTUFJ) NO-FP NO-FFI FLAT : JIT-ReleaseSIMARM - KBC-INT-SRC-DET-ReleaseIA32: done\\n\\rTests: 86 Success: 82 (Rerun: 0) Skipped: 0 Timeout: 4 Divergences: 0\\n\\nIsolate (/b/s/w/itg_9AO2/dart_fuzzZDTUFJ) NO-FP NO-FFI FLAT : JIT-ReleaseSIMARM - KBC-INT-SRC-DET-ReleaseIA32 timeout: 2799733858, 109847756, 3259564069, 2884344666\\n\\n\\nIsolate (/b/s/w/itg_9AO2/dart_fuzzPBXQTY) NO-FP NO-FFI FLAT : KBC-INT-noVFP-DebugSIMARM - KBC-INT-O3-DET-ReleaseIA32: done\\n\\rTests: 58 Success: 57 (Rerun: 0) Skipped: 0 Timeout: 1 Divergences: 0\\n\\nIsolate (/b/s/w/itg_9AO2/dart_fuzzPBXQTY) NO-FP NO-FFI FLAT : KBC-INT-noVFP-DebugSIMARM - KBC-INT-O3-DET-ReleaseIA32 timeout: 772227734\\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\": \"3189\"}, \"id\": \"cron:v1:3189\"}]}, \"$recipe_engine/swarming\": {\"server\": \"https://chromium-swarm.appspot.com\"}, \"bot_id\": \"luci-dart-try-xenial-37-mi1u\", \"buildername\": \"fuzz-linux\", \"buildnumber\": 1064, \"clobber\": \"true\", \"got_revision\": \"e7b3737b8429a07762c047c2b6cf66243552e7b4\", \"path_config\": \"generic\", \"recipe\": \"dart/neo\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"browsers\", \"builder_33a1618f16b024d21e5509670c1b9da205aa675340ae77e33c3092d35efc05be_v2\", \"builder_390c115de1588aa44715b0a51be737386537dace0abbffb181966fe58d365023_v2\", \"builder_56a3c93bb2d7bc0af2be6e3c1545f193e6d6178854545c4826c86a4473896de9_v2\", \"builder_6cbd46bb7b85f2b5182064189e0144fd34df9d1a71ef5b4bc3ca003434985b44_v2\", \"builder_7ac26ffb2555723738bb40d39fe5d89f2f2f3a436d29e8fb3937519466e06fbe_v2\", \"builder_8949c8dcce2aeb2bc996a62a5f0905a891fc8b28f646674fea9daaf49a06323f_v2\", \"builder_b076a5b5387968aada53d33ff1c7f4b89b6a73c49ce0ebd5ac6a7185fd3656ba_v2\", \"builder_b4903f1f4f72e5aba35fcf81c8aa2a39a5c11d06b874553a5e6743c0759f1672_v2\", \"builder_b68c6c3591f0859d1e8449b612ebffd8ca7725d0421245922abffa29640ffb76_v2\", \"builder_d9afc272cea55efebacbb1b0e6d30bdc11e05602c27eb52ed561a0c06ddbb70b_v2\", \"builder_de2f45c670c5ef61720bbf05943b0d093fc36ab9b4db0bfbb3fe1513b6318dfd_v2\", \"builder_e1f1d36cd04fd7e3403dcadfdc2687cb256ff030c2137b3ab39a4dfaa7844b77_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"dart-ci\"], \"gpu\": [\"none\"], \"host_class\": [\"default\"], \"id\": [\"luci-dart-try-xenial-37-mi1u\"], \"image\": [\"dart-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"dart.tests\", \"luci.dart.try\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5498-3454aa6\"], \"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\\rTests: 36 Success: 33 (Rerun: 0) Skipped: 0 Timeout: 2 Divergences: 1\\n\\nIsolate (/b/s/w/itg_9AO2/dart_fuzzVWZIGG) NO-FP NO-FFI FLAT : AOT-DebugX64 - JIT-STACKTRACEEVERY-130-SLOWPATH-DET-ReleaseSIMARM timeout: 2383252413, 1179492812\\n\\n\\nIsolate (/b/s/w/itg_9AO2/dart_fuzzZDTUFJ) NO-FP NO-FFI FLAT : JIT-ReleaseSIMARM - KBC-INT-SRC-DET-ReleaseIA32: done\\n\\rTests: 86 Success: 82 (Rerun: 0) Skipped: 0 Timeout: 4 Divergences: 0\\n\\nIsolate (/b/s/w/itg_9AO2/dart_fuzzZDTUFJ) NO-FP NO-FFI FLAT : JIT-ReleaseSIMARM - KBC-INT-SRC-DET-ReleaseIA32 timeout: 2799733858, 109847756, 3259564069, 2884344666\\n\\n\\nIsolate (/b/s/w/itg_9AO2/dart_fuzzPBXQTY) NO-FP NO-FFI FLAT : KBC-INT-noVFP-DebugSIMARM - KBC-INT-O3-DET-ReleaseIA32: done\\n\\rTests: 58 Success: 57 (Rerun: 0) Skipped: 0 Timeout: 1 Divergences: 0\\n\\nIsolate (/b/s/w/itg_9AO2/dart_fuzzPBXQTY) NO-FP NO-FFI FLAT : KBC-INT-noVFP-DebugSIMARM - KBC-INT-O3-DET-ReleaseIA32 timeout: 772227734\\n\\n\\nfailure (1 divergences)\"}}",
"service_account": "dart-luci-try-builder@dart-ci.iam.gserviceaccount.com",
"started_ts": "1598584312414552",
"status": "COMPLETED",
"status_changed_ts": "1598584312927837",
"tags": [
"build_address:luci.dart.ci.sandbox/fuzz-linux/1064",
"builder:fuzz-linux",
"scheduler_invocation_id:9036187374878052512",
"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/8870757311892614688/+/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:4e4bd39b850b3010",
"user_agent:luci-scheduler"
],
"updated_ts": "1598588338479026",
"url": "https://ci.chromium.org/b/8870757311892614688",
"utcnow_ts": "1598588339921600"
}
}
[04:18:59.932] Invocation finished in 1h18m55.379416709s with status FAILED