[15:55:24.671] New invocation is queued and will start shortly
[15:55:25.813] Starting the invocation (attempt 1)
[15:55:25.851] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:55:25.852] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:55:25.852] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028437852871543728",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f0e03306e587863247d807f8a5a64a68a0be93b3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9028437852871543728",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/f0e03306e587863247d807f8a5a64a68a0be93b3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f0e03306e587863247d807f8a5a64a68a0be93b3",
"gitiles_ref:refs/heads/master"
]
}
[15:55:26.470] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605974125940984",
"id": "8863007790876503200",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f0e03306e587863247d807f8a5a64a68a0be93b3\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605974126366125",
"tags": [
"build_address:luci.chromium.ci/win-asan/15762",
"builder:win-asan",
"buildset:commit/git/f0e03306e587863247d807f8a5a64a68a0be93b3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f0e03306e587863247d807f8a5a64a68a0be93b3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028437852871543728",
"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/8863007790876503200/+/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": "1605974126366265",
"url": "https://ci.chromium.org/b/8863007790876503200",
"utcnow_ts": "1605974126463129"
}
}
[15:55:26.470] Task URL: https://ci.chromium.org/b/8863007790876503200
[15:55:26.470] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:2:0) after 1m0s
[15:55:30.976] Received PubSub notification, asking Buildbucket for the build status
[15:55:31.156] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:26.596] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:2:0)
[15:56:26.596] Timer tick, asking Buildbucket for the build status
[15:56:26.691] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:26.691] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:4:0) after 1m0s
[15:57:26.737] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:4:0)
[15:57:26.737] Timer tick, asking Buildbucket for the build status
[15:57:26.843] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:26.843] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:5:0) after 1m0s
[15:58:26.879] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:5:0)
[15:58:26.879] Timer tick, asking Buildbucket for the build status
[15:58:27.006] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:27.006] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:6:0) after 1m0s
[15:59:27.042] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:6:0)
[15:59:27.042] Timer tick, asking Buildbucket for the build status
[15:59:27.153] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:27.153] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:7:0) after 1m0s
[16:00:27.136] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:7:0)
[16:00:27.136] Timer tick, asking Buildbucket for the build status
[16:00:27.278] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:27.279] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:8:0) after 1m0s
[16:01:27.341] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:8:0)
[16:01:27.341] Timer tick, asking Buildbucket for the build status
[16:01:27.598] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:27.598] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:9:0) after 1m0s
[16:02:27.743] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:9:0)
[16:02:27.743] Timer tick, asking Buildbucket for the build status
[16:02:27.808] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:27.808] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:10:0) after 1m0s
[16:03:27.883] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:10:0)
[16:03:27.883] Timer tick, asking Buildbucket for the build status
[16:03:27.949] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:27.949] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:11:0) after 1m0s
[16:04:28.015] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:11:0)
[16:04:28.015] Timer tick, asking Buildbucket for the build status
[16:04:28.160] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:28.160] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:12:0) after 1m0s
[16:05:28.306] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:12:0)
[16:05:28.306] Timer tick, asking Buildbucket for the build status
[16:05:28.434] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:28.434] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:13:0) after 1m0s
[16:06:28.526] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:13:0)
[16:06:28.526] Timer tick, asking Buildbucket for the build status
[16:06:28.605] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:28.605] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:14:0) after 1m0s
[16:07:28.728] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:14:0)
[16:07:28.728] Timer tick, asking Buildbucket for the build status
[16:07:29.004] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:29.004] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:15:0) after 1m0s
[16:08:29.088] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:15:0)
[16:08:29.088] Timer tick, asking Buildbucket for the build status
[16:08:29.223] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:29.223] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:16:0) after 1m0s
[16:09:29.309] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:16:0)
[16:09:29.309] Timer tick, asking Buildbucket for the build status
[16:09:29.441] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:29.441] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:17:0) after 1m0s
[16:10:29.526] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:17:0)
[16:10:29.526] Timer tick, asking Buildbucket for the build status
[16:10:29.616] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:29.616] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:18:0) after 1m0s
[16:11:29.693] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:18:0)
[16:11:29.693] Timer tick, asking Buildbucket for the build status
[16:11:30.287] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:30.287] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:19:0) after 1m0s
[16:12:30.428] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:19:0)
[16:12:30.428] Timer tick, asking Buildbucket for the build status
[16:12:30.595] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:30.595] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:20:0) after 1m0s
[16:13:30.665] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:20:0)
[16:13:30.665] Timer tick, asking Buildbucket for the build status
[16:13:30.779] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:30.779] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:21:0) after 1m0s
[16:14:30.801] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:21:0)
[16:14:30.801] Timer tick, asking Buildbucket for the build status
[16:14:30.953] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:30.953] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:22:0) after 1m0s
[16:15:31.066] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:22:0)
[16:15:31.066] Timer tick, asking Buildbucket for the build status
[16:15:31.210] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:31.210] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:23:0) after 1m0s
[16:16:31.312] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:23:0)
[16:16:31.312] Timer tick, asking Buildbucket for the build status
[16:16:31.440] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:31.440] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:24:0) after 1m0s
[16:17:31.445] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:24:0)
[16:17:31.445] Timer tick, asking Buildbucket for the build status
[16:17:31.568] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:31.568] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:25:0) after 1m0s
[16:18:31.589] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:25:0)
[16:18:31.589] Timer tick, asking Buildbucket for the build status
[16:18:31.785] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:31.785] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:26:0) after 1m0s
[16:19:31.796] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:26:0)
[16:19:31.796] Timer tick, asking Buildbucket for the build status
[16:19:31.919] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:31.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:27:0) after 1m0s
[16:20:31.946] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:27:0)
[16:20:31.946] Timer tick, asking Buildbucket for the build status
[16:20:32.056] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:32.056] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:28:0) after 1m0s
[16:21:32.148] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:28:0)
[16:21:32.148] Timer tick, asking Buildbucket for the build status
[16:21:32.697] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:32.697] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:29:0) after 1m0s
[16:22:32.718] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:29:0)
[16:22:32.718] Timer tick, asking Buildbucket for the build status
[16:22:32.799] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:32.799] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:30:0) after 1m0s
[16:23:32.784] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:30:0)
[16:23:32.784] Timer tick, asking Buildbucket for the build status
[16:23:32.848] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:32.848] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:31:0) after 1m0s
[16:24:32.874] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:31:0)
[16:24:32.874] Timer tick, asking Buildbucket for the build status
[16:24:32.942] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:32.942] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:32:0) after 1m0s
[16:25:33.013] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:32:0)
[16:25:33.013] Timer tick, asking Buildbucket for the build status
[16:25:33.154] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:33.154] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:33:0) after 1m0s
[16:26:33.175] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:33:0)
[16:26:33.175] Timer tick, asking Buildbucket for the build status
[16:26:33.242] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:33.242] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:34:0) after 1m0s
[16:27:33.262] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:34:0)
[16:27:33.262] Timer tick, asking Buildbucket for the build status
[16:27:33.504] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:33.504] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:35:0) after 1m0s
[16:28:33.529] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:35:0)
[16:28:33.529] Timer tick, asking Buildbucket for the build status
[16:28:33.723] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:33.723] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:36:0) after 1m0s
[16:29:33.747] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:36:0)
[16:29:33.747] Timer tick, asking Buildbucket for the build status
[16:29:33.821] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:33.821] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:37:0) after 1m0s
[16:30:33.854] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:37:0)
[16:30:33.854] Timer tick, asking Buildbucket for the build status
[16:30:34.988] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:34.988] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:38:0) after 1m0s
[16:31:35.152] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:38:0)
[16:31:35.152] Timer tick, asking Buildbucket for the build status
[16:31:35.357] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:35.357] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:39:0) after 1m0s
[16:32:35.378] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:39:0)
[16:32:35.378] Timer tick, asking Buildbucket for the build status
[16:32:35.809] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:35.809] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:40:0) after 1m0s
[16:33:35.836] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:40:0)
[16:33:35.837] Timer tick, asking Buildbucket for the build status
[16:33:36.079] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:36.079] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:41:0) after 1m0s
[16:34:36.262] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:41:0)
[16:34:36.262] Timer tick, asking Buildbucket for the build status
[16:34:36.509] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:36.509] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:42:0) after 1m0s
[16:35:36.543] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:42:0)
[16:35:36.543] Timer tick, asking Buildbucket for the build status
[16:35:38.328] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:38.328] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:43:0) after 1m0s
[16:36:38.403] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:43:0)
[16:36:38.403] Timer tick, asking Buildbucket for the build status
[16:36:38.490] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:38.490] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:44:0) after 1m0s
[16:37:38.479] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:44:0)
[16:37:38.479] Timer tick, asking Buildbucket for the build status
[16:37:38.597] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:38.597] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:45:0) after 1m0s
[16:38:38.611] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:45:0)
[16:38:38.611] Timer tick, asking Buildbucket for the build status
[16:38:38.743] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:38.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:46:0) after 1m0s
[16:39:38.770] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:46:0)
[16:39:38.770] Timer tick, asking Buildbucket for the build status
[16:39:38.875] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:38.875] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:47:0) after 1m0s
[16:40:38.927] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:47:0)
[16:40:38.927] Timer tick, asking Buildbucket for the build status
[16:40:40.289] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:40.289] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:48:0) after 1m0s
[16:41:40.347] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:48:0)
[16:41:40.347] Timer tick, asking Buildbucket for the build status
[16:41:40.417] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:40.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:49:0) after 1m0s
[16:42:40.439] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:49:0)
[16:42:40.439] Timer tick, asking Buildbucket for the build status
[16:42:40.526] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:40.526] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:50:0) after 1m0s
[16:43:40.651] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:50:0)
[16:43:40.651] Timer tick, asking Buildbucket for the build status
[16:43:40.729] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:40.729] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:51:0) after 1m0s
[16:44:40.798] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:51:0)
[16:44:40.798] Timer tick, asking Buildbucket for the build status
[16:44:40.870] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:40.870] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:52:0) after 1m0s
[16:45:40.970] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:52:0)
[16:45:40.970] Timer tick, asking Buildbucket for the build status
[16:45:41.354] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:41.354] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:53:0) after 1m0s
[16:46:41.446] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:53:0)
[16:46:41.446] Timer tick, asking Buildbucket for the build status
[16:46:41.768] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:41.768] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:54:0) after 1m0s
[16:47:41.765] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:54:0)
[16:47:41.765] Timer tick, asking Buildbucket for the build status
[16:47:41.903] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:41.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:55:0) after 1m0s
[16:48:41.925] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:55:0)
[16:48:41.925] Timer tick, asking Buildbucket for the build status
[16:48:42.071] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:42.071] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:56:0) after 1m0s
[16:49:42.127] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:56:0)
[16:49:42.127] Timer tick, asking Buildbucket for the build status
[16:49:42.307] Build 8863007790876503200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:42.307] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028437852871543728:57:0) after 1m0s
[16:50:12.290] Received PubSub notification, asking Buildbucket for the build status
[16:50:12.377] Build 8863007790876503200: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:50:12.377] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605977410749965",
"created_by": "project:chromium",
"created_ts": "1605974125940984",
"id": "8863007790876503200",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f0e03306e587863247d807f8a5a64a68a0be93b3\"}}",
"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\": \"f0e03306e587863247d807f8a5a64a68a0be93b3\", \"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-3-xoby\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15762, \"clang_revision\": \"llvmorg-12-init-12083-g94e4ec64-1\", \"got_angle_revision\": \"e51c9068a84f14e42157c097eb764ec3009e0e54\", \"got_dawn_revision\": \"41b3f9c1e4aaaa3d56d205d81e61deaebdd40d75\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"f0e03306e587863247d807f8a5a64a68a0be93b3\", \"got_revision_cp\": \"refs/heads/master@{#829993}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"6d612051c083238db89541be4fbb2d624a9baef4\", \"got_v8_revision\": \"22f2e5ef66ed5c820532f27b141096d3ddb1966e\", \"got_v8_revision_cp\": \"refs/heads/8.9.31@{#1}\", \"got_webrtc_revision\": \"7d75f2ca782f38006bb65bc67533e582190454e8\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32659}\", \"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\": \"f0e03306e587863247d807f8a5a64a68a0be93b3\", \"swarm_hashes_refs/heads/master(at){#829993}_without_patch\": {\"absl_hardening_tests\": \"03f8cf3a2f4169627e0ed28ba69c5c84c44e9bca\", \"accessibility_unittests\": \"fb53dc171b0a719d0aab3c657cd47e0319bf9b4f\", \"angle_unittests\": \"61d00a2ca7432bf2f24d1cfe2e38adfe0b5dada6\", \"app_shell_unittests\": \"231d1049e7e4a827c56534793149c0ccdcccfe36\", \"aura_unittests\": \"7f3e44ec9a4f08c3446356586239fe6c4c54fe35\", \"base_unittests\": \"b17ffdd03697a33f343c1c2a67807ddb161c7985\", \"base_util_unittests\": \"812836bc6dd6835f64320125857ead7b6fcb58da\", \"blink_common_unittests\": \"fb0ba58a55d4c89e3b2e8507aa9bf01b51295c14\", \"blink_fuzzer_unittests\": \"57b1d47a89e15f50aef04511f7b9925622f874b4\", \"blink_heap_unittests\": \"4961deb0c9af9390c7d103f0b4e5531e360ed474\", \"blink_platform_unittests\": \"26c40edcf6394322f5a639dcdd0589173bddbe97\", \"blink_unittests\": \"1b0b210de7c5a25c93ae37fcea701970cf549ee8\", \"boringssl_crypto_tests\": \"437c75175903f17674a9426a491631b4128312e4\", \"boringssl_ssl_tests\": \"f4ff432e1af43e5acb487de694833bb9c814729b\", \"browser_switcher_bho_unittests\": \"919516cdd26c2924eef5e801aba557510c19e98d\", \"browser_tests\": \"85e43a244f08844c0501edd35a6f68eeeb7db377\", \"capture_unittests\": \"c59e2862d479d275ee14875e0b1361cda16f9131\", \"cast_unittests\": \"2e81114622f67db4173bd0819448ed199add6ea0\", \"cc_unittests\": \"d42a98bbc33f8d3965b854c372205943f0863ebf\", \"chrome_app_unittests\": \"32941472390a0e83a32bf67ca4acd134252567d9\", \"chrome_cleaner_unittests\": \"7b80ca66f96ea4228110f27f40ec6928a7e0c0ca\", \"chrome_elf_unittests\": \"395ec163e520b8ece76cf8eed8edd4826f5555ef\", \"chromedriver_unittests\": \"1ed4c780f49f3e5ad6f7b840559f37df081e0148\", \"components_browsertests\": \"bf22086b03fe1951fbe43b8201e981246226c18d\", \"components_unittests\": \"f04550c3cd914d63fc0d6e8a39ef8c1ab7a2d6b5\", \"compositor_unittests\": \"d5129f93580bd6a52c4b28e7323051035dc05ab4\", \"content_browsertests\": \"c8185a9c82734ce2e238be38d97172b9f1bd9cf6\", \"content_unittests\": \"914ea7528b21170d88d9e3e2b073499d2231e7a5\", \"courgette_unittests\": \"a17f5074c9c443370901ebbd313a73fad4f2232d\", \"crashpad_tests\": \"2fa8caccdc442fd1d58e8af08fc7595ed23482c8\", \"cronet_tests\": \"64a1a87b84d94ba28aa36b43e4349cb99bb90ceb\", \"cronet_unittests\": \"77db119592d5c1ef68e9c029cfddd9430a31f9f6\", \"crypto_unittests\": \"3da2dbc00740440fb318d4c7ff7565d884f2c7d4\", \"delayloads_unittests\": \"e68dee02333688b08101411c977f4522e4d3a7c2\", \"device_unittests\": \"2c36c19f1f5a30403b1812982412930b8ffe4fce\", \"display_unittests\": \"0e7859cfabf5c929767bb12e87ee08954c1ffd2f\", \"elevation_service_unittests\": \"880fe3de2e7dc583d98adbf9c5d6bcc9c2fd7bc5\", \"events_unittests\": \"c4eba6bb9e73292f983ec6e88da3f87ab6053570\", \"extensions_browsertests\": \"5d7fd6807781273c8260f452176c05edaf9f288c\", \"extensions_unittests\": \"1b70391b8cae64a50d185c33fd32c6db2c9868ba\", \"filesystem_service_unittests\": \"fdac573d1382394d2f151c6d3bfbeb63e15a0cc3\", \"gcm_unit_tests\": \"f57052a52de0643e7f742d3751f42fd1513c1717\", \"gcp_unittests\": \"03c967426ef7fcdd34c134fabdd9aaefcccaf692\", \"gfx_unittests\": \"b72cc1dee8587b7712125ada73b4d76ac73e1d9c\", \"gin_unittests\": \"f3c145ba478a44a5a280790d3f2f8f22aa41d9e1\", \"google_apis_unittests\": \"8f85a3448b172e3a4a8e47a1bea93f3abbf09a66\", \"gpu_unittests\": \"600b8d882b615314b56fa3dd8ea9e11a4f966058\", \"gwp_asan_unittests\": \"d089adbe34f9eb3581284df92e7c9b9cae7bf80e\", \"headless_browsertests\": \"0ab4a0b28c076bac5636b2d92e371f73ab422745\", \"headless_unittests\": \"c18957894463d55503c3b331b97dbbc26b54e735\", \"install_static_unittests\": \"2edf1b7d23afcb4022d3824355ed553468a3e500\", \"installer_util_unittests\": \"99f6c32ed92424b80abbd849df29138afb655b61\", \"interactive_ui_tests\": \"908fa3db18aa7e67bdf8697fd87c9a1adb6a655c\", \"ipc_tests\": \"8a91f2ffb2683809f4c32af4109fa87e6e4cee65\", \"jingle_unittests\": \"c724bb89720f07bd799734ae38f279747592896d\", \"latency_unittests\": \"1104431caf1173a54aa4a519a628abb607982b19\", \"libjingle_xmpp_unittests\": \"572ece09f722d4c605e3b5329e22992e71ddf109\", \"liburlpattern_unittests\": \"4d9b160b32a730f6228271723d31ba3533ea8a90\", \"media_blink_unittests\": \"e886025ededdb066a8573ef7fb9724019cc3d5f7\", \"media_unittests\": \"beafab018506e52496a18445730b1a92300f4e1b\", \"message_center_unittests\": \"ab0d74f33b1115ba7259449f28b030d82bdd4d92\", \"midi_unittests\": \"d1c87dca65125232d5addd6c538d49aa18b2b6dc\", \"mojo_core_unittests\": \"475f21aeb586ace23eee0c18ba22b4aafbea0bc3\", \"mojo_unittests\": \"0734a3cc1a2c78220b9a22073a148abb89ab2710\", \"nacl_loader_unittests\": \"347b3c57fa898403fbe620a6c9fa18bc9eef2141\", \"native_theme_unittests\": \"ca5738b52eba8b510209eb143e06c9c2b0991998\", \"net_unittests\": \"3cd506f18c18a86a4994dbfe009d8c251640b384\", \"notification_helper_unittests\": \"1c53d2cde38bceb8a4a98d0ff358d2fb3b2f3cde\", \"pdf_unittests\": \"42aaef1ec9f0cd89c35455bb5e3ec4613a6b2551\", \"perfetto_unittests\": \"82bd99ddee7719e34966774e38dc3b74958506d3\", \"ppapi_unittests\": \"da99c3159c5fc243f5f6de5b2e8f974c6213739b\", \"printing_unittests\": \"9f1492dfd85b14a4c1274e914e554430dd6e94a2\", \"remoting_unittests\": \"4483a6fa7ae3f22b904af6f1f85412396bd22150\", \"sbox_integration_tests\": \"e6bd515c87268308824a2c219974ac6df2d152d1\", \"sbox_unittests\": \"fb25190ce879ae23856e8fa9ec2df388ea4a81f0\", \"sbox_validation_tests\": \"73711daf6e4bee6a49876d8236a80596d9026575\", \"service_manager_unittests\": \"8a2b0f87cdf0eae2fd15ba3d92035ea7cf208c55\", \"services_unittests\": \"6da9d2744d0ea8e618dcf81740c80263b2cc78a3\", \"setup_unittests\": \"bb2ca24c54cac58f02caed9ef369d2f3543b6eb8\", \"shell_dialogs_unittests\": \"38f4573715e605d5a9a70470cbed3a2b181f41c9\", \"skia_unittests\": \"23f518601809eec29f28ebf03b115857d16e4f55\", \"snapshot_unittests\": \"e04ae10d0e16b101dc24d6bbdb50df90cb781fa1\", \"sql_unittests\": \"b758c138cfee371b392954b82b108423636c39bc\", \"storage_unittests\": \"522bd2cbb9c46c9f169598a7b2fa04e07cfe7587\", \"sync_integration_tests\": \"b1cd67e3402d1cc541011b2abce220048ec7d27a\", \"traffic_annotation_auditor_unittests\": \"f47a08f7c985d97872e41dcc546da1e45a12b3a7\", \"ui_base_unittests\": \"62da446e645a853bb7cd268e8f1086b63971b6fc\", \"ui_touch_selection_unittests\": \"10dc99cf467af7e1afaa6969936270d1088c431b\", \"unit_tests\": \"b3b6a8fc4e92bceb3f742694d52b5451927ba04c\", \"updater_tests\": \"de754bb26075e20e3844059ccd0501d98c5170de\", \"url_unittests\": \"6ad24ee46ed673531cf4d3fba2020f90e7f10499\", \"views_unittests\": \"9572a3de56bc15b015f04b48cf19ae0ed4c8987b\", \"viz_unittests\": \"1dd2bfe1cb1cdda8b730ddb533f2a93de92a5e6f\", \"vr_common_unittests\": \"cbd06ec99cee6baca89f70b8f9f2c4ac9e6d37c5\", \"vr_pixeltests\": \"84f97c84ea69092f968def0a0abd9c1bfef0039e\", \"weblayer_browsertests\": \"8171b7f027fc7279340a4617326677292ebfb7c9\", \"weblayer_unittests\": \"12f7638e0e8d47501c437ee39dee8fd436013ca6\", \"wm_unittests\": \"1f6c0eeb8fbedfcdc888950e913f21e05fed2bd0\", \"wtf_unittests\": \"0c2ed8a1038d44d90a673bd9fc42e02f60276126\", \"zlib_unittests\": \"ba6da342d7ae880f9c35d222d5c5daa0c2a982a3\", \"zucchini_unittests\": \"75335a4920051e8a5388fc68fa6c32da0ae47dce\"}}, \"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-3-xoby\"], \"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\": [\"5637-4d8b832\"], \"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": "1605974129279322",
"status": "COMPLETED",
"status_changed_ts": "1605977411301663",
"tags": [
"build_address:luci.chromium.ci/win-asan/15762",
"builder:win-asan",
"buildset:commit/git/f0e03306e587863247d807f8a5a64a68a0be93b3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f0e03306e587863247d807f8a5a64a68a0be93b3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028437852871543728",
"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/8863007790876503200/+/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:500455f9929b8f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1605977411331111",
"url": "https://ci.chromium.org/b/8863007790876503200",
"utcnow_ts": "1605977412367955"
}
}
[16:50:12.377] Invocation finished in 54m47.723075487s with status SUCCEEDED