[15:21:28.550] New invocation is queued and will start shortly
[15:21:29.663] Starting the invocation (attempt 1)
[15:21:29.709] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:21:29.709] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:21:29.709] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9064497580528870592",
"parameters_json": "{\"builder_name\":\"ToTWinASanLibfuzzer\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3c3d2f43f6bbceeb2dd85ab2e0a02261aa665462\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTWinASanLibfuzzer",
"scheduler_invocation_id:9064497580528870592",
"scheduler_job_id:chromium/ToTWinASanLibfuzzer",
"user_agent:luci-scheduler",
"buildset:commit/git/3c3d2f43f6bbceeb2dd85ab2e0a02261aa665462",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3c3d2f43f6bbceeb2dd85ab2e0a02261aa665462",
"gitiles_ref:refs/heads/master"
]
}
[15:21:37.639] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1571584891392057",
"id": "8899067516882009520",
"parameters_json": "{\"builder_name\": \"ToTWinASanLibfuzzer\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3c3d2f43f6bbceeb2dd85ab2e0a02261aa665462\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1571584894705149",
"tags": [
"build_address:luci.chromium.ci/ToTWinASanLibfuzzer/4059",
"builder:ToTWinASanLibfuzzer",
"buildset:commit/git/3c3d2f43f6bbceeb2dd85ab2e0a02261aa665462",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3c3d2f43f6bbceeb2dd85ab2e0a02261aa665462",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9064497580528870592",
"scheduler_job_id:chromium/ToTWinASanLibfuzzer",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8899067516882009520/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1571584894705252",
"url": "https://ci.chromium.org/b/8899067516882009520",
"utcnow_ts": "1571584897595847"
}
}
[15:21:37.639] Task URL: https://ci.chromium.org/b/8899067516882009520
[15:21:37.639] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:2:0) after 1m0s
[15:22:37.662] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:2:0)
[15:22:37.662] Timer tick, asking Buildbucket for the build status
[15:22:38.077] Build 8899067516882009520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:22:38.077] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:3:0) after 1m0s
[15:23:38.215] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:3:0)
[15:23:38.215] Timer tick, asking Buildbucket for the build status
[15:23:39.146] Build 8899067516882009520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:23:39.146] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:4:0) after 1m0s
[15:24:39.187] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:4:0)
[15:24:39.187] Timer tick, asking Buildbucket for the build status
[15:24:39.363] Build 8899067516882009520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:24:39.363] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:5:0) after 1m0s
[15:25:39.390] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:5:0)
[15:25:39.390] Timer tick, asking Buildbucket for the build status
[15:25:39.653] Build 8899067516882009520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:25:39.653] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:6:0) after 1m0s
[15:26:39.684] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:6:0)
[15:26:39.684] Timer tick, asking Buildbucket for the build status
[15:26:40.295] Build 8899067516882009520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:26:40.295] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:7:0) after 1m0s
[15:27:40.521] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:7:0)
[15:27:40.521] Timer tick, asking Buildbucket for the build status
[15:27:40.731] Build 8899067516882009520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:27:40.731] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:8:0) after 1m0s
[15:28:40.904] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:8:0)
[15:28:40.904] Timer tick, asking Buildbucket for the build status
[15:28:42.009] Build 8899067516882009520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:28:42.009] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:9:0) after 1m0s
[15:29:42.438] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:9:0)
[15:29:42.438] Timer tick, asking Buildbucket for the build status
[15:29:43.971] Build 8899067516882009520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:29:43.971] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:10:0) after 1m0s
[15:30:44.198] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:10:0)
[15:30:44.198] Timer tick, asking Buildbucket for the build status
[15:30:44.829] Build 8899067516882009520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:30:44.829] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:11:0) after 1m0s
[15:31:16.839] Received PubSub notification, asking Buildbucket for the build status
[15:31:19.039] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:44.988] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:11:0)
[15:31:44.989] Timer tick, asking Buildbucket for the build status
[15:31:45.197] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:45.197] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:13:0) after 1m0s
[15:32:45.232] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:13:0)
[15:32:45.232] Timer tick, asking Buildbucket for the build status
[15:32:45.500] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:45.500] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:14:0) after 1m0s
[15:33:45.522] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:14:0)
[15:33:45.522] Timer tick, asking Buildbucket for the build status
[15:33:45.755] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:45.755] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:15:0) after 1m0s
[15:34:45.811] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:15:0)
[15:34:45.811] Timer tick, asking Buildbucket for the build status
[15:34:46.331] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:46.331] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:16:0) after 1m0s
[15:35:46.371] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:16:0)
[15:35:46.371] Timer tick, asking Buildbucket for the build status
[15:35:48.377] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:48.377] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:17:0) after 1m0s
[15:36:48.452] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:17:0)
[15:36:48.452] Timer tick, asking Buildbucket for the build status
[15:36:48.725] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:48.725] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:18:0) after 1m0s
[15:37:48.776] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:18:0)
[15:37:48.776] Timer tick, asking Buildbucket for the build status
[15:37:49.697] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:49.697] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:19:0) after 1m0s
[15:38:49.797] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:19:0)
[15:38:49.797] Timer tick, asking Buildbucket for the build status
[15:38:49.976] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:49.976] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:20:0) after 1m0s
[15:39:50.115] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:20:0)
[15:39:50.115] Timer tick, asking Buildbucket for the build status
[15:39:52.370] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:52.370] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:21:0) after 1m0s
[15:40:52.398] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:21:0)
[15:40:52.398] Timer tick, asking Buildbucket for the build status
[15:40:55.628] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:55.628] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:22:0) after 1m0s
[15:41:55.673] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:22:0)
[15:41:55.673] Timer tick, asking Buildbucket for the build status
[15:41:55.854] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:55.854] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:23:0) after 1m0s
[15:42:55.877] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:23:0)
[15:42:55.877] Timer tick, asking Buildbucket for the build status
[15:42:56.151] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:56.151] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:24:0) after 1m0s
[15:43:56.193] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:24:0)
[15:43:56.193] Timer tick, asking Buildbucket for the build status
[15:43:56.581] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:56.581] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:25:0) after 1m0s
[15:44:56.694] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:25:0)
[15:44:56.694] Timer tick, asking Buildbucket for the build status
[15:44:56.984] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:56.984] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:26:0) after 1m0s
[15:45:57.066] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:26:0)
[15:45:57.066] Timer tick, asking Buildbucket for the build status
[15:45:57.957] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:57.957] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:27:0) after 1m0s
[15:46:57.990] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:27:0)
[15:46:57.990] Timer tick, asking Buildbucket for the build status
[15:46:58.395] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:58.395] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:28:0) after 1m0s
[15:47:58.418] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:28:0)
[15:47:58.418] Timer tick, asking Buildbucket for the build status
[15:47:58.842] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:58.842] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:29:0) after 1m0s
[15:48:58.869] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:29:0)
[15:48:58.869] Timer tick, asking Buildbucket for the build status
[15:48:59.230] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:59.230] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:30:0) after 1m0s
[15:49:59.257] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:30:0)
[15:49:59.257] Timer tick, asking Buildbucket for the build status
[15:50:00.501] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:00.501] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:31:0) after 1m0s
[15:51:00.607] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:31:0)
[15:51:00.607] Timer tick, asking Buildbucket for the build status
[15:51:01.445] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:01.445] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:32:0) after 1m0s
[15:52:01.484] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:32:0)
[15:52:01.484] Timer tick, asking Buildbucket for the build status
[15:52:01.819] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:01.819] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:33:0) after 1m0s
[15:53:01.862] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:33:0)
[15:53:01.862] Timer tick, asking Buildbucket for the build status
[15:53:02.529] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:02.529] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:34:0) after 1m0s
[15:54:02.684] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:34:0)
[15:54:02.684] Timer tick, asking Buildbucket for the build status
[15:54:04.139] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:04.139] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:35:0) after 1m0s
[15:55:04.118] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:35:0)
[15:55:04.118] Timer tick, asking Buildbucket for the build status
[15:55:05.294] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:05.294] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:36:0) after 1m0s
[15:56:05.392] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:36:0)
[15:56:05.392] Timer tick, asking Buildbucket for the build status
[15:56:06.328] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:06.328] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:37:0) after 1m0s
[15:57:06.492] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:37:0)
[15:57:06.492] Timer tick, asking Buildbucket for the build status
[15:57:09.242] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:09.242] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:38:0) after 1m0s
[15:58:09.380] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:38:0)
[15:58:09.380] Timer tick, asking Buildbucket for the build status
[15:58:10.530] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:10.530] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:39:0) after 1m0s
[15:59:10.559] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:39:0)
[15:59:10.559] Timer tick, asking Buildbucket for the build status
[15:59:11.165] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:11.165] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:40:0) after 1m0s
[16:00:11.199] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:40:0)
[16:00:11.199] Timer tick, asking Buildbucket for the build status
[16:00:11.375] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:11.375] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:41:0) after 1m0s
[16:01:11.484] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:41:0)
[16:01:11.484] Timer tick, asking Buildbucket for the build status
[16:01:12.352] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:12.352] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:42:0) after 1m0s
[16:02:12.387] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:42:0)
[16:02:12.387] Timer tick, asking Buildbucket for the build status
[16:02:13.099] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:13.099] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:43:0) after 1m0s
[16:03:13.143] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:43:0)
[16:03:13.143] Timer tick, asking Buildbucket for the build status
[16:03:19.096] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:19.097] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:44:0) after 1m0s
[16:04:19.257] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:44:0)
[16:04:19.257] Timer tick, asking Buildbucket for the build status
[16:04:20.269] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:20.269] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:45:0) after 1m0s
[16:05:20.779] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:45:0)
[16:05:20.779] Timer tick, asking Buildbucket for the build status
[16:05:21.131] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:21.131] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:46:0) after 1m0s
[16:06:21.318] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:46:0)
[16:06:21.318] Timer tick, asking Buildbucket for the build status
[16:06:25.404] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:25.404] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:47:0) after 1m0s
[16:07:25.423] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:47:0)
[16:07:25.423] Timer tick, asking Buildbucket for the build status
[16:07:25.647] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:25.647] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:48:0) after 1m0s
[16:08:26.055] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:48:0)
[16:08:26.055] Timer tick, asking Buildbucket for the build status
[16:08:26.980] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:26.980] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:49:0) after 1m0s
[16:09:27.070] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:49:0)
[16:09:27.070] Timer tick, asking Buildbucket for the build status
[16:09:27.261] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:27.261] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:50:0) after 1m0s
[16:10:27.478] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:50:0)
[16:10:27.478] Timer tick, asking Buildbucket for the build status
[16:10:27.768] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:27.768] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:51:0) after 1m0s
[16:11:28.058] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:51:0)
[16:11:28.058] Timer tick, asking Buildbucket for the build status
[16:11:28.923] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:28.923] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:52:0) after 1m0s
[16:12:28.975] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:52:0)
[16:12:28.975] Timer tick, asking Buildbucket for the build status
[16:12:29.348] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:29.348] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:53:0) after 1m0s
[16:13:29.381] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:53:0)
[16:13:29.381] Timer tick, asking Buildbucket for the build status
[16:13:29.561] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:29.561] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:54:0) after 1m0s
[16:14:29.584] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:54:0)
[16:14:29.584] Timer tick, asking Buildbucket for the build status
[16:14:29.804] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:29.804] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:55:0) after 1m0s
[16:15:29.909] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:55:0)
[16:15:29.909] Timer tick, asking Buildbucket for the build status
[16:15:30.741] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:30.741] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:56:0) after 1m0s
[16:16:30.767] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:56:0)
[16:16:30.767] Timer tick, asking Buildbucket for the build status
[16:16:31.403] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:31.403] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:57:0) after 1m0s
[16:17:31.427] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:57:0)
[16:17:31.427] Timer tick, asking Buildbucket for the build status
[16:17:32.350] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:32.350] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:58:0) after 1m0s
[16:18:32.489] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:58:0)
[16:18:32.489] Timer tick, asking Buildbucket for the build status
[16:18:33.105] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:33.105] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:59:0) after 1m0s
[16:19:33.185] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:59:0)
[16:19:33.185] Timer tick, asking Buildbucket for the build status
[16:19:34.143] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:34.143] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:60:0) after 1m0s
[16:20:34.171] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:60:0)
[16:20:34.171] Timer tick, asking Buildbucket for the build status
[16:20:36.857] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:36.857] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:61:0) after 1m0s
[16:21:37.045] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:61:0)
[16:21:37.045] Timer tick, asking Buildbucket for the build status
[16:21:37.716] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:37.716] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:62:0) after 1m0s
[16:22:37.841] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:62:0)
[16:22:37.841] Timer tick, asking Buildbucket for the build status
[16:22:38.080] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:38.080] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:63:0) after 1m0s
[16:23:38.133] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:63:0)
[16:23:38.133] Timer tick, asking Buildbucket for the build status
[16:23:39.043] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:39.043] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:64:0) after 1m0s
[16:24:39.112] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:64:0)
[16:24:39.112] Timer tick, asking Buildbucket for the build status
[16:24:39.390] Build 8899067516882009520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:39.390] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9064497580528870592:65:0) after 1m0s
[16:24:50.053] Received PubSub notification, asking Buildbucket for the build status
[16:24:50.605] Build 8899067516882009520: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[16:24:50.605] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1571588687484323",
"created_by": "project:chromium",
"created_ts": "1571584891392057",
"failure_reason": "BUILD_FAILURE",
"id": "8899067516882009520",
"parameters_json": "{\"builder_name\": \"ToTWinASanLibfuzzer\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3c3d2f43f6bbceeb2dd85ab2e0a02261aa665462\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"#### Step _compile_ failed. Error logs are shown below:\\n```\\n[21/70638] CXX obj/base/third_party/double_conversion/double_conversion/strtod.obj\\nFAILED: obj/base/third_party/double_conversion/double_conversion/strtod.obj\\n..\\\\..\\\\third_party\\\\llvm-build\\\\Release+Asserts\\\\bin\\\\clang-cl.exe /nologo /showIncludes -imsvc..\\\\..\\\\thir...(too long)\\nfatal error: error in backend: Cannot select: t25: v2f64 = X86ISD::FHADD t24, t24, ../../base/third_party/double_conversion/double-conversion/strtod.cc:167:26 @[ ../../base/third_party/double_conversion/double-conversion/strtod.cc:238:37 @[ ../../base/third_party/double_conversion/double-conversion/strtod.cc:439:7 ] ]\\n```\\n##### ...The message was too long...\\n#### More information in raw_io.output[failure_summary]\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-win10-32-0-onaa\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTWinASanLibfuzzer\", \"buildnumber\": 4059, \"got_angle_revision\": \"0163470450726394efaf11570daade9f34eb2f6e\", \"got_clang_revision\": \"375362-e6125fc0-0\", \"got_dawn_revision\": \"8d000e0cc230663dbeae86f59aaa16fc91b1eac1\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"3c3d2f43f6bbceeb2dd85ab2e0a02261aa665462\", \"got_revision_cp\": \"refs/heads/master@{#707676}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_v8_revision\": \"b32cc6513131fb1a4327d7d8a15e533eb20e64b4\", \"got_v8_revision_cp\": \"refs/heads/8.0.3@{#1}\", \"got_webrtc_revision\": \"3663ed3ad67893746efd86267a936a7295031ab1\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29548}\", \"mastername\": \"chromium.clang\", \"path_config\": \"generic\", \"perf_dashboard_machine_group\": \"ChromiumClang\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3c3d2f43f6bbceeb2dd85ab2e0a02261aa665462\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"git\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-0-onaa\"], \"image\": [\"chrome-win10-1703-19091300-a244b1e46d2\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"4542-cd693bf\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}, \"ui\": {\"info\": \"#### Step _compile_ failed. Error logs are shown below:\\n```\\n[21/70638] CXX obj/base/third_party/double_conversion/double_conversion/strtod.obj\\nFAILED: obj/base/third_party/double_conversion/double_conversion/strtod.obj\\n..\\\\..\\\\third_party\\\\llvm-build\\\\Release+Asserts\\\\bin\\\\clang-cl.exe /nologo /showIncludes -imsvc..\\\\..\\\\thir...(too long)\\nfatal error: error in backend: Cannot select: t25: v2f64 = X86ISD::FHADD t24, t24, ../../base/third_party/double_conversion/double-conversion/strtod.cc:167:26 @[ ../../base/third_party/double_conversion/double-conversion/strtod.cc:238:37 @[ ../../base/third_party/double_conversion/double-conversion/strtod.cc:439:7 ] ]\\n```\\n##### ...The message was too long...\\n#### More information in raw_io.output[failure_summary]\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1571585473497499",
"status": "COMPLETED",
"status_changed_ts": "1571585474217274",
"tags": [
"build_address:luci.chromium.ci/ToTWinASanLibfuzzer/4059",
"builder:ToTWinASanLibfuzzer",
"buildset:commit/git/3c3d2f43f6bbceeb2dd85ab2e0a02261aa665462",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3c3d2f43f6bbceeb2dd85ab2e0a02261aa665462",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9064497580528870592",
"scheduler_job_id:chromium/ToTWinASanLibfuzzer",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8899067516882009520/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:480293f3289ad310",
"user_agent:luci-scheduler"
],
"updated_ts": "1571588687553077",
"url": "https://ci.chromium.org/b/8899067516882009520",
"utcnow_ts": "1571588690564011"
}
}
[16:24:50.606] Invocation finished in 1h3m22.074308056s with status FAILED