[09:55:11.151] New invocation is queued and will start shortly
[09:55:12.271] Starting the invocation (attempt 1)
[09:55:12.305] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:55:12.306] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:55:12.306] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020125595379022576",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"22f65038fa8c2d2cd9143435b89ac5f200c33bb2\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9020125595379022576",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/22f65038fa8c2d2cd9143435b89ac5f200c33bb2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/22f65038fa8c2d2cd9143435b89ac5f200c33bb2",
"gitiles_ref:refs/heads/master"
]
}
[09:55:13.155] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613901312413684",
"id": "8854695533393888016",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"22f65038fa8c2d2cd9143435b89ac5f200c33bb2\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613901312954413",
"tags": [
"build_address:luci.chromium.ci/win-asan/17459",
"builder:win-asan",
"buildset:commit/git/22f65038fa8c2d2cd9143435b89ac5f200c33bb2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/22f65038fa8c2d2cd9143435b89ac5f200c33bb2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020125595379022576",
"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/8854695533393888016/+/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": "1613901312954523",
"url": "https://ci.chromium.org/b/8854695533393888016",
"utcnow_ts": "1613901313148408"
}
}
[09:55:13.155] Task URL: https://ci.chromium.org/b/8854695533393888016
[09:55:13.155] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:2:0) after 1m0s
[09:55:25.325] Received PubSub notification, asking Buildbucket for the build status
[09:55:25.400] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:13.231] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:2:0)
[09:56:13.231] Timer tick, asking Buildbucket for the build status
[09:56:13.329] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:13.329] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:4:0) after 1m0s
[09:57:13.376] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:4:0)
[09:57:13.376] Timer tick, asking Buildbucket for the build status
[09:57:13.443] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:13.443] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:5:0) after 1m0s
[09:58:13.540] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:5:0)
[09:58:13.540] Timer tick, asking Buildbucket for the build status
[09:58:13.630] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:13.630] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:6:0) after 1m0s
[09:59:13.698] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:6:0)
[09:59:13.698] Timer tick, asking Buildbucket for the build status
[09:59:13.936] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:13.936] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:7:0) after 1m0s
[10:00:13.960] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:7:0)
[10:00:13.960] Timer tick, asking Buildbucket for the build status
[10:00:14.371] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:14.371] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:8:0) after 1m0s
[10:01:14.453] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:8:0)
[10:01:14.453] Timer tick, asking Buildbucket for the build status
[10:01:14.521] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:14.521] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:9:0) after 1m0s
[10:02:14.617] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:9:0)
[10:02:14.617] Timer tick, asking Buildbucket for the build status
[10:02:14.914] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:14.914] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:10:0) after 1m0s
[10:03:14.929] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:10:0)
[10:03:14.929] Timer tick, asking Buildbucket for the build status
[10:03:15.001] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:15.001] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:11:0) after 1m0s
[10:04:15.021] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:11:0)
[10:04:15.021] Timer tick, asking Buildbucket for the build status
[10:04:15.119] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:15.119] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:12:0) after 1m0s
[10:05:15.147] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:12:0)
[10:05:15.147] Timer tick, asking Buildbucket for the build status
[10:05:15.255] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:15.255] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:13:0) after 1m0s
[10:06:15.294] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:13:0)
[10:06:15.294] Timer tick, asking Buildbucket for the build status
[10:06:15.530] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:15.530] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:14:0) after 1m0s
[10:07:15.554] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:14:0)
[10:07:15.554] Timer tick, asking Buildbucket for the build status
[10:07:15.633] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:15.633] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:15:0) after 1m0s
[10:08:15.659] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:15:0)
[10:08:15.659] Timer tick, asking Buildbucket for the build status
[10:08:15.729] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:15.729] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:16:0) after 1m0s
[10:09:15.779] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:16:0)
[10:09:15.779] Timer tick, asking Buildbucket for the build status
[10:09:16.028] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:16.028] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:17:0) after 1m0s
[10:10:16.124] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:17:0)
[10:10:16.124] Timer tick, asking Buildbucket for the build status
[10:10:16.251] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:16.251] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:18:0) after 1m0s
[10:11:16.319] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:18:0)
[10:11:16.319] Timer tick, asking Buildbucket for the build status
[10:11:16.395] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:16.395] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:19:0) after 1m0s
[10:12:16.411] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:19:0)
[10:12:16.411] Timer tick, asking Buildbucket for the build status
[10:12:16.549] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:16.549] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:20:0) after 1m0s
[10:13:16.567] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:20:0)
[10:13:16.567] Timer tick, asking Buildbucket for the build status
[10:13:16.639] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:16.640] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:21:0) after 1m0s
[10:14:16.655] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:21:0)
[10:14:16.655] Timer tick, asking Buildbucket for the build status
[10:14:16.735] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:16.735] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:22:0) after 1m0s
[10:15:16.752] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:22:0)
[10:15:16.752] Timer tick, asking Buildbucket for the build status
[10:15:17.073] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:17.073] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:23:0) after 1m0s
[10:16:17.100] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:23:0)
[10:16:17.100] Timer tick, asking Buildbucket for the build status
[10:16:17.188] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:17.188] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:24:0) after 1m0s
[10:17:17.207] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:24:0)
[10:17:17.207] Timer tick, asking Buildbucket for the build status
[10:17:17.343] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:17.343] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:25:0) after 1m0s
[10:18:17.366] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:25:0)
[10:18:17.366] Timer tick, asking Buildbucket for the build status
[10:18:17.514] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:17.514] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:26:0) after 1m0s
[10:19:17.530] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:26:0)
[10:19:17.530] Timer tick, asking Buildbucket for the build status
[10:19:17.663] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:17.663] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:27:0) after 1m0s
[10:20:17.686] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:27:0)
[10:20:17.686] Timer tick, asking Buildbucket for the build status
[10:20:17.921] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:17.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:28:0) after 1m0s
[10:21:17.938] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:28:0)
[10:21:17.938] Timer tick, asking Buildbucket for the build status
[10:21:18.556] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:18.556] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:29:0) after 1m0s
[10:22:18.572] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:29:0)
[10:22:18.572] Timer tick, asking Buildbucket for the build status
[10:22:18.656] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:18.656] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:30:0) after 1m0s
[10:23:18.674] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:30:0)
[10:23:18.674] Timer tick, asking Buildbucket for the build status
[10:23:18.759] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:18.759] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:31:0) after 1m0s
[10:24:18.784] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:31:0)
[10:24:18.784] Timer tick, asking Buildbucket for the build status
[10:24:19.026] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:19.026] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:32:0) after 1m0s
[10:25:19.111] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:32:0)
[10:25:19.111] Timer tick, asking Buildbucket for the build status
[10:25:19.294] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:19.294] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:33:0) after 1m0s
[10:26:19.291] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:33:0)
[10:26:19.291] Timer tick, asking Buildbucket for the build status
[10:26:19.705] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:19.705] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:34:0) after 1m0s
[10:27:19.764] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:34:0)
[10:27:19.764] Timer tick, asking Buildbucket for the build status
[10:27:19.851] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:19.851] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:35:0) after 1m0s
[10:28:19.868] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:35:0)
[10:28:19.868] Timer tick, asking Buildbucket for the build status
[10:28:19.946] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:19.946] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:36:0) after 1m0s
[10:29:19.916] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:36:0)
[10:29:19.916] Timer tick, asking Buildbucket for the build status
[10:29:20.023] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:20.023] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:37:0) after 1m0s
[10:30:20.043] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:37:0)
[10:30:20.043] Timer tick, asking Buildbucket for the build status
[10:30:20.141] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:20.141] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:38:0) after 1m0s
[10:31:20.159] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:38:0)
[10:31:20.159] Timer tick, asking Buildbucket for the build status
[10:31:20.235] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:20.235] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:39:0) after 1m0s
[10:32:20.302] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:39:0)
[10:32:20.302] Timer tick, asking Buildbucket for the build status
[10:32:20.381] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:20.381] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:40:0) after 1m0s
[10:33:20.413] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:40:0)
[10:33:20.413] Timer tick, asking Buildbucket for the build status
[10:33:20.500] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:20.500] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:41:0) after 1m0s
[10:34:20.604] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:41:0)
[10:34:20.604] Timer tick, asking Buildbucket for the build status
[10:34:21.004] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:21.004] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:42:0) after 1m0s
[10:35:21.120] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:42:0)
[10:35:21.120] Timer tick, asking Buildbucket for the build status
[10:35:21.220] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:21.220] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:43:0) after 1m0s
[10:36:21.354] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:43:0)
[10:36:21.354] Timer tick, asking Buildbucket for the build status
[10:36:21.446] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:21.446] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:44:0) after 1m0s
[10:37:21.481] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:44:0)
[10:37:21.481] Timer tick, asking Buildbucket for the build status
[10:37:21.578] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:21.578] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:45:0) after 1m0s
[10:38:21.697] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:45:0)
[10:38:21.697] Timer tick, asking Buildbucket for the build status
[10:38:21.783] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:21.783] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:46:0) after 1m0s
[10:39:21.803] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:46:0)
[10:39:21.803] Timer tick, asking Buildbucket for the build status
[10:39:21.883] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:21.883] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:47:0) after 1m0s
[10:40:21.865] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:47:0)
[10:40:21.865] Timer tick, asking Buildbucket for the build status
[10:40:21.983] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:21.983] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:48:0) after 1m0s
[10:41:22.066] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:48:0)
[10:41:22.066] Timer tick, asking Buildbucket for the build status
[10:41:22.212] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:22.212] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:49:0) after 1m0s
[10:42:22.244] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:49:0)
[10:42:22.244] Timer tick, asking Buildbucket for the build status
[10:42:22.515] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:22.515] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:50:0) after 1m0s
[10:43:22.529] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:50:0)
[10:43:22.529] Timer tick, asking Buildbucket for the build status
[10:43:22.854] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:22.854] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:51:0) after 1m0s
[10:44:22.876] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:51:0)
[10:44:22.876] Timer tick, asking Buildbucket for the build status
[10:44:22.985] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:22.985] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:52:0) after 1m0s
[10:45:22.986] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:52:0)
[10:45:22.986] Timer tick, asking Buildbucket for the build status
[10:45:23.158] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:23.158] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:53:0) after 1m0s
[10:46:23.231] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:53:0)
[10:46:23.231] Timer tick, asking Buildbucket for the build status
[10:46:23.311] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:23.311] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:54:0) after 1m0s
[10:47:23.343] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:54:0)
[10:47:23.343] Timer tick, asking Buildbucket for the build status
[10:47:23.444] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:23.444] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:55:0) after 1m0s
[10:48:23.473] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:55:0)
[10:48:23.473] Timer tick, asking Buildbucket for the build status
[10:48:23.696] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:23.696] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:56:0) after 1m0s
[10:49:23.695] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:56:0)
[10:49:23.695] Timer tick, asking Buildbucket for the build status
[10:49:24.136] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:24.136] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:57:0) after 1m0s
[10:50:24.203] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:57:0)
[10:50:24.203] Timer tick, asking Buildbucket for the build status
[10:50:24.314] Build 8854695533393888016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:24.314] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020125595379022576:58:0) after 1m0s
[10:51:15.667] Received PubSub notification, asking Buildbucket for the build status
[10:51:16.035] Build 8854695533393888016: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:51:16.036] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613904672788047",
"created_by": "project:chromium",
"created_ts": "1613901312413684",
"id": "8854695533393888016",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"22f65038fa8c2d2cd9143435b89ac5f200c33bb2\"}}",
"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\": \"22f65038fa8c2d2cd9143435b89ac5f200c33bb2\", \"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-us-central1-b-32-1-r8z7\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17459, \"clang_revision\": \"llvmorg-13-init-1559-g01b87444-2\", \"got_angle_revision\": \"6e8cdd39b19912e7fe6408b0318d0907dc7e4d21\", \"got_dawn_revision\": \"1258e245a978083cab0b707c84dea814eadb3fbb\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"22f65038fa8c2d2cd9143435b89ac5f200c33bb2\", \"got_revision_cp\": \"refs/heads/master@{#856142}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"d85a7a27b27269741a779a72f33436b83d98687c\", \"got_v8_revision\": \"2430d8fffa7d4f8a0992bcb5eb3725e5367cd9ac\", \"got_v8_revision_cp\": \"refs/heads/9.0.229@{#1}\", \"got_webrtc_revision\": \"753c76a705199ea752933f3688a8e4c8233dca53\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33298}\", \"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\": \"22f65038fa8c2d2cd9143435b89ac5f200c33bb2\", \"swarm_hashes_refs/heads/master(at){#856142}_without_patch\": {\"absl_hardening_tests\": \"e04f1674c79d473a3e2ec7f43b98ab10afe8a948\", \"accessibility_unittests\": \"04bb5d81685151cfd0d68cd4486b39f3f80b3cb0\", \"angle_unittests\": \"489219fa9b076c8082666418b4e283e0633fa0e8\", \"app_shell_unittests\": \"d2b849c841ca21f6c812590f3792325c59c841e7\", \"aura_unittests\": \"a55ea8db6228fb89ed21e8510bd6cef813655347\", \"base_unittests\": \"1ceb22df0f743b895465b4bef1cb2600b451aa3c\", \"base_util_unittests\": \"4a24ae9205265c61bfb1a9220c14f27d1b9d590c\", \"blink_common_unittests\": \"aa54b0e0cb0a5945f85651dcb0efdf7d43fe9c88\", \"blink_fuzzer_unittests\": \"60573fc6aba7cb2883e443fc21eba97930b5f43b\", \"blink_heap_unittests\": \"6f5d23fa5f8522d216f6320bf6fce59bf9e29705\", \"blink_platform_unittests\": \"94dda5cfa9ebdcb15045dced0d6dfc800d798b71\", \"blink_unittests\": \"b68b31e2353aefc67ccf7286e7a6b4a3745cf492\", \"boringssl_crypto_tests\": \"2b0ecd2bff56d19ca45e48454a413c50a1b09777\", \"boringssl_ssl_tests\": \"8b3a5f3ddcb4b2e816e8227b339488d56dfa6f56\", \"browser_switcher_bho_unittests\": \"1211ef2ee8fb1f6eef648516423e73cdf0d102f9\", \"browser_tests\": \"73d7270c622c3a3dd945e3185d7c2542632a02e0\", \"capture_unittests\": \"e3b9ecda46a397aef652926dd865b745eee4c328\", \"cast_unittests\": \"b84707f74c19246454be5b6f45f583b659125df8\", \"cc_unittests\": \"8b3fe8f88b9133fa3df0a37332ab592e3b78e7a9\", \"chrome_app_unittests\": \"4c92d7bd80fbe210e368f2b7e79aae9986913516\", \"chrome_cleaner_unittests\": \"55e2f47cd864115643d7551ea3c064e2464eb5fc\", \"chrome_elf_unittests\": \"52f3e4ea13a187d5696d57a495bde28b65807b4d\", \"chromedriver_unittests\": \"3ba8aea7a1d2842f76d6704c548db367bbd4fcaa\", \"components_browsertests\": \"b75a1b53a734ccb0091735dfe39866de24d6954f\", \"components_unittests\": \"5a2b6612b7e47476d01150a8a076c0a052e7093d\", \"compositor_unittests\": \"7c63ffee8a47811ecfe1bdc641793061e0800cb4\", \"content_browsertests\": \"b920cc47f8f03625925742528476fe2971360489\", \"content_unittests\": \"1073709a57c7a371393debb79b99cefc2037fda6\", \"courgette_unittests\": \"3a8374677f99fe0e5c5776e38619bfada7d55a1d\", \"crashpad_tests\": \"7404d2fd388f46939e5fb883f9612ee165874e0f\", \"cronet_tests\": \"9a83294f13ad35a6cf82fdebc717dfbac040d35a\", \"cronet_unittests\": \"4979a12864a1c4e1330e7ce891d4369a2e32a4ad\", \"crypto_unittests\": \"bb7ab6223d44490aed5b625810f3bb94c6364428\", \"delayloads_unittests\": \"ddf90b9c20bb074d5ca8f931d745a8cfdb491dbf\", \"device_unittests\": \"7843a40d630ea0a50c2a3fd8ca70d7c2626edda5\", \"display_unittests\": \"0c4f5d584e2c1c5eeff2180855204802fdae2639\", \"elevation_service_unittests\": \"38ecf066bf76d3356db8bdbfac4d868a33ae5106\", \"events_unittests\": \"62ac9348f2536a55fc2688ffca32e899c89a4c56\", \"extensions_browsertests\": \"3fe37f1cfef949912347991daee39761b9263116\", \"extensions_unittests\": \"e6f8ba3ae1269aa5a2add5158b66b1ed7f0416aa\", \"filesystem_service_unittests\": \"894e8d9357c459cbee6bb5caa66fe77b9dcf7971\", \"gcm_unit_tests\": \"24851e5cf10fc135255713fac97c693863cf0a73\", \"gcp_unittests\": \"1064ea12de9161d5cd3d76f3bb545aab6a33687e\", \"gfx_unittests\": \"de4731e4450e4ae75f8402a6842184c59e009ca0\", \"gin_unittests\": \"4870a5d97c4ee8fa44241007482db1c691266529\", \"google_apis_unittests\": \"c7d3521637b26bdfac5393d97b0e280bd8bde35a\", \"gpu_unittests\": \"341d4fd0fd7a6bb3b0a14b265319d8668c9a7ff5\", \"gwp_asan_unittests\": \"c00f048445175ea5a75d5a5c9d055469a4f4a0e0\", \"headless_browsertests\": \"6b72b5881cb480f9daf4a40e35ff66dbb404bf7d\", \"headless_unittests\": \"a37a4717f41afad30b8a58a11273b838697b29ce\", \"install_static_unittests\": \"8202ce095aef2ad17f9d4fb46b5808e883f0276e\", \"installer_util_unittests\": \"893fb3aae0ecb76e6137ff4bcda57eaae8fd84a9\", \"interactive_ui_tests\": \"fbe6e20c06804b6a0d444ea6b764cba43eecca2e\", \"ipc_tests\": \"3d021fd03e790946e8fb17d066ac2cf55385e4cd\", \"jingle_unittests\": \"2387f7f8ccaf3b5e86c265186b2747625bcbec3a\", \"latency_unittests\": \"810a5adc2e5f3a5f4d7e0e85c967d34de4c093c6\", \"libjingle_xmpp_unittests\": \"1838b44993b93f95f7ac96d3353eea76732d49b2\", \"liburlpattern_unittests\": \"c0d6dbc61365d645cf1f0d3e3bac5a1d4c05a510\", \"media_blink_unittests\": \"be164486843b736c09ba93c43267fd530146f0a9\", \"media_unittests\": \"aebb7889b5a2be42b9d5127658f4f1c7f44f8f59\", \"message_center_unittests\": \"22280dd80769d6753cb360e0693dffd35d8221ce\", \"midi_unittests\": \"ef799d0780a0fd3a9692026fb544836f013c613c\", \"mojo_core_unittests\": \"f06ee34a8e63aa33bd666172a5eeb4cbdae01946\", \"mojo_unittests\": \"629a0dfb4452f574509e641d16313f0109f27708\", \"nacl_loader_unittests\": \"0e76ae3560435cd887a13c18ba2f7a4a630e66e8\", \"native_theme_unittests\": \"0b69c3d475061b683ff6b60101272ada5bceaba7\", \"net_unittests\": \"ee6230e4671b3460bde0ccfb2bf6bc122e624afc\", \"notification_helper_unittests\": \"d72c48b80f50ffb11d1ff94084d1dc28b867a500\", \"pdf_unittests\": \"2c49ac015cdda60be1e0a9f50a6acf0207ec670f\", \"perfetto_unittests\": \"b29ca25b2015564b48607123201865eb7a0deb08\", \"ppapi_unittests\": \"9f3f95f87dd1eab5bc0eb2d053988ba9e9e71a60\", \"printing_unittests\": \"ee12f88759fe7208fb15c6cf570ced02017e71dc\", \"remoting_unittests\": \"3e862d166d216df4d809f75311773e74e2755558\", \"sbox_integration_tests\": \"3995e50329370ea0713d1b92ee85bf47a43cc2fe\", \"sbox_unittests\": \"4f22d4da6535f959b0d550c8cf0b5aabb427af7f\", \"sbox_validation_tests\": \"c5e991b12786e38905ad66add06f53bdbb7abee0\", \"service_manager_unittests\": \"84e59031c18384eede41ef5a79400408a363417b\", \"services_unittests\": \"174e970c8a4da4cc74d56444e60fddc87ff90487\", \"setup_unittests\": \"e5b7ce1c0661e4138cd162daeca42af49e637f03\", \"shell_dialogs_unittests\": \"0a61fd977803871b6955c5d8fe20d80ea1fc2765\", \"skia_unittests\": \"80c5fcbe9de85e38a92a4e3fcddf4efac133b38a\", \"snapshot_unittests\": \"91c7d0b19f73ca0b096ac90cffc8aec266e11fde\", \"sql_unittests\": \"5b323fa2f39d43d5c9dc9b266449c526ff2bf153\", \"storage_unittests\": \"e5b59fd7341b97cefd3b9a47f8885d74294466a6\", \"sync_integration_tests\": \"39fa04f2d9f67ef7006e3c3ad588a4274819d0e1\", \"traffic_annotation_auditor_unittests\": \"774059a4d1525c99a60dd3eee241c4046b561136\", \"ui_base_unittests\": \"45accba7756e2cdf7819c2d2d81d5e5f90432e12\", \"ui_touch_selection_unittests\": \"ff2fec32cac3c2c37bc00fa8887eb6f5ca19b4a4\", \"unit_tests\": \"edbd2ee7ee71ca16c10c54956189cc729e12f8ec\", \"updater_tests\": \"7ef5fb030a609386eb39fb5f17ee33f144ba8ccc\", \"url_unittests\": \"6902a7d04e4fa2df1a806861575fd250457a55e2\", \"views_unittests\": \"a0b4e263461bb31c15605c201b65f3072710e680\", \"viz_unittests\": \"1eb876b80741224be8b136720b0a18aa96c8f7cc\", \"vr_common_unittests\": \"293714247fff4afd765fbbc6229705bb6173a967\", \"vr_pixeltests\": \"46e2b040075f92591beb3d1afbf9294b2a458457\", \"weblayer_browsertests\": \"7870adfd27a4bf82dddf6fea2b43201041158055\", \"weblayer_unittests\": \"9b7ad7c1d2c8cf9b6ae99c32e342341b57a1ed88\", \"wm_unittests\": \"6f429c5cc04c7b780d8b3c818a7b77a034eb378e\", \"wtf_unittests\": \"ad888a7ebf58a0eab9205cffe465acfe89e08aea\", \"zlib_unittests\": \"d17ddf218a891d025d74dea3cd99a9a800ef8238\", \"zucchini_unittests\": \"9907891d20b99c8b09101c204aa768f0902fbb25\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-us-central1-b-32-1-r8z7\"], \"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\": [\"5706-397711c\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613901313970107",
"status": "COMPLETED",
"status_changed_ts": "1613904673048496",
"tags": [
"build_address:luci.chromium.ci/win-asan/17459",
"builder:win-asan",
"buildset:commit/git/22f65038fa8c2d2cd9143435b89ac5f200c33bb2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/22f65038fa8c2d2cd9143435b89ac5f200c33bb2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020125595379022576",
"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/8854695533393888016/+/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:51dcd53dac742510",
"user_agent:luci-scheduler"
],
"updated_ts": "1613904673066177",
"url": "https://ci.chromium.org/b/8854695533393888016",
"utcnow_ts": "1613904676016833"
}
}
[10:51:16.036] Invocation finished in 56m4.899634326s with status SUCCEEDED