[02:07:56.527] New invocation is queued and will start shortly
[02:07:57.643] Starting the invocation (attempt 1)
[02:07:57.698] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:07:57.698] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:07:57.698] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023144691709362736",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"c0178d4d39df756fd7171a2718e9b44103aef8ca\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9023144691709362736",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/c0178d4d39df756fd7171a2718e9b44103aef8ca",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c0178d4d39df756fd7171a2718e9b44103aef8ca",
"gitiles_ref:refs/heads/master"
]
}
[02:07:58.417] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611022077788031",
"id": "8857714629719334400",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c0178d4d39df756fd7171a2718e9b44103aef8ca\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611022078232638",
"tags": [
"build_address:luci.chromium.ci/win-asan/16882",
"builder:win-asan",
"buildset:commit/git/c0178d4d39df756fd7171a2718e9b44103aef8ca",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c0178d4d39df756fd7171a2718e9b44103aef8ca",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023144691709362736",
"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/8857714629719334400/+/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": "1611022078232762",
"url": "https://ci.chromium.org/b/8857714629719334400",
"utcnow_ts": "1611022078408943"
}
}
[02:07:58.417] Task URL: https://ci.chromium.org/b/8857714629719334400
[02:07:58.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:2:0) after 1m0s
[02:08:02.641] Received PubSub notification, asking Buildbucket for the build status
[02:08:02.727] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:58.446] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:2:0)
[02:08:58.446] Timer tick, asking Buildbucket for the build status
[02:08:58.821] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:58.821] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:4:0) after 1m0s
[02:09:58.839] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:4:0)
[02:09:58.839] Timer tick, asking Buildbucket for the build status
[02:09:58.944] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:58.944] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:5:0) after 1m0s
[02:10:59.022] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:5:0)
[02:10:59.022] Timer tick, asking Buildbucket for the build status
[02:10:59.256] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:59.256] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:6:0) after 1m0s
[02:11:59.278] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:6:0)
[02:11:59.278] Timer tick, asking Buildbucket for the build status
[02:11:59.528] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:59.528] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:7:0) after 1m0s
[02:12:59.545] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:7:0)
[02:12:59.545] Timer tick, asking Buildbucket for the build status
[02:12:59.656] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:59.656] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:8:0) after 1m0s
[02:13:59.674] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:8:0)
[02:13:59.674] Timer tick, asking Buildbucket for the build status
[02:13:59.927] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:59.927] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:9:0) after 1m0s
[02:15:00.049] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:9:0)
[02:15:00.049] Timer tick, asking Buildbucket for the build status
[02:15:00.428] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:00.428] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:10:0) after 1m0s
[02:16:00.425] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:10:0)
[02:16:00.425] Timer tick, asking Buildbucket for the build status
[02:16:00.779] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:00.779] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:11:0) after 1m0s
[02:17:01.403] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:11:0)
[02:17:01.403] Timer tick, asking Buildbucket for the build status
[02:17:01.590] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:01.590] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:12:0) after 1m0s
[02:18:02.064] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:12:0)
[02:18:02.064] Timer tick, asking Buildbucket for the build status
[02:18:02.448] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:02.448] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:13:0) after 1m0s
[02:19:02.467] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:13:0)
[02:19:02.467] Timer tick, asking Buildbucket for the build status
[02:19:02.557] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:02.557] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:14:0) after 1m0s
[02:20:02.880] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:14:0)
[02:20:02.880] Timer tick, asking Buildbucket for the build status
[02:20:02.989] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:02.989] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:15:0) after 1m0s
[02:21:03.000] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:15:0)
[02:21:03.000] Timer tick, asking Buildbucket for the build status
[02:21:03.063] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:03.063] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:16:0) after 1m0s
[02:22:03.080] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:16:0)
[02:22:03.080] Timer tick, asking Buildbucket for the build status
[02:22:03.138] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:03.138] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:17:0) after 1m0s
[02:23:03.135] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:17:0)
[02:23:03.135] Timer tick, asking Buildbucket for the build status
[02:23:03.374] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:03.374] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:18:0) after 1m0s
[02:24:03.484] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:18:0)
[02:24:03.484] Timer tick, asking Buildbucket for the build status
[02:24:03.704] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:03.704] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:19:0) after 1m0s
[02:25:03.810] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:19:0)
[02:25:03.810] Timer tick, asking Buildbucket for the build status
[02:25:04.073] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:04.073] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:20:0) after 1m0s
[02:26:04.209] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:20:0)
[02:26:04.209] Timer tick, asking Buildbucket for the build status
[02:26:04.397] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:04.397] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:21:0) after 1m0s
[02:27:04.448] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:21:0)
[02:27:04.448] Timer tick, asking Buildbucket for the build status
[02:27:04.506] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:04.506] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:22:0) after 1m0s
[02:28:04.567] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:22:0)
[02:28:04.567] Timer tick, asking Buildbucket for the build status
[02:28:04.720] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:04.720] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:23:0) after 1m0s
[02:29:04.796] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:23:0)
[02:29:04.796] Timer tick, asking Buildbucket for the build status
[02:29:04.929] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:04.929] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:24:0) after 1m0s
[02:30:05.001] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:24:0)
[02:30:05.001] Timer tick, asking Buildbucket for the build status
[02:30:05.097] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:05.097] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:25:0) after 1m0s
[02:31:05.248] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:25:0)
[02:31:05.248] Timer tick, asking Buildbucket for the build status
[02:31:05.410] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:05.410] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:26:0) after 1m0s
[02:32:05.535] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:26:0)
[02:32:05.535] Timer tick, asking Buildbucket for the build status
[02:32:05.664] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:05.664] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:27:0) after 1m0s
[02:33:05.685] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:27:0)
[02:33:05.685] Timer tick, asking Buildbucket for the build status
[02:33:05.811] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:05.811] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:28:0) after 1m0s
[02:34:06.022] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:28:0)
[02:34:06.022] Timer tick, asking Buildbucket for the build status
[02:34:06.224] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:06.224] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:29:0) after 1m0s
[02:35:06.242] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:29:0)
[02:35:06.242] Timer tick, asking Buildbucket for the build status
[02:35:06.723] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:06.723] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:30:0) after 1m0s
[02:36:06.846] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:30:0)
[02:36:06.846] Timer tick, asking Buildbucket for the build status
[02:36:06.954] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:06.954] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:31:0) after 1m0s
[02:37:07.052] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:31:0)
[02:37:07.052] Timer tick, asking Buildbucket for the build status
[02:37:07.168] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:07.168] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:32:0) after 1m0s
[02:38:07.255] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:32:0)
[02:38:07.255] Timer tick, asking Buildbucket for the build status
[02:38:07.473] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:07.473] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:33:0) after 1m0s
[02:39:07.541] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:33:0)
[02:39:07.541] Timer tick, asking Buildbucket for the build status
[02:39:08.153] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:08.153] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:34:0) after 1m0s
[02:40:08.232] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:34:0)
[02:40:08.232] Timer tick, asking Buildbucket for the build status
[02:40:08.625] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:08.625] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:35:0) after 1m0s
[02:41:08.645] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:35:0)
[02:41:08.645] Timer tick, asking Buildbucket for the build status
[02:41:08.707] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:08.707] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:36:0) after 1m0s
[02:42:08.727] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:36:0)
[02:42:08.727] Timer tick, asking Buildbucket for the build status
[02:42:09.456] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:09.456] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:37:0) after 1m0s
[02:43:09.554] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:37:0)
[02:43:09.554] Timer tick, asking Buildbucket for the build status
[02:43:09.665] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:09.665] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:38:0) after 1m0s
[02:44:09.650] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:38:0)
[02:44:09.650] Timer tick, asking Buildbucket for the build status
[02:44:09.788] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:09.788] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:39:0) after 1m0s
[02:45:09.794] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:39:0)
[02:45:09.794] Timer tick, asking Buildbucket for the build status
[02:45:09.866] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:09.867] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:40:0) after 1m0s
[02:46:09.888] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:40:0)
[02:46:09.888] Timer tick, asking Buildbucket for the build status
[02:46:09.992] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:09.992] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:41:0) after 1m0s
[02:47:10.026] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:41:0)
[02:47:10.026] Timer tick, asking Buildbucket for the build status
[02:47:10.449] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:10.449] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:42:0) after 1m0s
[02:48:10.601] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:42:0)
[02:48:10.601] Timer tick, asking Buildbucket for the build status
[02:48:10.744] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:10.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:43:0) after 1m0s
[02:49:10.740] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:43:0)
[02:49:10.740] Timer tick, asking Buildbucket for the build status
[02:49:10.822] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:10.822] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:44:0) after 1m0s
[02:50:10.851] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:44:0)
[02:50:10.852] Timer tick, asking Buildbucket for the build status
[02:50:11.132] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:11.132] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:45:0) after 1m0s
[02:51:11.231] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:45:0)
[02:51:11.231] Timer tick, asking Buildbucket for the build status
[02:51:11.402] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:11.402] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:46:0) after 1m0s
[02:52:11.481] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:46:0)
[02:52:11.481] Timer tick, asking Buildbucket for the build status
[02:52:11.549] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:11.549] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:47:0) after 1m0s
[02:53:11.801] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:47:0)
[02:53:11.801] Timer tick, asking Buildbucket for the build status
[02:53:12.159] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:12.159] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:48:0) after 1m0s
[02:54:12.226] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:48:0)
[02:54:12.226] Timer tick, asking Buildbucket for the build status
[02:54:12.397] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:12.397] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:49:0) after 1m0s
[02:55:12.455] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:49:0)
[02:55:12.455] Timer tick, asking Buildbucket for the build status
[02:55:12.712] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:12.712] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:50:0) after 1m0s
[02:56:12.809] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:50:0)
[02:56:12.809] Timer tick, asking Buildbucket for the build status
[02:56:12.892] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:12.892] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:51:0) after 1m0s
[02:57:13.015] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:51:0)
[02:57:13.015] Timer tick, asking Buildbucket for the build status
[02:57:13.166] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:13.166] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:52:0) after 1m0s
[02:58:13.232] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:52:0)
[02:58:13.232] Timer tick, asking Buildbucket for the build status
[02:58:13.410] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:13.410] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:53:0) after 1m0s
[02:59:13.471] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:53:0)
[02:59:13.471] Timer tick, asking Buildbucket for the build status
[02:59:13.547] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:13.547] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:54:0) after 1m0s
[03:00:13.606] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:54:0)
[03:00:13.606] Timer tick, asking Buildbucket for the build status
[03:00:14.615] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:14.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:55:0) after 1m0s
[03:01:14.703] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:55:0)
[03:01:14.703] Timer tick, asking Buildbucket for the build status
[03:01:14.923] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:14.923] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:56:0) after 1m0s
[03:02:14.945] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:56:0)
[03:02:14.945] Timer tick, asking Buildbucket for the build status
[03:02:15.066] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:15.066] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:57:0) after 1m0s
[03:03:15.120] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:57:0)
[03:03:15.120] Timer tick, asking Buildbucket for the build status
[03:03:15.225] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:15.225] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:58:0) after 1m0s
[03:04:15.205] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:58:0)
[03:04:15.205] Timer tick, asking Buildbucket for the build status
[03:04:15.486] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:15.486] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:59:0) after 1m0s
[03:05:15.566] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:59:0)
[03:05:15.566] Timer tick, asking Buildbucket for the build status
[03:05:15.683] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:15.683] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:60:0) after 1m0s
[03:06:15.693] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:60:0)
[03:06:15.693] Timer tick, asking Buildbucket for the build status
[03:06:15.758] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:15.758] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:61:0) after 1m0s
[03:07:15.848] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:61:0)
[03:07:15.848] Timer tick, asking Buildbucket for the build status
[03:07:16.225] Build 8857714629719334400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:16.225] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023144691709362736:62:0) after 1m0s
[03:07:31.708] Received PubSub notification, asking Buildbucket for the build status
[03:07:31.779] Build 8857714629719334400: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:07:31.779] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611025650690826",
"created_by": "project:chromium",
"created_ts": "1611022077788031",
"id": "8857714629719334400",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c0178d4d39df756fd7171a2718e9b44103aef8ca\"}}",
"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\": \"c0178d4d39df756fd7171a2718e9b44103aef8ca\", \"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-0-nszv\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16882, \"clang_revision\": \"llvmorg-12-init-16296-g5e476061-2\", \"got_angle_revision\": \"5635dbb91641a72f1f713aa7c179e2432674f9c3\", \"got_dawn_revision\": \"4b316994ad01ab6b87032c5fd9b53c6d18956d8d\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"c0178d4d39df756fd7171a2718e9b44103aef8ca\", \"got_revision_cp\": \"refs/heads/master@{#844645}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"8da0f82baf359e2b91464f111306a094f86fe71b\", \"got_v8_revision\": \"ee927aaa58e688ad6aa0256b3929c1eeea0bebd5\", \"got_v8_revision_cp\": \"refs/heads/9.0.8@{#1}\", \"got_webrtc_revision\": \"29bd8638adb0a7294f7b8ae589fdd24077539dbb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33030}\", \"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\": \"c0178d4d39df756fd7171a2718e9b44103aef8ca\", \"swarm_hashes_refs/heads/master(at){#844645}_without_patch\": {\"absl_hardening_tests\": \"ebfef63da7acc9e3e703c5bddec9f85f6be79f09\", \"accessibility_unittests\": \"dac50e0cfd6767b7cc7ba8d42b3d75a109ada52f\", \"angle_unittests\": \"369849bffdf16ccadb3a52c20a11d84e876f5347\", \"app_shell_unittests\": \"f7d036fbc7b4e57d17f2ad0ee6330afc630a85ce\", \"aura_unittests\": \"f6566cde1f412f01d10e07e24d50b6aebdc7b937\", \"base_unittests\": \"e24ade3910a609d5e8deec23b098616e4ac8ed9e\", \"base_util_unittests\": \"a462d329a543e6a92d7fcf6dceaf1faf34cd2bfe\", \"blink_common_unittests\": \"7bd5ab69699bb4c479baf49a845108be1e73cbcb\", \"blink_fuzzer_unittests\": \"0d1a98f869c6c2fa3e1503a49ae2ca18b6066f59\", \"blink_heap_unittests\": \"a214f0554395d7f4e827c7c3be96bb6dcc39ae2e\", \"blink_platform_unittests\": \"e1623e975eb381f3ac2032843b9244adbae0cb49\", \"blink_unittests\": \"6540ab62884d734c081b067d9eae06ee93282086\", \"boringssl_crypto_tests\": \"d2a447f10f5e3f52a244c454d67043fe89c342dc\", \"boringssl_ssl_tests\": \"cfe3379698f021f6eaf1b17818fb78585246ab8a\", \"browser_switcher_bho_unittests\": \"90d791d55a314ff4959a27d49625a9b3ab38ec63\", \"browser_tests\": \"7a827688bee0a1ae629457e519d49b4a7bd29f62\", \"capture_unittests\": \"e2b2534aa5fabea3ad9873048364b86f7c56ceff\", \"cast_unittests\": \"3cdc88c3f5f59112f330a5ccc43e639f2b5a7f6e\", \"cc_unittests\": \"0471f322598a3fad2115176564d0ff35bdf81863\", \"chrome_app_unittests\": \"900751a14c66b1175c0b14b483ee2218778cc5cf\", \"chrome_cleaner_unittests\": \"4f38a88082e16d62cf34b6d86562fc25e134a259\", \"chrome_elf_unittests\": \"b337a62d2745be13745e7e1cadcea48cda213c40\", \"chromedriver_unittests\": \"6d5212630d829935e520f41b92b81e696a5ab5bb\", \"components_browsertests\": \"02dda5d9dde4ae90b7f7c10c36e026760138efc5\", \"components_unittests\": \"ae3c9fe85351eeedecd531cf430843d25f223513\", \"compositor_unittests\": \"994cc85b1a894715f427cfeaa9b29dc8af587272\", \"content_browsertests\": \"dc5d0b43015e6288a0f67754bf9b5a2d8f411f27\", \"content_unittests\": \"7903e9e798e66353f6afa96712843eac992cd6ad\", \"courgette_unittests\": \"5e4d6453fb3b338f3b2d99f6d013538578f95ed2\", \"crashpad_tests\": \"1d9fe6da264ef4f997ecc5f0ef85426ec3bdc073\", \"cronet_tests\": \"0c4c3135158167479c862ebdf8ff85e09fef0758\", \"cronet_unittests\": \"dc9b2e9305a79da62e098bdd935ab1fa20fff6e9\", \"crypto_unittests\": \"7f8137edf4dce3625cd62557beb93484eb10a521\", \"delayloads_unittests\": \"18fa1983adf3285fd589776eef4214cbdf09c73b\", \"device_unittests\": \"d10db8cd14733119d55caec52cad79e1619ea703\", \"display_unittests\": \"280fb6d1f1c4303a80c20b9404ab363b6168c484\", \"elevation_service_unittests\": \"a5e951441290bea6021629b433af6bdff5aee39c\", \"events_unittests\": \"7ec123c6a9c800b2003c76b8301b64c74c30c20f\", \"extensions_browsertests\": \"5c07f9369b53052d8a24d8243c549391900b56cb\", \"extensions_unittests\": \"cedfe22dbad4bc78d170993c2fbdb13495c666eb\", \"filesystem_service_unittests\": \"3b51f16e846fdf7bb3d79fe5bac397d4fd8a1829\", \"gcm_unit_tests\": \"bc7348bc9c144e420a561099aaf4f70a2133eee7\", \"gcp_unittests\": \"d3e97e64871fa993c3056e27e5dee5ad170891fd\", \"gfx_unittests\": \"b51a6c1f747d4c8d08c06ad8817b50ae10c65844\", \"gin_unittests\": \"e2a1942615849e70001f4c3b990e587cbef67656\", \"google_apis_unittests\": \"0b6681fbf4d8366e796bb711873bca8c0de923ce\", \"gpu_unittests\": \"9858dbba584d5b332d0ab16b54b73faeea057e91\", \"gwp_asan_unittests\": \"4e0065d1d3388c9198d76ec7432a1768514d776e\", \"headless_browsertests\": \"b7e8d1b06abd0742e233ea4b862d0a5a9c37dda7\", \"headless_unittests\": \"eac4e526aecb65b636df3066c375b223d2aabdc6\", \"install_static_unittests\": \"ff0137418b080e4d92b48f2e9b8818e39154a3a8\", \"installer_util_unittests\": \"676bb94736a092c750104ca02e01fd9ed82e3e01\", \"interactive_ui_tests\": \"3092e2f2cc473b9415f20ddc3545e4a23f2f2c5e\", \"ipc_tests\": \"814107703a9a3220107a9e0f048cacb833fe9b95\", \"jingle_unittests\": \"d7b41f1adf067d4d59869ddd20093bb95042bf57\", \"latency_unittests\": \"cfc56b4b0ab6ae35bedaa75a1a168db2cd054ed2\", \"libjingle_xmpp_unittests\": \"b7db71bfa5bd4c75fcc7df17ed97cba3a89ced9a\", \"liburlpattern_unittests\": \"699759f09985b2d557af1ee7ce85bd2a0cdffc00\", \"media_blink_unittests\": \"bf57e762b15c5fca1a0f859f5ad477b91c464ff9\", \"media_unittests\": \"bec7c01dd7b15f1a1dab1b8b51b8b9955035be33\", \"message_center_unittests\": \"3c456335be56849ca5740972b97942d61d77308b\", \"midi_unittests\": \"430c4ec8f81023a414437b24dc5214e97aa86fa1\", \"mojo_core_unittests\": \"bd9b9ba70b7260cfca8b696c77e7bae32a232342\", \"mojo_unittests\": \"2e30bf7037f632a4fc30a0907a7d37bae98009e7\", \"nacl_loader_unittests\": \"c2fa309ad772519f7efaf591ea5d4f9442028fc0\", \"native_theme_unittests\": \"c32b31c52e8e4617816a0c9916c162249b8aa344\", \"net_unittests\": \"ca15341b27ea899c98c131b77b51e23e3d6579e3\", \"notification_helper_unittests\": \"e5e4af5beaed8e1d4515cf9874a480fd7c866483\", \"pdf_unittests\": \"3399b907920d3689f32feeef5f56cdbfd6cc9008\", \"perfetto_unittests\": \"f08c96f4694893eae621b80abc55a4c6e7d3f1c0\", \"ppapi_unittests\": \"211f9f6b61f1e122ab1d0f5401d2646a90d7a7f7\", \"printing_unittests\": \"35ed46cd33b8a2193076473b13acf3f9b6873ddf\", \"remoting_unittests\": \"c1daa8b00c215838080e88d72bf8a4a22fc99921\", \"sbox_integration_tests\": \"bed360da394bf45b51aa9969a56f669331c62289\", \"sbox_unittests\": \"7fc8a80df0be42ada78ce8e2d8b32a15d9e45c12\", \"sbox_validation_tests\": \"521932972d2fe2c42b1662f22dfb588080b1ebd5\", \"service_manager_unittests\": \"2c044de81e14f2ad37b8599b9ab3aa79568389f1\", \"services_unittests\": \"d14a54f7858dfabeb01c2e2c521f6b4eb7bfd765\", \"setup_unittests\": \"87fc9ff0d8bb2453b4ac1ca1e6177001f1512817\", \"shell_dialogs_unittests\": \"4643c89a61fbbeb33b5e45cd555bf401f7c4e7fd\", \"skia_unittests\": \"bd7ab2e24a4addec2b341c421cae17d371582687\", \"snapshot_unittests\": \"6c8bb18d982d9896d4e8ca830f8fa69e3ba75ad0\", \"sql_unittests\": \"39322d3848faac96bfdaac4035eefe88a09a0b46\", \"storage_unittests\": \"39c77e1f649ea887e991e4739b006360c9b50c50\", \"sync_integration_tests\": \"cb5bc04473c971edd350e6c2676f18e0b1b5b29f\", \"traffic_annotation_auditor_unittests\": \"5d2aaa04d0e53de6849a09277c5d80b83b42385c\", \"ui_base_unittests\": \"40cce368eaf6614456fd2ab4799333d3a6d6ed4b\", \"ui_touch_selection_unittests\": \"12cc7188d8c0eb1464bfd20dd1d4001c79d2a7a7\", \"unit_tests\": \"ac56aea81e6c5901edf37860c940156926fbf597\", \"updater_tests\": \"07415210c38e13c6d001af3812c9d1623c4b52e8\", \"url_unittests\": \"b446ebeca53f6819bb42b34e3ee4623f4d33f960\", \"views_unittests\": \"f4b75779ad96da716dce0fe1151552e25b0e33af\", \"viz_unittests\": \"57b610965c1d0028d4cace1455599752b34fc8ed\", \"vr_common_unittests\": \"08b31002ba889e804362f8e71314d3e3bd881041\", \"vr_pixeltests\": \"a44d2843612c9ee664ac3587a3fefeb391ad61f0\", \"weblayer_browsertests\": \"696c6716669f230cf8bdf9c145abb7f8d2e91ffa\", \"weblayer_unittests\": \"13c8f0889b41a5233fac85aaca9ea8f7ea917cf7\", \"wm_unittests\": \"10cee174bf4b62cae36ec5f32b8676d145983268\", \"wtf_unittests\": \"ccb935d11eb65b2bd6727f1981c77802316b4f68\", \"zlib_unittests\": \"238e463f152dedf6a97cc8a7e9c9c09113900edc\", \"zucchini_unittests\": \"0a14845efc482728a6d8820cac93ff13408402e8\"}}, \"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-0-nszv\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5666-679c9bd\"], \"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": "1611022081811325",
"status": "COMPLETED",
"status_changed_ts": "1611025651053612",
"tags": [
"build_address:luci.chromium.ci/win-asan/16882",
"builder:win-asan",
"buildset:commit/git/c0178d4d39df756fd7171a2718e9b44103aef8ca",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c0178d4d39df756fd7171a2718e9b44103aef8ca",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023144691709362736",
"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/8857714629719334400/+/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:5131379aac361c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1611025651057542",
"url": "https://ci.chromium.org/b/8857714629719334400",
"utcnow_ts": "1611025651771030"
}
}
[03:07:31.779] Invocation finished in 59m35.272654673s with status SUCCEEDED