[03:07:32.500] New invocation is queued and will start shortly
[03:07:33.721] Starting the invocation (attempt 1)
[03:07:33.758] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:07:33.758] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:07:33.758] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023140942025711984",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"2a7b2aa02bfc301d4e7d6a6763499b2c26eea39c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9023140942025711984",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/2a7b2aa02bfc301d4e7d6a6763499b2c26eea39c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2a7b2aa02bfc301d4e7d6a6763499b2c26eea39c",
"gitiles_ref:refs/heads/master"
]
}
[03:07:35.431] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611025653892752",
"id": "8857710879902873264",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2a7b2aa02bfc301d4e7d6a6763499b2c26eea39c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611025655099301",
"tags": [
"build_address:luci.chromium.ci/win-asan/16883",
"builder:win-asan",
"buildset:commit/git/2a7b2aa02bfc301d4e7d6a6763499b2c26eea39c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2a7b2aa02bfc301d4e7d6a6763499b2c26eea39c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023140942025711984",
"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/8857710879902873264/+/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": "1611025655099410",
"url": "https://ci.chromium.org/b/8857710879902873264",
"utcnow_ts": "1611025655406676"
}
}
[03:07:35.431] Task URL: https://ci.chromium.org/b/8857710879902873264
[03:07:35.431] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:2:0) after 1m0s
[03:07:39.966] Received PubSub notification, asking Buildbucket for the build status
[03:07:40.032] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:35.539] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:2:0)
[03:08:35.539] Timer tick, asking Buildbucket for the build status
[03:08:35.870] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:35.870] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:4:0) after 1m0s
[03:09:35.955] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:4:0)
[03:09:35.955] Timer tick, asking Buildbucket for the build status
[03:09:36.063] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:36.063] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:5:0) after 1m0s
[03:10:37.581] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:5:0)
[03:10:37.581] Timer tick, asking Buildbucket for the build status
[03:10:37.712] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:37.712] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:6:0) after 1m0s
[03:11:37.684] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:6:0)
[03:11:37.684] Timer tick, asking Buildbucket for the build status
[03:11:37.790] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:37.790] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:7:0) after 1m0s
[03:12:37.810] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:7:0)
[03:12:37.810] Timer tick, asking Buildbucket for the build status
[03:12:37.912] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:37.912] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:8:0) after 1m0s
[03:13:37.966] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:8:0)
[03:13:37.966] Timer tick, asking Buildbucket for the build status
[03:13:38.269] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:38.269] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:9:0) after 1m0s
[03:14:38.320] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:9:0)
[03:14:38.320] Timer tick, asking Buildbucket for the build status
[03:14:38.384] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:38.384] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:10:0) after 1m0s
[03:15:38.462] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:10:0)
[03:15:38.462] Timer tick, asking Buildbucket for the build status
[03:15:38.572] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:38.572] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:11:0) after 1m0s
[03:16:38.591] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:11:0)
[03:16:38.591] Timer tick, asking Buildbucket for the build status
[03:16:38.668] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:38.668] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:12:0) after 1m0s
[03:17:38.709] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:12:0)
[03:17:38.709] Timer tick, asking Buildbucket for the build status
[03:17:39.031] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:39.031] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:13:0) after 1m0s
[03:18:39.096] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:13:0)
[03:18:39.096] Timer tick, asking Buildbucket for the build status
[03:18:39.201] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:39.201] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:14:0) after 1m0s
[03:19:39.207] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:14:0)
[03:19:39.207] Timer tick, asking Buildbucket for the build status
[03:19:39.577] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:39.577] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:15:0) after 1m0s
[03:20:39.600] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:15:0)
[03:20:39.600] Timer tick, asking Buildbucket for the build status
[03:20:39.655] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:39.655] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:16:0) after 1m0s
[03:21:39.721] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:16:0)
[03:21:39.721] Timer tick, asking Buildbucket for the build status
[03:21:39.782] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:39.782] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:17:0) after 1m0s
[03:22:39.802] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:17:0)
[03:22:39.802] Timer tick, asking Buildbucket for the build status
[03:22:40.105] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:40.105] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:18:0) after 1m0s
[03:23:40.123] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:18:0)
[03:23:40.123] Timer tick, asking Buildbucket for the build status
[03:23:40.493] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:40.493] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:19:0) after 1m0s
[03:24:40.495] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:19:0)
[03:24:40.495] Timer tick, asking Buildbucket for the build status
[03:24:41.300] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:41.300] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:20:0) after 1m0s
[03:25:41.442] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:20:0)
[03:25:41.442] Timer tick, asking Buildbucket for the build status
[03:25:41.576] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:41.576] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:21:0) after 1m0s
[03:27:12.226] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:21:0)
[03:27:12.226] Timer tick, asking Buildbucket for the build status
[03:27:12.527] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:12.527] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:22:0) after 1m0s
[03:28:12.717] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:22:0)
[03:28:12.717] Timer tick, asking Buildbucket for the build status
[03:28:12.796] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:12.796] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:23:0) after 1m0s
[03:29:16.656] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:23:0)
[03:29:16.656] Timer tick, asking Buildbucket for the build status
[03:29:16.830] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:16.830] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:24:0) after 1m0s
[03:30:16.960] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:24:0)
[03:30:16.960] Timer tick, asking Buildbucket for the build status
[03:30:17.265] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:17.265] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:25:0) after 1m0s
[03:31:18.010] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:25:0)
[03:31:18.010] Timer tick, asking Buildbucket for the build status
[03:31:18.186] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:18.187] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:26:0) after 1m0s
[03:32:18.211] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:26:0)
[03:32:18.211] Timer tick, asking Buildbucket for the build status
[03:32:18.313] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:18.313] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:27:0) after 1m0s
[03:33:18.428] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:27:0)
[03:33:18.428] Timer tick, asking Buildbucket for the build status
[03:33:18.615] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:18.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:28:0) after 1m0s
[03:34:18.646] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:28:0)
[03:34:18.646] Timer tick, asking Buildbucket for the build status
[03:34:18.767] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:18.767] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:29:0) after 1m0s
[03:35:25.872] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:29:0)
[03:35:25.872] Timer tick, asking Buildbucket for the build status
[03:35:25.948] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:25.948] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:30:0) after 1m0s
[03:36:25.997] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:30:0)
[03:36:25.997] Timer tick, asking Buildbucket for the build status
[03:36:26.066] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:26.066] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:31:0) after 1m0s
[03:37:26.286] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:31:0)
[03:37:26.286] Timer tick, asking Buildbucket for the build status
[03:37:26.360] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:26.360] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:32:0) after 1m0s
[03:38:26.678] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:32:0)
[03:38:26.678] Timer tick, asking Buildbucket for the build status
[03:38:26.835] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:26.835] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:33:0) after 1m0s
[03:39:26.872] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:33:0)
[03:39:26.872] Timer tick, asking Buildbucket for the build status
[03:39:26.965] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:26.965] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:34:0) after 1m0s
[03:40:27.764] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:34:0)
[03:40:27.764] Timer tick, asking Buildbucket for the build status
[03:40:27.907] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:27.907] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:35:0) after 1m0s
[03:41:28.323] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:35:0)
[03:41:28.323] Timer tick, asking Buildbucket for the build status
[03:41:28.428] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:28.428] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:36:0) after 1m0s
[03:42:28.668] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:36:0)
[03:42:28.668] Timer tick, asking Buildbucket for the build status
[03:42:28.733] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:28.733] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:37:0) after 1m0s
[03:43:28.855] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:37:0)
[03:43:28.855] Timer tick, asking Buildbucket for the build status
[03:43:29.599] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:29.599] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:38:0) after 1m0s
[03:44:29.611] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:38:0)
[03:44:29.611] Timer tick, asking Buildbucket for the build status
[03:44:29.813] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:29.813] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:39:0) after 1m0s
[03:45:29.863] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:39:0)
[03:45:29.863] Timer tick, asking Buildbucket for the build status
[03:45:29.941] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:29.941] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:40:0) after 1m0s
[03:46:30.030] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:40:0)
[03:46:30.030] Timer tick, asking Buildbucket for the build status
[03:46:30.129] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:30.129] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:41:0) after 1m0s
[03:47:30.204] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:41:0)
[03:47:30.204] Timer tick, asking Buildbucket for the build status
[03:47:30.337] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:30.337] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:42:0) after 1m0s
[03:48:30.343] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:42:0)
[03:48:30.343] Timer tick, asking Buildbucket for the build status
[03:48:30.443] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:30.443] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:43:0) after 1m0s
[03:49:30.477] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:43:0)
[03:49:30.477] Timer tick, asking Buildbucket for the build status
[03:49:30.551] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:30.551] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:44:0) after 1m0s
[03:50:30.593] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:44:0)
[03:50:30.593] Timer tick, asking Buildbucket for the build status
[03:50:30.694] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:30.694] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:45:0) after 1m0s
[03:51:30.714] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:45:0)
[03:51:30.714] Timer tick, asking Buildbucket for the build status
[03:51:31.120] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:31.120] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:46:0) after 1m0s
[03:52:31.139] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:46:0)
[03:52:31.139] Timer tick, asking Buildbucket for the build status
[03:52:31.249] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:31.249] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:47:0) after 1m0s
[03:53:31.273] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:47:0)
[03:53:31.273] Timer tick, asking Buildbucket for the build status
[03:53:31.447] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:31.447] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:48:0) after 1m0s
[03:54:31.471] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:48:0)
[03:54:31.471] Timer tick, asking Buildbucket for the build status
[03:54:31.547] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:31.547] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:49:0) after 1m0s
[03:55:31.569] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:49:0)
[03:55:31.569] Timer tick, asking Buildbucket for the build status
[03:55:31.986] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:31.986] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:50:0) after 1m0s
[03:56:32.471] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:50:0)
[03:56:32.471] Timer tick, asking Buildbucket for the build status
[03:56:32.581] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:32.581] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:51:0) after 1m0s
[03:57:32.722] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:51:0)
[03:57:32.722] Timer tick, asking Buildbucket for the build status
[03:57:34.102] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:34.102] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:52:0) after 1m0s
[03:58:34.163] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:52:0)
[03:58:34.163] Timer tick, asking Buildbucket for the build status
[03:58:34.368] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:34.368] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:53:0) after 1m0s
[03:59:34.435] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:53:0)
[03:59:34.435] Timer tick, asking Buildbucket for the build status
[03:59:34.687] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:34.687] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:54:0) after 1m0s
[04:00:34.812] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:54:0)
[04:00:34.812] Timer tick, asking Buildbucket for the build status
[04:00:34.911] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:34.911] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:55:0) after 1m0s
[04:01:34.913] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:55:0)
[04:01:34.913] Timer tick, asking Buildbucket for the build status
[04:01:35.003] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:35.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:56:0) after 1m0s
[04:02:35.141] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:56:0)
[04:02:35.141] Timer tick, asking Buildbucket for the build status
[04:02:35.243] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:35.243] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:57:0) after 1m0s
[04:03:37.344] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:57:0)
[04:03:37.344] Timer tick, asking Buildbucket for the build status
[04:03:38.287] Build 8857710879902873264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:38.287] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023140942025711984:58:0) after 1m0s
[04:04:13.074] Received PubSub notification, asking Buildbucket for the build status
[04:04:13.141] Build 8857710879902873264: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:04:13.142] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611029052004593",
"created_by": "project:chromium",
"created_ts": "1611025653892752",
"id": "8857710879902873264",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2a7b2aa02bfc301d4e7d6a6763499b2c26eea39c\"}}",
"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\": \"2a7b2aa02bfc301d4e7d6a6763499b2c26eea39c\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-win10-32-0-nszv\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16883, \"clang_revision\": \"llvmorg-12-init-16296-g5e476061-2\", \"got_angle_revision\": \"5635dbb91641a72f1f713aa7c179e2432674f9c3\", \"got_dawn_revision\": \"4b316994ad01ab6b87032c5fd9b53c6d18956d8d\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"2a7b2aa02bfc301d4e7d6a6763499b2c26eea39c\", \"got_revision_cp\": \"refs/heads/master@{#844654}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"8da0f82baf359e2b91464f111306a094f86fe71b\", \"got_v8_revision\": \"ee927aaa58e688ad6aa0256b3929c1eeea0bebd5\", \"got_v8_revision_cp\": \"refs/heads/9.0.8@{#1}\", \"got_webrtc_revision\": \"29bd8638adb0a7294f7b8ae589fdd24077539dbb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33030}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.win:win-asan\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2a7b2aa02bfc301d4e7d6a6763499b2c26eea39c\", \"swarm_hashes_refs/heads/master(at){#844654}_without_patch\": {\"absl_hardening_tests\": \"ebfef63da7acc9e3e703c5bddec9f85f6be79f09\", \"accessibility_unittests\": \"dac50e0cfd6767b7cc7ba8d42b3d75a109ada52f\", \"angle_unittests\": \"369849bffdf16ccadb3a52c20a11d84e876f5347\", \"app_shell_unittests\": \"93a09aebda867dede051f2974a53abac60e69fad\", \"aura_unittests\": \"f6566cde1f412f01d10e07e24d50b6aebdc7b937\", \"base_unittests\": \"e24ade3910a609d5e8deec23b098616e4ac8ed9e\", \"base_util_unittests\": \"a462d329a543e6a92d7fcf6dceaf1faf34cd2bfe\", \"blink_common_unittests\": \"ee99a6a64d4ed9e9c5ee960fa4a1898a128ebff1\", \"blink_fuzzer_unittests\": \"d362882041931d590a00ce82ead71acc967116b3\", \"blink_heap_unittests\": \"d0fdf5d1241e1f862882eb452f9a8cf5c480dd07\", \"blink_platform_unittests\": \"e90008593cd543da142a76418af4d847046889ea\", \"blink_unittests\": \"0f6bf398d43ed27710f218d829462a1da5d3fef0\", \"boringssl_crypto_tests\": \"d2a447f10f5e3f52a244c454d67043fe89c342dc\", \"boringssl_ssl_tests\": \"cfe3379698f021f6eaf1b17818fb78585246ab8a\", \"browser_switcher_bho_unittests\": \"90d791d55a314ff4959a27d49625a9b3ab38ec63\", \"browser_tests\": \"22cb976ce74051517825ee0a5f7b384e7fb7f91f\", \"capture_unittests\": \"e2b2534aa5fabea3ad9873048364b86f7c56ceff\", \"cast_unittests\": \"3cdc88c3f5f59112f330a5ccc43e639f2b5a7f6e\", \"cc_unittests\": \"0471f322598a3fad2115176564d0ff35bdf81863\", \"chrome_app_unittests\": \"fc4d4b3001aac5bb47ab51f849f385a051c45dbe\", \"chrome_cleaner_unittests\": \"4f38a88082e16d62cf34b6d86562fc25e134a259\", \"chrome_elf_unittests\": \"23869ab6e86a811db0d710c6a983f0621ad3fa49\", \"chromedriver_unittests\": \"bfbfbcff16bfdf002a636d0e9f276e4f2de9ec14\", \"components_browsertests\": \"aa22b3fce94a44821abea25ef35825fef7985d21\", \"components_unittests\": \"e07696e33bad1a6685a40eea974a7ee428b11cbc\", \"compositor_unittests\": \"994cc85b1a894715f427cfeaa9b29dc8af587272\", \"content_browsertests\": \"a484d8d3790ea9937d85376a739d20858b39f873\", \"content_unittests\": \"d4d23fabe9c406dca0aa3e46a2aa0da9d3a0fc0e\", \"courgette_unittests\": \"5e4d6453fb3b338f3b2d99f6d013538578f95ed2\", \"crashpad_tests\": \"1d9fe6da264ef4f997ecc5f0ef85426ec3bdc073\", \"cronet_tests\": \"0c4c3135158167479c862ebdf8ff85e09fef0758\", \"cronet_unittests\": \"dc9b2e9305a79da62e098bdd935ab1fa20fff6e9\", \"crypto_unittests\": \"7f8137edf4dce3625cd62557beb93484eb10a521\", \"delayloads_unittests\": \"ea93db6d1dd33148d43fbdbde21822676032ca70\", \"device_unittests\": \"053011281bd0fc4d03f4be6b08b2001564a163b3\", \"display_unittests\": \"280fb6d1f1c4303a80c20b9404ab363b6168c484\", \"elevation_service_unittests\": \"04075de6db6a803fb58d578743bdf47ddd5bd84f\", \"events_unittests\": \"14177b8c7cc2e08c5cbc114a39bc12deae5dd976\", \"extensions_browsertests\": \"0f59ca56200f8865041825f872f3833b1e1b0c9f\", \"extensions_unittests\": \"c03fee7dee011fc16802892726b32325389edba4\", \"filesystem_service_unittests\": \"3b51f16e846fdf7bb3d79fe5bac397d4fd8a1829\", \"gcm_unit_tests\": \"bc7348bc9c144e420a561099aaf4f70a2133eee7\", \"gcp_unittests\": \"9f6e5f7dbe3320fb108c33d8b84f00484a31f74d\", \"gfx_unittests\": \"b51a6c1f747d4c8d08c06ad8817b50ae10c65844\", \"gin_unittests\": \"e2a1942615849e70001f4c3b990e587cbef67656\", \"google_apis_unittests\": \"0b6681fbf4d8366e796bb711873bca8c0de923ce\", \"gpu_unittests\": \"9858dbba584d5b332d0ab16b54b73faeea057e91\", \"gwp_asan_unittests\": \"4e0065d1d3388c9198d76ec7432a1768514d776e\", \"headless_browsertests\": \"047306b1ae93ebed5e4401f40d44dd41e154d04f\", \"headless_unittests\": \"1727ebf9314606d3cf10e8737ae1afe46ec5f9bf\", \"install_static_unittests\": \"ff0137418b080e4d92b48f2e9b8818e39154a3a8\", \"installer_util_unittests\": \"9e9f3448a34ab4b958390f9e100f84e8c191b925\", \"interactive_ui_tests\": \"7883fa0b821827a650c0fd2e7501aaa4cb505b2a\", \"ipc_tests\": \"814107703a9a3220107a9e0f048cacb833fe9b95\", \"jingle_unittests\": \"d7b41f1adf067d4d59869ddd20093bb95042bf57\", \"latency_unittests\": \"cfc56b4b0ab6ae35bedaa75a1a168db2cd054ed2\", \"libjingle_xmpp_unittests\": \"b7db71bfa5bd4c75fcc7df17ed97cba3a89ced9a\", \"liburlpattern_unittests\": \"699759f09985b2d557af1ee7ce85bd2a0cdffc00\", \"media_blink_unittests\": \"bcee1a2ee91cf1320145f8bac9fdda807097bc32\", \"media_unittests\": \"bec7c01dd7b15f1a1dab1b8b51b8b9955035be33\", \"message_center_unittests\": \"3c456335be56849ca5740972b97942d61d77308b\", \"midi_unittests\": \"430c4ec8f81023a414437b24dc5214e97aa86fa1\", \"mojo_core_unittests\": \"bd9b9ba70b7260cfca8b696c77e7bae32a232342\", \"mojo_unittests\": \"8a651bc935b442ff4eeb00020dcceb2422c9ea2a\", \"nacl_loader_unittests\": \"68a53aa07740d7729da4ae679dd909f0dc4f94a1\", \"native_theme_unittests\": \"c32b31c52e8e4617816a0c9916c162249b8aa344\", \"net_unittests\": \"ca15341b27ea899c98c131b77b51e23e3d6579e3\", \"notification_helper_unittests\": \"7822342d998375602e096d18f1f7bfc6eb9e6d84\", \"pdf_unittests\": \"352de97624b940983d54ffe28862b3ce90e686e0\", \"perfetto_unittests\": \"f08c96f4694893eae621b80abc55a4c6e7d3f1c0\", \"ppapi_unittests\": \"211f9f6b61f1e122ab1d0f5401d2646a90d7a7f7\", \"printing_unittests\": \"35ed46cd33b8a2193076473b13acf3f9b6873ddf\", \"remoting_unittests\": \"c1daa8b00c215838080e88d72bf8a4a22fc99921\", \"sbox_integration_tests\": \"bed360da394bf45b51aa9969a56f669331c62289\", \"sbox_unittests\": \"7fc8a80df0be42ada78ce8e2d8b32a15d9e45c12\", \"sbox_validation_tests\": \"521932972d2fe2c42b1662f22dfb588080b1ebd5\", \"service_manager_unittests\": \"2c044de81e14f2ad37b8599b9ab3aa79568389f1\", \"services_unittests\": \"d86e83aff7a79d3b91fec355bb3d2b09ddb26148\", \"setup_unittests\": \"87fc9ff0d8bb2453b4ac1ca1e6177001f1512817\", \"shell_dialogs_unittests\": \"4643c89a61fbbeb33b5e45cd555bf401f7c4e7fd\", \"skia_unittests\": \"bd7ab2e24a4addec2b341c421cae17d371582687\", \"snapshot_unittests\": \"6c8bb18d982d9896d4e8ca830f8fa69e3ba75ad0\", \"sql_unittests\": \"39322d3848faac96bfdaac4035eefe88a09a0b46\", \"storage_unittests\": \"846e9dd9a8417def39b64a802959b81f2e192ff9\", \"sync_integration_tests\": \"0b1ebf004bd87c36058976189652a9fd027f5a1d\", \"traffic_annotation_auditor_unittests\": \"5d2aaa04d0e53de6849a09277c5d80b83b42385c\", \"ui_base_unittests\": \"e74d15995ee7d8fc6e2488ccdacc980bb9b6ae22\", \"ui_touch_selection_unittests\": \"12cc7188d8c0eb1464bfd20dd1d4001c79d2a7a7\", \"unit_tests\": \"aecde2f8d58787641bb19038d6b506271fb6d054\", \"updater_tests\": \"b4d25317f7d70c1c2aa2a7c4b1eb376c62be70c2\", \"url_unittests\": \"b446ebeca53f6819bb42b34e3ee4623f4d33f960\", \"views_unittests\": \"f4b75779ad96da716dce0fe1151552e25b0e33af\", \"viz_unittests\": \"57b610965c1d0028d4cace1455599752b34fc8ed\", \"vr_common_unittests\": \"784408dd26f559255aab3e471e20cfe6d2e235fa\", \"vr_pixeltests\": \"78e9c03693a1c49dcd7c894bceadbb0bcf7ed260\", \"weblayer_browsertests\": \"a3135e05870874c7544aa012c223186e710856a3\", \"weblayer_unittests\": \"dfe6cc18362fc6ab45284456411e08fd9e3ba137\", \"wm_unittests\": \"10cee174bf4b62cae36ec5f32b8676d145983268\", \"wtf_unittests\": \"ccb935d11eb65b2bd6727f1981c77802316b4f68\", \"zlib_unittests\": \"238e463f152dedf6a97cc8a7e9c9c09113900edc\", \"zucchini_unittests\": \"0a14845efc482728a6d8820cac93ff13408402e8\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-0-nszv\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5666-679c9bd\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611025658045592",
"status": "COMPLETED",
"status_changed_ts": "1611029052404430",
"tags": [
"build_address:luci.chromium.ci/win-asan/16883",
"builder:win-asan",
"buildset:commit/git/2a7b2aa02bfc301d4e7d6a6763499b2c26eea39c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2a7b2aa02bfc301d4e7d6a6763499b2c26eea39c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023140942025711984",
"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/8857710879902873264/+/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:51316e2e8e227b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1611029052410641",
"url": "https://ci.chromium.org/b/8857710879902873264",
"utcnow_ts": "1611029053133362"
}
}
[04:04:13.142] Invocation finished in 56m40.657407744s with status SUCCEEDED