[05:17:22.496] New invocation is queued and will start shortly
[05:17:23.558] Starting the invocation (attempt 1)
[05:17:23.596] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:17:23.601] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:17:23.601] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030924112733882624",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3a47b622f08058daa6445ad2799aa6a123179628\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9030924112733882624",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/3a47b622f08058daa6445ad2799aa6a123179628",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3a47b622f08058daa6445ad2799aa6a123179628",
"gitiles_ref:refs/heads/master"
]
}
[05:17:24.344] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603603043686978",
"id": "8865494050821716656",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3a47b622f08058daa6445ad2799aa6a123179628\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603603044227233",
"tags": [
"build_address:luci.chromium.ci/win-asan/15258",
"builder:win-asan",
"buildset:commit/git/3a47b622f08058daa6445ad2799aa6a123179628",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3a47b622f08058daa6445ad2799aa6a123179628",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030924112733882624",
"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/8865494050821716656/+/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": "1603603044227377",
"url": "https://ci.chromium.org/b/8865494050821716656",
"utcnow_ts": "1603603044335789"
}
}
[05:17:24.344] Task URL: https://ci.chromium.org/b/8865494050821716656
[05:17:24.344] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:2:0) after 1m0s
[05:17:42.692] Received PubSub notification, asking Buildbucket for the build status
[05:17:42.893] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:24.411] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:2:0)
[05:18:24.413] Timer tick, asking Buildbucket for the build status
[05:18:24.713] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:24.713] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:4:0) after 1m0s
[05:19:24.735] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:4:0)
[05:19:24.735] Timer tick, asking Buildbucket for the build status
[05:19:24.858] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:24.858] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:5:0) after 1m0s
[05:20:24.884] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:5:0)
[05:20:24.884] Timer tick, asking Buildbucket for the build status
[05:20:25.053] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:25.053] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:6:0) after 1m0s
[05:21:25.069] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:6:0)
[05:21:25.069] Timer tick, asking Buildbucket for the build status
[05:21:25.172] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:25.172] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:7:0) after 1m0s
[05:22:25.317] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:7:0)
[05:22:25.317] Timer tick, asking Buildbucket for the build status
[05:22:25.412] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:25.412] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:8:0) after 1m0s
[05:23:25.487] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:8:0)
[05:23:25.487] Timer tick, asking Buildbucket for the build status
[05:23:25.582] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:25.582] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:9:0) after 1m0s
[05:24:25.702] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:9:0)
[05:24:25.702] Timer tick, asking Buildbucket for the build status
[05:24:25.906] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:25.906] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:10:0) after 1m0s
[05:25:25.971] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:10:0)
[05:25:25.971] Timer tick, asking Buildbucket for the build status
[05:25:26.165] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:26.165] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:11:0) after 1m0s
[05:26:26.180] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:11:0)
[05:26:26.180] Timer tick, asking Buildbucket for the build status
[05:26:26.283] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:26.283] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:12:0) after 1m0s
[05:27:26.382] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:12:0)
[05:27:26.382] Timer tick, asking Buildbucket for the build status
[05:27:26.803] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:26.803] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:13:0) after 1m0s
[05:28:26.887] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:13:0)
[05:28:26.887] Timer tick, asking Buildbucket for the build status
[05:28:26.994] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:26.994] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:14:0) after 1m0s
[05:29:27.007] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:14:0)
[05:29:27.007] Timer tick, asking Buildbucket for the build status
[05:29:27.130] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:27.130] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:15:0) after 1m0s
[05:30:27.195] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:15:0)
[05:30:27.195] Timer tick, asking Buildbucket for the build status
[05:30:27.601] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:27.601] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:16:0) after 1m0s
[05:31:27.586] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:16:0)
[05:31:27.586] Timer tick, asking Buildbucket for the build status
[05:31:27.718] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:27.718] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:17:0) after 1m0s
[05:32:27.738] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:17:0)
[05:32:27.738] Timer tick, asking Buildbucket for the build status
[05:32:28.026] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:28.026] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:18:0) after 1m0s
[05:33:28.047] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:18:0)
[05:33:28.047] Timer tick, asking Buildbucket for the build status
[05:33:28.184] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:28.184] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:19:0) after 1m0s
[05:34:28.168] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:19:0)
[05:34:28.168] Timer tick, asking Buildbucket for the build status
[05:34:28.903] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:28.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:20:0) after 1m0s
[05:35:28.975] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:20:0)
[05:35:28.975] Timer tick, asking Buildbucket for the build status
[05:35:29.095] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:29.095] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:21:0) after 1m0s
[05:36:29.119] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:21:0)
[05:36:29.120] Timer tick, asking Buildbucket for the build status
[05:36:29.234] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:29.234] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:22:0) after 1m0s
[05:37:29.304] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:22:0)
[05:37:29.304] Timer tick, asking Buildbucket for the build status
[05:37:29.818] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:29.818] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:23:0) after 1m0s
[05:38:29.890] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:23:0)
[05:38:29.890] Timer tick, asking Buildbucket for the build status
[05:38:29.998] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:29.998] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:24:0) after 1m0s
[05:39:30.093] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:24:0)
[05:39:30.093] Timer tick, asking Buildbucket for the build status
[05:39:30.209] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:30.209] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:25:0) after 1m0s
[05:40:30.277] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:25:0)
[05:40:30.277] Timer tick, asking Buildbucket for the build status
[05:40:30.501] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:30.501] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:26:0) after 1m0s
[05:41:30.535] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:26:0)
[05:41:30.535] Timer tick, asking Buildbucket for the build status
[05:41:30.693] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:30.693] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:27:0) after 1m0s
[05:42:30.768] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:27:0)
[05:42:30.768] Timer tick, asking Buildbucket for the build status
[05:42:30.884] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:30.884] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:28:0) after 1m0s
[05:43:30.920] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:28:0)
[05:43:30.920] Timer tick, asking Buildbucket for the build status
[05:43:30.984] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:30.984] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:29:0) after 1m0s
[05:44:31.002] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:29:0)
[05:44:31.002] Timer tick, asking Buildbucket for the build status
[05:44:31.077] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:31.077] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:30:0) after 1m0s
[05:45:31.101] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:30:0)
[05:45:31.101] Timer tick, asking Buildbucket for the build status
[05:45:31.191] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:31.192] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:31:0) after 1m0s
[05:46:31.252] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:31:0)
[05:46:31.252] Timer tick, asking Buildbucket for the build status
[05:46:31.335] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:31.335] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:32:0) after 1m0s
[05:47:31.419] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:32:0)
[05:47:31.419] Timer tick, asking Buildbucket for the build status
[05:47:31.702] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:31.702] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:33:0) after 1m0s
[05:48:31.722] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:33:0)
[05:48:31.722] Timer tick, asking Buildbucket for the build status
[05:48:31.882] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:31.882] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:34:0) after 1m0s
[05:49:31.903] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:34:0)
[05:49:31.903] Timer tick, asking Buildbucket for the build status
[05:49:31.976] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:31.976] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:35:0) after 1m0s
[05:50:31.998] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:35:0)
[05:50:31.998] Timer tick, asking Buildbucket for the build status
[05:50:32.068] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:32.068] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:36:0) after 1m0s
[05:51:32.089] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:36:0)
[05:51:32.089] Timer tick, asking Buildbucket for the build status
[05:51:32.452] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:32.452] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:37:0) after 1m0s
[05:52:32.478] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:37:0)
[05:52:32.478] Timer tick, asking Buildbucket for the build status
[05:52:39.271] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:39.271] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:38:0) after 1m0s
[05:53:39.290] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:38:0)
[05:53:39.290] Timer tick, asking Buildbucket for the build status
[05:53:39.373] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:39.373] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:39:0) after 1m0s
[05:54:39.445] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:39:0)
[05:54:39.445] Timer tick, asking Buildbucket for the build status
[05:54:39.574] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:39.574] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:40:0) after 1m0s
[05:55:39.608] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:40:0)
[05:55:39.608] Timer tick, asking Buildbucket for the build status
[05:55:39.672] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:39.672] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:41:0) after 1m0s
[05:56:39.750] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:41:0)
[05:56:39.750] Timer tick, asking Buildbucket for the build status
[05:56:40.295] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:40.295] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:42:0) after 1m0s
[05:57:40.314] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:42:0)
[05:57:40.314] Timer tick, asking Buildbucket for the build status
[05:57:40.486] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:40.486] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:43:0) after 1m0s
[05:58:40.510] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:43:0)
[05:58:40.510] Timer tick, asking Buildbucket for the build status
[05:58:40.836] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:40.836] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:44:0) after 1m0s
[05:59:40.861] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:44:0)
[05:59:40.861] Timer tick, asking Buildbucket for the build status
[05:59:40.964] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:40.964] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:45:0) after 1m0s
[06:00:40.985] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:45:0)
[06:00:40.985] Timer tick, asking Buildbucket for the build status
[06:00:41.308] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:41.308] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:46:0) after 1m0s
[06:01:43.368] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:46:0)
[06:01:43.368] Timer tick, asking Buildbucket for the build status
[06:01:43.504] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:43.504] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:47:0) after 1m0s
[06:02:43.612] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:47:0)
[06:02:43.613] Timer tick, asking Buildbucket for the build status
[06:02:43.828] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:43.828] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:48:0) after 1m0s
[06:03:43.878] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:48:0)
[06:03:43.878] Timer tick, asking Buildbucket for the build status
[06:03:43.959] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:43.959] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:49:0) after 1m0s
[06:04:44.082] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:49:0)
[06:04:44.082] Timer tick, asking Buildbucket for the build status
[06:04:44.162] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:44.162] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:50:0) after 1m0s
[06:05:44.269] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:50:0)
[06:05:44.269] Timer tick, asking Buildbucket for the build status
[06:05:44.426] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:44.426] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:51:0) after 1m0s
[06:06:44.646] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:51:0)
[06:06:44.646] Timer tick, asking Buildbucket for the build status
[06:06:44.706] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:44.706] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:52:0) after 1m0s
[06:07:44.810] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:52:0)
[06:07:44.810] Timer tick, asking Buildbucket for the build status
[06:07:44.970] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:44.970] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:53:0) after 1m0s
[06:08:45.041] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:53:0)
[06:08:45.041] Timer tick, asking Buildbucket for the build status
[06:08:45.175] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:45.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:54:0) after 1m0s
[06:09:45.216] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:54:0)
[06:09:45.216] Timer tick, asking Buildbucket for the build status
[06:09:45.290] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:45.290] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:55:0) after 1m0s
[06:10:45.314] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:55:0)
[06:10:45.314] Timer tick, asking Buildbucket for the build status
[06:10:45.392] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:45.392] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:56:0) after 1m0s
[06:11:45.436] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:56:0)
[06:11:45.436] Timer tick, asking Buildbucket for the build status
[06:11:45.518] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:45.518] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:57:0) after 1m0s
[06:12:45.506] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:57:0)
[06:12:45.506] Timer tick, asking Buildbucket for the build status
[06:12:45.910] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:45.910] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:58:0) after 1m0s
[06:13:45.940] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:58:0)
[06:13:45.940] Timer tick, asking Buildbucket for the build status
[06:13:46.084] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:46.084] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:59:0) after 1m0s
[06:14:46.139] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:59:0)
[06:14:46.139] Timer tick, asking Buildbucket for the build status
[06:14:46.202] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:46.202] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:60:0) after 1m0s
[06:15:47.711] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:60:0)
[06:15:47.711] Timer tick, asking Buildbucket for the build status
[06:15:48.348] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:48.348] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:61:0) after 1m0s
[06:16:48.764] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:61:0)
[06:16:48.764] Timer tick, asking Buildbucket for the build status
[06:16:48.872] Build 8865494050821716656: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:48.872] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030924112733882624:62:0) after 1m0s
[06:16:56.659] Received PubSub notification, asking Buildbucket for the build status
[06:16:56.744] Build 8865494050821716656: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:16:56.744] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603606615713022",
"created_by": "project:chromium",
"created_ts": "1603603043686978",
"id": "8865494050821716656",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3a47b622f08058daa6445ad2799aa6a123179628\"}}",
"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\": \"3a47b622f08058daa6445ad2799aa6a123179628\", \"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-1-kqo6\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15258, \"clang_revision\": \"llvmorg-12-init-5627-gf086e85e-2\", \"got_angle_revision\": \"7a0263547cda936b320d80c650b69d7522ee1a9f\", \"got_dawn_revision\": \"42103bc2e911144745d8d8930b07ba7e58553a34\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"3a47b622f08058daa6445ad2799aa6a123179628\", \"got_revision_cp\": \"refs/heads/master@{#820599}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"73fe59b55662be0ff07e79da1ece8b9e42415dca\", \"got_v8_revision_cp\": \"refs/heads/8.8.171@{#1}\", \"got_webrtc_revision\": \"3065e6ef3016a906d1db82e1d4322cbd53d43247\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32481}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3a47b622f08058daa6445ad2799aa6a123179628\", \"swarm_hashes_refs/heads/master(at){#820599}_without_patch\": {\"absl_hardening_tests\": \"c0d095f9e6d56f70d3e8b652d34e877284bf398c\", \"accessibility_unittests\": \"d48876d5100d2e556c1ba56f0eaef1733847c633\", \"angle_unittests\": \"e2baa7f729f6aee79da313851cd04234851f5595\", \"app_shell_unittests\": \"48c9a4830764029c74b12b25fc40f372a698e413\", \"aura_unittests\": \"8834e90f78378baa6ff2b328ded35b13b124f626\", \"base_unittests\": \"a7d733ba7e169e316e4483afb06f22a28d53ddfc\", \"base_util_unittests\": \"dc8edee8b9bf78fef95fa158335837e6c9b00a26\", \"blink_common_unittests\": \"87b03765e4bdb1ef1fd6c4889d275220b248edba\", \"blink_fuzzer_unittests\": \"bdee8f387d3cb8af03484941eb38abd1ac11ac57\", \"blink_heap_unittests\": \"89e4964e5b9efd91c44a0c1353e1ef627662e893\", \"blink_platform_unittests\": \"81166232e47dbf7aabe3c2bc19c0cc59594a8891\", \"blink_unittests\": \"3ba5e2194991529ece7f5b25da055c7ba4c91792\", \"boringssl_crypto_tests\": \"ec3dce471bb5bbdea87f66eaabc0a4446bf6d57e\", \"boringssl_ssl_tests\": \"a07467c4170ee998b2ac2ce77e3354e1b94faa25\", \"browser_switcher_bho_unittests\": \"a2f6c7291c00af1ac526cf25ae5b12d033783ccc\", \"browser_tests\": \"36ff089c77235780878f26cab42737d0f2317e56\", \"capture_unittests\": \"8f556be11ca2efd35f1dbb945e554d66486b9207\", \"cast_unittests\": \"e1668a5b2ba0c1d38a0435a6e5db7b1cfc5872c7\", \"cc_unittests\": \"429398c02a6c7790c8fa566f27e3770b9e209822\", \"chrome_app_unittests\": \"d2adafc2e1f48982b3697530b1e3191bfb8ab4e8\", \"chrome_cleaner_unittests\": \"2bcbb0c23e996c0ea96b32571bd5bc20d88e4e99\", \"chrome_elf_unittests\": \"a974bbeaefdd518fc9346b70ad56614ca3582250\", \"chromedriver_unittests\": \"79bf577d42597d8dd7cf715225b0f51bd341b1ea\", \"components_browsertests\": \"aaacbb5d8b46c67080ef7d7449f23e07f9bd227f\", \"components_unittests\": \"2f158d5636dece4fd9c67d899dcdbaa4c3fce23d\", \"compositor_unittests\": \"521e2ebc7bc085eb7d8d3333a219282ee26e3a2c\", \"content_browsertests\": \"48649b87ecdb81128c0f40aecda57bd359a024e8\", \"content_unittests\": \"e25feaa37cab5c9ca71cb3fc35565406d9456750\", \"courgette_unittests\": \"080e0737e316593e009d4ec9d474bcbd9dfb41b8\", \"crashpad_tests\": \"1328ac7d00785a1459bcb60d995ba7529b5e2129\", \"cronet_tests\": \"fc52e7538a23a352e1cfd964f5bf843daf6a4d0e\", \"cronet_unittests\": \"a346ba5b79d8e8e3da2dd26755f28cf7f03ff937\", \"crypto_unittests\": \"f8e9a355a519399b7333dcb8f329f99234b941eb\", \"delayloads_unittests\": \"8fc80370ffb1520c640617d77eb841362195d88d\", \"device_unittests\": \"1ac07ad999be00fe5a2f6daceb1c8b05b1df30f9\", \"display_unittests\": \"a9b8c08a6d6179b4d0a9e06019fcf1ea4b741e6c\", \"elevation_service_unittests\": \"345d709ac0950d09a566634a4c175b78ae880ffe\", \"events_unittests\": \"cd473a2b2a83c8037a7f3dd09d23a4c84b863495\", \"extensions_browsertests\": \"10ce41f937f04c0619233016c563fb4206559026\", \"extensions_unittests\": \"e221a1cddf0091909afd6a3b0fae338e862bd989\", \"filesystem_service_unittests\": \"5102e343e1ad5488cc79d364ceeff2693b8d5a28\", \"gcm_unit_tests\": \"cd2338dec40dca5cf6f03d1fdf8c7c94e9de464a\", \"gcp_unittests\": \"5eb52b02bce0256ebda0e198132860ff4935a355\", \"gfx_unittests\": \"bc4a280164a699fb350bb1b647487051c02f14cf\", \"gin_unittests\": \"4b9162fbefe31fe936f54eb3caedd9997fc85806\", \"google_apis_unittests\": \"5135b9fac7fb142e7c8bf059cacf95fce66c943e\", \"gpu_unittests\": \"674ff61c8b4cb0adf13dd4de97a5d74d583a9224\", \"gwp_asan_unittests\": \"2f2145511e82ec434b898e1cd3613c666401fad1\", \"headless_browsertests\": \"6157388f80365f25ce80db3c6a5dd749e8a4641b\", \"headless_unittests\": \"0f15616cde0d7787423613079cd1ccebd5db4706\", \"install_static_unittests\": \"d7aa732d849fb38a65c48d79d12a8472a2e2bb3f\", \"installer_util_unittests\": \"12d9df7d508ad12c21a661afb551561cc291bca5\", \"interactive_ui_tests\": \"6472d9485c1be83ab7fee7a89221d0d3eb72c086\", \"ipc_tests\": \"9ab3c238fcc746af6997920865bf01b0f43e7c0c\", \"jingle_unittests\": \"94f2b8ea10c82b8a1d8cd7b088c2b6ad511bb2d5\", \"latency_unittests\": \"ca5dc0a010628b5b08b92b5648b871b69b57f8b0\", \"libjingle_xmpp_unittests\": \"527c7b1d4413da918d67abccd186f3e556d2590f\", \"media_blink_unittests\": \"2ed3721fed3c76a8f65d99c0ec68b4e7c6e5fcee\", \"media_unittests\": \"f0686154cf908c1e37e93bc50fd12db04d0b5db0\", \"message_center_unittests\": \"37797581f65304795f8ab473b70347d5f4a9a1f3\", \"midi_unittests\": \"6038f4a4fe09c327baa35104034fbd0d8f90856f\", \"mojo_core_unittests\": \"e4a4d4e8e3f2c179f833025ab9335d0f1654d6dc\", \"mojo_unittests\": \"bc7102a879884890fe56b2cc6e2f5d74393e270d\", \"nacl_loader_unittests\": \"52103030bb259a25be31c4a400472869527d2631\", \"native_theme_unittests\": \"bc728bb2dc93539828972ddeab1822bb442113fa\", \"net_unittests\": \"ecfc9eec95debfbc91e082e59bcd4d578a900850\", \"notification_helper_unittests\": \"24ccf4423058db9cfd791f327acd5c1ed1e1e91a\", \"pdf_unittests\": \"1cb45083aa46b70de7f29c456933f4db3fc159a1\", \"perfetto_unittests\": \"b1cc7d4ee3bb65678dcbde5c2f18850967538151\", \"ppapi_unittests\": \"61c9968b5fb208df17bfa70d7cf6c7095ffdca14\", \"printing_unittests\": \"b1a0839ffad7252deea75a2c5d3c1862f91c07bb\", \"remoting_unittests\": \"2826bb9e5d8ed2b295ba98d9cf79fe5d28b874c9\", \"sbox_integration_tests\": \"879fbfc8598389bafe00dd89f659a1ef74f22aee\", \"sbox_unittests\": \"4df42aadbf8ea4f5aac35272b5ecdba3154635f6\", \"sbox_validation_tests\": \"9c99e2aeabbd850678c2e8a24a9276b73ee245cf\", \"service_manager_unittests\": \"4d0b14f1ed875e988a4a43675b6f60075eae1d28\", \"services_unittests\": \"db50a9006112a955b9be5a073551c350da8beacf\", \"setup_unittests\": \"76b521de3bec6e4ad54c0e6cc86c531080957e37\", \"shell_dialogs_unittests\": \"fe7e23c3e24fc776554e34ca5627cf47df57f859\", \"skia_unittests\": \"9f4bd87a3b9bcc4ad837d15b57fb5674baba965b\", \"snapshot_unittests\": \"074bf87f132206797daa323fdb1686ed1eee8f2e\", \"sql_unittests\": \"758aed851f5a76a56e7f0368c7cbf49b25e4c364\", \"storage_unittests\": \"23f993aaa615e03c13c95ecad48393d5a6ee193d\", \"sync_integration_tests\": \"8e0c92d80718dc84d98e3491bbc78923307471d3\", \"traffic_annotation_auditor_unittests\": \"584724910ed2387ac7e784a6c19bc6ffb7ef9652\", \"ui_base_unittests\": \"0ccea353394035198dd75d8914d040b7d84f4cfc\", \"ui_touch_selection_unittests\": \"b5fcdffe418e905e1d336724d94d1f4a9db313b7\", \"unit_tests\": \"cbc32101d9a6d44c867e5e97045f4ae6aa3696d6\", \"updater_tests\": \"524e2661aca1ab79160fadaafcf155a5ba63640e\", \"url_unittests\": \"6e9ea58d716c9312bcb8a02f9c7bfe2992fa724c\", \"views_unittests\": \"972cb40fecc3819a53d2240019097ed0cf1d7947\", \"viz_unittests\": \"1ead8bc09f9c4601e91bb4664b954805e50f58ab\", \"vr_common_unittests\": \"377d99f9ef5bc05f36d3cfe7c7b442bc25fee3e4\", \"vr_pixeltests\": \"11d0e9c385b433bf0e5a866f21c44471fb27abf8\", \"weblayer_browsertests\": \"de99556e480e5bf6a4fcd38917848e4f9907a76d\", \"weblayer_unittests\": \"b9df0ee47babd40064c1f43bb23f9371ca0e173e\", \"wm_unittests\": \"d10dd6ba996bf5adede3a8940fb7d83e93a39a2d\", \"wtf_unittests\": \"5c55cb946d1bc6beb6f7f84d898aa24b17bbf042\", \"zlib_unittests\": \"fdd1e99e88f59ed3615e7124b01cd4d068bd4167\", \"zucchini_unittests\": \"98f1e93e2ad67a6f1714bd6ad2ee178cd7b0a773\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_a4ee364c4b5996d1649f16c77d7186222b75eb5b75762fbbe3baeec97aac12d9_v2\", \"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-1-kqo6\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5612-26d29a7\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603603045801482",
"status": "COMPLETED",
"status_changed_ts": "1603606616125143",
"tags": [
"build_address:luci.chromium.ci/win-asan/15258",
"builder:win-asan",
"buildset:commit/git/3a47b622f08058daa6445ad2799aa6a123179628",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3a47b622f08058daa6445ad2799aa6a123179628",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030924112733882624",
"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/8865494050821716656/+/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:4f770221e514cd10",
"user_agent:luci-scheduler"
],
"updated_ts": "1603606616132039",
"url": "https://ci.chromium.org/b/8865494050821716656",
"utcnow_ts": "1603606616730784"
}
}
[06:16:56.744] Invocation finished in 59m34.26538334s with status SUCCEEDED