[21:02:20.909] New invocation is queued and will start shortly
[21:02:21.985] Starting the invocation (attempt 1)
[21:02:22.043] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:02:22.046] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:02:22.046] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018362278800726688",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"2359ad7a092c893b1827a9c1f9750db8c77354fe\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9018362278800726688",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/2359ad7a092c893b1827a9c1f9750db8c77354fe",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2359ad7a092c893b1827a9c1f9750db8c77354fe",
"gitiles_ref:refs/heads/master"
]
}
[21:02:22.887] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615582942152760",
"id": "8852932216808160272",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2359ad7a092c893b1827a9c1f9750db8c77354fe\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615582942561743",
"tags": [
"build_address:luci.chromium.ci/win-asan/17777",
"builder:win-asan",
"buildset:commit/git/2359ad7a092c893b1827a9c1f9750db8c77354fe",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2359ad7a092c893b1827a9c1f9750db8c77354fe",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018362278800726688",
"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/8852932216808160272/+/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": "1615582942561893",
"url": "https://ci.chromium.org/b/8852932216808160272",
"utcnow_ts": "1615582942868802"
}
}
[21:02:22.887] Task URL: https://ci.chromium.org/b/8852932216808160272
[21:02:22.887] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:2:0) after 1m0s
[21:02:24.334] Received PubSub notification, asking Buildbucket for the build status
[21:02:24.541] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:22.917] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:2:0)
[21:03:22.917] Timer tick, asking Buildbucket for the build status
[21:03:22.984] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:22.984] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:4:0) after 1m0s
[21:04:22.995] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:4:0)
[21:04:22.995] Timer tick, asking Buildbucket for the build status
[21:04:23.061] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:23.062] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:5:0) after 1m0s
[21:05:23.052] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:5:0)
[21:05:23.052] Timer tick, asking Buildbucket for the build status
[21:05:23.123] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:23.123] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:6:0) after 1m0s
[21:06:23.138] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:6:0)
[21:06:23.138] Timer tick, asking Buildbucket for the build status
[21:06:23.345] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:23.345] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:7:0) after 1m0s
[21:07:23.385] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:7:0)
[21:07:23.385] Timer tick, asking Buildbucket for the build status
[21:07:23.460] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:23.460] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:8:0) after 1m0s
[21:08:23.870] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:8:0)
[21:08:23.870] Timer tick, asking Buildbucket for the build status
[21:08:23.944] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:23.944] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:9:0) after 1m0s
[21:09:24.097] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:9:0)
[21:09:24.097] Timer tick, asking Buildbucket for the build status
[21:09:24.261] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:24.261] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:10:0) after 1m0s
[21:10:25.251] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:10:0)
[21:10:25.251] Timer tick, asking Buildbucket for the build status
[21:10:25.331] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:25.331] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:11:0) after 1m0s
[21:11:25.358] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:11:0)
[21:11:25.358] Timer tick, asking Buildbucket for the build status
[21:11:25.458] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:25.458] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:12:0) after 1m0s
[21:12:25.484] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:12:0)
[21:12:25.484] Timer tick, asking Buildbucket for the build status
[21:12:25.580] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:25.580] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:13:0) after 1m0s
[21:13:25.667] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:13:0)
[21:13:25.667] Timer tick, asking Buildbucket for the build status
[21:13:25.742] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:25.742] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:14:0) after 1m0s
[21:14:25.794] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:14:0)
[21:14:25.794] Timer tick, asking Buildbucket for the build status
[21:14:26.220] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:26.220] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:15:0) after 1m0s
[21:15:26.329] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:15:0)
[21:15:26.329] Timer tick, asking Buildbucket for the build status
[21:15:26.536] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:26.536] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:16:0) after 1m0s
[21:16:26.623] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:16:0)
[21:16:26.623] Timer tick, asking Buildbucket for the build status
[21:16:26.688] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:26.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:17:0) after 1m0s
[21:17:26.767] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:17:0)
[21:17:26.767] Timer tick, asking Buildbucket for the build status
[21:17:26.855] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:26.855] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:18:0) after 1m0s
[21:18:27.051] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:18:0)
[21:18:27.051] Timer tick, asking Buildbucket for the build status
[21:18:27.120] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:27.120] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:19:0) after 1m0s
[21:19:27.129] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:19:0)
[21:19:27.129] Timer tick, asking Buildbucket for the build status
[21:19:27.207] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:27.207] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:20:0) after 1m0s
[21:20:27.367] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:20:0)
[21:20:27.367] Timer tick, asking Buildbucket for the build status
[21:20:27.462] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:27.462] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:21:0) after 1m0s
[21:21:27.734] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:21:0)
[21:21:27.734] Timer tick, asking Buildbucket for the build status
[21:21:28.185] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:28.185] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:22:0) after 1m0s
[21:22:28.210] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:22:0)
[21:22:28.210] Timer tick, asking Buildbucket for the build status
[21:22:28.549] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:28.549] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:23:0) after 1m0s
[21:23:28.607] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:23:0)
[21:23:28.607] Timer tick, asking Buildbucket for the build status
[21:23:28.681] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:28.681] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:24:0) after 1m0s
[21:24:28.729] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:24:0)
[21:24:28.729] Timer tick, asking Buildbucket for the build status
[21:24:29.324] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:29.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:25:0) after 1m0s
[21:25:29.356] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:25:0)
[21:25:29.356] Timer tick, asking Buildbucket for the build status
[21:25:29.454] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:29.454] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:26:0) after 1m0s
[21:26:29.473] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:26:0)
[21:26:29.473] Timer tick, asking Buildbucket for the build status
[21:26:29.843] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:29.843] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:27:0) after 1m0s
[21:27:29.878] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:27:0)
[21:27:29.879] Timer tick, asking Buildbucket for the build status
[21:27:29.994] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:29.994] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:28:0) after 1m0s
[21:28:30.014] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:28:0)
[21:28:30.014] Timer tick, asking Buildbucket for the build status
[21:28:30.110] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:30.110] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:29:0) after 1m0s
[21:29:30.129] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:29:0)
[21:29:30.129] Timer tick, asking Buildbucket for the build status
[21:29:30.356] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:30.356] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:30:0) after 1m0s
[21:30:30.376] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:30:0)
[21:30:30.376] Timer tick, asking Buildbucket for the build status
[21:30:30.620] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:30.620] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:31:0) after 1m0s
[21:31:30.711] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:31:0)
[21:31:30.711] Timer tick, asking Buildbucket for the build status
[21:31:30.793] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:30.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:32:0) after 1m0s
[21:32:30.971] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:32:0)
[21:32:30.971] Timer tick, asking Buildbucket for the build status
[21:32:31.066] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:31.066] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:33:0) after 1m0s
[21:33:31.167] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:33:0)
[21:33:31.167] Timer tick, asking Buildbucket for the build status
[21:33:31.252] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:31.252] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:34:0) after 1m0s
[21:34:31.215] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:34:0)
[21:34:31.215] Timer tick, asking Buildbucket for the build status
[21:34:31.299] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:31.299] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:35:0) after 1m0s
[21:35:31.369] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:35:0)
[21:35:31.369] Timer tick, asking Buildbucket for the build status
[21:35:31.816] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:31.816] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:36:0) after 1m0s
[21:36:31.843] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:36:0)
[21:36:31.843] Timer tick, asking Buildbucket for the build status
[21:36:32.185] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:32.185] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:37:0) after 1m0s
[21:37:32.238] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:37:0)
[21:37:32.238] Timer tick, asking Buildbucket for the build status
[21:37:32.358] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:32.358] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:38:0) after 1m0s
[21:38:32.415] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:38:0)
[21:38:32.415] Timer tick, asking Buildbucket for the build status
[21:38:32.922] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:32.922] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:39:0) after 1m0s
[21:39:32.893] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:39:0)
[21:39:32.893] Timer tick, asking Buildbucket for the build status
[21:39:32.982] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:32.982] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:40:0) after 1m0s
[21:40:33.050] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:40:0)
[21:40:33.050] Timer tick, asking Buildbucket for the build status
[21:40:33.128] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:33.128] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:41:0) after 1m0s
[21:41:33.259] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:41:0)
[21:41:33.259] Timer tick, asking Buildbucket for the build status
[21:41:33.342] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:33.342] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:42:0) after 1m0s
[21:42:33.480] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:42:0)
[21:42:33.480] Timer tick, asking Buildbucket for the build status
[21:42:35.570] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:35.570] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:43:0) after 1m0s
[21:43:35.682] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:43:0)
[21:43:35.682] Timer tick, asking Buildbucket for the build status
[21:43:36.343] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:36.343] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:44:0) after 1m0s
[21:44:36.406] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:44:0)
[21:44:36.406] Timer tick, asking Buildbucket for the build status
[21:44:36.962] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:36.962] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:45:0) after 1m0s
[21:45:36.981] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:45:0)
[21:45:36.981] Timer tick, asking Buildbucket for the build status
[21:45:37.240] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:37.240] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:46:0) after 1m0s
[21:46:37.277] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:46:0)
[21:46:37.277] Timer tick, asking Buildbucket for the build status
[21:46:37.384] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:37.384] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:47:0) after 1m0s
[21:47:37.470] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:47:0)
[21:47:37.470] Timer tick, asking Buildbucket for the build status
[21:47:37.553] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:37.553] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:48:0) after 1m0s
[21:48:37.693] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:48:0)
[21:48:37.693] Timer tick, asking Buildbucket for the build status
[21:48:37.908] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:37.908] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:49:0) after 1m0s
[21:49:38.015] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:49:0)
[21:49:38.015] Timer tick, asking Buildbucket for the build status
[21:49:38.139] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:38.139] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:50:0) after 1m0s
[21:50:38.196] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:50:0)
[21:50:38.196] Timer tick, asking Buildbucket for the build status
[21:50:38.272] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:38.272] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:51:0) after 1m0s
[21:51:38.380] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:51:0)
[21:51:38.380] Timer tick, asking Buildbucket for the build status
[21:51:38.461] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:38.461] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:52:0) after 1m0s
[21:52:38.490] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:52:0)
[21:52:38.490] Timer tick, asking Buildbucket for the build status
[21:52:38.842] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:38.842] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:53:0) after 1m0s
[21:53:38.910] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:53:0)
[21:53:38.910] Timer tick, asking Buildbucket for the build status
[21:53:39.111] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:39.111] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:54:0) after 1m0s
[21:54:39.212] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:54:0)
[21:54:39.212] Timer tick, asking Buildbucket for the build status
[21:54:39.440] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:39.440] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:55:0) after 1m0s
[21:55:39.466] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:55:0)
[21:55:39.466] Timer tick, asking Buildbucket for the build status
[21:55:39.550] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:39.550] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:56:0) after 1m0s
[21:56:39.587] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:56:0)
[21:56:39.587] Timer tick, asking Buildbucket for the build status
[21:56:39.667] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:39.667] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:57:0) after 1m0s
[21:57:39.710] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:57:0)
[21:57:39.710] Timer tick, asking Buildbucket for the build status
[21:57:39.797] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:39.798] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:58:0) after 1m0s
[21:58:39.885] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:58:0)
[21:58:39.885] Timer tick, asking Buildbucket for the build status
[21:58:40.255] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:40.255] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:59:0) after 1m0s
[21:59:40.309] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:59:0)
[21:59:40.309] Timer tick, asking Buildbucket for the build status
[21:59:40.380] Build 8852932216808160272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:40.380] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018362278800726688:60:0) after 1m0s
[22:00:35.834] Received PubSub notification, asking Buildbucket for the build status
[22:00:35.914] Build 8852932216808160272: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:00:35.914] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615586433417186",
"created_by": "project:chromium",
"created_ts": "1615582942152760",
"id": "8852932216808160272",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2359ad7a092c893b1827a9c1f9750db8c77354fe\"}}",
"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\": \"2359ad7a092c893b1827a9c1f9750db8c77354fe\", \"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-2-zecp\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17777, \"clang_revision\": \"llvmorg-13-init-3462-gfe5c2c3c-2\", \"got_angle_revision\": \"41a2672f43fb125e83b4942133e487995da9bf7c\", \"got_dawn_revision\": \"c53ea046a603d5085268584f16bfdf61586f4c4c\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"2359ad7a092c893b1827a9c1f9750db8c77354fe\", \"got_revision_cp\": \"refs/heads/master@{#862518}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"c78dae86e7d1a60020001fdc648f30502620b03a\", \"got_v8_revision\": \"9d12b666c3e113f5cd61e2b2eb384aae242ac840\", \"got_v8_revision_cp\": \"refs/heads/9.1.105@{#1}\", \"got_webrtc_revision\": \"86473404362e38131203537b8a8c8ec7c1abc31a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33444}\", \"is_cached\": true, \"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\": \"2359ad7a092c893b1827a9c1f9750db8c77354fe\", \"swarm_hashes_refs/heads/master(at){#862518}_without_patch\": {\"absl_hardening_tests\": \"936d0dd7c64c0f1b38033254e100c2b023fec043\", \"accessibility_unittests\": \"db91c5a4beef945151a0f285ee47591df79b94f6\", \"angle_unittests\": \"6fbb2810f9454b6ab1cc01938b9a2caee02c8d55\", \"app_shell_unittests\": \"7c4cb6589d96eede098a98fd4e601d23e7a7a4b4\", \"aura_unittests\": \"87cc9030c94e80ece1582e5da2ca2375cf7c0fb8\", \"base_unittests\": \"b6a8ab6533947093e4e734158a90cb854a4a6b71\", \"base_util_unittests\": \"ed3f460df789604e33e7aa33ba0250e65781b775\", \"blink_common_unittests\": \"cb581783359ab1934f52e34962e570ba1edb385b\", \"blink_fuzzer_unittests\": \"12067e14657d0b7af3546aa46281f4d09bd6903b\", \"blink_heap_unittests\": \"d0dd2a5f8312725dd83775501ce69ba6613bf597\", \"blink_platform_unittests\": \"d7b217a5297ba8049f9dab905136bd6a35e923f2\", \"blink_unittests\": \"9ddfa801d6642ca891de7d6369064e33e60cb16c\", \"boringssl_crypto_tests\": \"48116f73155803b3adbfbff3cb583975da7f25c8\", \"boringssl_ssl_tests\": \"b03c50f14055d33e112a72355586775436c4a7ff\", \"browser_switcher_bho_unittests\": \"5ef088f8f246dad48142fe7fa207f649a5718e7b\", \"browser_tests\": \"1cc262ef93fa77de7d859322ef904f89e348d868\", \"capture_unittests\": \"7c57291eff3f09af4988cc96a789c244c77fc856\", \"cast_unittests\": \"ba6f675511c4dc1273408be1631c8c3cd52c18b2\", \"cc_unittests\": \"b0d165684a7ab01f955537593b2892594df3c88b\", \"chrome_app_unittests\": \"edac66189da9974ce8cfed5503fedcca63e97b72\", \"chrome_cleaner_unittests\": \"99fa3f8d410b5643078620e43cbd1240897f933b\", \"chrome_elf_unittests\": \"c67a2774bf74cc2cacdd08815e5d9ecd974834ea\", \"chromedriver_unittests\": \"e1c4fc43c94f29f429d772ba9135ad783eef62c0\", \"color_unittests\": \"64691e93be9315b76e8cfa506785e7200605eba7\", \"components_browsertests\": \"b18dccb30a09973f03afb07d9d32d8bf618e5aaa\", \"components_unittests\": \"0a7c1e384214c35d87b9e0bfeb27966109c74c58\", \"compositor_unittests\": \"4e65f9349278ff3c8e0b074c4f7e6bb2198bf429\", \"content_browsertests\": \"f3a244843f5e265c9ac242afb7312428aa3a280c\", \"content_unittests\": \"5c46dc7f8faca950df84fac6fabbeb8efa50e110\", \"courgette_unittests\": \"49d75bdf43f6b751ea90f397254ec6783366377f\", \"crashpad_tests\": \"f7b301eb0cf9ffb1ba22f33c44f446255abc8b2f\", \"cronet_tests\": \"a6a6488b60db72981087098b41f37c2a4dd3a81c\", \"cronet_unittests\": \"60f8369bb7300364897d653c8e685939f77f3141\", \"crypto_unittests\": \"bf2e08c4e92bc611b47d57881f522a6f2c5b6d7d\", \"delayloads_unittests\": \"1e273a4d91fb85041b141f97c94c8b9d1a6ef4e4\", \"device_unittests\": \"0998d7c66fdef60246eb3aabf4779abb9cf88f67\", \"display_unittests\": \"e83ececcb8c6bb49986631368fcb8d162a6038f7\", \"elevation_service_unittests\": \"e6a30b6c8be594c597f10fe7555f9df408f48b43\", \"events_unittests\": \"e19fa4149e98ebeb6b89a8bb4dfb8a58bc9bc3c7\", \"extensions_browsertests\": \"f1db96c97841a7ad6543a62ad04e9609ba5cb821\", \"extensions_unittests\": \"de50575cfa13c13007b50ae6e59abe457ef60de4\", \"filesystem_service_unittests\": \"44e2818b97840fbf3ff5a55c4b628e3d0bbad00a\", \"gcm_unit_tests\": \"b22ec2f595b01f019b755013084d08278202573e\", \"gcp_unittests\": \"2f04f80ce57646a4d48ace73880d82ca74c15077\", \"gfx_unittests\": \"fb27a76738428b2d8ae07d04cb25cfea29b50e4f\", \"gin_unittests\": \"440c36d64641528ccd8360a8655759ac332db5db\", \"google_apis_unittests\": \"0bee583eb7d8057635b18512f8c1641d17305eeb\", \"gpu_unittests\": \"51af8d5e7c7a509e3120ef712aac07f1efdee215\", \"gwp_asan_unittests\": \"4a234ce89939697e2b86eb806c2dd073f71d4ed0\", \"headless_browsertests\": \"ad685851b6a302f3a24d111b03faeeb0a4cf1625\", \"headless_unittests\": \"c72fe1624089d512cfb06767e5192f87ef9dc09a\", \"install_static_unittests\": \"317facf15094077d66257477ad7a416f3f2c4486\", \"installer_util_unittests\": \"c12ff2bb5a8945c30124637340a1e88d3f4d544b\", \"interactive_ui_tests\": \"cb7645dd79343ecec15eb71502f83ff0211bfb02\", \"ipc_tests\": \"9c320ffb2945e88832b3b4cf2694c9a77f6056c1\", \"jingle_unittests\": \"06141f2f2c51afde07959921dff1ce9f4697bc22\", \"latency_unittests\": \"17476f9f1129f3655a45ed603cab7a07029d5987\", \"libjingle_xmpp_unittests\": \"1b73f3ea8c879dc1250e80f25c9a50e14cef73cd\", \"liburlpattern_unittests\": \"6433462f30a880c19bd0e8c45e9d1dccc2884be4\", \"media_blink_unittests\": \"1d68316e8a05aaa2f662ba6918723a165d2f9a99\", \"media_unittests\": \"15c893473aec49b21880fe4a0142887b029bb9f0\", \"message_center_unittests\": \"2f7b04f92b6d2c68421fd2c6bd67048d04d2c67a\", \"midi_unittests\": \"74f234ace5a36edfced7844963f7f8dba6c4331c\", \"mojo_core_unittests\": \"de06a3440909647503e9d40caef1ec81e7bc1e26\", \"mojo_unittests\": \"5a921af2dc86477c328e92e29e721a7359110286\", \"nacl_loader_unittests\": \"43ca9a8eb49eb3d0990992395761803bf2212082\", \"native_theme_unittests\": \"de996289cde83bca2c17abb02858692240d5fb50\", \"net_unittests\": \"53be76be44c4443c032e41afeab7d7ffe2183a64\", \"notification_helper_unittests\": \"61af7d81162e9aebcdc0ec467ddefe373a6bbacc\", \"pdf_unittests\": \"4492c6b0df4c323743864a744e6c8020aa6822c7\", \"perfetto_unittests\": \"c71a85c5f9c575bd063d6d79c285d1e95947cbdb\", \"ppapi_unittests\": \"091660b7c080439565dfc34161259a30ff8c1273\", \"printing_unittests\": \"27ae7ad2fb48bd491730b4559bed5d8d8f636497\", \"remoting_unittests\": \"5d00aff72b667e2d7f500674e2bd0ba1f03e8049\", \"sbox_integration_tests\": \"48f038212544dcd93c2535d3937c73358a5430e0\", \"sbox_unittests\": \"58c41596f7257d3377087ecb2586f36894edfe73\", \"sbox_validation_tests\": \"fde24e102bd7947044e113ef1f6515bc5700ac37\", \"service_manager_unittests\": \"0b27261f1569e2991281ffe88d7b9571a73bd29c\", \"services_unittests\": \"d3d5fa11cfe31cf8c474993a7c701fba59f8cad7\", \"setup_unittests\": \"c38c1a3d87fe76b8eb3f7aa7099250a293cb366d\", \"shell_dialogs_unittests\": \"f2001545f579505288232ee6bce47fbccc5ba5b9\", \"skia_unittests\": \"4a94a2e427389f7a4ef5877600b38743e78a917a\", \"snapshot_unittests\": \"422aedc41a347d020aba3817ee699329f8f2e80e\", \"sql_unittests\": \"551259d0d96367b3b08401703f2a07c22a3fcff9\", \"storage_unittests\": \"189441a55d72db08eb8ae5901629285470504ce8\", \"sync_integration_tests\": \"bc91d371afbf98f7e51f6bd6e0d284760855d96e\", \"traffic_annotation_auditor_unittests\": \"8a37abac64bbe7d553b55f61562626b1fc5c1520\", \"ui_base_unittests\": \"30a9d9d2e89c4edf53000c977937f6dd9b420e53\", \"ui_touch_selection_unittests\": \"af93e38b359ef204e0f0de518a81a2b601e23c6a\", \"unit_tests\": \"32f9102cd3f9e0cf0fb687344f814179967e74da\", \"updater_tests\": \"b5916d4a16da2f47b507c6e3d1b21dc22cd64669\", \"url_unittests\": \"07c998e6808ffcc4e2cb10f99b3644675a9316c4\", \"views_unittests\": \"e4af3413206466593dd5df8e024143934cb8c0c9\", \"viz_unittests\": \"722e7aa08bfd6db08707df6b3383ef733a76fbdc\", \"vr_common_unittests\": \"bafd5e38d83ab839d5c827fdab9401272c7c61ce\", \"vr_pixeltests\": \"235223ad30a04b3ae99c0b183a7a2b35a034772a\", \"weblayer_browsertests\": \"0b38a2e77e140e21814ea016c9e9f597d71e2761\", \"weblayer_unittests\": \"2375793ded1c9a574e8765764ec5050735f99538\", \"wm_unittests\": \"4fc2ef2da35eb401c7e8893a1e042b085dd966d3\", \"wtf_unittests\": \"3b3c41822c71e4004177b1675bf6ccc624fa9d00\", \"zlib_unittests\": \"c340da81e5fb0a6f815974026c10b56fa5c153d6\", \"zucchini_unittests\": \"25004f2a1b8e10536ea7709d8efd7d2007db9cac\"}}, \"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-2-zecp\"], \"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\": [\"5754-8c4f760\"], \"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": "1615582943627483",
"status": "COMPLETED",
"status_changed_ts": "1615586433897237",
"tags": [
"build_address:luci.chromium.ci/win-asan/17777",
"builder:win-asan",
"buildset:commit/git/2359ad7a092c893b1827a9c1f9750db8c77354fe",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2359ad7a092c893b1827a9c1f9750db8c77354fe",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018362278800726688",
"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/8852932216808160272/+/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:524110df11457110",
"user_agent:luci-scheduler"
],
"updated_ts": "1615586433990968",
"url": "https://ci.chromium.org/b/8852932216808160272",
"utcnow_ts": "1615586435905737"
}
}
[22:00:35.914] Invocation finished in 58m15.046337198s with status SUCCEEDED