[05:04:26.352] New invocation is queued and will start shortly
[05:04:27.501] Starting the invocation (attempt 1)
[05:04:27.536] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:04:27.536] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:04:27.536] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9025670302528629840",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d3017b1d2dd488252aa2af0cbfc11933aeede96e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9025670302528629840",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/d3017b1d2dd488252aa2af0cbfc11933aeede96e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d3017b1d2dd488252aa2af0cbfc11933aeede96e",
"gitiles_ref:refs/heads/master"
]
}
[05:04:29.265] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1608613467696396",
"id": "8860240240455829600",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d3017b1d2dd488252aa2af0cbfc11933aeede96e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1608613468883345",
"tags": [
"build_address:luci.chromium.ci/win-asan/16377",
"builder:win-asan",
"buildset:commit/git/d3017b1d2dd488252aa2af0cbfc11933aeede96e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d3017b1d2dd488252aa2af0cbfc11933aeede96e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025670302528629840",
"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/8860240240455829600/+/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": "1608613468884352",
"url": "https://ci.chromium.org/b/8860240240455829600",
"utcnow_ts": "1608613469220344"
}
}
[05:04:29.265] Task URL: https://ci.chromium.org/b/8860240240455829600
[05:04:29.265] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:2:0) after 1m0s
[05:04:32.887] Received PubSub notification, asking Buildbucket for the build status
[05:04:33.090] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:29.342] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:2:0)
[05:05:29.342] Timer tick, asking Buildbucket for the build status
[05:05:29.850] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:29.850] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:4:0) after 1m0s
[05:06:29.893] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:4:0)
[05:06:29.893] Timer tick, asking Buildbucket for the build status
[05:06:29.999] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:29.999] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:5:0) after 1m0s
[05:07:30.018] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:5:0)
[05:07:30.018] Timer tick, asking Buildbucket for the build status
[05:07:30.524] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:30.524] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:6:0) after 1m0s
[05:08:30.614] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:6:0)
[05:08:30.614] Timer tick, asking Buildbucket for the build status
[05:08:30.938] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:30.938] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:7:0) after 1m0s
[05:09:30.990] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:7:0)
[05:09:30.990] Timer tick, asking Buildbucket for the build status
[05:09:31.133] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:31.133] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:8:0) after 1m0s
[05:10:31.177] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:8:0)
[05:10:31.177] Timer tick, asking Buildbucket for the build status
[05:10:31.316] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:31.316] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:9:0) after 1m0s
[05:11:31.319] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:9:0)
[05:11:31.319] Timer tick, asking Buildbucket for the build status
[05:11:31.425] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:31.425] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:10:0) after 1m0s
[05:12:31.471] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:10:0)
[05:12:31.471] Timer tick, asking Buildbucket for the build status
[05:12:31.638] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:31.638] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:11:0) after 1m0s
[05:13:31.738] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:11:0)
[05:13:31.738] Timer tick, asking Buildbucket for the build status
[05:13:32.024] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:32.024] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:12:0) after 1m0s
[05:14:32.070] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:12:0)
[05:14:32.070] Timer tick, asking Buildbucket for the build status
[05:14:32.229] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:32.229] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:13:0) after 1m0s
[05:15:32.250] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:13:0)
[05:15:32.250] Timer tick, asking Buildbucket for the build status
[05:15:32.735] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:32.735] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:14:0) after 1m0s
[05:16:32.824] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:14:0)
[05:16:32.824] Timer tick, asking Buildbucket for the build status
[05:16:32.941] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:32.941] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:15:0) after 1m0s
[05:17:32.968] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:15:0)
[05:17:32.968] Timer tick, asking Buildbucket for the build status
[05:17:33.298] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:33.298] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:16:0) after 1m0s
[05:18:33.325] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:16:0)
[05:18:33.325] Timer tick, asking Buildbucket for the build status
[05:18:33.469] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:33.469] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:17:0) after 1m0s
[05:19:33.478] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:17:0)
[05:19:33.478] Timer tick, asking Buildbucket for the build status
[05:19:33.759] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:33.759] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:18:0) after 1m0s
[05:20:33.853] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:18:0)
[05:20:33.853] Timer tick, asking Buildbucket for the build status
[05:20:34.343] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:34.343] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:19:0) after 1m0s
[05:21:34.393] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:19:0)
[05:21:34.393] Timer tick, asking Buildbucket for the build status
[05:21:34.529] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:34.529] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:20:0) after 1m0s
[05:22:34.584] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:20:0)
[05:22:34.584] Timer tick, asking Buildbucket for the build status
[05:22:34.712] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:34.712] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:21:0) after 1m0s
[05:23:34.720] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:21:0)
[05:23:34.720] Timer tick, asking Buildbucket for the build status
[05:23:34.825] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:34.825] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:22:0) after 1m0s
[05:24:34.918] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:22:0)
[05:24:34.918] Timer tick, asking Buildbucket for the build status
[05:24:35.447] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:35.447] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:23:0) after 1m0s
[05:25:35.454] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:23:0)
[05:25:35.454] Timer tick, asking Buildbucket for the build status
[05:25:35.603] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:35.603] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:24:0) after 1m0s
[05:26:35.621] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:24:0)
[05:26:35.621] Timer tick, asking Buildbucket for the build status
[05:26:35.746] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:35.746] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:25:0) after 1m0s
[05:27:35.808] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:25:0)
[05:27:35.808] Timer tick, asking Buildbucket for the build status
[05:27:35.987] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:35.987] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:26:0) after 1m0s
[05:28:36.044] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:26:0)
[05:28:36.044] Timer tick, asking Buildbucket for the build status
[05:28:36.610] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:36.610] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:27:0) after 1m0s
[05:29:36.648] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:27:0)
[05:29:36.648] Timer tick, asking Buildbucket for the build status
[05:29:36.821] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:36.821] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:28:0) after 1m0s
[05:30:36.853] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:28:0)
[05:30:36.853] Timer tick, asking Buildbucket for the build status
[05:30:37.233] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:37.233] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:29:0) after 1m0s
[05:31:37.284] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:29:0)
[05:31:37.284] Timer tick, asking Buildbucket for the build status
[05:31:37.505] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:37.505] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:30:0) after 1m0s
[05:32:37.525] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:30:0)
[05:32:37.525] Timer tick, asking Buildbucket for the build status
[05:32:37.888] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:37.888] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:31:0) after 1m0s
[05:33:37.968] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:31:0)
[05:33:37.968] Timer tick, asking Buildbucket for the build status
[05:33:38.076] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:38.076] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:32:0) after 1m0s
[05:34:38.099] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:32:0)
[05:34:38.099] Timer tick, asking Buildbucket for the build status
[05:34:38.245] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:38.245] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:33:0) after 1m0s
[05:35:38.290] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:33:0)
[05:35:38.290] Timer tick, asking Buildbucket for the build status
[05:35:38.576] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:38.576] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:34:0) after 1m0s
[05:36:38.645] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:34:0)
[05:36:38.645] Timer tick, asking Buildbucket for the build status
[05:36:38.755] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:38.755] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:35:0) after 1m0s
[05:37:38.782] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:35:0)
[05:37:38.782] Timer tick, asking Buildbucket for the build status
[05:37:39.162] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:39.162] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:36:0) after 1m0s
[05:38:39.217] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:36:0)
[05:38:39.217] Timer tick, asking Buildbucket for the build status
[05:38:39.348] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:39.348] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:37:0) after 1m0s
[05:39:39.369] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:37:0)
[05:39:39.369] Timer tick, asking Buildbucket for the build status
[05:39:39.858] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:39.858] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:38:0) after 1m0s
[05:40:39.902] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:38:0)
[05:40:39.902] Timer tick, asking Buildbucket for the build status
[05:40:40.202] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:40.202] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:39:0) after 1m0s
[05:41:40.233] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:39:0)
[05:41:40.233] Timer tick, asking Buildbucket for the build status
[05:41:40.351] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:40.351] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:40:0) after 1m0s
[05:42:40.439] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:40:0)
[05:42:40.439] Timer tick, asking Buildbucket for the build status
[05:42:40.983] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:40.983] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:41:0) after 1m0s
[05:43:41.036] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:41:0)
[05:43:41.036] Timer tick, asking Buildbucket for the build status
[05:43:41.163] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:41.163] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:42:0) after 1m0s
[05:44:41.182] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:42:0)
[05:44:41.182] Timer tick, asking Buildbucket for the build status
[05:44:41.323] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:41.323] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:43:0) after 1m0s
[05:45:41.354] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:43:0)
[05:45:41.354] Timer tick, asking Buildbucket for the build status
[05:45:41.504] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:41.504] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:44:0) after 1m0s
[05:46:41.526] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:44:0)
[05:46:41.526] Timer tick, asking Buildbucket for the build status
[05:46:41.681] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:41.681] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:45:0) after 1m0s
[05:47:41.701] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:45:0)
[05:47:41.701] Timer tick, asking Buildbucket for the build status
[05:47:42.583] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:42.583] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:46:0) after 1m0s
[05:48:42.637] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:46:0)
[05:48:42.637] Timer tick, asking Buildbucket for the build status
[05:48:42.784] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:42.784] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:47:0) after 1m0s
[05:49:42.811] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:47:0)
[05:49:42.811] Timer tick, asking Buildbucket for the build status
[05:49:42.944] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:42.945] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:48:0) after 1m0s
[05:50:42.992] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:48:0)
[05:50:42.992] Timer tick, asking Buildbucket for the build status
[05:50:43.067] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:43.067] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:49:0) after 1m0s
[05:51:43.153] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:49:0)
[05:51:43.153] Timer tick, asking Buildbucket for the build status
[05:51:43.296] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:43.296] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:50:0) after 1m0s
[05:52:43.391] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:50:0)
[05:52:43.391] Timer tick, asking Buildbucket for the build status
[05:52:43.566] Build 8860240240455829600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:43.566] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9025670302528629840:51:0) after 1m0s
[05:53:32.966] Received PubSub notification, asking Buildbucket for the build status
[05:53:33.053] Build 8860240240455829600: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:53:33.053] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1608616410586285",
"created_by": "project:chromium",
"created_ts": "1608613467696396",
"id": "8860240240455829600",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d3017b1d2dd488252aa2af0cbfc11933aeede96e\"}}",
"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\": \"d3017b1d2dd488252aa2af0cbfc11933aeede96e\", \"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-6-gpyc\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16377, \"clang_revision\": \"llvmorg-12-init-12923-g6ee22ca6-1\", \"got_angle_revision\": \"11c31e0a4a73d7d62e765dc7ec400560fbb16b5e\", \"got_dawn_revision\": \"ec56b90ceab0c16e3c9f5603cc26562ec7bc2430\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"d3017b1d2dd488252aa2af0cbfc11933aeede96e\", \"got_revision_cp\": \"refs/heads/master@{#838793}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1cc5b3357d2ff3c81ef7ec0b07a6660796bde5cd\", \"got_v8_revision\": \"ab90f8251bdc6bd9dc6033afdd2374af4883794f\", \"got_v8_revision_cp\": \"refs/heads/8.9.181@{#1}\", \"got_webrtc_revision\": \"9e63abad22c306ac080816fde7d428b779b5037d\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32870}\", \"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\": \"d3017b1d2dd488252aa2af0cbfc11933aeede96e\", \"swarm_hashes_refs/heads/master(at){#838793}_without_patch\": {\"absl_hardening_tests\": \"39f20418589f7c30f3194c31d0f3075429c07b21\", \"accessibility_unittests\": \"776afa5ec54f3748943835308cf6cddfad536407\", \"angle_unittests\": \"c0d4c7654b6c8d58395191e9072291593c00731b\", \"app_shell_unittests\": \"8e40cabbe386d3fc89a52bab9e4257bcefcf0c96\", \"aura_unittests\": \"269c5b6b29bc546434eba0bf98daa6d9917e2c27\", \"base_unittests\": \"42e974b3f9fa94cde0fd491121bfac60232dc94d\", \"base_util_unittests\": \"980b1219da6d12b16ee8cd2163d13acd7bc447ea\", \"blink_common_unittests\": \"9172788b89b6597c277058bab489d311d084f191\", \"blink_fuzzer_unittests\": \"c08e524c6c863638e9e4c26a45d174607cc974f1\", \"blink_heap_unittests\": \"f626996cdafea9023157695e5ed76f4caedae783\", \"blink_platform_unittests\": \"701b683a784dd9913e11594cf69448097117f647\", \"blink_unittests\": \"1eb3e4e3969e206ef80d532dc9802aabf2607c22\", \"boringssl_crypto_tests\": \"16fc97f8f1fc57e1aa10895e2a0c4d6bc2743348\", \"boringssl_ssl_tests\": \"99f1af84bcd30319868457a4c4ec2efae6688671\", \"browser_switcher_bho_unittests\": \"03562d54f20fb0e3c8188c91a2ebf5c318f8a595\", \"browser_tests\": \"90c4d6c01b06e97be363c027dee74c4c8b222f14\", \"capture_unittests\": \"9b5b10717b5c45da1b05676a76bb00bd159a6976\", \"cast_unittests\": \"364362603de8fe0a9285cb4949f9e762030147d4\", \"cc_unittests\": \"2fa892fbce01802d29cf0e7012315dded0bcd185\", \"chrome_app_unittests\": \"f7b8c5f7f241451e5bfdd1801190e6fe2101642d\", \"chrome_cleaner_unittests\": \"a8d69beeb83e892b291badc3c53c71cea8083d7a\", \"chrome_elf_unittests\": \"146c4acb3f2ff54ce516b34d68f20ae37312ddcb\", \"chromedriver_unittests\": \"0cf2101ae14f89717e619fc962a0c36821045e72\", \"components_browsertests\": \"8fa32f1bbcb57369a09a37dbfb1061aefd98e22c\", \"components_unittests\": \"82bfd579819d8c28f8cd951c3e5bccf374d2d7c5\", \"compositor_unittests\": \"06fb04e1dd3a0da7e90e3c7a35797b9ae89b5318\", \"content_browsertests\": \"f453389b65f4f254996c9f0e68a53e0f3060c4f8\", \"content_unittests\": \"996f7d67008ac96542977316982f80d4669d5114\", \"courgette_unittests\": \"3412500d7cd474065ae627bdfcf0d7ee32e524ec\", \"crashpad_tests\": \"24e92dc4a4b0e336c7d7cec2c5c604ba4577510d\", \"cronet_tests\": \"6e48c3a8e85121307b8e85045142a637ea11a5d0\", \"cronet_unittests\": \"aabb2bb73c59e2227369cafeba52df77c60bbb37\", \"crypto_unittests\": \"fafc1d6736085a6069a68a6683e072028261c2ad\", \"delayloads_unittests\": \"47e4f017b3a8b3c2426fc6bbc098453770a2b8fb\", \"device_unittests\": \"a160d40d66c456528d974c8a6be6394647b370ab\", \"display_unittests\": \"57d1c0010d80e52c97b6a901d695b4d48fb08beb\", \"elevation_service_unittests\": \"5a6940063290c32ef75c2897a8ce75a1528bbe1c\", \"events_unittests\": \"4d0fc4b5961205708f74ffe650eb8df33d39e8cb\", \"extensions_browsertests\": \"027f01a2c1c7e770f7bd94e847c53fc5b89135d4\", \"extensions_unittests\": \"2fa85ce3207170b358d4feb2c03a86fba5a28361\", \"filesystem_service_unittests\": \"2a9da2511b2d8885b6e8434d8e3fb1913dfea239\", \"gcm_unit_tests\": \"2cd8b5932ecb63944a372bd47cc3570869daa16b\", \"gcp_unittests\": \"2645c8be1aa9ed7e537c6bbcf39054335a47236f\", \"gfx_unittests\": \"dd1805bdca98a59ebf637c077ab957fc43c24583\", \"gin_unittests\": \"002a75a703934aa205772a60b148dc20acf8c221\", \"google_apis_unittests\": \"6d67c5b0c81bfd4db5abd348035e843b7ee79f4a\", \"gpu_unittests\": \"5e822da16c6a152f610ec0beab729055a5c9f501\", \"gwp_asan_unittests\": \"befb8d1bc6a2e09b6e0d9cfe14d6bdaed9064c6a\", \"headless_browsertests\": \"a2bf79098f01bb37700ebaf7fc4d1f9526e8a9a3\", \"headless_unittests\": \"00a9fc2b6200fecf4562d4c9ab8eae73d46779ce\", \"install_static_unittests\": \"25ab4676aa5c08488a848eea8f94799f4ba493c1\", \"installer_util_unittests\": \"b0598b4e82e4fe200cbbd1e6060bbd5f2d71d621\", \"interactive_ui_tests\": \"e50a69353765f7d459e3257ac9fdb28deac181a3\", \"ipc_tests\": \"048a3fe8a8b9f94bf4e16af04bffe9e1dc02d344\", \"jingle_unittests\": \"dc57f769e3156754254dde9ba19e1d09c028dfbe\", \"latency_unittests\": \"738d010def5c7defa6041c8034b5169aee6a812e\", \"libjingle_xmpp_unittests\": \"745cc5d939d01cdc340f665ad5e8f1e8b9dcf67f\", \"liburlpattern_unittests\": \"b572973968ae8e29c94963b512d8dce2500a120e\", \"media_blink_unittests\": \"b910f8dc3f75ab257507f29c586e97d2df5ea034\", \"media_unittests\": \"82be17a22a270f5d1137500ae32beeae4b9aa3c5\", \"message_center_unittests\": \"bcff8eff8d62d7ae8f82777d4a4e3d001914c083\", \"midi_unittests\": \"5cfcf7d6a03b1c5e0216324f9affb3118d7bd5a1\", \"mojo_core_unittests\": \"b9506ecd9af4262463bca9108f660032f8f6aaab\", \"mojo_unittests\": \"8e6a92ffdbccdf22f799a7790349a75c914a35b6\", \"nacl_loader_unittests\": \"50798e1fdb6873012a31fd854f3416dd4064f9a0\", \"native_theme_unittests\": \"f9e3f3c83cbcff03d292b7e2e386b69c12e0ea83\", \"net_unittests\": \"880fa0a2a176a96d039b883c53baa92b67d8c5a2\", \"notification_helper_unittests\": \"2d51c339986b3b4bc1786af99044e745ea62bd37\", \"pdf_unittests\": \"e049989bbcda0779e0cbc32095d05a083ebe2392\", \"perfetto_unittests\": \"ff781e25c4e9a53177d8c2933f514507a44deee4\", \"ppapi_unittests\": \"d4f8d7966a192129300bf041e1bca51101b98ae5\", \"printing_unittests\": \"f03474a99937d656abc75d2dc195fcb03552d31e\", \"remoting_unittests\": \"6739d06418534c03ea2ab4f1161627ff2bf83ef4\", \"sbox_integration_tests\": \"1102a703f28a17648290e4e61153acea42d34ed2\", \"sbox_unittests\": \"795f6dedb474e1c924819163a0cc9c914f367cdf\", \"sbox_validation_tests\": \"3d30d654d895acf4f2f18e5d76bb9016536799e1\", \"service_manager_unittests\": \"12f133fd617a883b2a5ab6877c93dc8054317dbf\", \"services_unittests\": \"a75067e5ef9bae3a5e42533ec4273f2ce44b7394\", \"setup_unittests\": \"36709591cf7b9ec1b56cbade707dbb1908325a28\", \"shell_dialogs_unittests\": \"e2d3ef555aa14258208c1ae984e1703de93d0ee6\", \"skia_unittests\": \"f2c42be9b02974f01d2a314761720eb03897d520\", \"snapshot_unittests\": \"2d5bc157f208a1272878bfbc4976ea754f3737b0\", \"sql_unittests\": \"d53535e7593c46e816252f46ad672c2ae6360ee9\", \"storage_unittests\": \"7c87a611442de1656e5b531a18ddbf4a3b29a1fd\", \"sync_integration_tests\": \"3bb460659a9981f1d3c0113bee3493357c384bee\", \"traffic_annotation_auditor_unittests\": \"f0b066b7317a4fbd3454e95155abfd42400eaedb\", \"ui_base_unittests\": \"7f0c17f8592d3dd9d342e9152959400e9da7373d\", \"ui_touch_selection_unittests\": \"5d208843f5683cde08ef8f0031bd95cad2fa542e\", \"unit_tests\": \"30e75d315b84bb6222e539fbd0b6a0d155824465\", \"updater_tests\": \"12ed3d042459a59a789e564666c2495d43e4c957\", \"url_unittests\": \"40a69d5c06af15ebc69fc5ce1507cce33aaa0be7\", \"views_unittests\": \"f928e490a0d1a2d5dcf04c04c74a1912970bf270\", \"viz_unittests\": \"456f3d0f47aedd0d74c5153881489f7b67c560a0\", \"vr_common_unittests\": \"849d546dd487ae100eb9dce9153e8b9068d467b6\", \"vr_pixeltests\": \"bc28f728c740f3c4c286ca31aa13ee11d14639d6\", \"weblayer_browsertests\": \"c91c011635238c371a2f8cefa8c196ee5ae7a712\", \"weblayer_unittests\": \"2b12195d7ee21e160c57c0223fd17cf2aa446357\", \"wm_unittests\": \"4c87323285b11bb5f47948e9722198dbdc9920c7\", \"wtf_unittests\": \"dafd08d36bacbe15140f725bc84f67c167d45f4d\", \"zlib_unittests\": \"6f2e532f45d8ca7b8f502379784df0afbb20b999\", \"zucchini_unittests\": \"ab18aafeafb6a4a5cdc2654c2d529922f274f300\"}}, \"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-6-gpyc\"], \"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\": [\"5657-0417a3f\"], \"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": "1608613472059503",
"status": "COMPLETED",
"status_changed_ts": "1608616411093030",
"tags": [
"build_address:luci.chromium.ci/win-asan/16377",
"builder:win-asan",
"buildset:commit/git/d3017b1d2dd488252aa2af0cbfc11933aeede96e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d3017b1d2dd488252aa2af0cbfc11933aeede96e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025670302528629840",
"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/8860240240455829600/+/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:50a1a7256003a710",
"user_agent:luci-scheduler"
],
"updated_ts": "1608616411134451",
"url": "https://ci.chromium.org/b/8860240240455829600",
"utcnow_ts": "1608616413045848"
}
}
[05:53:33.053] Invocation finished in 49m6.717982965s with status SUCCEEDED