[14:58:16.430] New invocation is queued and will start shortly
[14:58:17.607] Starting the invocation (attempt 1)
[14:58:17.759] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:58:17.759] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:58:17.759] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023549211473994672",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"9b006e135017235cf74feaa113000b85be0dd619\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9023549211473994672",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/9b006e135017235cf74feaa113000b85be0dd619",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9b006e135017235cf74feaa113000b85be0dd619",
"gitiles_ref:refs/heads/master"
]
}
[14:58:20.737] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610636297904903",
"id": "8858119149247364048",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9b006e135017235cf74feaa113000b85be0dd619\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610636299260800",
"tags": [
"build_address:luci.chromium.ci/win-asan/16818",
"builder:win-asan",
"buildset:commit/git/9b006e135017235cf74feaa113000b85be0dd619",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9b006e135017235cf74feaa113000b85be0dd619",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023549211473994672",
"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/8858119149247364048/+/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": "1610636299260910",
"url": "https://ci.chromium.org/b/8858119149247364048",
"utcnow_ts": "1610636300729286"
}
}
[14:58:20.737] Task URL: https://ci.chromium.org/b/8858119149247364048
[14:58:20.737] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:2:0) after 1m0s
[14:58:32.209] Received PubSub notification, asking Buildbucket for the build status
[14:58:32.294] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:20.782] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:2:0)
[14:59:20.782] Timer tick, asking Buildbucket for the build status
[14:59:20.910] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:20.910] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:4:0) after 1m0s
[15:00:20.985] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:4:0)
[15:00:20.985] Timer tick, asking Buildbucket for the build status
[15:00:21.386] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:21.386] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:5:0) after 1m0s
[15:01:21.470] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:5:0)
[15:01:21.470] Timer tick, asking Buildbucket for the build status
[15:01:21.657] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:21.657] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:6:0) after 1m0s
[15:02:21.729] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:6:0)
[15:02:21.729] Timer tick, asking Buildbucket for the build status
[15:02:21.826] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:21.826] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:7:0) after 1m0s
[15:03:21.902] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:7:0)
[15:03:21.902] Timer tick, asking Buildbucket for the build status
[15:03:22.042] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:22.042] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:8:0) after 1m0s
[15:04:22.065] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:8:0)
[15:04:22.065] Timer tick, asking Buildbucket for the build status
[15:04:22.385] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:22.385] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:9:0) after 1m0s
[15:05:22.447] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:9:0)
[15:05:22.447] Timer tick, asking Buildbucket for the build status
[15:05:22.545] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:22.546] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:10:0) after 1m0s
[15:06:22.547] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:10:0)
[15:06:22.547] Timer tick, asking Buildbucket for the build status
[15:06:22.639] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:22.639] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:11:0) after 1m0s
[15:07:22.662] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:11:0)
[15:07:22.662] Timer tick, asking Buildbucket for the build status
[15:07:22.993] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:22.993] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:12:0) after 1m0s
[15:08:23.018] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:12:0)
[15:08:23.018] Timer tick, asking Buildbucket for the build status
[15:08:23.288] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:23.288] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:13:0) after 1m0s
[15:09:23.333] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:13:0)
[15:09:23.333] Timer tick, asking Buildbucket for the build status
[15:09:23.445] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:23.445] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:14:0) after 1m0s
[15:10:23.472] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:14:0)
[15:10:23.472] Timer tick, asking Buildbucket for the build status
[15:10:23.552] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:23.552] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:15:0) after 1m0s
[15:11:23.572] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:15:0)
[15:11:23.572] Timer tick, asking Buildbucket for the build status
[15:11:24.012] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:24.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:16:0) after 1m0s
[15:12:24.009] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:16:0)
[15:12:24.009] Timer tick, asking Buildbucket for the build status
[15:12:24.247] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:24.247] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:17:0) after 1m0s
[15:13:24.273] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:17:0)
[15:13:24.273] Timer tick, asking Buildbucket for the build status
[15:13:24.988] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:24.988] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:18:0) after 1m0s
[15:14:25.044] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:18:0)
[15:14:25.044] Timer tick, asking Buildbucket for the build status
[15:14:25.160] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:25.160] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:19:0) after 1m0s
[15:15:25.186] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:19:0)
[15:15:25.186] Timer tick, asking Buildbucket for the build status
[15:15:25.337] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:25.337] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:20:0) after 1m0s
[15:16:25.372] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:20:0)
[15:16:25.372] Timer tick, asking Buildbucket for the build status
[15:16:25.551] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:25.551] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:21:0) after 1m0s
[15:17:25.590] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:21:0)
[15:17:25.590] Timer tick, asking Buildbucket for the build status
[15:17:25.739] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:25.739] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:22:0) after 1m0s
[15:18:25.763] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:22:0)
[15:18:25.763] Timer tick, asking Buildbucket for the build status
[15:18:25.991] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:25.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:23:0) after 1m0s
[15:19:26.087] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:23:0)
[15:19:26.087] Timer tick, asking Buildbucket for the build status
[15:19:26.258] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:26.258] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:24:0) after 1m0s
[15:20:26.340] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:24:0)
[15:20:26.340] Timer tick, asking Buildbucket for the build status
[15:20:26.538] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:26.538] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:25:0) after 1m0s
[15:21:26.667] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:25:0)
[15:21:26.667] Timer tick, asking Buildbucket for the build status
[15:21:27.038] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:27.038] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:26:0) after 1m0s
[15:22:27.158] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:26:0)
[15:22:27.158] Timer tick, asking Buildbucket for the build status
[15:22:27.490] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:27.490] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:27:0) after 1m0s
[15:23:27.506] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:27:0)
[15:23:27.506] Timer tick, asking Buildbucket for the build status
[15:23:27.637] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:27.637] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:28:0) after 1m0s
[15:24:27.736] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:28:0)
[15:24:27.736] Timer tick, asking Buildbucket for the build status
[15:24:28.384] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:28.384] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:29:0) after 1m0s
[15:25:28.539] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:29:0)
[15:25:28.539] Timer tick, asking Buildbucket for the build status
[15:25:28.796] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:28.796] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:30:0) after 1m0s
[15:26:29.031] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:30:0)
[15:26:29.031] Timer tick, asking Buildbucket for the build status
[15:26:29.133] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:29.133] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:31:0) after 1m0s
[15:27:29.317] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:31:0)
[15:27:29.317] Timer tick, asking Buildbucket for the build status
[15:27:29.430] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:29.430] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:32:0) after 1m0s
[15:28:29.836] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:32:0)
[15:28:29.836] Timer tick, asking Buildbucket for the build status
[15:28:29.973] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:29.973] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:33:0) after 1m0s
[15:29:30.028] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:33:0)
[15:29:30.028] Timer tick, asking Buildbucket for the build status
[15:29:30.340] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:30.340] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:34:0) after 1m0s
[15:30:30.390] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:34:0)
[15:30:30.390] Timer tick, asking Buildbucket for the build status
[15:30:30.452] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:30.452] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:35:0) after 1m0s
[15:31:30.721] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:35:0)
[15:31:30.723] Timer tick, asking Buildbucket for the build status
[15:31:30.898] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:30.898] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:36:0) after 1m0s
[15:32:30.981] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:36:0)
[15:32:30.982] Timer tick, asking Buildbucket for the build status
[15:32:31.189] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:31.189] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:37:0) after 1m0s
[15:33:31.476] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:37:0)
[15:33:31.476] Timer tick, asking Buildbucket for the build status
[15:33:31.642] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:31.642] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:38:0) after 1m0s
[15:34:31.724] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:38:0)
[15:34:31.724] Timer tick, asking Buildbucket for the build status
[15:34:31.805] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:31.805] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:39:0) after 1m0s
[15:35:31.872] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:39:0)
[15:35:31.872] Timer tick, asking Buildbucket for the build status
[15:35:31.958] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:31.958] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:40:0) after 1m0s
[15:36:31.996] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:40:0)
[15:36:31.996] Timer tick, asking Buildbucket for the build status
[15:36:32.085] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:32.085] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:41:0) after 1m0s
[15:37:32.142] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:41:0)
[15:37:32.142] Timer tick, asking Buildbucket for the build status
[15:37:32.489] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:32.489] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:42:0) after 1m0s
[15:38:32.472] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:42:0)
[15:38:32.472] Timer tick, asking Buildbucket for the build status
[15:38:32.689] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:32.689] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:43:0) after 1m0s
[15:39:32.699] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:43:0)
[15:39:32.699] Timer tick, asking Buildbucket for the build status
[15:39:32.809] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:32.809] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:44:0) after 1m0s
[15:40:32.853] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:44:0)
[15:40:32.853] Timer tick, asking Buildbucket for the build status
[15:40:32.949] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:32.949] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:45:0) after 1m0s
[15:41:32.984] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:45:0)
[15:41:32.984] Timer tick, asking Buildbucket for the build status
[15:41:33.134] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:33.134] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:46:0) after 1m0s
[15:42:33.179] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:46:0)
[15:42:33.179] Timer tick, asking Buildbucket for the build status
[15:42:33.380] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:33.380] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:47:0) after 1m0s
[15:43:33.472] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:47:0)
[15:43:33.472] Timer tick, asking Buildbucket for the build status
[15:43:33.610] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:33.610] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:48:0) after 1m0s
[15:44:33.633] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:48:0)
[15:44:33.633] Timer tick, asking Buildbucket for the build status
[15:44:33.740] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:33.740] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:49:0) after 1m0s
[15:45:33.767] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:49:0)
[15:45:33.767] Timer tick, asking Buildbucket for the build status
[15:45:33.841] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:33.841] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:50:0) after 1m0s
[15:46:33.876] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:50:0)
[15:46:33.876] Timer tick, asking Buildbucket for the build status
[15:46:34.030] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:34.030] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:51:0) after 1m0s
[15:47:34.099] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:51:0)
[15:47:34.099] Timer tick, asking Buildbucket for the build status
[15:47:34.221] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:34.221] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:52:0) after 1m0s
[15:48:34.222] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:52:0)
[15:48:34.222] Timer tick, asking Buildbucket for the build status
[15:48:34.448] Build 8858119149247364048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:34.448] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023549211473994672:53:0) after 1m0s
[15:48:51.622] Received PubSub notification, asking Buildbucket for the build status
[15:48:52.020] Build 8858119149247364048: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:48:52.020] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610639330348461",
"created_by": "project:chromium",
"created_ts": "1610636297904903",
"id": "8858119149247364048",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9b006e135017235cf74feaa113000b85be0dd619\"}}",
"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\": \"9b006e135017235cf74feaa113000b85be0dd619\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-win10-32-3-nb2x\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16818, \"clang_revision\": \"llvmorg-12-init-16296-g5e476061-1\", \"got_angle_revision\": \"b421774ae9c3a78ca833a506ce1ea3baa01c3bbe\", \"got_dawn_revision\": \"247f511f198f901ce3eb0344f355f53bf9ffe59d\", \"got_nacl_revision\": \"d28e6c52e05ea2f1b3231de473b6dbfce59bce40\", \"got_revision\": \"9b006e135017235cf74feaa113000b85be0dd619\", \"got_revision_cp\": \"refs/heads/master@{#843530}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"5255c465bbbab020b2fa98f818a705e764865869\", \"got_v8_revision\": \"c80a50a3c4de747d61e044cea6f94223016110d2\", \"got_v8_revision_cp\": \"refs/heads/8.9.273@{#1}\", \"got_webrtc_revision\": \"1c5e63e5451374783aaf0259f5c23d3688a5b2ff\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32938}\", \"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\": \"9b006e135017235cf74feaa113000b85be0dd619\", \"swarm_hashes_refs/heads/master(at){#843530}_without_patch\": {\"absl_hardening_tests\": \"e5d200530756ee63183975eb05cece6b271f0d95\", \"accessibility_unittests\": \"b438b08af2e5659edddd4edc297d9a7774b6d219\", \"angle_unittests\": \"fa9cee359bb98e6df1e537fe9b48a8295a3f30af\", \"app_shell_unittests\": \"52fdb0de9b2ffffe08e68be0df7eb972b1a22fa6\", \"aura_unittests\": \"3b2af61501be05a3825a0ddc52fccb736d5c2c6a\", \"base_unittests\": \"518489998ecf849e371215691510c2a413e17054\", \"base_util_unittests\": \"262151d1d7b6f11e1333516b147d64315a589055\", \"blink_common_unittests\": \"9483fde062f20dfead44808933fa48398b307faa\", \"blink_fuzzer_unittests\": \"48d874535e6b9ae90137626297b502c775898fba\", \"blink_heap_unittests\": \"14100eecbc2c38aebaa7af900ff467e69e1d9ae5\", \"blink_platform_unittests\": \"d5a1769b67b0a5e3c58c6f2145ef8e2e139208d7\", \"blink_unittests\": \"8274118b25e5205e99372a402e0c16c1b191aaa7\", \"boringssl_crypto_tests\": \"4d55d3433385cd277560b7b757b8856f144c9052\", \"boringssl_ssl_tests\": \"f4a74d0719257cd8a75f0fc3203113baa17c1708\", \"browser_switcher_bho_unittests\": \"2140e8c5d7e45c625b12f9c245eda90eb093d4e9\", \"browser_tests\": \"23b1f24f17184bd3b6e4d5d4f3590889870aa7a8\", \"capture_unittests\": \"105f58d162bfab4f745b4849ae622416438bfe10\", \"cast_unittests\": \"c3a235835a89a40c2c173816aab0ff845fa3bd34\", \"cc_unittests\": \"f485e36ae4bb60a7db2c49a5ebbd7a8c61892a4b\", \"chrome_app_unittests\": \"876c6422c05b4172f3d8b977bf926cfa4c22e9c0\", \"chrome_cleaner_unittests\": \"92cf8b0122e7b319c0eb41e5a782fedb88af5223\", \"chrome_elf_unittests\": \"c207f5c000193c03bfde5c84636d312607a6f18f\", \"chromedriver_unittests\": \"a5484a1a802e2a62def86d6e5f47c040086a26df\", \"components_browsertests\": \"00134cb00074f85079445d241c6df3a78c07297d\", \"components_unittests\": \"a027cdd6c19e8ad2eb609b101245bd6119304265\", \"compositor_unittests\": \"e5833570d32937a36076acb48603cde58182fbd4\", \"content_browsertests\": \"9be244f36f3b291301d50b541a66c3bba6f5a4d8\", \"content_unittests\": \"5face659a230ae1d5471ab1218cf2e9ad7d1d84b\", \"courgette_unittests\": \"5b36c05fbf6b6a0daaeb02ba86575ec3a7f6186e\", \"crashpad_tests\": \"274aaa96e55b178c72ba7f6ea60b2494a08f27b7\", \"cronet_tests\": \"3d72c0300c84e8036ae3b3c75f7151a2b94bd4f7\", \"cronet_unittests\": \"5a5cc0454f2cd62813f22fad29baa50e4c30f6bc\", \"crypto_unittests\": \"13e3b845582a26f4f7e63923560370dc444e7ff9\", \"delayloads_unittests\": \"1319b4c4c660c57ff2f0267cc07d3a1479ac46b8\", \"device_unittests\": \"22f1671462ae714ca1eea4dccc7448e3f56abda6\", \"display_unittests\": \"d2624e2e698c932aaacad6e7b86e0ee666b9a0d2\", \"elevation_service_unittests\": \"935aed7bf652d835a007d9163d2f687b5769c5ca\", \"events_unittests\": \"8d39e1c08d8d9c5f8fcf63b61464e17c6d009f21\", \"extensions_browsertests\": \"ea76d107323348db44d69b3295762619b4c21b4e\", \"extensions_unittests\": \"448ba017a001b6bc8a72ae6fbfef7bb22b66bed3\", \"filesystem_service_unittests\": \"519f37d0a276c7c759a96edb1d035087db6e484f\", \"gcm_unit_tests\": \"9ba89fc161466703b3dad2eb16d8109a74ec2603\", \"gcp_unittests\": \"dc4d18b67d11c51a56642b0f584407ea43d81aef\", \"gfx_unittests\": \"55b51df9af7717bc75c38c7bfc24e2af51e6c65a\", \"gin_unittests\": \"db00921617e1fd9e2ec4a2b8cca1d56f3c9cdb2b\", \"google_apis_unittests\": \"6c40703f8ecb3401b0becae81aa3b94d257946d6\", \"gpu_unittests\": \"bb9f3460bd6d1006ea5509519bcd6a634b506552\", \"gwp_asan_unittests\": \"0edb5e62ab3bf0fd55d1879597645b04f8f920c5\", \"headless_browsertests\": \"9ff8d9233ab49911543403897736a165cd72325f\", \"headless_unittests\": \"67a818608c9353ed0a7164f1eb792633800c7f6e\", \"install_static_unittests\": \"b34655fa879dd19a7c852488e9794b5945dff31c\", \"installer_util_unittests\": \"e02de4e542631e787f01f3c97cb9d2cd6e6403a0\", \"interactive_ui_tests\": \"ca442748d35bb0fae0a56ed1c9757c3db1055b66\", \"ipc_tests\": \"b60cd4e6dbfbc7ff6d3f338130a4696741c18712\", \"jingle_unittests\": \"46bc3dcb2a6c2d6e1a484b130408e82a2812272b\", \"latency_unittests\": \"94faecce237c0c379aaeccef36b09a1d19434f5b\", \"libjingle_xmpp_unittests\": \"28d9f75b640c56f0722f94da46fdeda8bac30f37\", \"liburlpattern_unittests\": \"6d7aa038f5e23f9350f241bfca4beaaea063e019\", \"media_blink_unittests\": \"80e034cbdd6561d002c98f3da004390e2a7cdcec\", \"media_unittests\": \"d8d45966c325c2f3fae646807e82ed3323e460ad\", \"message_center_unittests\": \"4676e06ca5ab11598f2c244b104ec0c7d41794bf\", \"midi_unittests\": \"92cb49e04ad7f2c8f57717ca582fe552b8040360\", \"mojo_core_unittests\": \"cc2d1f8753fe339755fda5bd8ca0c0aa3b658051\", \"mojo_unittests\": \"ea829425eef53a7f16783f897cb88f2e99c217d2\", \"nacl_loader_unittests\": \"be9de91f33b8e2cde2f7fe4469f9ed6b5314e84a\", \"native_theme_unittests\": \"3c92077c59581b98c2dcd4e622130e91a61200e2\", \"net_unittests\": \"e090bf6e981640cd7c47d3d4bf75fd4df0035a50\", \"notification_helper_unittests\": \"c8c3cf1629248de7ba31b959e5ad9e01ba8cc6a6\", \"pdf_unittests\": \"725d1b5114b3113c0c25d972f65417a839cb9d20\", \"perfetto_unittests\": \"d232aaa00814b97103f49b55419728a7ea8b169f\", \"ppapi_unittests\": \"33009a2b6baf269d6baa3c045c489adfc9be3327\", \"printing_unittests\": \"f8389c7c38a4c22710a603145ddcc65b6956b2bd\", \"remoting_unittests\": \"c75b021c8458dba2a88282f64d92e4570e4d5500\", \"sbox_integration_tests\": \"918c44c0dba0a7476ac0403e32c1ab20a0c3b4fa\", \"sbox_unittests\": \"3e90ce37a98cfc8214fa7bf36f691328e5fe1340\", \"sbox_validation_tests\": \"8e927bdb66d094882b16bd9dd2885175f1d53b0e\", \"service_manager_unittests\": \"8873e33e7f606fe5f5acdeb63312c214c0853480\", \"services_unittests\": \"1915c3a7d73f796b904a62cd06553c306e8a0ca3\", \"setup_unittests\": \"87f9af6f06a3d98bb66a4f7c15cdccbc53c18a20\", \"shell_dialogs_unittests\": \"21286863a59c0daf5d129c16be69325587d6e1bc\", \"skia_unittests\": \"cd4170b304af356fd7bc7050a281610073383fff\", \"snapshot_unittests\": \"d38a3d17cb534ee753f183bbcd75c885c6cd7dea\", \"sql_unittests\": \"47c132da9e8b679a7f214ffce49b52ec01323bda\", \"storage_unittests\": \"fabdf27751a393269aa287bd92067c77b79c00aa\", \"sync_integration_tests\": \"56431dd7916e4f4daff7a90af6f6082a234578ef\", \"traffic_annotation_auditor_unittests\": \"2f4a7eed60d8f9bc58273b19706aca6df832f51d\", \"ui_base_unittests\": \"c83049c04da0001c0020632421c0e338a6747b80\", \"ui_touch_selection_unittests\": \"0b09bce87c20fab73088126b22e38a53144d0d08\", \"unit_tests\": \"c2c198d533719088d3dbab9a61af4efab727f102\", \"updater_tests\": \"a0c7bbd1b7120f396d2e3b43d70eb12443fb0f4e\", \"url_unittests\": \"2cd8594fcc2595a70a3651cad0e65e288c3ad289\", \"views_unittests\": \"184392c17dfc00030ed9303841fc8a2335dadad6\", \"viz_unittests\": \"1f60df319261626480de69f254c910ee85db5d6c\", \"vr_common_unittests\": \"a06b5f8b04319b79eb31e8b68a47cf8f7c17c7dd\", \"vr_pixeltests\": \"90293e3799c4d40edfb811f8b3d5b87b0e82ca94\", \"weblayer_browsertests\": \"3eb6458a5d30fd158573fbf6e40680b08d81b011\", \"weblayer_unittests\": \"13f62bc788d0843988a3edd4d81e4394b73c3052\", \"wm_unittests\": \"c009890b12e75f68cbbf588928780a41136cb0b9\", \"wtf_unittests\": \"7de64d91d939d6aab7255d47ff0eea87a445457f\", \"zlib_unittests\": \"a210b2dc73ef9bd9735550fd6e75ca91eed09365\", \"zucchini_unittests\": \"b306dc77361d37da49650fb7266fa492967c7b40\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-3-nb2x\"], \"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\": [\"5661-c6f6250\"], \"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": "1610636309046363",
"status": "COMPLETED",
"status_changed_ts": "1610639330676374",
"tags": [
"build_address:luci.chromium.ci/win-asan/16818",
"builder:win-asan",
"buildset:commit/git/9b006e135017235cf74feaa113000b85be0dd619",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9b006e135017235cf74feaa113000b85be0dd619",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023549211473994672",
"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/8858119149247364048/+/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:511a392929bf4210",
"user_agent:luci-scheduler"
],
"updated_ts": "1610639330684939",
"url": "https://ci.chromium.org/b/8858119149247364048",
"utcnow_ts": "1610639332002535"
}
}
[15:48:52.020] Invocation finished in 50m35.623620485s with status SUCCEEDED