[04:45:34.896] New invocation is queued and will start shortly
[04:45:35.993] Starting the invocation (attempt 1)
[04:45:36.038] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:45:36.038] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:45:36.038] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9025490295012499696",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"28d345f8e94d44f6543333553f4a4ed6e421e8af\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9025490295012499696",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/28d345f8e94d44f6543333553f4a4ed6e421e8af",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/28d345f8e94d44f6543333553f4a4ed6e421e8af",
"gitiles_ref:refs/heads/master"
]
}
[04:45:36.649] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1608785136132696",
"id": "8860060233053263504",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"28d345f8e94d44f6543333553f4a4ed6e421e8af\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1608785136537591",
"tags": [
"build_address:luci.chromium.ci/win-asan/16423",
"builder:win-asan",
"buildset:commit/git/28d345f8e94d44f6543333553f4a4ed6e421e8af",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/28d345f8e94d44f6543333553f4a4ed6e421e8af",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025490295012499696",
"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/8860060233053263504/+/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": "1608785136537688",
"url": "https://ci.chromium.org/b/8860060233053263504",
"utcnow_ts": "1608785136640975"
}
}
[04:45:36.649] Task URL: https://ci.chromium.org/b/8860060233053263504
[04:45:36.649] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:2:0) after 1m0s
[04:45:39.416] Received PubSub notification, asking Buildbucket for the build status
[04:45:39.481] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:37.268] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:2:0)
[04:46:37.268] Timer tick, asking Buildbucket for the build status
[04:46:37.355] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:37.355] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:4:0) after 1m0s
[04:47:37.373] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:4:0)
[04:47:37.373] Timer tick, asking Buildbucket for the build status
[04:47:37.482] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:37.482] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:5:0) after 1m0s
[04:48:37.490] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:5:0)
[04:48:37.490] Timer tick, asking Buildbucket for the build status
[04:48:37.644] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:37.644] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:6:0) after 1m0s
[04:49:37.744] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:6:0)
[04:49:37.744] Timer tick, asking Buildbucket for the build status
[04:49:37.861] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:37.861] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:7:0) after 1m0s
[04:50:37.919] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:7:0)
[04:50:37.919] Timer tick, asking Buildbucket for the build status
[04:50:38.033] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:38.033] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:8:0) after 1m0s
[04:51:38.041] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:8:0)
[04:51:38.041] Timer tick, asking Buildbucket for the build status
[04:51:38.154] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:38.154] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:9:0) after 1m0s
[04:52:38.178] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:9:0)
[04:52:38.178] Timer tick, asking Buildbucket for the build status
[04:52:38.238] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:38.238] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:10:0) after 1m0s
[04:53:38.318] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:10:0)
[04:53:38.318] Timer tick, asking Buildbucket for the build status
[04:53:38.382] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:38.382] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:11:0) after 1m0s
[04:54:38.402] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:11:0)
[04:54:38.402] Timer tick, asking Buildbucket for the build status
[04:54:38.545] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:38.545] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:12:0) after 1m0s
[04:55:38.692] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:12:0)
[04:55:38.692] Timer tick, asking Buildbucket for the build status
[04:55:39.004] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:39.004] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:13:0) after 1m0s
[04:56:38.991] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:13:0)
[04:56:38.991] Timer tick, asking Buildbucket for the build status
[04:56:39.088] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:39.088] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:14:0) after 1m0s
[04:57:39.187] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:14:0)
[04:57:39.187] Timer tick, asking Buildbucket for the build status
[04:57:39.272] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:39.272] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:15:0) after 1m0s
[04:58:39.404] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:15:0)
[04:58:39.404] Timer tick, asking Buildbucket for the build status
[04:58:39.888] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:39.888] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:16:0) after 1m0s
[04:59:39.950] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:16:0)
[04:59:39.950] Timer tick, asking Buildbucket for the build status
[04:59:40.076] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:40.076] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:17:0) after 1m0s
[05:00:40.107] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:17:0)
[05:00:40.107] Timer tick, asking Buildbucket for the build status
[05:00:40.315] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:40.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:18:0) after 1m0s
[05:01:40.386] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:18:0)
[05:01:40.386] Timer tick, asking Buildbucket for the build status
[05:01:40.592] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:40.592] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:19:0) after 1m0s
[05:02:40.680] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:19:0)
[05:02:40.680] Timer tick, asking Buildbucket for the build status
[05:02:40.908] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:40.908] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:20:0) after 1m0s
[05:03:40.962] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:20:0)
[05:03:40.962] Timer tick, asking Buildbucket for the build status
[05:03:41.582] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:41.582] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:21:0) after 1m0s
[05:04:41.648] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:21:0)
[05:04:41.648] Timer tick, asking Buildbucket for the build status
[05:04:41.725] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:41.725] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:22:0) after 1m0s
[05:05:41.787] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:22:0)
[05:05:41.787] Timer tick, asking Buildbucket for the build status
[05:05:41.916] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:41.916] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:23:0) after 1m0s
[05:06:41.925] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:23:0)
[05:06:41.925] Timer tick, asking Buildbucket for the build status
[05:06:43.142] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:43.142] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:24:0) after 1m0s
[05:07:43.168] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:24:0)
[05:07:43.168] Timer tick, asking Buildbucket for the build status
[05:07:43.267] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:43.267] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:25:0) after 1m0s
[05:08:43.292] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:25:0)
[05:08:43.292] Timer tick, asking Buildbucket for the build status
[05:08:43.406] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:43.406] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:26:0) after 1m0s
[05:09:43.427] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:26:0)
[05:09:43.427] Timer tick, asking Buildbucket for the build status
[05:09:43.718] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:43.718] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:27:0) after 1m0s
[05:10:43.852] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:27:0)
[05:10:43.852] Timer tick, asking Buildbucket for the build status
[05:10:44.074] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:44.074] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:28:0) after 1m0s
[05:11:44.099] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:28:0)
[05:11:44.099] Timer tick, asking Buildbucket for the build status
[05:11:44.177] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:44.177] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:29:0) after 1m0s
[05:12:44.216] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:29:0)
[05:12:44.216] Timer tick, asking Buildbucket for the build status
[05:12:44.302] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:44.302] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:30:0) after 1m0s
[05:13:44.278] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:30:0)
[05:13:44.278] Timer tick, asking Buildbucket for the build status
[05:13:44.392] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:44.392] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:31:0) after 1m0s
[05:14:44.443] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:31:0)
[05:14:44.443] Timer tick, asking Buildbucket for the build status
[05:14:44.601] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:44.601] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:32:0) after 1m0s
[05:15:44.689] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:32:0)
[05:15:44.689] Timer tick, asking Buildbucket for the build status
[05:15:44.794] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:44.794] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:33:0) after 1m0s
[05:16:44.852] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:33:0)
[05:16:44.852] Timer tick, asking Buildbucket for the build status
[05:16:45.188] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:45.188] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:34:0) after 1m0s
[05:17:45.258] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:34:0)
[05:17:45.258] Timer tick, asking Buildbucket for the build status
[05:17:45.328] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:45.329] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:35:0) after 1m0s
[05:18:45.377] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:35:0)
[05:18:45.377] Timer tick, asking Buildbucket for the build status
[05:18:45.456] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:45.456] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:36:0) after 1m0s
[05:19:45.468] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:36:0)
[05:19:45.468] Timer tick, asking Buildbucket for the build status
[05:19:45.557] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:45.557] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:37:0) after 1m0s
[05:20:45.610] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:37:0)
[05:20:45.610] Timer tick, asking Buildbucket for the build status
[05:20:45.796] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:45.796] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:38:0) after 1m0s
[05:21:45.844] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:38:0)
[05:21:45.844] Timer tick, asking Buildbucket for the build status
[05:21:45.919] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:45.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:39:0) after 1m0s
[05:22:45.943] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:39:0)
[05:22:45.943] Timer tick, asking Buildbucket for the build status
[05:22:46.074] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:46.074] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:40:0) after 1m0s
[05:23:46.128] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:40:0)
[05:23:46.128] Timer tick, asking Buildbucket for the build status
[05:23:46.254] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:46.254] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:41:0) after 1m0s
[05:24:46.275] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:41:0)
[05:24:46.275] Timer tick, asking Buildbucket for the build status
[05:24:46.408] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:46.408] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:42:0) after 1m0s
[05:25:46.403] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:42:0)
[05:25:46.403] Timer tick, asking Buildbucket for the build status
[05:25:46.543] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:46.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:43:0) after 1m0s
[05:26:46.579] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:43:0)
[05:26:46.579] Timer tick, asking Buildbucket for the build status
[05:26:46.689] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:46.689] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:44:0) after 1m0s
[05:27:46.808] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:44:0)
[05:27:46.808] Timer tick, asking Buildbucket for the build status
[05:27:47.145] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:47.145] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:45:0) after 1m0s
[05:28:47.242] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:45:0)
[05:28:47.242] Timer tick, asking Buildbucket for the build status
[05:28:47.810] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:47.810] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:46:0) after 1m0s
[05:29:47.834] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:46:0)
[05:29:47.834] Timer tick, asking Buildbucket for the build status
[05:29:47.947] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:47.947] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:47:0) after 1m0s
[05:30:47.970] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:47:0)
[05:30:47.970] Timer tick, asking Buildbucket for the build status
[05:30:48.098] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:48.098] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:48:0) after 1m0s
[05:31:48.173] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:48:0)
[05:31:48.173] Timer tick, asking Buildbucket for the build status
[05:31:48.238] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:48.238] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:49:0) after 1m0s
[05:32:48.275] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:49:0)
[05:32:48.275] Timer tick, asking Buildbucket for the build status
[05:32:48.405] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:48.405] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:50:0) after 1m0s
[05:33:48.515] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:50:0)
[05:33:48.515] Timer tick, asking Buildbucket for the build status
[05:33:48.581] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:48.581] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:51:0) after 1m0s
[05:34:48.692] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:51:0)
[05:34:48.692] Timer tick, asking Buildbucket for the build status
[05:34:48.767] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:48.767] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:52:0) after 1m0s
[05:35:48.836] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:52:0)
[05:35:48.836] Timer tick, asking Buildbucket for the build status
[05:35:48.949] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:48.949] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:53:0) after 1m0s
[05:36:48.951] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:53:0)
[05:36:48.951] Timer tick, asking Buildbucket for the build status
[05:36:49.032] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:49.032] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:54:0) after 1m0s
[05:37:49.084] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:54:0)
[05:37:49.084] Timer tick, asking Buildbucket for the build status
[05:37:49.177] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:49.177] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:55:0) after 1m0s
[05:38:49.306] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:55:0)
[05:38:49.306] Timer tick, asking Buildbucket for the build status
[05:38:49.434] Build 8860060233053263504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:49.434] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025490295012499696:56:0) after 1m0s
[05:38:57.441] Received PubSub notification, asking Buildbucket for the build status
[05:38:57.545] Build 8860060233053263504: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:38:57.545] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1608788336473534",
"created_by": "project:chromium",
"created_ts": "1608785136132696",
"id": "8860060233053263504",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"28d345f8e94d44f6543333553f4a4ed6e421e8af\"}}",
"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\": \"28d345f8e94d44f6543333553f4a4ed6e421e8af\", \"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-gpyc\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16423, \"clang_revision\": \"llvmorg-12-init-12923-g6ee22ca6-1\", \"got_angle_revision\": \"cde0e3ab3d710ca9838d226873462c5f093f60bd\", \"got_dawn_revision\": \"700809a7f75bab9df6d1195153ea1cbfb078046c\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"28d345f8e94d44f6543333553f4a4ed6e421e8af\", \"got_revision_cp\": \"refs/heads/master@{#839239}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1cc5b3357d2ff3c81ef7ec0b07a6660796bde5cd\", \"got_v8_revision\": \"711cf5ad4a12abe0f6b50058cb2248d7fb80374e\", \"got_v8_revision_cp\": \"refs/heads/8.9.187@{#1}\", \"got_webrtc_revision\": \"fec83cc8602580ce1c078f7cd4e7f4d2be4ac850\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32877}\", \"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\": \"28d345f8e94d44f6543333553f4a4ed6e421e8af\", \"swarm_hashes_refs/heads/master(at){#839239}_without_patch\": {\"absl_hardening_tests\": \"ce1f0f9b9b25e3cdf6a07a0e0b76af9716afb48f\", \"accessibility_unittests\": \"27310c8655900b9e8841bda1db6e13e2ab208ee8\", \"angle_unittests\": \"67cd23f99a5073ad7c8b5b3f06dcdc0ce55ee69a\", \"app_shell_unittests\": \"507b9715cb7ee5232ccf515439253b3ee9f8ca81\", \"aura_unittests\": \"607a5f33a1808eb3bce53e661bce4b80ce25cffc\", \"base_unittests\": \"e4a41f788bc9fce6eaa8930a80427275a9b311d7\", \"base_util_unittests\": \"5c845bf46e78057b517371484642806e1e521fd4\", \"blink_common_unittests\": \"3aa1a4380205089b21298a708e55007f8b8464d4\", \"blink_fuzzer_unittests\": \"fe59375883e2efe00e955c6caa6951a7ac37a447\", \"blink_heap_unittests\": \"c658261ef0ad4998dff4e4d9f3a039719251d1a9\", \"blink_platform_unittests\": \"8e5044920a67189947c12af6494f3cc50abfa192\", \"blink_unittests\": \"94d576bdb125c07c50009905a87d1b88d8cf0a1d\", \"boringssl_crypto_tests\": \"2504f21ea2ffdfb788e76dcef30b9541551ef265\", \"boringssl_ssl_tests\": \"cedf376879c94d77766e67635c228f52690a5ae8\", \"browser_switcher_bho_unittests\": \"a778b9e8cd53b81c550f894474346318a7bfba9d\", \"browser_tests\": \"a87b7082597d54a4cc9a16f3a5d07fabbede888b\", \"capture_unittests\": \"2fdf347d676aeedf37d248f444340a4b5a133812\", \"cast_unittests\": \"4765b2ff9248dc98dd72ede287d337b8e361f129\", \"cc_unittests\": \"b3ebcbe7a610704a2ab69800e8aaa2e2c7f2b151\", \"chrome_app_unittests\": \"a4c1fb1fd2c6dfc6cd937dd69c6a4c1a98de0e16\", \"chrome_cleaner_unittests\": \"3743c25d53a8096981a99d00d61ab56f8779d409\", \"chrome_elf_unittests\": \"e4cf0b85d8a12459b5e223f0cdc70bfdd69aebf7\", \"chromedriver_unittests\": \"e4c940635c2c505e65530ae50da3a7a3a4d85acf\", \"components_browsertests\": \"680bf0c4b950acf4828eb76a505ccc9a99409c46\", \"components_unittests\": \"b155720aca7c4f08ae74f10f15fc2318fa0e3444\", \"compositor_unittests\": \"ddc9be87954d10aa566232d0c690a7aa1dbceea9\", \"content_browsertests\": \"8139f0334831c445bc16e1a6c44f89eb325e7080\", \"content_unittests\": \"3280582c2f5429144ae9026c5f6930e823a01be2\", \"courgette_unittests\": \"9255ed270c746a4277c076afb8e4ecc0765a665e\", \"crashpad_tests\": \"505482293273a34ff74cf1fe369e89dbddb15977\", \"cronet_tests\": \"42306de6bc0a9e370d0af711b6144b02d405132a\", \"cronet_unittests\": \"baedfee418e3573dbbd2715ef8071caf00e0008d\", \"crypto_unittests\": \"c48cfbbd3fe8af209aefad43c9d29265df725895\", \"delayloads_unittests\": \"7a884103fd044a04586d4f7834b725b2d58a8376\", \"device_unittests\": \"1dc7e474af238d81f7d1ab45ded7e377c74288c3\", \"display_unittests\": \"732f121d09698de2aae53c9885d7c490e975ae43\", \"elevation_service_unittests\": \"6de55826ea858ee24f43756f1f08d486344640b5\", \"events_unittests\": \"31a8c9fedfe6cb8341abaeee35155e06bba66317\", \"extensions_browsertests\": \"caddbb352168b353d0fba50aa6a54db97115f5f1\", \"extensions_unittests\": \"e1c8e960f3685fe830c2d9e15c9f145fe167fd03\", \"filesystem_service_unittests\": \"ad643e4ab3e0696cce39bd415a38d0fab5220f9d\", \"gcm_unit_tests\": \"8e9aa2eff23ed6cd3f402dd20ba2f61585d848ba\", \"gcp_unittests\": \"b2535801c3e3e6070268755427222ac1131179d3\", \"gfx_unittests\": \"60e925ac4fefb26780020893e02544e38fa54321\", \"gin_unittests\": \"be87c5dc4264fc574b938f678825984e75e90b79\", \"google_apis_unittests\": \"97309d37eb241c486d250350a065389df665950f\", \"gpu_unittests\": \"a7dbd7f960f0baedf9f9785245d00b16c7ff850b\", \"gwp_asan_unittests\": \"4ee736f8e9eb3049d0288af289c5b9b8a75d030f\", \"headless_browsertests\": \"1e6ac446764474ecdafacb5ab936bdba0b4b19d0\", \"headless_unittests\": \"01c02af05baaa42753964ca2f6521de32e38a6bc\", \"install_static_unittests\": \"dbe67ad51cbd2c5819bbb6f002b027aa1114b09d\", \"installer_util_unittests\": \"d35d816efcbd2b7ca9d9a2f385d8189eb7f25fd2\", \"interactive_ui_tests\": \"c965fa01cda6c15d3c2b091d0db823a267577197\", \"ipc_tests\": \"99e2c4ff9f7e7e28456f14bcdd517f543d012247\", \"jingle_unittests\": \"295d5f89dc031a078b905c6e6ffd835320046e9a\", \"latency_unittests\": \"b64fd012cb7cef2aff2d121e8c9277e86fe4792a\", \"libjingle_xmpp_unittests\": \"2ca994cb2da85c1c6fd970340d7618f54a90e9c3\", \"liburlpattern_unittests\": \"e83204cc574022d43bc66ff187ae4be4bfd1d3a0\", \"media_blink_unittests\": \"10ac300108e7c6853e46b52767ff0e648ecffbf8\", \"media_unittests\": \"760010b38a5f2ae8f11327bd7c4a30067bb6a88f\", \"message_center_unittests\": \"0a13efcdd488114dc3bff56eabe3db0b79ae078e\", \"midi_unittests\": \"135cf2ff92e76ecc53e8ac69eb28f006ba502668\", \"mojo_core_unittests\": \"19501930761909f9a2dc66e5f038640dca795c62\", \"mojo_unittests\": \"6aac5ef4b910cba7b838fb3b377ee338262cca90\", \"nacl_loader_unittests\": \"250ec60c1844ab52bc0c12fa65a38a105096579e\", \"native_theme_unittests\": \"eef2ccf3747995b59fcd5c29ac59b28fa5e045a1\", \"net_unittests\": \"174af46ccf001969f8170a643cf29fcf07e28d7a\", \"notification_helper_unittests\": \"050c833536ec94dee458fc26c9785e4dc715069a\", \"pdf_unittests\": \"26403603f9181477c896e9d1cc020a829d4b2707\", \"perfetto_unittests\": \"579be7f61edfec382e75f1d9d552160b7eec9df3\", \"ppapi_unittests\": \"aa2bbb4829503dd05c6a8756281ebd22651cab51\", \"printing_unittests\": \"5b980d123001d6f9ab6244fdf10b3125746e2f1f\", \"remoting_unittests\": \"c76ec3ce7414879567d2dc00dcd3bbafffb0f2be\", \"sbox_integration_tests\": \"be56f3e66968a0273b92354c28e94f781ea5c76f\", \"sbox_unittests\": \"ebbdcfed84b280a25f8a8f05ce6b0571b4498c4e\", \"sbox_validation_tests\": \"5b1f6785a0e202c160a932a0d96b671710dc02e9\", \"service_manager_unittests\": \"803748f732c9a1d97a54a3277087c2f883e5773f\", \"services_unittests\": \"7b267a640b778508317547824a962ec00e1f68ea\", \"setup_unittests\": \"9b863d7b1f0f1e4b39731225bd9f7adc8165af0b\", \"shell_dialogs_unittests\": \"657b7dc2896c7a3fe8d365fda11907ab0787c6de\", \"skia_unittests\": \"65aa43ad6d127387c7db7b5295384dbff9850c8f\", \"snapshot_unittests\": \"5ef1b3e52e243db9b3d481ec82606ed4234b1d66\", \"sql_unittests\": \"b45de565cabf3f41cf03e4f4dcf579a0121ba3a4\", \"storage_unittests\": \"36fce9edde49c60c541529339cb82db74cb81848\", \"sync_integration_tests\": \"bd92234738e49098ab0f782a377c2fe50f19afbb\", \"traffic_annotation_auditor_unittests\": \"3f34342a60a5a98b898c5e1a338714f05fa8f51c\", \"ui_base_unittests\": \"d933f650e277656b1998bac0a2d54053f3f03c43\", \"ui_touch_selection_unittests\": \"6e745243577dda461317a407e06cfc81de15a2b3\", \"unit_tests\": \"9820e5b82a9517d4d10127c13e24834778b30880\", \"updater_tests\": \"1bc62f8c7f46425f15496849efb96e50e158450e\", \"url_unittests\": \"36ba39195cb043b45bc22d4352af6dfd9e6fb6a6\", \"views_unittests\": \"c57e5785abe002d0c9a6c785601b910056b880e0\", \"viz_unittests\": \"3e8cb6bc118e45a6de1ecd5c0831e33a8fd3e9f2\", \"vr_common_unittests\": \"658f8a82536186fbc006e4d80ced0a65c7c07071\", \"vr_pixeltests\": \"ea5e9bb7f9f99ced21075ffa6b6f5aee72d23c2b\", \"weblayer_browsertests\": \"d36c232bd8a5edf9b5860e747ba4777043acd72a\", \"weblayer_unittests\": \"87e65ab249cd4dbd7e3b083d66726d35e096d45c\", \"wm_unittests\": \"a65871512c27cdb5b86f84242ae1ec26dfbf9935\", \"wtf_unittests\": \"0fd00f2e0ea034bd8efa6cd7853d6a92d331675a\", \"zlib_unittests\": \"e628db89766469d0cdb585c401b421df55196a2b\", \"zucchini_unittests\": \"cdb5b6a1297b26bd6c43ad609c532815f0456100\"}}, \"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-6-gpyc\"], \"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\": [\"5657-0417a3f\"], \"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": "1608785138542176",
"status": "COMPLETED",
"status_changed_ts": "1608788336769560",
"tags": [
"build_address:luci.chromium.ci/win-asan/16423",
"builder:win-asan",
"buildset:commit/git/28d345f8e94d44f6543333553f4a4ed6e421e8af",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/28d345f8e94d44f6543333553f4a4ed6e421e8af",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025490295012499696",
"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/8860060233053263504/+/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:50abe294700bda10",
"user_agent:luci-scheduler"
],
"updated_ts": "1608788336808445",
"url": "https://ci.chromium.org/b/8860060233053263504",
"utcnow_ts": "1608788337534285"
}
}
[05:38:57.545] Invocation finished in 53m22.664226238s with status SUCCEEDED