[14:51:22.727] New invocation is queued and will start shortly
[14:51:23.891] Starting the invocation (attempt 1)
[14:51:23.933] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:51:23.933] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:51:23.934] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028441881439763504",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"11c10161166c703c568730ee61a09c6f0041be3a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9028441881439763504",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/11c10161166c703c568730ee61a09c6f0041be3a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/11c10161166c703c568730ee61a09c6f0041be3a",
"gitiles_ref:refs/heads/master"
]
}
[14:51:24.435] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605970284019095",
"id": "8863011819423131568",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"11c10161166c703c568730ee61a09c6f0041be3a\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605970284328457",
"tags": [
"build_address:luci.chromium.ci/win-asan/15761",
"builder:win-asan",
"buildset:commit/git/11c10161166c703c568730ee61a09c6f0041be3a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/11c10161166c703c568730ee61a09c6f0041be3a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028441881439763504",
"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/8863011819423131568/+/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": "1605970284328574",
"url": "https://ci.chromium.org/b/8863011819423131568",
"utcnow_ts": "1605970284427554"
}
}
[14:51:24.435] Task URL: https://ci.chromium.org/b/8863011819423131568
[14:51:24.435] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:2:0) after 1m0s
[14:51:28.324] Received PubSub notification, asking Buildbucket for the build status
[14:51:28.407] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:24.559] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:2:0)
[14:52:24.559] Timer tick, asking Buildbucket for the build status
[14:52:24.696] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:24.696] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:4:0) after 1m0s
[14:53:24.808] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:4:0)
[14:53:24.808] Timer tick, asking Buildbucket for the build status
[14:53:24.913] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:24.913] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:5:0) after 1m0s
[14:54:24.999] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:5:0)
[14:54:24.999] Timer tick, asking Buildbucket for the build status
[14:54:25.112] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:25.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:6:0) after 1m0s
[14:55:25.137] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:6:0)
[14:55:25.137] Timer tick, asking Buildbucket for the build status
[14:55:25.325] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:25.325] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:7:0) after 1m0s
[14:56:25.341] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:7:0)
[14:56:25.341] Timer tick, asking Buildbucket for the build status
[14:56:25.458] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:25.458] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:8:0) after 1m0s
[14:57:25.478] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:8:0)
[14:57:25.478] Timer tick, asking Buildbucket for the build status
[14:57:25.543] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:25.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:9:0) after 1m0s
[14:58:25.579] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:9:0)
[14:58:25.579] Timer tick, asking Buildbucket for the build status
[14:58:25.655] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:25.655] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:10:0) after 1m0s
[14:59:25.678] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:10:0)
[14:59:25.678] Timer tick, asking Buildbucket for the build status
[14:59:25.746] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:25.747] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:11:0) after 1m0s
[15:00:25.730] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:11:0)
[15:00:25.730] Timer tick, asking Buildbucket for the build status
[15:00:26.115] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:26.115] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:12:0) after 1m0s
[15:01:26.149] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:12:0)
[15:01:26.150] Timer tick, asking Buildbucket for the build status
[15:01:26.353] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:26.353] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:13:0) after 1m0s
[15:02:26.436] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:13:0)
[15:02:26.437] Timer tick, asking Buildbucket for the build status
[15:02:26.561] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:26.561] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:14:0) after 1m0s
[15:03:26.589] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:14:0)
[15:03:26.589] Timer tick, asking Buildbucket for the build status
[15:03:26.697] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:26.697] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:15:0) after 1m0s
[15:04:26.724] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:15:0)
[15:04:26.724] Timer tick, asking Buildbucket for the build status
[15:04:27.031] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:27.031] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:16:0) after 1m0s
[15:05:27.072] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:16:0)
[15:05:27.072] Timer tick, asking Buildbucket for the build status
[15:05:27.227] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:27.227] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:17:0) after 1m0s
[15:06:27.214] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:17:0)
[15:06:27.214] Timer tick, asking Buildbucket for the build status
[15:06:27.341] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:27.341] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:18:0) after 1m0s
[15:07:27.399] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:18:0)
[15:07:27.399] Timer tick, asking Buildbucket for the build status
[15:07:28.056] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:28.056] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:19:0) after 1m0s
[15:08:28.213] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:19:0)
[15:08:28.213] Timer tick, asking Buildbucket for the build status
[15:08:28.348] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:28.348] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:20:0) after 1m0s
[15:09:28.370] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:20:0)
[15:09:28.370] Timer tick, asking Buildbucket for the build status
[15:09:28.493] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:28.493] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:21:0) after 1m0s
[15:10:28.586] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:21:0)
[15:10:28.586] Timer tick, asking Buildbucket for the build status
[15:10:29.053] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:29.053] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:22:0) after 1m0s
[15:11:29.132] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:22:0)
[15:11:29.132] Timer tick, asking Buildbucket for the build status
[15:11:29.347] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:29.347] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:23:0) after 1m0s
[15:12:29.352] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:23:0)
[15:12:29.352] Timer tick, asking Buildbucket for the build status
[15:12:29.918] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:29.918] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:24:0) after 1m0s
[15:13:29.983] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:24:0)
[15:13:29.983] Timer tick, asking Buildbucket for the build status
[15:13:30.226] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:30.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:25:0) after 1m0s
[15:14:30.326] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:25:0)
[15:14:30.326] Timer tick, asking Buildbucket for the build status
[15:14:30.837] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:30.837] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:26:0) after 1m0s
[15:15:31.863] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:26:0)
[15:15:31.863] Timer tick, asking Buildbucket for the build status
[15:15:32.251] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:32.251] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:27:0) after 1m0s
[15:16:32.459] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:27:0)
[15:16:32.459] Timer tick, asking Buildbucket for the build status
[15:16:32.639] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:32.639] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:28:0) after 1m0s
[15:17:32.717] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:28:0)
[15:17:32.717] Timer tick, asking Buildbucket for the build status
[15:17:32.933] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:32.933] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:29:0) after 1m0s
[15:18:33.106] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:29:0)
[15:18:33.106] Timer tick, asking Buildbucket for the build status
[15:18:33.394] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:33.394] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:30:0) after 1m0s
[15:19:33.475] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:30:0)
[15:19:33.475] Timer tick, asking Buildbucket for the build status
[15:19:34.004] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:34.004] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:31:0) after 1m0s
[15:20:34.276] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:31:0)
[15:20:34.276] Timer tick, asking Buildbucket for the build status
[15:20:40.568] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:40.568] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:32:0) after 1m0s
[15:21:40.697] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:32:0)
[15:21:40.697] Timer tick, asking Buildbucket for the build status
[15:21:40.816] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:40.816] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:33:0) after 1m0s
[15:22:41.031] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:33:0)
[15:22:41.031] Timer tick, asking Buildbucket for the build status
[15:22:41.157] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:41.157] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:34:0) after 1m0s
[15:23:41.242] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:34:0)
[15:23:41.242] Timer tick, asking Buildbucket for the build status
[15:23:41.310] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:41.310] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:35:0) after 1m0s
[15:24:42.196] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:35:0)
[15:24:42.196] Timer tick, asking Buildbucket for the build status
[15:24:42.301] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:42.301] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:36:0) after 1m0s
[15:25:42.429] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:36:0)
[15:25:42.429] Timer tick, asking Buildbucket for the build status
[15:25:43.285] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:43.285] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:37:0) after 1m0s
[15:26:43.325] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:37:0)
[15:26:43.325] Timer tick, asking Buildbucket for the build status
[15:26:43.432] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:43.432] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:38:0) after 1m0s
[15:27:43.604] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:38:0)
[15:27:43.604] Timer tick, asking Buildbucket for the build status
[15:27:43.733] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:43.733] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:39:0) after 1m0s
[15:28:43.787] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:39:0)
[15:28:43.787] Timer tick, asking Buildbucket for the build status
[15:28:43.901] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:43.901] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:40:0) after 1m0s
[15:29:44.024] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:40:0)
[15:29:44.024] Timer tick, asking Buildbucket for the build status
[15:29:44.134] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:44.134] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:41:0) after 1m0s
[15:30:44.224] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:41:0)
[15:30:44.224] Timer tick, asking Buildbucket for the build status
[15:30:44.765] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:44.765] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:42:0) after 1m0s
[15:31:44.796] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:42:0)
[15:31:44.797] Timer tick, asking Buildbucket for the build status
[15:31:44.936] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:44.936] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:43:0) after 1m0s
[15:32:44.992] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:43:0)
[15:32:44.992] Timer tick, asking Buildbucket for the build status
[15:32:45.301] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:45.301] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:44:0) after 1m0s
[15:33:45.371] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:44:0)
[15:33:45.371] Timer tick, asking Buildbucket for the build status
[15:33:45.448] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:45.448] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:45:0) after 1m0s
[15:34:45.547] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:45:0)
[15:34:45.547] Timer tick, asking Buildbucket for the build status
[15:34:45.629] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:45.629] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:46:0) after 1m0s
[15:35:45.769] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:46:0)
[15:35:45.769] Timer tick, asking Buildbucket for the build status
[15:35:45.844] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:45.844] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:47:0) after 1m0s
[15:36:45.865] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:47:0)
[15:36:45.865] Timer tick, asking Buildbucket for the build status
[15:36:45.977] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:45.977] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:48:0) after 1m0s
[15:37:46.122] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:48:0)
[15:37:46.122] Timer tick, asking Buildbucket for the build status
[15:37:46.404] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:46.404] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:49:0) after 1m0s
[15:38:46.495] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:49:0)
[15:38:46.495] Timer tick, asking Buildbucket for the build status
[15:38:46.613] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:46.613] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:50:0) after 1m0s
[15:39:46.663] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:50:0)
[15:39:46.663] Timer tick, asking Buildbucket for the build status
[15:39:46.739] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:46.739] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:51:0) after 1m0s
[15:40:46.852] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:51:0)
[15:40:46.852] Timer tick, asking Buildbucket for the build status
[15:40:46.943] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:46.943] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:52:0) after 1m0s
[15:41:47.025] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:52:0)
[15:41:47.025] Timer tick, asking Buildbucket for the build status
[15:41:47.143] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:47.143] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:53:0) after 1m0s
[15:42:47.157] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:53:0)
[15:42:47.157] Timer tick, asking Buildbucket for the build status
[15:42:47.570] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:47.570] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:54:0) after 1m0s
[15:43:47.576] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:54:0)
[15:43:47.576] Timer tick, asking Buildbucket for the build status
[15:43:47.653] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:47.653] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:55:0) after 1m0s
[15:44:47.634] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:55:0)
[15:44:47.634] Timer tick, asking Buildbucket for the build status
[15:44:47.733] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:47.733] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:56:0) after 1m0s
[15:45:47.864] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:56:0)
[15:45:47.864] Timer tick, asking Buildbucket for the build status
[15:45:48.001] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:48.001] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:57:0) after 1m0s
[15:46:48.042] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:57:0)
[15:46:48.042] Timer tick, asking Buildbucket for the build status
[15:46:48.162] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:48.163] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:58:0) after 1m0s
[15:47:48.201] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:58:0)
[15:47:48.201] Timer tick, asking Buildbucket for the build status
[15:47:48.309] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:48.309] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:59:0) after 1m0s
[15:48:48.346] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:59:0)
[15:48:48.346] Timer tick, asking Buildbucket for the build status
[15:48:48.715] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:48.715] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:60:0) after 1m0s
[15:49:48.739] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:60:0)
[15:49:48.739] Timer tick, asking Buildbucket for the build status
[15:49:49.047] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:49.047] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:61:0) after 1m0s
[15:50:49.168] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:61:0)
[15:50:49.168] Timer tick, asking Buildbucket for the build status
[15:50:49.236] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:49.236] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:62:0) after 1m0s
[15:51:49.347] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:62:0)
[15:51:49.347] Timer tick, asking Buildbucket for the build status
[15:51:50.377] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:50.377] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:63:0) after 1m0s
[15:52:50.562] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:63:0)
[15:52:50.562] Timer tick, asking Buildbucket for the build status
[15:52:50.922] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:50.922] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:64:0) after 1m0s
[15:53:51.159] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:64:0)
[15:53:51.159] Timer tick, asking Buildbucket for the build status
[15:53:51.298] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:51.298] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:65:0) after 1m0s
[15:54:51.372] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:65:0)
[15:54:51.372] Timer tick, asking Buildbucket for the build status
[15:54:51.559] Build 8863011819423131568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:51.559] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028441881439763504:66:0) after 1m0s
[15:55:23.158] Received PubSub notification, asking Buildbucket for the build status
[15:55:23.233] Build 8863011819423131568: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:55:23.233] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605974120768872",
"created_by": "project:chromium",
"created_ts": "1605970284019095",
"id": "8863011819423131568",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"11c10161166c703c568730ee61a09c6f0041be3a\"}}",
"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\": \"11c10161166c703c568730ee61a09c6f0041be3a\", \"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\": 15761, \"clang_revision\": \"llvmorg-12-init-12083-g94e4ec64-1\", \"got_angle_revision\": \"e51c9068a84f14e42157c097eb764ec3009e0e54\", \"got_dawn_revision\": \"41b3f9c1e4aaaa3d56d205d81e61deaebdd40d75\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"11c10161166c703c568730ee61a09c6f0041be3a\", \"got_revision_cp\": \"refs/heads/master@{#829990}\", \"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\": \"11c10161166c703c568730ee61a09c6f0041be3a\", \"swarm_hashes_refs/heads/master(at){#829990}_without_patch\": {\"absl_hardening_tests\": \"03f8cf3a2f4169627e0ed28ba69c5c84c44e9bca\", \"accessibility_unittests\": \"fb53dc171b0a719d0aab3c657cd47e0319bf9b4f\", \"angle_unittests\": \"61d00a2ca7432bf2f24d1cfe2e38adfe0b5dada6\", \"app_shell_unittests\": \"66dd6fd95b30e59505a7e05ee3e9095efa527ebe\", \"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\": \"2e1fbf988dbe3c770a062ddf998b123fc46a9b6e\", \"capture_unittests\": \"c59e2862d479d275ee14875e0b1361cda16f9131\", \"cast_unittests\": \"2e81114622f67db4173bd0819448ed199add6ea0\", \"cc_unittests\": \"d42a98bbc33f8d3965b854c372205943f0863ebf\", \"chrome_app_unittests\": \"32941472390a0e83a32bf67ca4acd134252567d9\", \"chrome_cleaner_unittests\": \"7b80ca66f96ea4228110f27f40ec6928a7e0c0ca\", \"chrome_elf_unittests\": \"08f09bae4f22a861251fae1f0d1171f25bb207b4\", \"chromedriver_unittests\": \"215a10f3094fc54eb4cec4c11bbb24ab034d74ea\", \"components_browsertests\": \"2a65ff12b8e49f50519bf961f227965d349fd945\", \"components_unittests\": \"ad26700c43372d8a4b74675975dbbcca8e405bce\", \"compositor_unittests\": \"d5129f93580bd6a52c4b28e7323051035dc05ab4\", \"content_browsertests\": \"7c02578133c7307e1fd3f8b3ff11fda2401f2ec2\", \"content_unittests\": \"fc6040090baba0749b863309402ea326897ce45a\", \"courgette_unittests\": \"a17f5074c9c443370901ebbd313a73fad4f2232d\", \"crashpad_tests\": \"2fa8caccdc442fd1d58e8af08fc7595ed23482c8\", \"cronet_tests\": \"64a1a87b84d94ba28aa36b43e4349cb99bb90ceb\", \"cronet_unittests\": \"77db119592d5c1ef68e9c029cfddd9430a31f9f6\", \"crypto_unittests\": \"3da2dbc00740440fb318d4c7ff7565d884f2c7d4\", \"delayloads_unittests\": \"92d296cdaf8065ca39e6882bd29c6977dfc4d119\", \"device_unittests\": \"2c36c19f1f5a30403b1812982412930b8ffe4fce\", \"display_unittests\": \"0e7859cfabf5c929767bb12e87ee08954c1ffd2f\", \"elevation_service_unittests\": \"1f1367b1aee5f49f67aa93b842fae1b40e6a6fd0\", \"events_unittests\": \"c4eba6bb9e73292f983ec6e88da3f87ab6053570\", \"extensions_browsertests\": \"d8b1e60615f3bda812ae304a5b6d9f99293fd667\", \"extensions_unittests\": \"c5e29a28fdfcb7be26074df9a858879276745991\", \"filesystem_service_unittests\": \"fdac573d1382394d2f151c6d3bfbeb63e15a0cc3\", \"gcm_unit_tests\": \"f57052a52de0643e7f742d3751f42fd1513c1717\", \"gcp_unittests\": \"a9741eac08b427b50a19c7d9b1ca170861a124b5\", \"gfx_unittests\": \"b72cc1dee8587b7712125ada73b4d76ac73e1d9c\", \"gin_unittests\": \"f3c145ba478a44a5a280790d3f2f8f22aa41d9e1\", \"google_apis_unittests\": \"8f85a3448b172e3a4a8e47a1bea93f3abbf09a66\", \"gpu_unittests\": \"600b8d882b615314b56fa3dd8ea9e11a4f966058\", \"gwp_asan_unittests\": \"d089adbe34f9eb3581284df92e7c9b9cae7bf80e\", \"headless_browsertests\": \"b351605b3340027f5b9012a1f7bef996f3863573\", \"headless_unittests\": \"c18957894463d55503c3b331b97dbbc26b54e735\", \"install_static_unittests\": \"2edf1b7d23afcb4022d3824355ed553468a3e500\", \"installer_util_unittests\": \"31c97198a576fe33f5f372b5991a9f62a3af948d\", \"interactive_ui_tests\": \"0b164b21248ee118e932996d04371d035194eb2a\", \"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\": \"9419b9e0d6b593358390605f134cb5d503aa9f5e\", \"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\": \"43f0647691a4ef472b5d17cb85985e8819c1b603\", \"traffic_annotation_auditor_unittests\": \"f47a08f7c985d97872e41dcc546da1e45a12b3a7\", \"ui_base_unittests\": \"62da446e645a853bb7cd268e8f1086b63971b6fc\", \"ui_touch_selection_unittests\": \"10dc99cf467af7e1afaa6969936270d1088c431b\", \"unit_tests\": \"1fe0629bf00e3a2b5dcea2f221a505ae8ccb1085\", \"updater_tests\": \"442b54fe9cf1a74303b699d8b98ba8ac4ffa607b\", \"url_unittests\": \"6ad24ee46ed673531cf4d3fba2020f90e7f10499\", \"views_unittests\": \"9572a3de56bc15b015f04b48cf19ae0ed4c8987b\", \"viz_unittests\": \"1dd2bfe1cb1cdda8b730ddb533f2a93de92a5e6f\", \"vr_common_unittests\": \"cbd06ec99cee6baca89f70b8f9f2c4ac9e6d37c5\", \"vr_pixeltests\": \"84f97c84ea69092f968def0a0abd9c1bfef0039e\", \"weblayer_browsertests\": \"20c1b3f971598df17417eb11fe91e458073738cb\", \"weblayer_unittests\": \"0556a6534024e54b4e5bd1f343e25744db4beac2\", \"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": "1605970287278484",
"status": "COMPLETED",
"status_changed_ts": "1605974121378346",
"tags": [
"build_address:luci.chromium.ci/win-asan/15761",
"builder:win-asan",
"buildset:commit/git/11c10161166c703c568730ee61a09c6f0041be3a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/11c10161166c703c568730ee61a09c6f0041be3a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028441881439763504",
"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/8863011819423131568/+/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:50041b585a107a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1605974121474945",
"url": "https://ci.chromium.org/b/8863011819423131568",
"utcnow_ts": "1605974123224444"
}
}
[15:55:23.233] Invocation finished in 1h4m0.521623698s with status SUCCEEDED