[08:10:40.418] New invocation is queued and will start shortly
[08:10:41.879] Starting the invocation (attempt 1)
[08:10:41.946] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:10:41.946] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:10:41.946] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9038523354904103920",
"parameters_json": "{\"builder_name\":\"ToTWinASanLibfuzzer\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"a402358c2b760e55be4f4f446ed19cbae7766fe6\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTWinASanLibfuzzer",
"scheduler_invocation_id:9038523354904103920",
"scheduler_job_id:chromium/ToTWinASanLibfuzzer",
"user_agent:luci-scheduler",
"buildset:commit/git/a402358c2b760e55be4f4f446ed19cbae7766fe6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a402358c2b760e55be4f4f446ed19cbae7766fe6",
"gitiles_ref:refs/heads/master"
]
}
[08:10:44.576] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1596355843415375",
"id": "8873093291093185632",
"parameters_json": "{\"builder_name\": \"ToTWinASanLibfuzzer\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a402358c2b760e55be4f4f446ed19cbae7766fe6\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1596355844250319",
"tags": [
"build_address:luci.chromium.ci/ToTWinASanLibfuzzer/6161",
"builder:ToTWinASanLibfuzzer",
"buildset:commit/git/a402358c2b760e55be4f4f446ed19cbae7766fe6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a402358c2b760e55be4f4f446ed19cbae7766fe6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9038523354904103920",
"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/8873093291093185632/+/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": "1596355844250644",
"url": "https://ci.chromium.org/b/8873093291093185632",
"utcnow_ts": "1596355844567192"
}
}
[08:10:44.576] Task URL: https://ci.chromium.org/b/8873093291093185632
[08:10:44.576] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:2:0) after 1m0s
[08:10:50.761] Received PubSub notification, asking Buildbucket for the build status
[08:10:50.835] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:44.764] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:2:0)
[08:11:44.764] Timer tick, asking Buildbucket for the build status
[08:11:44.876] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:44.876] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:4:0) after 1m0s
[08:12:45.108] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:4:0)
[08:12:45.108] Timer tick, asking Buildbucket for the build status
[08:12:45.468] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:45.468] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:5:0) after 1m0s
[08:13:45.623] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:5:0)
[08:13:45.623] Timer tick, asking Buildbucket for the build status
[08:13:45.737] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:45.737] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:6:0) after 1m0s
[08:14:45.826] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:6:0)
[08:14:45.826] Timer tick, asking Buildbucket for the build status
[08:14:45.910] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:45.910] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:7:0) after 1m0s
[08:15:45.996] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:7:0)
[08:15:45.996] Timer tick, asking Buildbucket for the build status
[08:15:46.068] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:46.068] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:8:0) after 1m0s
[08:16:46.107] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:8:0)
[08:16:46.107] Timer tick, asking Buildbucket for the build status
[08:16:46.272] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:46.272] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:9:0) after 1m0s
[08:17:46.304] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:9:0)
[08:17:46.304] Timer tick, asking Buildbucket for the build status
[08:17:46.380] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:46.380] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:10:0) after 1m0s
[08:18:46.431] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:10:0)
[08:18:46.431] Timer tick, asking Buildbucket for the build status
[08:18:46.807] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:46.807] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:11:0) after 1m0s
[08:19:46.828] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:11:0)
[08:19:46.828] Timer tick, asking Buildbucket for the build status
[08:19:46.889] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:46.889] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:12:0) after 1m0s
[08:20:46.917] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:12:0)
[08:20:46.917] Timer tick, asking Buildbucket for the build status
[08:20:46.988] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:46.988] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:13:0) after 1m0s
[08:21:47.014] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:13:0)
[08:21:47.014] Timer tick, asking Buildbucket for the build status
[08:21:47.514] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:47.514] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:14:0) after 1m0s
[08:22:47.558] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:14:0)
[08:22:47.558] Timer tick, asking Buildbucket for the build status
[08:22:47.785] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:47.785] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:15:0) after 1m0s
[08:23:47.862] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:15:0)
[08:23:47.862] Timer tick, asking Buildbucket for the build status
[08:23:47.941] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:47.941] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:16:0) after 1m0s
[08:24:48.014] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:16:0)
[08:24:48.014] Timer tick, asking Buildbucket for the build status
[08:24:48.097] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:48.097] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:17:0) after 1m0s
[08:25:48.123] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:17:0)
[08:25:48.123] Timer tick, asking Buildbucket for the build status
[08:25:48.256] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:48.256] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:18:0) after 1m0s
[08:26:48.289] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:18:0)
[08:26:48.289] Timer tick, asking Buildbucket for the build status
[08:26:48.369] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:48.369] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:19:0) after 1m0s
[08:27:48.375] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:19:0)
[08:27:48.375] Timer tick, asking Buildbucket for the build status
[08:27:48.696] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:48.696] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:20:0) after 1m0s
[08:28:48.760] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:20:0)
[08:28:48.760] Timer tick, asking Buildbucket for the build status
[08:28:48.819] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:48.819] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:21:0) after 1m0s
[08:29:48.851] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:21:0)
[08:29:48.851] Timer tick, asking Buildbucket for the build status
[08:29:49.031] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:49.032] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:22:0) after 1m0s
[08:30:49.153] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:22:0)
[08:30:49.153] Timer tick, asking Buildbucket for the build status
[08:30:49.584] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:49.584] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:23:0) after 1m0s
[08:31:49.648] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:23:0)
[08:31:49.649] Timer tick, asking Buildbucket for the build status
[08:31:49.809] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:49.809] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:24:0) after 1m0s
[08:32:49.838] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:24:0)
[08:32:49.838] Timer tick, asking Buildbucket for the build status
[08:32:49.969] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:49.969] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:25:0) after 1m0s
[08:33:49.992] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:25:0)
[08:33:49.992] Timer tick, asking Buildbucket for the build status
[08:33:50.065] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:50.065] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:26:0) after 1m0s
[08:34:50.106] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:26:0)
[08:34:50.106] Timer tick, asking Buildbucket for the build status
[08:34:50.181] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:50.181] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:27:0) after 1m0s
[08:35:50.250] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:27:0)
[08:35:50.250] Timer tick, asking Buildbucket for the build status
[08:35:50.486] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:50.486] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:28:0) after 1m0s
[08:36:50.566] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:28:0)
[08:36:50.566] Timer tick, asking Buildbucket for the build status
[08:36:50.692] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:50.692] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:29:0) after 1m0s
[08:37:50.707] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:29:0)
[08:37:50.707] Timer tick, asking Buildbucket for the build status
[08:37:50.797] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:50.797] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:30:0) after 1m0s
[08:38:50.823] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:30:0)
[08:38:50.823] Timer tick, asking Buildbucket for the build status
[08:38:50.901] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:50.901] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:31:0) after 1m0s
[08:39:50.946] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:31:0)
[08:39:50.946] Timer tick, asking Buildbucket for the build status
[08:39:51.013] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:51.013] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:32:0) after 1m0s
[08:40:50.988] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:32:0)
[08:40:50.988] Timer tick, asking Buildbucket for the build status
[08:40:51.143] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:51.143] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:33:0) after 1m0s
[08:41:51.212] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:33:0)
[08:41:51.212] Timer tick, asking Buildbucket for the build status
[08:41:51.306] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:51.306] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:34:0) after 1m0s
[08:42:51.371] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:34:0)
[08:42:51.371] Timer tick, asking Buildbucket for the build status
[08:42:51.454] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:51.454] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:35:0) after 1m0s
[08:43:51.488] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:35:0)
[08:43:51.488] Timer tick, asking Buildbucket for the build status
[08:43:51.564] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:51.564] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:36:0) after 1m0s
[08:44:51.545] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:36:0)
[08:44:51.545] Timer tick, asking Buildbucket for the build status
[08:44:51.605] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:51.605] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:37:0) after 1m0s
[08:45:51.631] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:37:0)
[08:45:51.631] Timer tick, asking Buildbucket for the build status
[08:45:51.769] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:51.769] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:38:0) after 1m0s
[08:46:51.768] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:38:0)
[08:46:51.768] Timer tick, asking Buildbucket for the build status
[08:46:51.915] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:51.915] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:39:0) after 1m0s
[08:47:51.960] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:39:0)
[08:47:51.960] Timer tick, asking Buildbucket for the build status
[08:47:52.059] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:52.059] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:40:0) after 1m0s
[08:48:52.135] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:40:0)
[08:48:52.135] Timer tick, asking Buildbucket for the build status
[08:48:52.259] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:52.259] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:41:0) after 1m0s
[08:49:52.250] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:41:0)
[08:49:52.250] Timer tick, asking Buildbucket for the build status
[08:49:52.323] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:52.323] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:42:0) after 1m0s
[08:50:52.393] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:42:0)
[08:50:52.393] Timer tick, asking Buildbucket for the build status
[08:50:52.717] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:52.717] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:43:0) after 1m0s
[08:51:52.757] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:43:0)
[08:51:52.757] Timer tick, asking Buildbucket for the build status
[08:51:52.891] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:52.891] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:44:0) after 1m0s
[08:52:53.031] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:44:0)
[08:52:53.031] Timer tick, asking Buildbucket for the build status
[08:52:53.178] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:53.178] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:45:0) after 1m0s
[08:53:53.212] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:45:0)
[08:53:53.212] Timer tick, asking Buildbucket for the build status
[08:53:53.443] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:53.443] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:46:0) after 1m0s
[08:54:53.503] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:46:0)
[08:54:53.503] Timer tick, asking Buildbucket for the build status
[08:54:53.892] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:53.892] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:47:0) after 1m0s
[08:55:53.964] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:47:0)
[08:55:53.964] Timer tick, asking Buildbucket for the build status
[08:55:54.111] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:54.111] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:48:0) after 1m0s
[08:56:54.139] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:48:0)
[08:56:54.139] Timer tick, asking Buildbucket for the build status
[08:56:54.216] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:54.216] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:49:0) after 1m0s
[08:57:54.253] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:49:0)
[08:57:54.253] Timer tick, asking Buildbucket for the build status
[08:57:54.418] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:54.418] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:50:0) after 1m0s
[08:58:54.457] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:50:0)
[08:58:54.457] Timer tick, asking Buildbucket for the build status
[08:58:54.609] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:54.609] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:51:0) after 1m0s
[08:59:54.641] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:51:0)
[08:59:54.641] Timer tick, asking Buildbucket for the build status
[08:59:54.699] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:54.699] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:52:0) after 1m0s
[09:00:54.733] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:52:0)
[09:00:54.733] Timer tick, asking Buildbucket for the build status
[09:00:54.902] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:54.902] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:53:0) after 1m0s
[09:01:54.925] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:53:0)
[09:01:54.925] Timer tick, asking Buildbucket for the build status
[09:01:55.248] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:55.248] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:54:0) after 1m0s
[09:02:55.273] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:54:0)
[09:02:55.273] Timer tick, asking Buildbucket for the build status
[09:02:55.461] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:55.461] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:55:0) after 1m0s
[09:03:55.547] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:55:0)
[09:03:55.547] Timer tick, asking Buildbucket for the build status
[09:03:55.621] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:55.621] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:56:0) after 1m0s
[09:04:55.711] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:56:0)
[09:04:55.711] Timer tick, asking Buildbucket for the build status
[09:04:55.763] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:55.763] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:57:0) after 1m0s
[09:05:55.760] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:57:0)
[09:05:55.760] Timer tick, asking Buildbucket for the build status
[09:05:55.898] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:55.898] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:58:0) after 1m0s
[09:06:55.925] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:58:0)
[09:06:55.925] Timer tick, asking Buildbucket for the build status
[09:06:55.999] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:55.999] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:59:0) after 1m0s
[09:07:56.037] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:59:0)
[09:07:56.037] Timer tick, asking Buildbucket for the build status
[09:07:56.114] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:56.114] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:60:0) after 1m0s
[09:08:56.245] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:60:0)
[09:08:56.245] Timer tick, asking Buildbucket for the build status
[09:08:56.441] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:56.441] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:61:0) after 1m0s
[09:09:56.547] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:61:0)
[09:09:56.547] Timer tick, asking Buildbucket for the build status
[09:09:56.639] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:56.639] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:62:0) after 1m0s
[09:10:56.740] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:62:0)
[09:10:56.740] Timer tick, asking Buildbucket for the build status
[09:10:56.870] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:56.870] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:63:0) after 1m0s
[09:11:56.920] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:63:0)
[09:11:56.920] Timer tick, asking Buildbucket for the build status
[09:11:56.994] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:56.994] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:64:0) after 1m0s
[09:12:57.018] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:64:0)
[09:12:57.018] Timer tick, asking Buildbucket for the build status
[09:12:57.226] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:57.226] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:65:0) after 1m0s
[09:13:57.252] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:65:0)
[09:13:57.253] Timer tick, asking Buildbucket for the build status
[09:13:57.408] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:57.408] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:66:0) after 1m0s
[09:14:57.432] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:66:0)
[09:14:57.432] Timer tick, asking Buildbucket for the build status
[09:14:57.507] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:57.507] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:67:0) after 1m0s
[09:15:58.111] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:67:0)
[09:15:58.111] Timer tick, asking Buildbucket for the build status
[09:15:58.385] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:58.385] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:68:0) after 1m0s
[09:16:58.409] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:68:0)
[09:16:58.409] Timer tick, asking Buildbucket for the build status
[09:16:58.489] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:58.489] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:69:0) after 1m0s
[09:17:58.552] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:69:0)
[09:17:58.552] Timer tick, asking Buildbucket for the build status
[09:17:58.613] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:58.613] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:70:0) after 1m0s
[09:18:58.667] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:70:0)
[09:18:58.667] Timer tick, asking Buildbucket for the build status
[09:18:58.832] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:58.832] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:71:0) after 1m0s
[09:19:58.853] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:71:0)
[09:19:58.853] Timer tick, asking Buildbucket for the build status
[09:19:58.932] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:58.932] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:72:0) after 1m0s
[09:20:58.956] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:72:0)
[09:20:58.956] Timer tick, asking Buildbucket for the build status
[09:20:59.176] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:59.176] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:73:0) after 1m0s
[09:21:59.238] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:73:0)
[09:21:59.238] Timer tick, asking Buildbucket for the build status
[09:21:59.315] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:59.315] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:74:0) after 1m0s
[09:22:59.362] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:74:0)
[09:22:59.362] Timer tick, asking Buildbucket for the build status
[09:22:59.478] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:59.478] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:75:0) after 1m0s
[09:23:59.539] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:75:0)
[09:23:59.539] Timer tick, asking Buildbucket for the build status
[09:23:59.612] Build 8873093291093185632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:59.612] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9038523354904103920:76:0) after 1m0s
[09:24:23.405] Received PubSub notification, asking Buildbucket for the build status
[09:24:23.501] Build 8873093291093185632: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[09:24:23.501] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1596360262778594",
"created_by": "project:chromium",
"created_ts": "1596355843415375",
"failure_reason": "BUILD_FAILURE",
"id": "8873093291093185632",
"parameters_json": "{\"builder_name\": \"ToTWinASanLibfuzzer\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a402358c2b760e55be4f4f446ed19cbae7766fe6\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"#### Step _compile_ failed. Error logs are shown below:\\n```\\n[21424/82833] ACTION //components/policy/proto:proto_library_chrome_device_policy_full_runtime_proto_gen(//build/toolchain/win:win_clang_x64)\\nFAILED: gen/components/policy/proto/fuzzer/chrome_device_policy.pb.h gen/components/policy/proto/fuzzer/chrome_device_policy.pb.cc gen/components/policy/proto/fuzzer/policy_common_definitions.pb.h gen/components/policy/proto/fuzzer/policy_common_definitions.pb.cc\\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-5-e1ew\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTWinASanLibfuzzer\", \"buildnumber\": 6161, \"clang_revision\": \"n362149-21c165de-0\", \"got_angle_revision\": \"41442cce3d0f30dbfce4d95bdda18c0faa452b43\", \"got_dawn_revision\": \"8c9858e9b8e36b8c13606b1053133ab395c03418\", \"got_nacl_revision\": \"3008f9e6de122325d8f9dbf02f7cdd51fa1ec306\", \"got_revision\": \"a402358c2b760e55be4f4f446ed19cbae7766fe6\", \"got_revision_cp\": \"refs/heads/master@{#793946}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"4568d8587998b3db6c25ba7def35105ee1c31f42\", \"got_v8_revision\": \"26aefc721cb2bbc63e070796204183c53d93abd4\", \"got_v8_revision_cp\": \"refs/heads/8.6.315@{#1}\", \"got_webrtc_revision\": \"353dcec4c1e839753875ed515e106647dc241e39\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31825}\", \"mastername\": \"chromium.clang\", \"path_config\": \"generic\", \"perf_dashboard_machine_group\": \"ChromiumClang\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a402358c2b760e55be4f4f446ed19cbae7766fe6\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_91c730c3e6ead475130e2ae78bc3f03e09cb9dcb91c3469d4450b29020110401_v2\", \"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-5-e1ew\"], \"image\": [\"chrome-win10-1703-20071600-faa8609efbc\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5436-adf7f8a\"], \"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[21424/82833] ACTION //components/policy/proto:proto_library_chrome_device_policy_full_runtime_proto_gen(//build/toolchain/win:win_clang_x64)\\nFAILED: gen/components/policy/proto/fuzzer/chrome_device_policy.pb.h gen/components/policy/proto/fuzzer/chrome_device_policy.pb.cc gen/components/policy/proto/fuzzer/policy_common_definitions.pb.h gen/components/policy/proto/fuzzer/policy_common_definitions.pb.cc\\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": "1596355850160182",
"status": "COMPLETED",
"status_changed_ts": "1596355850505175",
"tags": [
"build_address:luci.chromium.ci/ToTWinASanLibfuzzer/6161",
"builder:ToTWinASanLibfuzzer",
"buildset:commit/git/a402358c2b760e55be4f4f446ed19cbae7766fe6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a402358c2b760e55be4f4f446ed19cbae7766fe6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9038523354904103920",
"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/8873093291093185632/+/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:4dc70aa56c8ef610",
"user_agent:luci-scheduler"
],
"updated_ts": "1596360262993045",
"url": "https://ci.chromium.org/b/8873093291093185632",
"utcnow_ts": "1596360263490901"
}
}
[09:24:23.501] Invocation finished in 1h13m43.104024506s with status FAILED