[01:11:38.367] New invocation is queued and will start shortly
[01:11:39.594] Starting the invocation (attempt 1)
[01:11:39.689] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:11:39.690] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:11:39.690] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9070168059547259296",
"parameters_json": "{\"builder_name\":\"ToTWinASanLibfuzzer\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"fe111245d06132f09813117267da947c578fb9b6\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTWinASanLibfuzzer",
"scheduler_invocation_id:9070168059547259296",
"scheduler_job_id:chromium/ToTWinASanLibfuzzer",
"user_agent:luci-scheduler",
"buildset:commit/git/fe111245d06132f09813117267da947c578fb9b6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fe111245d06132f09813117267da947c578fb9b6",
"gitiles_ref:refs/heads/master"
]
}
[01:11:40.800] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1566177100069519",
"id": "8904737997076457248",
"parameters_json": "{\"builder_name\": \"ToTWinASanLibfuzzer\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"fe111245d06132f09813117267da947c578fb9b6\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1566177100700261",
"tags": [
"build_address:luci.chromium.ci/ToTWinASanLibfuzzer/3537",
"builder:ToTWinASanLibfuzzer",
"buildset:commit/git/fe111245d06132f09813117267da947c578fb9b6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fe111245d06132f09813117267da947c578fb9b6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9070168059547259296",
"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/8904737997076457248/+/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": "1566177100700407",
"url": "https://ci.chromium.org/b/8904737997076457248",
"utcnow_ts": "1566177100792464"
}
}
[01:11:40.800] Task URL: https://ci.chromium.org/b/8904737997076457248
[01:11:40.800] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:2:0) after 1m0s
[01:12:40.869] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:2:0)
[01:12:40.869] Timer tick, asking Buildbucket for the build status
[01:12:41.024] Build 8904737997076457248: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:12:41.024] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:3:0) after 1m0s
[01:13:41.047] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:3:0)
[01:13:41.047] Timer tick, asking Buildbucket for the build status
[01:13:41.226] Build 8904737997076457248: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:13:41.226] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:4:0) after 1m0s
[01:14:41.316] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:4:0)
[01:14:41.316] Timer tick, asking Buildbucket for the build status
[01:14:41.846] Build 8904737997076457248: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:14:41.846] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:5:0) after 1m0s
[01:15:03.800] Received PubSub notification, asking Buildbucket for the build status
[01:15:03.938] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:41.910] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:5:0)
[01:15:41.910] Timer tick, asking Buildbucket for the build status
[01:15:43.874] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:43.874] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:7:0) after 1m0s
[01:16:43.893] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:7:0)
[01:16:43.893] Timer tick, asking Buildbucket for the build status
[01:16:45.796] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:45.796] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:8:0) after 1m0s
[01:17:45.816] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:8:0)
[01:17:45.816] Timer tick, asking Buildbucket for the build status
[01:17:46.259] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:46.259] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:9:0) after 1m0s
[01:18:46.300] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:9:0)
[01:18:46.300] Timer tick, asking Buildbucket for the build status
[01:18:46.510] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:46.510] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:10:0) after 1m0s
[01:19:46.538] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:10:0)
[01:19:46.538] Timer tick, asking Buildbucket for the build status
[01:19:47.509] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:47.509] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:11:0) after 1m0s
[01:20:47.580] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:11:0)
[01:20:47.580] Timer tick, asking Buildbucket for the build status
[01:20:47.736] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:47.736] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:12:0) after 1m0s
[01:21:47.828] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:12:0)
[01:21:47.828] Timer tick, asking Buildbucket for the build status
[01:21:48.095] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:48.095] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:13:0) after 1m0s
[01:22:48.177] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:13:0)
[01:22:48.177] Timer tick, asking Buildbucket for the build status
[01:22:48.813] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:48.813] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:14:0) after 1m0s
[01:23:48.841] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:14:0)
[01:23:48.841] Timer tick, asking Buildbucket for the build status
[01:23:49.018] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:49.018] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:15:0) after 1m0s
[01:24:49.020] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:15:0)
[01:24:49.020] Timer tick, asking Buildbucket for the build status
[01:24:49.342] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:49.366] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:16:0) after 1m0s
[01:25:49.397] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:16:0)
[01:25:49.397] Timer tick, asking Buildbucket for the build status
[01:25:49.611] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:49.611] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:17:0) after 1m0s
[01:26:49.632] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:17:0)
[01:26:49.632] Timer tick, asking Buildbucket for the build status
[01:26:49.894] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:49.894] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:18:0) after 1m0s
[01:27:49.913] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:18:0)
[01:27:49.913] Timer tick, asking Buildbucket for the build status
[01:27:50.343] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:50.343] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:19:0) after 1m0s
[01:28:50.617] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:19:0)
[01:28:50.617] Timer tick, asking Buildbucket for the build status
[01:28:50.779] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:50.779] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:20:0) after 1m0s
[01:29:50.812] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:20:0)
[01:29:50.812] Timer tick, asking Buildbucket for the build status
[01:29:53.150] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:53.150] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:21:0) after 1m0s
[01:30:53.288] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:21:0)
[01:30:53.288] Timer tick, asking Buildbucket for the build status
[01:30:53.475] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:53.475] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:22:0) after 1m0s
[01:31:53.565] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:22:0)
[01:31:53.565] Timer tick, asking Buildbucket for the build status
[01:31:53.791] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:53.791] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:23:0) after 1m0s
[01:32:53.813] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:23:0)
[01:32:53.813] Timer tick, asking Buildbucket for the build status
[01:32:54.072] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:54.072] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:24:0) after 1m0s
[01:33:54.173] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:24:0)
[01:33:54.173] Timer tick, asking Buildbucket for the build status
[01:33:54.718] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:54.718] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:25:0) after 1m0s
[01:34:54.860] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:25:0)
[01:34:54.860] Timer tick, asking Buildbucket for the build status
[01:34:55.094] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:55.094] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:26:0) after 1m0s
[01:35:55.352] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:26:0)
[01:35:55.352] Timer tick, asking Buildbucket for the build status
[01:35:55.599] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:55.599] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:27:0) after 1m0s
[01:36:55.681] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:27:0)
[01:36:55.681] Timer tick, asking Buildbucket for the build status
[01:36:56.118] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:56.118] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:28:0) after 1m0s
[01:37:56.246] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:28:0)
[01:37:56.246] Timer tick, asking Buildbucket for the build status
[01:37:56.943] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:56.943] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:29:0) after 1m0s
[01:38:57.045] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:29:0)
[01:38:57.045] Timer tick, asking Buildbucket for the build status
[01:38:57.903] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:57.903] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:30:0) after 1m0s
[01:39:57.980] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:30:0)
[01:39:57.980] Timer tick, asking Buildbucket for the build status
[01:39:58.356] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:58.356] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:31:0) after 1m0s
[01:40:58.376] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:31:0)
[01:40:58.377] Timer tick, asking Buildbucket for the build status
[01:40:58.537] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:58.537] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:32:0) after 1m0s
[01:41:58.645] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:32:0)
[01:41:58.645] Timer tick, asking Buildbucket for the build status
[01:41:59.251] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:59.251] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:33:0) after 1m0s
[01:42:59.295] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:33:0)
[01:42:59.295] Timer tick, asking Buildbucket for the build status
[01:42:59.728] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:59.728] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:34:0) after 1m0s
[01:43:59.818] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:34:0)
[01:43:59.818] Timer tick, asking Buildbucket for the build status
[01:44:00.050] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:00.050] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:35:0) after 1m0s
[01:45:00.197] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:35:0)
[01:45:00.197] Timer tick, asking Buildbucket for the build status
[01:45:00.375] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:00.375] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:36:0) after 1m0s
[01:46:00.430] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:36:0)
[01:46:00.430] Timer tick, asking Buildbucket for the build status
[01:46:00.642] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:00.642] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:37:0) after 1m0s
[01:47:00.704] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:37:0)
[01:47:00.704] Timer tick, asking Buildbucket for the build status
[01:47:01.071] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:01.071] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:38:0) after 1m0s
[01:48:01.079] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:38:0)
[01:48:01.080] Timer tick, asking Buildbucket for the build status
[01:48:01.336] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:01.336] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:39:0) after 1m0s
[01:49:01.405] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:39:0)
[01:49:01.405] Timer tick, asking Buildbucket for the build status
[01:49:01.673] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:01.673] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:40:0) after 1m0s
[01:50:01.741] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:40:0)
[01:50:01.741] Timer tick, asking Buildbucket for the build status
[01:50:01.882] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:01.882] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:41:0) after 1m0s
[01:51:01.877] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:41:0)
[01:51:01.877] Timer tick, asking Buildbucket for the build status
[01:51:02.014] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:02.014] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:42:0) after 1m0s
[01:52:02.080] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:42:0)
[01:52:02.080] Timer tick, asking Buildbucket for the build status
[01:52:02.432] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:02.432] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:43:0) after 1m0s
[01:53:02.487] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:43:0)
[01:53:02.487] Timer tick, asking Buildbucket for the build status
[01:53:02.772] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:02.772] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:44:0) after 1m0s
[01:54:02.830] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:44:0)
[01:54:02.830] Timer tick, asking Buildbucket for the build status
[01:54:02.993] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:02.993] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:45:0) after 1m0s
[01:55:03.018] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:45:0)
[01:55:03.018] Timer tick, asking Buildbucket for the build status
[01:55:03.440] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:03.440] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:46:0) after 1m0s
[01:56:03.507] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:46:0)
[01:56:03.507] Timer tick, asking Buildbucket for the build status
[01:56:03.760] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:03.760] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:47:0) after 1m0s
[01:57:03.781] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:47:0)
[01:57:03.781] Timer tick, asking Buildbucket for the build status
[01:57:04.223] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:04.223] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:48:0) after 1m0s
[01:58:04.246] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:48:0)
[01:58:04.246] Timer tick, asking Buildbucket for the build status
[01:58:04.414] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:04.414] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:49:0) after 1m0s
[01:59:04.435] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:49:0)
[01:59:04.435] Timer tick, asking Buildbucket for the build status
[01:59:04.792] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:04.792] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:50:0) after 1m0s
[02:00:04.834] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:50:0)
[02:00:04.834] Timer tick, asking Buildbucket for the build status
[02:00:05.729] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:05.729] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:51:0) after 1m0s
[02:01:05.815] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:51:0)
[02:01:05.815] Timer tick, asking Buildbucket for the build status
[02:01:06.061] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:06.061] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:52:0) after 1m0s
[02:02:06.133] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:52:0)
[02:02:06.133] Timer tick, asking Buildbucket for the build status
[02:02:06.391] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:06.391] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:53:0) after 1m0s
[02:03:06.550] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:53:0)
[02:03:06.550] Timer tick, asking Buildbucket for the build status
[02:03:06.717] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:06.717] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:54:0) after 1m0s
[02:04:06.783] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:54:0)
[02:04:06.783] Timer tick, asking Buildbucket for the build status
[02:04:06.938] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:06.938] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:55:0) after 1m0s
[02:05:06.969] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:55:0)
[02:05:06.969] Timer tick, asking Buildbucket for the build status
[02:05:09.396] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:09.396] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:56:0) after 1m0s
[02:06:09.502] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:56:0)
[02:06:09.502] Timer tick, asking Buildbucket for the build status
[02:06:10.164] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:10.164] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:57:0) after 1m0s
[02:07:10.194] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:57:0)
[02:07:10.194] Timer tick, asking Buildbucket for the build status
[02:07:10.424] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:10.424] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:58:0) after 1m0s
[02:08:10.454] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:58:0)
[02:08:10.454] Timer tick, asking Buildbucket for the build status
[02:08:10.612] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:10.612] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:59:0) after 1m0s
[02:09:10.614] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:59:0)
[02:09:10.614] Timer tick, asking Buildbucket for the build status
[02:09:11.043] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:11.043] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:60:0) after 1m0s
[02:10:11.100] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:60:0)
[02:10:11.100] Timer tick, asking Buildbucket for the build status
[02:10:11.359] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:11.359] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:61:0) after 1m0s
[02:11:11.419] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:61:0)
[02:11:11.419] Timer tick, asking Buildbucket for the build status
[02:11:11.668] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:11.668] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:62:0) after 1m0s
[02:12:11.708] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:62:0)
[02:12:11.708] Timer tick, asking Buildbucket for the build status
[02:12:11.867] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:11.867] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:63:0) after 1m0s
[02:13:11.898] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:63:0)
[02:13:11.898] Timer tick, asking Buildbucket for the build status
[02:13:12.059] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:12.059] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:64:0) after 1m0s
[02:14:12.076] Handling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:64:0)
[02:14:12.076] Timer tick, asking Buildbucket for the build status
[02:14:12.214] Build 8904737997076457248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:12.214] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinASanLibfuzzer:9070168059547259296:65:0) after 1m0s
[02:14:19.464] Received PubSub notification, asking Buildbucket for the build status
[02:14:19.562] Build 8904737997076457248: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[02:14:19.562] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1566180859056894",
"created_by": "project:chromium",
"created_ts": "1566177100069519",
"failure_reason": "BUILD_FAILURE",
"id": "8904737997076457248",
"parameters_json": "{\"builder_name\": \"ToTWinASanLibfuzzer\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"fe111245d06132f09813117267da947c578fb9b6\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"#### Step _compile_ failed. Error logs are shown below:\\n```\\n[7024/61681] CXX obj/third_party/angle/third_party/vulkan-tools/VkICD_mock_icd/mock_icd.obj\\nFAILED: obj/third_party/angle/third_party/vulkan-tools/VkICD_mock_icd/mock_icd.obj\\n..\\\\..\\\\third_party\\\\llvm-build\\\\Release+Asserts\\\\bin\\\\clang-cl.exe /nologo /showIncludes -imsvc..\\\\..\\\\thir...(too long)\\ngen/third_party/angle/third_party/vulkan-tools/angle/vulkan/mock_icd.cpp(102,42): error: result of '2^32' is 34; did you mean '1LL \u003c\u003c 32'? [-Werror,-Wxor-used-as-pow]\\nlimits-\u003emaxDrawIndexedIndexValue = (2^32) - 1;\\n~^~~\\n1LL \u003c\u003c 32\\ngen/third_party/angle/third_party/vulkan-tools/angle/vulkan/mock_icd.cpp(102,42): note: replace expression with '0x2 ^ 32' to silence this warning\\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-843b\", \"branch\": \"refs/heads/master\", \"buildername\": \"ToTWinASanLibfuzzer\", \"buildnumber\": 3537, \"got_angle_revision\": \"265fdf0c5fd6b1e28a54c18ca40a8461c7f449a7\", \"got_clang_revision\": \"369226-2eb7951d-0\", \"got_dawn_revision\": \"ee3de1e1f3da2386197a2c586304deb263890a35\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"fe111245d06132f09813117267da947c578fb9b6\", \"got_revision_cp\": \"refs/heads/master@{#687984}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"7b861aca66ea8080a32eba6217f8833cdcc32a09\", \"got_v8_revision_cp\": \"refs/heads/7.8.113@{#1}\", \"got_webrtc_revision\": \"f5e5d250bc85616e74487f8330ed8d99cc9cf84f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28880}\", \"mastername\": \"chromium.clang\", \"path_config\": \"generic\", \"perf_dashboard_machine_group\": \"ChromiumClang\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"fe111245d06132f09813117267da947c578fb9b6\"}, \"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-5-843b\"], \"image\": [\"chrome-win10-1703-19072400-fedda89f1f1\"], \"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\": [\"4397-8786906\"], \"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[7024/61681] CXX obj/third_party/angle/third_party/vulkan-tools/VkICD_mock_icd/mock_icd.obj\\nFAILED: obj/third_party/angle/third_party/vulkan-tools/VkICD_mock_icd/mock_icd.obj\\n..\\\\..\\\\third_party\\\\llvm-build\\\\Release+Asserts\\\\bin\\\\clang-cl.exe /nologo /showIncludes -imsvc..\\\\..\\\\thir...(too long)\\ngen/third_party/angle/third_party/vulkan-tools/angle/vulkan/mock_icd.cpp(102,42): error: result of '2^32' is 34; did you mean '1LL \u003c\u003c 32'? [-Werror,-Wxor-used-as-pow]\\nlimits-\u003emaxDrawIndexedIndexValue = (2^32) - 1;\\n~^~~\\n1LL \u003c\u003c 32\\ngen/third_party/angle/third_party/vulkan-tools/angle/vulkan/mock_icd.cpp(102,42): note: replace expression with '0x2 ^ 32' to silence this warning\\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": "1566177302790861",
"status": "COMPLETED",
"status_changed_ts": "1566177303406487",
"tags": [
"build_address:luci.chromium.ci/ToTWinASanLibfuzzer/3537",
"builder:ToTWinASanLibfuzzer",
"buildset:commit/git/fe111245d06132f09813117267da947c578fb9b6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fe111245d06132f09813117267da947c578fb9b6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9070168059547259296",
"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/8904737997076457248/+/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:46c03f8ca575de10",
"user_agent:luci-scheduler"
],
"updated_ts": "1566180859105297",
"url": "https://ci.chromium.org/b/8904737997076457248",
"utcnow_ts": "1566180859556058"
}
}
[02:14:19.562] Invocation finished in 1h2m41.233098316s with status FAILED