[20:50:54.739] New invocation is queued and will start shortly
[20:50:56.132] Starting the invocation (attempt 1)
[20:50:56.177] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:50:56.177] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:50:56.178] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9065835808671621280",
"parameters_json": "{\"builder_name\":\"ToTWinASanLibfuzzer\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"333f3f58c707886acaf34e14425ef11432d45a7f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTWinASanLibfuzzer",
"scheduler_invocation_id:9065835808671621280",
"scheduler_job_id:chromium/ToTWinASanLibfuzzer",
"user_agent:luci-scheduler",
"buildset:commit/git/333f3f58c707886acaf34e14425ef11432d45a7f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/333f3f58c707886acaf34e14425ef11432d45a7f",
"gitiles_ref:refs/heads/master"
]
}
[20:50:57.126] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1570308656520105",
"id": "8900405746139005856",
"parameters_json": "{\"builder_name\": \"ToTWinASanLibfuzzer\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"333f3f58c707886acaf34e14425ef11432d45a7f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1570308656980212",
"tags": [
"build_address:luci.chromium.ci/ToTWinASanLibfuzzer/3947",
"builder:ToTWinASanLibfuzzer",
"buildset:commit/git/333f3f58c707886acaf34e14425ef11432d45a7f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/333f3f58c707886acaf34e14425ef11432d45a7f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9065835808671621280",
"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/8900405746139005856/+/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": "1570308656980331",
"url": "https://ci.chromium.org/b/8900405746139005856",
"utcnow_ts": "1570308657115235"
}
}
[20:50:57.126] Task URL: https://ci.chromium.org/b/8900405746139005856
[20:50:57.126] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:2:0) after 1m0s
[20:51:57.157] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:2:0)
[20:51:57.157] Timer tick, asking Buildbucket for the build status
[20:51:57.680] Build 8900405746139005856: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:51:57.680] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:3:0) after 1m0s
[20:52:57.709] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:3:0)
[20:52:57.709] Timer tick, asking Buildbucket for the build status
[20:52:57.909] Build 8900405746139005856: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:52:57.909] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:4:0) after 1m0s
[20:53:58.007] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:4:0)
[20:53:58.007] Timer tick, asking Buildbucket for the build status
[20:53:58.543] Build 8900405746139005856: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:53:58.543] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:5:0) after 1m0s
[20:54:29.833] Received PubSub notification, asking Buildbucket for the build status
[20:54:30.804] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:58.660] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:5:0)
[20:54:58.660] Timer tick, asking Buildbucket for the build status
[20:54:59.729] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:59.729] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:7:0) after 1m0s
[20:55:59.749] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:7:0)
[20:55:59.749] Timer tick, asking Buildbucket for the build status
[20:56:00.462] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:00.462] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:8:0) after 1m0s
[20:57:00.498] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:8:0)
[20:57:00.498] Timer tick, asking Buildbucket for the build status
[20:57:00.861] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:00.861] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:9:0) after 1m0s
[20:58:00.858] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:9:0)
[20:58:00.858] Timer tick, asking Buildbucket for the build status
[20:58:01.330] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:01.330] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:10:0) after 1m0s
[20:59:01.351] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:10:0)
[20:59:01.351] Timer tick, asking Buildbucket for the build status
[20:59:02.781] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:02.781] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:11:0) after 1m0s
[21:00:02.856] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:11:0)
[21:00:02.856] Timer tick, asking Buildbucket for the build status
[21:00:04.507] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:04.508] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:12:0) after 1m0s
[21:01:04.550] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:12:0)
[21:01:04.550] Timer tick, asking Buildbucket for the build status
[21:01:05.126] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:05.126] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:13:0) after 1m0s
[21:02:05.597] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:13:0)
[21:02:05.597] Timer tick, asking Buildbucket for the build status
[21:02:06.143] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:06.143] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:14:0) after 1m0s
[21:03:06.311] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:14:0)
[21:03:06.311] Timer tick, asking Buildbucket for the build status
[21:03:07.150] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:07.150] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:15:0) after 1m0s
[21:04:07.176] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:15:0)
[21:04:07.176] Timer tick, asking Buildbucket for the build status
[21:04:07.374] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:07.374] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:16:0) after 1m0s
[21:05:07.539] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:16:0)
[21:05:07.539] Timer tick, asking Buildbucket for the build status
[21:05:07.743] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:07.743] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:17:0) after 1m0s
[21:06:08.214] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:17:0)
[21:06:08.214] Timer tick, asking Buildbucket for the build status
[21:06:08.710] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:08.710] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:18:0) after 1m0s
[21:07:08.886] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:18:0)
[21:07:08.886] Timer tick, asking Buildbucket for the build status
[21:07:09.105] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:09.105] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:19:0) after 1m0s
[21:08:09.307] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:19:0)
[21:08:09.307] Timer tick, asking Buildbucket for the build status
[21:08:09.923] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:09.923] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:20:0) after 1m0s
[21:09:09.947] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:20:0)
[21:09:09.947] Timer tick, asking Buildbucket for the build status
[21:09:10.182] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:10.182] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:21:0) after 1m0s
[21:10:10.202] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:21:0)
[21:10:10.202] Timer tick, asking Buildbucket for the build status
[21:10:10.588] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:10.588] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:22:0) after 1m0s
[21:11:10.774] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:22:0)
[21:11:10.774] Timer tick, asking Buildbucket for the build status
[21:11:11.292] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:11.292] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:23:0) after 1m0s
[21:12:11.444] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:23:0)
[21:12:11.444] Timer tick, asking Buildbucket for the build status
[21:12:11.671] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:11.671] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:24:0) after 1m0s
[21:13:11.729] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:24:0)
[21:13:11.729] Timer tick, asking Buildbucket for the build status
[21:13:11.986] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:11.986] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:25:0) after 1m0s
[21:14:12.022] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:25:0)
[21:14:12.022] Timer tick, asking Buildbucket for the build status
[21:14:12.228] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:12.228] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:26:0) after 1m0s
[21:15:12.300] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:26:0)
[21:15:12.300] Timer tick, asking Buildbucket for the build status
[21:15:13.677] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:13.677] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:27:0) after 1m0s
[21:16:13.709] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:27:0)
[21:16:13.709] Timer tick, asking Buildbucket for the build status
[21:16:13.899] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:13.899] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:28:0) after 1m0s
[21:17:13.956] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:28:0)
[21:17:13.956] Timer tick, asking Buildbucket for the build status
[21:17:14.687] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:14.687] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:29:0) after 1m0s
[21:18:15.007] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:29:0)
[21:18:15.007] Timer tick, asking Buildbucket for the build status
[21:18:15.320] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:15.320] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:30:0) after 1m0s
[21:19:15.478] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:30:0)
[21:19:15.478] Timer tick, asking Buildbucket for the build status
[21:19:15.721] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:15.721] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:31:0) after 1m0s
[21:20:16.071] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:31:0)
[21:20:16.071] Timer tick, asking Buildbucket for the build status
[21:20:16.872] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:16.872] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:32:0) after 1m0s
[21:21:16.904] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:32:0)
[21:21:16.904] Timer tick, asking Buildbucket for the build status
[21:21:17.220] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:17.220] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:33:0) after 1m0s
[21:22:17.297] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:33:0)
[21:22:17.297] Timer tick, asking Buildbucket for the build status
[21:22:17.533] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:17.534] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:34:0) after 1m0s
[21:23:17.585] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:34:0)
[21:23:17.585] Timer tick, asking Buildbucket for the build status
[21:23:17.917] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:17.917] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:35:0) after 1m0s
[21:24:17.993] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:35:0)
[21:24:17.993] Timer tick, asking Buildbucket for the build status
[21:24:18.728] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:18.728] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:36:0) after 1m0s
[21:25:18.755] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:36:0)
[21:25:18.755] Timer tick, asking Buildbucket for the build status
[21:25:22.903] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:22.903] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:37:0) after 1m0s
[21:26:22.929] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:37:0)
[21:26:22.929] Timer tick, asking Buildbucket for the build status
[21:26:23.592] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:23.592] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:38:0) after 1m0s
[21:27:23.680] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:38:0)
[21:27:23.680] Timer tick, asking Buildbucket for the build status
[21:27:24.484] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:24.484] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:39:0) after 1m0s
[21:28:24.561] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:39:0)
[21:28:24.561] Timer tick, asking Buildbucket for the build status
[21:28:24.832] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:24.832] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:40:0) after 1m0s
[21:29:24.859] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:40:0)
[21:29:24.859] Timer tick, asking Buildbucket for the build status
[21:29:25.243] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:25.243] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:41:0) after 1m0s
[21:30:25.238] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:41:0)
[21:30:25.238] Timer tick, asking Buildbucket for the build status
[21:30:27.038] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:27.038] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:42:0) after 1m0s
[21:31:27.043] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:42:0)
[21:31:27.043] Timer tick, asking Buildbucket for the build status
[21:31:27.263] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:27.263] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:43:0) after 1m0s
[21:32:27.339] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:43:0)
[21:32:27.339] Timer tick, asking Buildbucket for the build status
[21:32:27.737] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:27.737] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:44:0) after 1m0s
[21:33:27.759] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:44:0)
[21:33:27.759] Timer tick, asking Buildbucket for the build status
[21:33:27.925] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:27.925] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:45:0) after 1m0s
[21:34:27.947] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:45:0)
[21:34:27.947] Timer tick, asking Buildbucket for the build status
[21:34:28.999] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:28.999] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:46:0) after 1m0s
[21:35:29.009] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:46:0)
[21:35:29.009] Timer tick, asking Buildbucket for the build status
[21:35:29.513] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:29.513] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:47:0) after 1m0s
[21:36:29.576] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:47:0)
[21:36:29.576] Timer tick, asking Buildbucket for the build status
[21:36:29.762] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:29.762] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:48:0) after 1m0s
[21:37:29.838] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:48:0)
[21:37:29.838] Timer tick, asking Buildbucket for the build status
[21:37:30.394] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:30.394] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:49:0) after 1m0s
[21:38:30.418] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:49:0)
[21:38:30.418] Timer tick, asking Buildbucket for the build status
[21:38:30.848] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:30.849] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:50:0) after 1m0s
[21:39:30.922] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:50:0)
[21:39:30.922] Timer tick, asking Buildbucket for the build status
[21:39:31.390] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:31.390] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:51:0) after 1m0s
[21:40:31.409] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:51:0)
[21:40:31.409] Timer tick, asking Buildbucket for the build status
[21:40:32.404] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:32.405] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:52:0) after 1m0s
[21:41:32.464] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:52:0)
[21:41:32.464] Timer tick, asking Buildbucket for the build status
[21:41:32.668] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:32.668] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:53:0) after 1m0s
[21:42:32.741] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:53:0)
[21:42:32.741] Timer tick, asking Buildbucket for the build status
[21:42:33.193] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:33.193] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:54:0) after 1m0s
[21:43:33.212] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:54:0)
[21:43:33.212] Timer tick, asking Buildbucket for the build status
[21:43:33.654] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:33.654] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:55:0) after 1m0s
[21:44:33.646] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:55:0)
[21:44:33.646] Timer tick, asking Buildbucket for the build status
[21:44:34.186] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:34.186] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:56:0) after 1m0s
[21:45:34.335] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:56:0)
[21:45:34.335] Timer tick, asking Buildbucket for the build status
[21:45:38.516] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:38.516] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:57:0) after 1m0s
[21:46:38.542] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:57:0)
[21:46:38.542] Timer tick, asking Buildbucket for the build status
[21:46:38.806] Build 8900405746139005856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:38.806] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9065835808671621280:58:0) after 1m0s
[21:46:58.461] Received PubSub notification, asking Buildbucket for the build status
[21:46:58.637] Build 8900405746139005856: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[21:46:58.637] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1570312017873520",
"created_by": "project:chromium",
"created_ts": "1570308656520105",
"failure_reason": "BUILD_FAILURE",
"id": "8900405746139005856",
"parameters_json": "{\"builder_name\": \"ToTWinASanLibfuzzer\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"333f3f58c707886acaf34e14425ef11432d45a7f\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"#### Step _compile_ failed. Error logs are shown below:\\n```\\n[2296/59523] CXX obj/courgette/courgette_lib/disassembler_elf_32_arm.obj\\nFAILED: obj/courgette/courgette_lib/disassembler_elf_32_arm.obj\\n..\\\\..\\\\third_party\\\\llvm-build\\\\Release+Asserts\\\\bin\\\\clang-cl.exe /nologo /showIncludes -imsvc..\\\\..\\\\thir...(too long)\\n../../courgette/disassembler_elf_32_arm.cc(527,19): error: bitwise negation of a boolean expression; did you mean logical negation? [-Werror,-Wbool-operation]\\non_32bit = (~(on_32bit ^ (op_size == 4))) != 0;\\n^~~~~~~~~~~~~~~~~~~~~~~~~~~~\\n!\\n1 error generated.\\n```\\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-1-nruz\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTWinASanLibfuzzer\", \"buildnumber\": 3947, \"got_angle_revision\": \"5e9d4ee99ea11265ac48cdc41cc60480f37e4f02\", \"got_clang_revision\": \"373834-8815be04-0\", \"got_dawn_revision\": \"21dfc919547fb3b139b56271d1aa09518bd75801\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"333f3f58c707886acaf34e14425ef11432d45a7f\", \"got_revision_cp\": \"refs/heads/master@{#703161}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_v8_revision\": \"d59e86cad68a0cbe50b36219614685fe1811804b\", \"got_v8_revision_cp\": \"refs/heads/7.9.218@{#1}\", \"got_webrtc_revision\": \"b441acf656520aa6ff9d8864b0aa1b065f1771c8\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29389}\", \"mastername\": \"chromium.clang\", \"path_config\": \"generic\", \"perf_dashboard_machine_group\": \"ChromiumClang\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"333f3f58c707886acaf34e14425ef11432d45a7f\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_91c730c3e6ead475130e2ae78bc3f03e09cb9dcb91c3469d4450b29020110401_v2\", \"git\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-1-nruz\"], \"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\": [\"4466-755d6a2\"], \"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[2296/59523] CXX obj/courgette/courgette_lib/disassembler_elf_32_arm.obj\\nFAILED: obj/courgette/courgette_lib/disassembler_elf_32_arm.obj\\n..\\\\..\\\\third_party\\\\llvm-build\\\\Release+Asserts\\\\bin\\\\clang-cl.exe /nologo /showIncludes -imsvc..\\\\..\\\\thir...(too long)\\n../../courgette/disassembler_elf_32_arm.cc(527,19): error: bitwise negation of a boolean expression; did you mean logical negation? [-Werror,-Wbool-operation]\\non_32bit = (~(on_32bit ^ (op_size == 4))) != 0;\\n^~~~~~~~~~~~~~~~~~~~~~~~~~~~\\n!\\n1 error generated.\\n```\\n#### More information in raw_io.output[failure_summary]\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1570308867885121",
"status": "COMPLETED",
"status_changed_ts": "1570308868953819",
"tags": [
"build_address:luci.chromium.ci/ToTWinASanLibfuzzer/3947",
"builder:ToTWinASanLibfuzzer",
"buildset:commit/git/333f3f58c707886acaf34e14425ef11432d45a7f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/333f3f58c707886acaf34e14425ef11432d45a7f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9065835808671621280",
"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/8900405746139005856/+/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:47b6821982c1f110",
"user_agent:luci-scheduler"
],
"updated_ts": "1570312018019098",
"url": "https://ci.chromium.org/b/8900405746139005856",
"utcnow_ts": "1570312018621980"
}
}
[21:46:58.637] Invocation finished in 56m3.915498648s with status FAILED