[22:00:00.760] New invocation is queued and will start shortly
[22:00:02.096] Starting the invocation (attempt 1)
[22:00:02.134] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:00:02.134] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:00:02.134] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030951629188478960",
"parameters_json": "{\"builder_name\":\"ToTWinASanLibfuzzer\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d70238178796c63ee5a04db0586eca9602088114\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTWinASanLibfuzzer",
"scheduler_invocation_id:9030951629188478960",
"scheduler_job_id:chromium/ToTWinASanLibfuzzer",
"user_agent:luci-scheduler",
"buildset:commit/git/d70238178796c63ee5a04db0586eca9602088114",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d70238178796c63ee5a04db0586eca9602088114",
"gitiles_ref:refs/heads/master"
]
}
[22:00:04.500] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603576803547802",
"id": "8865521565602292416",
"parameters_json": "{\"builder_name\": \"ToTWinASanLibfuzzer\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d70238178796c63ee5a04db0586eca9602088114\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603576804300568",
"tags": [
"build_address:luci.chromium.ci/ToTWinASanLibfuzzer/6901",
"builder:ToTWinASanLibfuzzer",
"buildset:commit/git/d70238178796c63ee5a04db0586eca9602088114",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d70238178796c63ee5a04db0586eca9602088114",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030951629188478960",
"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/8865521565602292416/+/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": "1603576804301565",
"url": "https://ci.chromium.org/b/8865521565602292416",
"utcnow_ts": "1603576804486196"
}
}
[22:00:04.500] Task URL: https://ci.chromium.org/b/8865521565602292416
[22:00:04.500] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:2:0) after 1m0s
[22:00:35.728] Received PubSub notification, asking Buildbucket for the build status
[22:00:35.809] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:04.620] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:2:0)
[22:01:04.620] Timer tick, asking Buildbucket for the build status
[22:01:04.722] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:04.722] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:4:0) after 1m0s
[22:02:04.754] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:4:0)
[22:02:04.754] Timer tick, asking Buildbucket for the build status
[22:02:05.276] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:05.276] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:5:0) after 1m0s
[22:03:05.345] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:5:0)
[22:03:05.345] Timer tick, asking Buildbucket for the build status
[22:03:05.542] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:05.542] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:6:0) after 1m0s
[22:04:05.580] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:6:0)
[22:04:05.580] Timer tick, asking Buildbucket for the build status
[22:04:05.661] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:05.662] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:7:0) after 1m0s
[22:05:05.661] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:7:0)
[22:05:05.661] Timer tick, asking Buildbucket for the build status
[22:05:05.730] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:05.730] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:8:0) after 1m0s
[22:06:05.784] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:8:0)
[22:06:05.784] Timer tick, asking Buildbucket for the build status
[22:06:06.463] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:06.464] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:9:0) after 1m0s
[22:07:06.486] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:9:0)
[22:07:06.486] Timer tick, asking Buildbucket for the build status
[22:07:06.819] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:06.819] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:10:0) after 1m0s
[22:08:06.837] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:10:0)
[22:08:06.837] Timer tick, asking Buildbucket for the build status
[22:08:06.903] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:06.903] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:11:0) after 1m0s
[22:09:06.917] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:11:0)
[22:09:06.917] Timer tick, asking Buildbucket for the build status
[22:09:07.015] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:07.015] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:12:0) after 1m0s
[22:10:07.057] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:12:0)
[22:10:07.057] Timer tick, asking Buildbucket for the build status
[22:10:07.301] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:07.301] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:13:0) after 1m0s
[22:11:07.324] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:13:0)
[22:11:07.324] Timer tick, asking Buildbucket for the build status
[22:11:07.435] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:07.435] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:14:0) after 1m0s
[22:12:07.457] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:14:0)
[22:12:07.457] Timer tick, asking Buildbucket for the build status
[22:12:07.518] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:07.518] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:15:0) after 1m0s
[22:13:07.592] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:15:0)
[22:13:07.593] Timer tick, asking Buildbucket for the build status
[22:13:07.804] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:07.804] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:16:0) after 1m0s
[22:14:07.885] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:16:0)
[22:14:07.885] Timer tick, asking Buildbucket for the build status
[22:14:07.951] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:07.951] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:17:0) after 1m0s
[22:15:07.973] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:17:0)
[22:15:07.973] Timer tick, asking Buildbucket for the build status
[22:15:08.391] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:08.391] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:18:0) after 1m0s
[22:16:08.415] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:18:0)
[22:16:08.415] Timer tick, asking Buildbucket for the build status
[22:16:08.587] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:08.587] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:19:0) after 1m0s
[22:17:08.652] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:19:0)
[22:17:08.652] Timer tick, asking Buildbucket for the build status
[22:17:08.713] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:08.713] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:20:0) after 1m0s
[22:18:08.746] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:20:0)
[22:18:08.746] Timer tick, asking Buildbucket for the build status
[22:18:08.815] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:08.815] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:21:0) after 1m0s
[22:19:08.839] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:21:0)
[22:19:08.839] Timer tick, asking Buildbucket for the build status
[22:19:08.901] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:08.901] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:22:0) after 1m0s
[22:20:08.924] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:22:0)
[22:20:08.924] Timer tick, asking Buildbucket for the build status
[22:20:09.222] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:09.222] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:23:0) after 1m0s
[22:21:09.292] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:23:0)
[22:21:09.292] Timer tick, asking Buildbucket for the build status
[22:21:09.364] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:09.364] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:24:0) after 1m0s
[22:22:09.389] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:24:0)
[22:22:09.389] Timer tick, asking Buildbucket for the build status
[22:22:09.610] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:09.610] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:25:0) after 1m0s
[22:23:09.604] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:25:0)
[22:23:09.604] Timer tick, asking Buildbucket for the build status
[22:23:09.673] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:09.673] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:26:0) after 1m0s
[22:24:09.707] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:26:0)
[22:24:09.707] Timer tick, asking Buildbucket for the build status
[22:24:09.765] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:09.765] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:27:0) after 1m0s
[22:25:09.823] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:27:0)
[22:25:09.823] Timer tick, asking Buildbucket for the build status
[22:25:09.935] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:09.935] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:28:0) after 1m0s
[22:26:10.015] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:28:0)
[22:26:10.015] Timer tick, asking Buildbucket for the build status
[22:26:10.076] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:10.076] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:29:0) after 1m0s
[22:27:10.128] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:29:0)
[22:27:10.128] Timer tick, asking Buildbucket for the build status
[22:27:10.302] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:10.302] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:30:0) after 1m0s
[22:28:10.354] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:30:0)
[22:28:10.354] Timer tick, asking Buildbucket for the build status
[22:28:10.422] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:10.422] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:31:0) after 1m0s
[22:29:10.402] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:31:0)
[22:29:10.402] Timer tick, asking Buildbucket for the build status
[22:29:10.460] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:10.460] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:32:0) after 1m0s
[22:30:10.483] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:32:0)
[22:30:10.483] Timer tick, asking Buildbucket for the build status
[22:30:10.584] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:10.584] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:33:0) after 1m0s
[22:31:10.611] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:33:0)
[22:31:10.611] Timer tick, asking Buildbucket for the build status
[22:31:10.681] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:10.681] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:34:0) after 1m0s
[22:32:10.700] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:34:0)
[22:32:10.700] Timer tick, asking Buildbucket for the build status
[22:32:10.772] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:10.772] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:35:0) after 1m0s
[22:33:10.799] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:35:0)
[22:33:10.799] Timer tick, asking Buildbucket for the build status
[22:33:10.870] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:10.870] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:36:0) after 1m0s
[22:34:10.899] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:36:0)
[22:34:10.899] Timer tick, asking Buildbucket for the build status
[22:34:11.113] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:11.113] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:37:0) after 1m0s
[22:35:11.171] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:37:0)
[22:35:11.171] Timer tick, asking Buildbucket for the build status
[22:35:11.285] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:11.285] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:38:0) after 1m0s
[22:36:11.353] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:38:0)
[22:36:11.353] Timer tick, asking Buildbucket for the build status
[22:36:11.423] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:11.423] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:39:0) after 1m0s
[22:37:11.549] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:39:0)
[22:37:11.549] Timer tick, asking Buildbucket for the build status
[22:37:12.000] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:12.000] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:40:0) after 1m0s
[22:38:12.028] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:40:0)
[22:38:12.028] Timer tick, asking Buildbucket for the build status
[22:38:12.293] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:12.293] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:41:0) after 1m0s
[22:39:12.353] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:41:0)
[22:39:12.353] Timer tick, asking Buildbucket for the build status
[22:39:12.457] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:12.457] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:42:0) after 1m0s
[22:40:12.494] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:42:0)
[22:40:12.494] Timer tick, asking Buildbucket for the build status
[22:40:12.604] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:12.604] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:43:0) after 1m0s
[22:41:12.667] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:43:0)
[22:41:12.667] Timer tick, asking Buildbucket for the build status
[22:41:12.789] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:12.789] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:44:0) after 1m0s
[22:42:12.824] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:44:0)
[22:42:12.824] Timer tick, asking Buildbucket for the build status
[22:42:12.961] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:12.961] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:45:0) after 1m0s
[22:43:13.045] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:45:0)
[22:43:13.045] Timer tick, asking Buildbucket for the build status
[22:43:13.315] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:13.315] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:46:0) after 1m0s
[22:44:13.348] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:46:0)
[22:44:13.348] Timer tick, asking Buildbucket for the build status
[22:44:13.416] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:13.417] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:47:0) after 1m0s
[22:45:13.487] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:47:0)
[22:45:13.487] Timer tick, asking Buildbucket for the build status
[22:45:13.608] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:13.608] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:48:0) after 1m0s
[22:46:13.628] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:48:0)
[22:46:13.628] Timer tick, asking Buildbucket for the build status
[22:46:13.846] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:13.846] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:49:0) after 1m0s
[22:47:13.925] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:49:0)
[22:47:13.925] Timer tick, asking Buildbucket for the build status
[22:47:14.043] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:14.043] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:50:0) after 1m0s
[22:48:14.063] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:50:0)
[22:48:14.063] Timer tick, asking Buildbucket for the build status
[22:48:14.208] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:14.208] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:51:0) after 1m0s
[22:49:14.187] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:51:0)
[22:49:14.187] Timer tick, asking Buildbucket for the build status
[22:49:14.296] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:14.297] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:52:0) after 1m0s
[22:50:14.321] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:52:0)
[22:50:14.321] Timer tick, asking Buildbucket for the build status
[22:50:14.431] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:14.431] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:53:0) after 1m0s
[22:51:14.517] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:53:0)
[22:51:14.517] Timer tick, asking Buildbucket for the build status
[22:51:14.591] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:14.591] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:54:0) after 1m0s
[22:52:14.806] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:54:0)
[22:52:14.806] Timer tick, asking Buildbucket for the build status
[22:52:14.869] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:14.869] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:55:0) after 1m0s
[22:53:14.938] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:55:0)
[22:53:14.938] Timer tick, asking Buildbucket for the build status
[22:53:14.999] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:14.999] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:56:0) after 1m0s
[22:54:15.117] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:56:0)
[22:54:15.117] Timer tick, asking Buildbucket for the build status
[22:54:15.181] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:15.181] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:57:0) after 1m0s
[22:55:15.206] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:57:0)
[22:55:15.206] Timer tick, asking Buildbucket for the build status
[22:55:15.303] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:15.303] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:58:0) after 1m0s
[22:56:15.348] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:58:0)
[22:56:15.348] Timer tick, asking Buildbucket for the build status
[22:56:15.779] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:15.780] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:59:0) after 1m0s
[22:57:16.103] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:59:0)
[22:57:16.103] Timer tick, asking Buildbucket for the build status
[22:57:16.185] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:16.185] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:60:0) after 1m0s
[22:58:16.261] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:60:0)
[22:58:16.261] Timer tick, asking Buildbucket for the build status
[22:58:16.351] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:16.351] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:61:0) after 1m0s
[22:59:16.399] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:61:0)
[22:59:16.399] Timer tick, asking Buildbucket for the build status
[22:59:16.460] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:16.460] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:62:0) after 1m0s
[23:00:16.598] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:62:0)
[23:00:16.598] Timer tick, asking Buildbucket for the build status
[23:00:16.874] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:16.874] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:63:0) after 1m0s
[23:01:17.009] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:63:0)
[23:01:17.009] Timer tick, asking Buildbucket for the build status
[23:01:17.109] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:17.109] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:64:0) after 1m0s
[23:02:17.234] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:64:0)
[23:02:17.234] Timer tick, asking Buildbucket for the build status
[23:02:17.316] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:17.316] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:65:0) after 1m0s
[23:03:17.479] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:65:0)
[23:03:17.479] Timer tick, asking Buildbucket for the build status
[23:03:17.538] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:17.538] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:66:0) after 1m0s
[23:04:17.561] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:66:0)
[23:04:17.561] Timer tick, asking Buildbucket for the build status
[23:04:17.686] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:17.686] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:67:0) after 1m0s
[23:05:17.748] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:67:0)
[23:05:17.748] Timer tick, asking Buildbucket for the build status
[23:05:17.868] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:17.868] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:68:0) after 1m0s
[23:06:17.940] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:68:0)
[23:06:17.941] Timer tick, asking Buildbucket for the build status
[23:06:18.042] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:18.042] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:69:0) after 1m0s
[23:07:18.161] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:69:0)
[23:07:18.161] Timer tick, asking Buildbucket for the build status
[23:07:18.241] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:18.241] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:70:0) after 1m0s
[23:08:18.269] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:70:0)
[23:08:18.269] Timer tick, asking Buildbucket for the build status
[23:08:18.344] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:18.344] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:71:0) after 1m0s
[23:09:19.699] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:71:0)
[23:09:19.699] Timer tick, asking Buildbucket for the build status
[23:09:19.757] Build 8865521565602292416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:19.757] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9030951629188478960:72:0) after 1m0s
[23:10:05.964] Received PubSub notification, asking Buildbucket for the build status
[23:10:06.029] Build 8865521565602292416: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[23:10:06.029] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603581005686199",
"created_by": "project:chromium",
"created_ts": "1603576803547802",
"failure_reason": "BUILD_FAILURE",
"id": "8865521565602292416",
"parameters_json": "{\"builder_name\": \"ToTWinASanLibfuzzer\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d70238178796c63ee5a04db0586eca9602088114\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"#### Step _compile_ failed. Error logs are shown below:\\n```\\n[10262/66494] ACTION //components/policy:proto_library_cloud_policy_full_runtime_proto_gen(//build/toolchain/win:win_clang_x64)\\nFAILED: gen/components/policy/proto/fuzzer/cloud_policy.pb.h gen/components/policy/proto/fuzzer/cloud_policy.pb.cc\\nC:\\\\b\\\\s\\\\w\\\\ir\\\\cipd_bin_packages\\\\cpython\\\\bin\\\\python.exe ../../tools/protoc_wrapper/protoc_wrapper.py cloud_policy.proto --protoc ./protoc.exe --proto-in-dir gen/components/policy/proto --plugin override_lite_runtime_plugin.exe --plugin-out-dir gen/components/policy/proto/fuzzer --import-dir=../../components/policy/proto\\ngen/components/policy/proto/fuzzer/policy_common_definitions.pb.cc: Invalid argumentProtoc has returned non-zero status: 1\\n```\\n#### More information in raw_io.output[failure_summary]\"}, \"properties\": {\"$build/goma\": {\"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"d70238178796c63ee5a04db0586eca9602088114\", \"project\": \"chromium/src\"}], \"$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-6-63si\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.clang\", \"buildername\": \"ToTWinASanLibfuzzer\", \"buildnumber\": 6901, \"clang_revision\": \"llvmorg-12-init-9622-g1e09dbb6-0\", \"got_angle_revision\": \"7a0263547cda936b320d80c650b69d7522ee1a9f\", \"got_dawn_revision\": \"42103bc2e911144745d8d8930b07ba7e58553a34\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"d70238178796c63ee5a04db0586eca9602088114\", \"got_revision_cp\": \"refs/heads/master@{#820588}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"73fe59b55662be0ff07e79da1ece8b9e42415dca\", \"got_v8_revision_cp\": \"refs/heads/8.8.171@{#1}\", \"got_webrtc_revision\": \"3065e6ef3016a906d1db82e1d4322cbd53d43247\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32481}\", \"path_config\": \"generic\", \"perf_dashboard_machine_group\": \"ChromiumClang\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d70238178796c63ee5a04db0586eca9602088114\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_91c730c3e6ead475130e2ae78bc3f03e09cb9dcb91c3469d4450b29020110401_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-6-63si\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"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\": [\"5612-26d29a7\"], \"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[10262/66494] ACTION //components/policy:proto_library_cloud_policy_full_runtime_proto_gen(//build/toolchain/win:win_clang_x64)\\nFAILED: gen/components/policy/proto/fuzzer/cloud_policy.pb.h gen/components/policy/proto/fuzzer/cloud_policy.pb.cc\\nC:\\\\b\\\\s\\\\w\\\\ir\\\\cipd_bin_packages\\\\cpython\\\\bin\\\\python.exe ../../tools/protoc_wrapper/protoc_wrapper.py cloud_policy.proto --protoc ./protoc.exe --proto-in-dir gen/components/policy/proto --plugin override_lite_runtime_plugin.exe --plugin-out-dir gen/components/policy/proto/fuzzer --import-dir=../../components/policy/proto\\ngen/components/policy/proto/fuzzer/policy_common_definitions.pb.cc: Invalid argumentProtoc has returned non-zero status: 1\\n```\\n#### More information in raw_io.output[failure_summary]\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603576834889448",
"status": "COMPLETED",
"status_changed_ts": "1603576835247487",
"tags": [
"build_address:luci.chromium.ci/ToTWinASanLibfuzzer/6901",
"builder:ToTWinASanLibfuzzer",
"buildset:commit/git/d70238178796c63ee5a04db0586eca9602088114",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d70238178796c63ee5a04db0586eca9602088114",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030951629188478960",
"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/8865521565602292416/+/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:4f7571be28ca2710",
"user_agent:luci-scheduler"
],
"updated_ts": "1603581005743362",
"url": "https://ci.chromium.org/b/8865521565602292416",
"utcnow_ts": "1603581006022077"
}
}
[23:10:06.029] Invocation finished in 1h10m5.285473444s with status FAILED