[04:59:26.697] New invocation is queued and will start shortly
[04:59:27.746] Starting the invocation (attempt 1)
[04:59:27.788] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:59:27.788] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:59:27.788] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023133901680228928",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"17a7d1fcce21b4c20023ec0a5e52aedf16dbdf09\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9023133901680228928",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/17a7d1fcce21b4c20023ec0a5e52aedf16dbdf09",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/17a7d1fcce21b4c20023ec0a5e52aedf16dbdf09",
"gitiles_ref:refs/heads/master"
]
}
[04:59:28.559] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611032367880080",
"id": "8857703839776391056",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"17a7d1fcce21b4c20023ec0a5e52aedf16dbdf09\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611032368306471",
"tags": [
"build_address:luci.chromium.ci/win-asan/16885",
"builder:win-asan",
"buildset:commit/git/17a7d1fcce21b4c20023ec0a5e52aedf16dbdf09",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/17a7d1fcce21b4c20023ec0a5e52aedf16dbdf09",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023133901680228928",
"scheduler_job_id:chromium/win-asan",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8857703839776391056/+/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": "1611032368306738",
"url": "https://ci.chromium.org/b/8857703839776391056",
"utcnow_ts": "1611032368498466"
}
}
[04:59:28.560] Task URL: https://ci.chromium.org/b/8857703839776391056
[04:59:28.560] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:2:0) after 1m0s
[04:59:30.566] Received PubSub notification, asking Buildbucket for the build status
[04:59:30.637] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:28.745] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:2:0)
[05:00:28.745] Timer tick, asking Buildbucket for the build status
[05:00:28.984] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:28.985] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:4:0) after 1m0s
[05:01:29.084] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:4:0)
[05:01:29.084] Timer tick, asking Buildbucket for the build status
[05:01:29.504] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:29.504] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:5:0) after 1m0s
[05:02:29.618] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:5:0)
[05:02:29.618] Timer tick, asking Buildbucket for the build status
[05:02:29.708] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:29.708] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:6:0) after 1m0s
[05:03:29.719] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:6:0)
[05:03:29.719] Timer tick, asking Buildbucket for the build status
[05:03:30.408] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:30.408] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:7:0) after 1m0s
[05:04:30.431] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:7:0)
[05:04:30.431] Timer tick, asking Buildbucket for the build status
[05:04:30.612] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:30.612] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:8:0) after 1m0s
[05:05:30.745] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:8:0)
[05:05:30.745] Timer tick, asking Buildbucket for the build status
[05:05:30.814] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:30.814] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:9:0) after 1m0s
[05:06:30.914] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:9:0)
[05:06:30.914] Timer tick, asking Buildbucket for the build status
[05:06:30.978] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:30.978] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:10:0) after 1m0s
[05:07:30.973] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:10:0)
[05:07:30.973] Timer tick, asking Buildbucket for the build status
[05:07:31.071] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:31.071] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:11:0) after 1m0s
[05:08:31.113] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:11:0)
[05:08:31.113] Timer tick, asking Buildbucket for the build status
[05:08:31.219] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:31.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:12:0) after 1m0s
[05:09:31.292] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:12:0)
[05:09:31.292] Timer tick, asking Buildbucket for the build status
[05:09:31.411] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:31.411] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:13:0) after 1m0s
[05:10:31.468] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:13:0)
[05:10:31.468] Timer tick, asking Buildbucket for the build status
[05:10:31.779] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:31.779] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:14:0) after 1m0s
[05:11:31.826] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:14:0)
[05:11:31.826] Timer tick, asking Buildbucket for the build status
[05:11:31.881] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:31.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:15:0) after 1m0s
[05:12:31.926] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:15:0)
[05:12:31.926] Timer tick, asking Buildbucket for the build status
[05:12:32.060] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:32.060] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:16:0) after 1m0s
[05:13:32.046] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:16:0)
[05:13:32.046] Timer tick, asking Buildbucket for the build status
[05:13:32.170] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:32.170] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:17:0) after 1m0s
[05:14:32.181] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:17:0)
[05:14:32.181] Timer tick, asking Buildbucket for the build status
[05:14:32.318] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:32.318] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:18:0) after 1m0s
[05:15:32.423] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:18:0)
[05:15:32.423] Timer tick, asking Buildbucket for the build status
[05:15:32.550] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:32.550] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:19:0) after 1m0s
[05:16:32.574] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:19:0)
[05:16:32.574] Timer tick, asking Buildbucket for the build status
[05:16:32.828] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:32.828] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:20:0) after 1m0s
[05:17:32.885] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:20:0)
[05:17:32.885] Timer tick, asking Buildbucket for the build status
[05:17:32.977] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:32.977] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:21:0) after 1m0s
[05:18:33.094] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:21:0)
[05:18:33.094] Timer tick, asking Buildbucket for the build status
[05:18:33.216] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:33.216] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:22:0) after 1m0s
[05:19:33.393] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:22:0)
[05:19:33.393] Timer tick, asking Buildbucket for the build status
[05:19:33.505] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:33.505] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:23:0) after 1m0s
[05:20:33.599] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:23:0)
[05:20:33.599] Timer tick, asking Buildbucket for the build status
[05:20:33.696] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:33.696] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:24:0) after 1m0s
[05:21:33.745] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:24:0)
[05:21:33.745] Timer tick, asking Buildbucket for the build status
[05:21:33.879] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:33.879] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:25:0) after 1m0s
[05:22:33.925] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:25:0)
[05:22:33.925] Timer tick, asking Buildbucket for the build status
[05:22:34.033] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:34.033] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:26:0) after 1m0s
[05:23:34.086] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:26:0)
[05:23:34.086] Timer tick, asking Buildbucket for the build status
[05:23:34.163] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:34.163] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:27:0) after 1m0s
[05:24:34.220] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:27:0)
[05:24:34.220] Timer tick, asking Buildbucket for the build status
[05:24:34.340] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:34.340] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:28:0) after 1m0s
[05:25:34.363] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:28:0)
[05:25:34.363] Timer tick, asking Buildbucket for the build status
[05:25:34.625] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:34.625] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:29:0) after 1m0s
[05:26:34.650] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:29:0)
[05:26:34.650] Timer tick, asking Buildbucket for the build status
[05:26:34.743] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:34.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:30:0) after 1m0s
[05:27:34.804] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:30:0)
[05:27:34.804] Timer tick, asking Buildbucket for the build status
[05:27:34.879] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:34.879] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:31:0) after 1m0s
[05:28:34.899] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:31:0)
[05:28:34.899] Timer tick, asking Buildbucket for the build status
[05:28:35.018] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:35.018] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:32:0) after 1m0s
[05:29:35.047] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:32:0)
[05:29:35.047] Timer tick, asking Buildbucket for the build status
[05:29:35.255] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:35.255] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:33:0) after 1m0s
[05:30:35.311] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:33:0)
[05:30:35.312] Timer tick, asking Buildbucket for the build status
[05:30:35.376] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:35.376] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:34:0) after 1m0s
[05:31:35.356] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:34:0)
[05:31:35.356] Timer tick, asking Buildbucket for the build status
[05:31:35.709] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:35.709] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:35:0) after 1m0s
[05:32:35.767] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:35:0)
[05:32:35.767] Timer tick, asking Buildbucket for the build status
[05:32:36.013] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:36.013] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:36:0) after 1m0s
[05:33:36.095] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:36:0)
[05:33:36.095] Timer tick, asking Buildbucket for the build status
[05:33:36.178] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:36.178] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:37:0) after 1m0s
[05:34:36.199] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:37:0)
[05:34:36.199] Timer tick, asking Buildbucket for the build status
[05:34:36.443] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:36.443] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:38:0) after 1m0s
[05:35:36.606] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:38:0)
[05:35:36.606] Timer tick, asking Buildbucket for the build status
[05:35:36.796] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:36.797] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:39:0) after 1m0s
[05:36:36.924] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:39:0)
[05:36:36.924] Timer tick, asking Buildbucket for the build status
[05:36:37.567] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:37.567] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:40:0) after 1m0s
[05:37:37.598] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:40:0)
[05:37:37.598] Timer tick, asking Buildbucket for the build status
[05:37:37.882] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:37.882] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:41:0) after 1m0s
[05:38:37.925] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:41:0)
[05:38:37.925] Timer tick, asking Buildbucket for the build status
[05:38:38.254] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:38.254] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:42:0) after 1m0s
[05:39:38.279] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:42:0)
[05:39:38.279] Timer tick, asking Buildbucket for the build status
[05:39:38.382] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:38.382] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:43:0) after 1m0s
[05:40:38.413] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:43:0)
[05:40:38.413] Timer tick, asking Buildbucket for the build status
[05:40:38.759] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:38.759] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:44:0) after 1m0s
[05:41:38.942] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:44:0)
[05:41:38.942] Timer tick, asking Buildbucket for the build status
[05:41:39.085] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:39.085] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:45:0) after 1m0s
[05:42:39.192] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:45:0)
[05:42:39.192] Timer tick, asking Buildbucket for the build status
[05:42:39.305] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:39.305] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:46:0) after 1m0s
[05:43:39.290] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:46:0)
[05:43:39.290] Timer tick, asking Buildbucket for the build status
[05:43:39.671] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:39.671] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:47:0) after 1m0s
[05:44:39.764] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:47:0)
[05:44:39.764] Timer tick, asking Buildbucket for the build status
[05:44:39.880] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:39.880] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:48:0) after 1m0s
[05:45:39.933] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:48:0)
[05:45:39.933] Timer tick, asking Buildbucket for the build status
[05:45:39.993] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:39.993] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:49:0) after 1m0s
[05:46:40.015] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:49:0)
[05:46:40.015] Timer tick, asking Buildbucket for the build status
[05:46:40.419] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:40.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:50:0) after 1m0s
[05:47:40.445] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:50:0)
[05:47:40.445] Timer tick, asking Buildbucket for the build status
[05:47:40.513] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:40.513] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:51:0) after 1m0s
[05:48:40.563] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:51:0)
[05:48:40.563] Timer tick, asking Buildbucket for the build status
[05:48:40.633] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:40.633] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:52:0) after 1m0s
[05:49:40.677] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:52:0)
[05:49:40.677] Timer tick, asking Buildbucket for the build status
[05:49:41.009] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:41.009] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:53:0) after 1m0s
[05:50:41.068] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:53:0)
[05:50:41.068] Timer tick, asking Buildbucket for the build status
[05:50:41.173] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:41.173] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:54:0) after 1m0s
[05:51:41.232] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:54:0)
[05:51:41.232] Timer tick, asking Buildbucket for the build status
[05:51:41.590] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:41.590] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:55:0) after 1m0s
[05:52:41.592] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:55:0)
[05:52:41.592] Timer tick, asking Buildbucket for the build status
[05:52:41.872] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:41.872] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:56:0) after 1m0s
[05:53:41.861] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:56:0)
[05:53:41.861] Timer tick, asking Buildbucket for the build status
[05:53:41.986] Build 8857703839776391056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:41.986] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023133901680228928:57:0) after 1m0s
[05:53:49.333] Received PubSub notification, asking Buildbucket for the build status
[05:53:49.409] Build 8857703839776391056: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:53:49.409] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611035628723002",
"created_by": "project:chromium",
"created_ts": "1611032367880080",
"id": "8857703839776391056",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"17a7d1fcce21b4c20023ec0a5e52aedf16dbdf09\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"17a7d1fcce21b4c20023ec0a5e52aedf16dbdf09\", \"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-0-nszv\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16885, \"clang_revision\": \"llvmorg-12-init-16296-g5e476061-2\", \"got_angle_revision\": \"5635dbb91641a72f1f713aa7c179e2432674f9c3\", \"got_dawn_revision\": \"4b316994ad01ab6b87032c5fd9b53c6d18956d8d\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"17a7d1fcce21b4c20023ec0a5e52aedf16dbdf09\", \"got_revision_cp\": \"refs/heads/master@{#844668}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"8da0f82baf359e2b91464f111306a094f86fe71b\", \"got_v8_revision\": \"ee927aaa58e688ad6aa0256b3929c1eeea0bebd5\", \"got_v8_revision_cp\": \"refs/heads/9.0.8@{#1}\", \"got_webrtc_revision\": \"29bd8638adb0a7294f7b8ae589fdd24077539dbb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33030}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.win:win-asan\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"17a7d1fcce21b4c20023ec0a5e52aedf16dbdf09\", \"swarm_hashes_refs/heads/master(at){#844668}_without_patch\": {\"absl_hardening_tests\": \"ebfef63da7acc9e3e703c5bddec9f85f6be79f09\", \"accessibility_unittests\": \"eafd9269836f0879456e826c283da3d433f06685\", \"angle_unittests\": \"369849bffdf16ccadb3a52c20a11d84e876f5347\", \"app_shell_unittests\": \"6dcae13ce9a611a42f2fb4d56c6c2566362e52bc\", \"aura_unittests\": \"fac4702470c442db67a0f54eff049c22b124b2f3\", \"base_unittests\": \"e24ade3910a609d5e8deec23b098616e4ac8ed9e\", \"base_util_unittests\": \"a462d329a543e6a92d7fcf6dceaf1faf34cd2bfe\", \"blink_common_unittests\": \"373014617fc2dfe416fac482642188af0c82804f\", \"blink_fuzzer_unittests\": \"e86ca0e9b769249488aaed9f93ee7d0fe3edc605\", \"blink_heap_unittests\": \"5b10132ceabef3b4f8b4f77e95794076ffc1602e\", \"blink_platform_unittests\": \"03ae671bbfd9ef593cd4757eb932749aede140e2\", \"blink_unittests\": \"af239d2f583e3ec0c2d19e9e7b7d887c1859d4f6\", \"boringssl_crypto_tests\": \"d2a447f10f5e3f52a244c454d67043fe89c342dc\", \"boringssl_ssl_tests\": \"cfe3379698f021f6eaf1b17818fb78585246ab8a\", \"browser_switcher_bho_unittests\": \"90d791d55a314ff4959a27d49625a9b3ab38ec63\", \"browser_tests\": \"c9b658ee7b437378f97f59cd832b0dfb44b5bc49\", \"capture_unittests\": \"3e97282aa14db2cf5eea375744a64c0721923104\", \"cast_unittests\": \"a24d98aa9b2b8b856fcf948141412fd285a9d249\", \"cc_unittests\": \"660418080a0ca14bc96dd828f888052daa3065f3\", \"chrome_app_unittests\": \"97ae65349345aaf7f073c48421f68d44fa34d307\", \"chrome_cleaner_unittests\": \"42e4b11d3a2418c734eb5addadb9f3f383aca688\", \"chrome_elf_unittests\": \"321c81db4f7b357a01d1f90472afd9cbb4638a4d\", \"chromedriver_unittests\": \"2347b2478656d6f7ac5a5e348a1a8e63af2488c0\", \"components_browsertests\": \"4301c036048cc3429b48aab0fe82475e78671c35\", \"components_unittests\": \"a8d0086fd54434ac9deae231e48269e973f92d30\", \"compositor_unittests\": \"eaac12a9cb8300329233c786661e3a00afccae19\", \"content_browsertests\": \"a1dbbf11f42f4a8beb53161cb5228f1a5cf99ebe\", \"content_unittests\": \"015818da593ea0c2802fc6eca6a473018e5d681c\", \"courgette_unittests\": \"5e4d6453fb3b338f3b2d99f6d013538578f95ed2\", \"crashpad_tests\": \"1d9fe6da264ef4f997ecc5f0ef85426ec3bdc073\", \"cronet_tests\": \"5899a790c261a3e14955858dc709fc1618d6ccc3\", \"cronet_unittests\": \"708533885bf7745d492f81bab895bd318d4cd166\", \"crypto_unittests\": \"7f8137edf4dce3625cd62557beb93484eb10a521\", \"delayloads_unittests\": \"c88052c6f92929a1f1d70c9028be20519f8e8eb7\", \"device_unittests\": \"3e971dd9b34d3928d4bf7ee2e38aadfafe962356\", \"display_unittests\": \"280fb6d1f1c4303a80c20b9404ab363b6168c484\", \"elevation_service_unittests\": \"56d8afe5099bdffad326cd196479df0e738f457b\", \"events_unittests\": \"4c44c593942aa92cd6a5d13637d900f518eea252\", \"extensions_browsertests\": \"be111200d680021221df69f477609ae73070b5b6\", \"extensions_unittests\": \"97218d4053a5e119438c267fa9a6b6a15eddc405\", \"filesystem_service_unittests\": \"2eb3f67104df216b5d9bdd4000f450d00b2d3524\", \"gcm_unit_tests\": \"6834186ca7768460ddf5aefd3c1f59e2dc5df86b\", \"gcp_unittests\": \"24440fac83450d31689698a432ab8be06dd02b5f\", \"gfx_unittests\": \"5ed123eb1122b6d38671f0e83e073b8eb6328cd3\", \"gin_unittests\": \"e2a1942615849e70001f4c3b990e587cbef67656\", \"google_apis_unittests\": \"12d1020ac2a6f052663a96994c9555b8023010f4\", \"gpu_unittests\": \"dcc25f58ed59ec36dcae51834803fb12a0a28b21\", \"gwp_asan_unittests\": \"4e0065d1d3388c9198d76ec7432a1768514d776e\", \"headless_browsertests\": \"8c4c3e6c27c4f44a8dfe1cb18c7345f87c5ea268\", \"headless_unittests\": \"b137762b650e850c64b9e0e3f901e84f1e3b9603\", \"install_static_unittests\": \"5742a47686c22ca1bc1108cc62a14428c9cebd11\", \"installer_util_unittests\": \"8733b06342e5e877ad971c474651c9088c27d6d0\", \"interactive_ui_tests\": \"544e0239c94a906beec3243f51b442308376d0a3\", \"ipc_tests\": \"880e62e50159b1b7e3d36a7d3111cbc323ffcb70\", \"jingle_unittests\": \"a76ececcd4e20964865293e5d92f57de4fabeb40\", \"latency_unittests\": \"17a6acc7d0d08f9376007a80c282d0fa2e7533fb\", \"libjingle_xmpp_unittests\": \"b7db71bfa5bd4c75fcc7df17ed97cba3a89ced9a\", \"liburlpattern_unittests\": \"699759f09985b2d557af1ee7ce85bd2a0cdffc00\", \"media_blink_unittests\": \"4eb0c24d784c146a55027ab5e5d9da7b336ce993\", \"media_unittests\": \"88bc8424bae86874c9f8108bb3d344f319fd9e55\", \"message_center_unittests\": \"6345bd6b6be503d8c9d750420b5c6758954e7d4d\", \"midi_unittests\": \"209de91f90f79808fda664f24d8e87706298a49e\", \"mojo_core_unittests\": \"bd9b9ba70b7260cfca8b696c77e7bae32a232342\", \"mojo_unittests\": \"06d630f7c493b17b20e5b6c3d6084feea84346cf\", \"nacl_loader_unittests\": \"838c7a255ddc8b54be5aa6046dea1b5943fd4b24\", \"native_theme_unittests\": \"c32b31c52e8e4617816a0c9916c162249b8aa344\", \"net_unittests\": \"ca15341b27ea899c98c131b77b51e23e3d6579e3\", \"notification_helper_unittests\": \"ef11ffee103c23c099d67760f32cb8daf66525a9\", \"pdf_unittests\": \"c520962b542cfab9398bd27d32ff65165f447bfe\", \"perfetto_unittests\": \"f08c96f4694893eae621b80abc55a4c6e7d3f1c0\", \"ppapi_unittests\": \"9eb68bcebadb40d042adf2d4c16db81e798d55b8\", \"printing_unittests\": \"85695a54010d45f1866f8b773dcbfe22af5c53c5\", \"remoting_unittests\": \"17d740650f2088c98bcbc2aad568dc502c479a5d\", \"sbox_integration_tests\": \"bed360da394bf45b51aa9969a56f669331c62289\", \"sbox_unittests\": \"7fc8a80df0be42ada78ce8e2d8b32a15d9e45c12\", \"sbox_validation_tests\": \"521932972d2fe2c42b1662f22dfb588080b1ebd5\", \"service_manager_unittests\": \"b91f43950a3610cd5743ad3c34a23095f426350e\", \"services_unittests\": \"18aec502972d9ad9b1f41cbd91864f4ba02481f9\", \"setup_unittests\": \"f59226b2eede989b841379af69b0c92cefd533fb\", \"shell_dialogs_unittests\": \"5b7e64acb190b1e147cb9ae685e56272974c3af0\", \"skia_unittests\": \"bd7ab2e24a4addec2b341c421cae17d371582687\", \"snapshot_unittests\": \"1072732d4c9b386c0020ec84b835248fb03cbd5e\", \"sql_unittests\": \"39322d3848faac96bfdaac4035eefe88a09a0b46\", \"storage_unittests\": \"6ccc3a9b9fc43ab715a243aeaf483a71b364b41a\", \"sync_integration_tests\": \"92ec2db7662a07f542326751a5689705c9e575dc\", \"traffic_annotation_auditor_unittests\": \"27f7cbeb9cceb3b44ff1bcb5e3935853b9a62cf8\", \"ui_base_unittests\": \"07bbc1f622b92d99e4e0b8d62077a0d8d4ff0e83\", \"ui_touch_selection_unittests\": \"479344e88c008d7061f4529afe88826782877810\", \"unit_tests\": \"b014c6ce216d4190effabd9d823a96d3d1ea4acb\", \"updater_tests\": \"1fdfe1fcfbe9f7da67f613c40a05972e8cbd700e\", \"url_unittests\": \"8ecf472720e7beb6a9ba6e77338ff8446a14ea03\", \"views_unittests\": \"85def6954bbaa08d43329dd9f24f002abcf2bb4c\", \"viz_unittests\": \"01f4d05e1ea971fd2b8cff3ef0d853f94130d681\", \"vr_common_unittests\": \"c4c1604513cedfab037c71fac2ceed5094428fff\", \"vr_pixeltests\": \"1bed0ad7681b63454baa917033e34f95d808519d\", \"weblayer_browsertests\": \"f7ee88fe1615a7c4c5aac5a4115599a49113c53d\", \"weblayer_unittests\": \"1648bc8e8f388b05f458474dd284ada9ce91bdc8\", \"wm_unittests\": \"a8f8558ebf3c2a5f4c60e8f754583dbcccf9ec3c\", \"wtf_unittests\": \"7d65bf1781c26a934ab82c14aec5ff9cb206f09f\", \"zlib_unittests\": \"238e463f152dedf6a97cc8a7e9c9c09113900edc\", \"zucchini_unittests\": \"0a14845efc482728a6d8820cac93ff13408402e8\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"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-0-nszv\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"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\": [\"5666-679c9bd\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611032369733632",
"status": "COMPLETED",
"status_changed_ts": "1611035628983496",
"tags": [
"build_address:luci.chromium.ci/win-asan/16885",
"builder:win-asan",
"buildset:commit/git/17a7d1fcce21b4c20023ec0a5e52aedf16dbdf09",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/17a7d1fcce21b4c20023ec0a5e52aedf16dbdf09",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023133901680228928",
"scheduler_job_id:chromium/win-asan",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8857703839776391056/+/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:5131d49da7b87110",
"user_agent:luci-scheduler"
],
"updated_ts": "1611035628987509",
"url": "https://ci.chromium.org/b/8857703839776391056",
"utcnow_ts": "1611035629399587"
}
}
[05:53:49.409] Invocation finished in 54m22.728190205s with status SUCCEEDED