[13:08:28.261] New invocation is queued and will start shortly
[13:08:29.416] Starting the invocation (attempt 1)
[13:08:29.462] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:08:29.462] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:08:29.462] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028720146740831232",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"69cb7c65ad845cdab1cd5f4256237e72fceba2dd\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9028720146740831232",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/69cb7c65ad845cdab1cd5f4256237e72fceba2dd",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/69cb7c65ad845cdab1cd5f4256237e72fceba2dd",
"gitiles_ref:refs/heads/master"
]
}
[13:08:30.358] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605704909576174",
"id": "8863290084694342976",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"69cb7c65ad845cdab1cd5f4256237e72fceba2dd\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605704910059314",
"tags": [
"build_address:luci.chromium.ci/win-asan/15705",
"builder:win-asan",
"buildset:commit/git/69cb7c65ad845cdab1cd5f4256237e72fceba2dd",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/69cb7c65ad845cdab1cd5f4256237e72fceba2dd",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028720146740831232",
"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/8863290084694342976/+/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": "1605704910059690",
"url": "https://ci.chromium.org/b/8863290084694342976",
"utcnow_ts": "1605704910336830"
}
}
[13:08:30.358] Task URL: https://ci.chromium.org/b/8863290084694342976
[13:08:30.358] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:2:0) after 1m0s
[13:08:32.615] Received PubSub notification, asking Buildbucket for the build status
[13:08:32.677] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:30.424] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:2:0)
[13:09:30.424] Timer tick, asking Buildbucket for the build status
[13:09:30.530] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:30.530] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:4:0) after 1m0s
[13:10:30.565] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:4:0)
[13:10:30.565] Timer tick, asking Buildbucket for the build status
[13:10:30.720] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:30.720] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:5:0) after 1m0s
[13:11:30.754] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:5:0)
[13:11:30.754] Timer tick, asking Buildbucket for the build status
[13:11:30.864] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:30.864] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:6:0) after 1m0s
[13:12:30.930] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:6:0)
[13:12:30.930] Timer tick, asking Buildbucket for the build status
[13:12:31.113] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:31.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:7:0) after 1m0s
[13:13:31.236] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:7:0)
[13:13:31.236] Timer tick, asking Buildbucket for the build status
[13:13:31.358] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:31.358] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:8:0) after 1m0s
[13:14:31.436] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:8:0)
[13:14:31.436] Timer tick, asking Buildbucket for the build status
[13:14:31.876] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:31.876] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:9:0) after 1m0s
[13:15:32.035] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:9:0)
[13:15:32.035] Timer tick, asking Buildbucket for the build status
[13:15:32.110] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:32.110] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:10:0) after 1m0s
[13:16:32.201] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:10:0)
[13:16:32.201] Timer tick, asking Buildbucket for the build status
[13:16:32.380] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:32.380] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:11:0) after 1m0s
[13:17:32.481] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:11:0)
[13:17:32.481] Timer tick, asking Buildbucket for the build status
[13:17:32.559] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:32.559] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:12:0) after 1m0s
[13:18:32.600] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:12:0)
[13:18:32.600] Timer tick, asking Buildbucket for the build status
[13:18:32.824] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:32.824] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:13:0) after 1m0s
[13:19:32.924] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:13:0)
[13:19:32.924] Timer tick, asking Buildbucket for the build status
[13:19:33.060] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:33.060] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:14:0) after 1m0s
[13:20:33.175] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:14:0)
[13:20:33.175] Timer tick, asking Buildbucket for the build status
[13:20:33.291] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:33.291] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:15:0) after 1m0s
[13:21:33.280] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:15:0)
[13:21:33.280] Timer tick, asking Buildbucket for the build status
[13:21:33.401] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:33.401] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:16:0) after 1m0s
[13:22:33.672] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:16:0)
[13:22:33.672] Timer tick, asking Buildbucket for the build status
[13:22:33.902] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:33.902] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:17:0) after 1m0s
[13:23:34.108] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:17:0)
[13:23:34.108] Timer tick, asking Buildbucket for the build status
[13:23:34.539] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:34.539] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:18:0) after 1m0s
[13:24:34.729] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:18:0)
[13:24:34.729] Timer tick, asking Buildbucket for the build status
[13:24:34.829] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:34.829] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:19:0) after 1m0s
[13:25:34.936] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:19:0)
[13:25:34.936] Timer tick, asking Buildbucket for the build status
[13:25:35.054] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:35.054] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:20:0) after 1m0s
[13:26:35.126] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:20:0)
[13:26:35.126] Timer tick, asking Buildbucket for the build status
[13:26:35.271] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:35.271] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:21:0) after 1m0s
[13:27:35.376] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:21:0)
[13:27:35.376] Timer tick, asking Buildbucket for the build status
[13:27:35.824] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:35.824] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:22:0) after 1m0s
[13:28:35.949] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:22:0)
[13:28:35.949] Timer tick, asking Buildbucket for the build status
[13:28:37.419] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:37.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:23:0) after 1m0s
[13:29:37.553] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:23:0)
[13:29:37.553] Timer tick, asking Buildbucket for the build status
[13:29:37.964] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:37.964] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:24:0) after 1m0s
[13:30:37.986] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:24:0)
[13:30:37.986] Timer tick, asking Buildbucket for the build status
[13:30:38.168] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:38.168] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:25:0) after 1m0s
[13:31:38.205] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:25:0)
[13:31:38.206] Timer tick, asking Buildbucket for the build status
[13:31:38.381] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:38.381] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:26:0) after 1m0s
[13:32:38.400] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:26:0)
[13:32:38.400] Timer tick, asking Buildbucket for the build status
[13:32:38.516] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:38.516] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:27:0) after 1m0s
[13:33:38.594] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:27:0)
[13:33:38.594] Timer tick, asking Buildbucket for the build status
[13:33:38.701] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:38.702] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:28:0) after 1m0s
[13:34:38.780] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:28:0)
[13:34:38.780] Timer tick, asking Buildbucket for the build status
[13:34:39.058] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:39.058] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:29:0) after 1m0s
[13:35:39.072] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:29:0)
[13:35:39.072] Timer tick, asking Buildbucket for the build status
[13:35:39.705] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:39.705] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:30:0) after 1m0s
[13:36:39.731] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:30:0)
[13:36:39.731] Timer tick, asking Buildbucket for the build status
[13:36:39.843] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:39.843] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:31:0) after 1m0s
[13:37:39.869] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:31:0)
[13:37:39.869] Timer tick, asking Buildbucket for the build status
[13:37:40.044] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:40.044] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:32:0) after 1m0s
[13:38:40.141] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:32:0)
[13:38:40.141] Timer tick, asking Buildbucket for the build status
[13:38:40.422] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:40.422] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:33:0) after 1m0s
[13:39:40.481] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:33:0)
[13:39:40.481] Timer tick, asking Buildbucket for the build status
[13:39:41.320] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:41.320] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:34:0) after 1m0s
[13:40:41.409] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:34:0)
[13:40:41.409] Timer tick, asking Buildbucket for the build status
[13:40:41.491] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:41.491] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:35:0) after 1m0s
[13:41:41.517] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:35:0)
[13:41:41.517] Timer tick, asking Buildbucket for the build status
[13:41:41.646] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:41.646] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:36:0) after 1m0s
[13:42:41.691] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:36:0)
[13:42:41.691] Timer tick, asking Buildbucket for the build status
[13:42:42.163] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:42.163] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:37:0) after 1m0s
[13:43:42.227] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:37:0)
[13:43:42.227] Timer tick, asking Buildbucket for the build status
[13:43:42.619] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:42.619] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:38:0) after 1m0s
[13:44:42.692] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:38:0)
[13:44:42.692] Timer tick, asking Buildbucket for the build status
[13:44:43.180] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:43.180] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:39:0) after 1m0s
[13:45:43.204] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:39:0)
[13:45:43.204] Timer tick, asking Buildbucket for the build status
[13:45:43.505] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:43.505] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:40:0) after 1m0s
[13:46:43.596] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:40:0)
[13:46:43.596] Timer tick, asking Buildbucket for the build status
[13:46:43.746] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:43.746] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:41:0) after 1m0s
[13:47:43.856] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:41:0)
[13:47:43.856] Timer tick, asking Buildbucket for the build status
[13:47:43.943] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:43.943] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:42:0) after 1m0s
[13:48:44.045] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:42:0)
[13:48:44.045] Timer tick, asking Buildbucket for the build status
[13:48:44.144] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:44.144] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:43:0) after 1m0s
[13:49:44.186] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:43:0)
[13:49:44.186] Timer tick, asking Buildbucket for the build status
[13:49:44.462] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:44.462] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:44:0) after 1m0s
[13:50:44.535] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:44:0)
[13:50:44.535] Timer tick, asking Buildbucket for the build status
[13:50:44.613] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:44.613] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:45:0) after 1m0s
[13:51:44.757] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:45:0)
[13:51:44.757] Timer tick, asking Buildbucket for the build status
[13:51:44.982] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:44.982] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:46:0) after 1m0s
[13:52:45.215] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:46:0)
[13:52:45.215] Timer tick, asking Buildbucket for the build status
[13:52:45.366] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:45.366] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:47:0) after 1m0s
[13:53:45.550] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:47:0)
[13:53:45.550] Timer tick, asking Buildbucket for the build status
[13:53:45.688] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:45.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:48:0) after 1m0s
[13:54:45.731] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:48:0)
[13:54:45.731] Timer tick, asking Buildbucket for the build status
[13:54:45.869] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:45.869] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:49:0) after 1m0s
[13:55:45.926] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:49:0)
[13:55:45.926] Timer tick, asking Buildbucket for the build status
[13:55:46.155] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:46.155] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:50:0) after 1m0s
[13:56:46.296] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:50:0)
[13:56:46.296] Timer tick, asking Buildbucket for the build status
[13:56:46.372] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:46.372] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:51:0) after 1m0s
[13:57:46.487] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:51:0)
[13:57:46.487] Timer tick, asking Buildbucket for the build status
[13:57:47.006] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:47.006] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:52:0) after 1m0s
[13:58:47.146] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:52:0)
[13:58:47.146] Timer tick, asking Buildbucket for the build status
[13:58:47.270] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:47.270] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:53:0) after 1m0s
[13:59:47.392] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:53:0)
[13:59:47.392] Timer tick, asking Buildbucket for the build status
[13:59:47.680] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:47.680] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:54:0) after 1m0s
[14:00:47.771] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:54:0)
[14:00:47.771] Timer tick, asking Buildbucket for the build status
[14:00:47.902] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:47.902] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:55:0) after 1m0s
[14:01:48.001] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:55:0)
[14:01:48.001] Timer tick, asking Buildbucket for the build status
[14:01:50.166] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:50.166] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:56:0) after 1m0s
[14:02:50.284] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:56:0)
[14:02:50.284] Timer tick, asking Buildbucket for the build status
[14:02:50.630] Build 8863290084694342976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:50.630] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028720146740831232:57:0) after 1m0s
[14:03:48.826] Received PubSub notification, asking Buildbucket for the build status
[14:03:49.503] Build 8863290084694342976: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:03:49.503] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605708225469297",
"created_by": "project:chromium",
"created_ts": "1605704909576174",
"id": "8863290084694342976",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"69cb7c65ad845cdab1cd5f4256237e72fceba2dd\"}}",
"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\": \"69cb7c65ad845cdab1cd5f4256237e72fceba2dd\", \"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-8-6zek\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15705, \"clang_revision\": \"llvmorg-12-init-11780-g6ef07111-1\", \"got_angle_revision\": \"d1219d7bc85c22e75fa8b1148a38ddab60601b04\", \"got_dawn_revision\": \"55f251dffe05a471f5979a315fa6fee54804e3b8\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"69cb7c65ad845cdab1cd5f4256237e72fceba2dd\", \"got_revision_cp\": \"refs/heads/master@{#828686}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"50066a3edffa96879ad1545a8e61c009c86c6e71\", \"got_v8_revision\": \"3644d1fc3b7f59e11f5e80b6feb79634736e0192\", \"got_v8_revision_cp\": \"refs/heads/8.9.7@{#1}\", \"got_webrtc_revision\": \"afaca889d46b2c493de34a8f0771c89dea17bb1a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32614}\", \"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\": \"69cb7c65ad845cdab1cd5f4256237e72fceba2dd\", \"swarm_hashes_refs/heads/master(at){#828686}_without_patch\": {\"absl_hardening_tests\": \"705ee181d0db53373ce123ba84e74ae1a33daf77\", \"accessibility_unittests\": \"9a096c5d7b9d1063f959ad596a66db9b4544e005\", \"angle_unittests\": \"1f2a645b9a54093bb36abec5122200f1b1d5ced8\", \"app_shell_unittests\": \"c263d090e0ae2aa79e538ce06596f48f8d5514f4\", \"aura_unittests\": \"90eaa8605df1ae919f891514409ea126d6f911eb\", \"base_unittests\": \"6995c3e58c6a5d67f1e7df2684646d6d186054e8\", \"base_util_unittests\": \"85c6ad9b4409a15f83f8e2aa7421fa8f8f44b816\", \"blink_common_unittests\": \"fb502b17313d86732d47416c1e8ca148a1047fd8\", \"blink_fuzzer_unittests\": \"29c29794d994a103a6d9795b677871747bab51e7\", \"blink_heap_unittests\": \"be6c504b74a06ca1e20313707c0f9e2daa163eb1\", \"blink_platform_unittests\": \"127c8495a0428e0ff041d260e19bb3b63f427947\", \"blink_unittests\": \"77503baa99a207a2b3a5e4de8eeca867e9f681d3\", \"boringssl_crypto_tests\": \"0e80802ff7328684788567ef229b3cdb0de33499\", \"boringssl_ssl_tests\": \"99992ae1274a0fcd2a8c283efef2fd4736508cfc\", \"browser_switcher_bho_unittests\": \"54b8f115fc9f09e358602da0199de88847a62277\", \"browser_tests\": \"89a32805848d4287c4a436d055f437e8f902c6be\", \"capture_unittests\": \"f9b570fb170064a7fe20ec5dae1743638f2de0f9\", \"cast_unittests\": \"f30524497a4bbfd4b2618c2d6e9f46cd40449928\", \"cc_unittests\": \"2ab0c573db31f84b27d16c8eb3aba731af9fc72f\", \"chrome_app_unittests\": \"a24ddefa229d2c90c12e9b6de9cb63725c954ec8\", \"chrome_cleaner_unittests\": \"67c82e8df731d0014c1bdb8ba5d2e94af19274fe\", \"chrome_elf_unittests\": \"4a429cb915dab9968aa83f337f541fbdc2746c96\", \"chromedriver_unittests\": \"11e38f2ff54adcd12192c2584954646c5ec74382\", \"components_browsertests\": \"f905e351063ad3cca84c804dee950b00760c65eb\", \"components_unittests\": \"c75c904e119d5cafd4a88cac147c39386d352fb1\", \"compositor_unittests\": \"d966f948bfaf5c75a15cf3d93b62eb41d5b7d739\", \"content_browsertests\": \"c739810045433c346f5032ea175acfb8a96153b5\", \"content_unittests\": \"b127e72c3285e463b80d79e084e93be304e1ee66\", \"courgette_unittests\": \"0baa008b18273dadfe03f1fd4a520bdcf3f84a1b\", \"crashpad_tests\": \"5f4dfabd540fb673c2e334e7c2db6d98153e4693\", \"cronet_tests\": \"0a690f4429f8febf0bf7c0bc640a62db264252bc\", \"cronet_unittests\": \"96a0f7df68b975778913ef178ecc89dab4f51514\", \"crypto_unittests\": \"6a974deb8c5432bf00bf1945d038d9f2273d18f9\", \"delayloads_unittests\": \"1292ac83e57663e55bfd449a1c91568e1d585ae2\", \"device_unittests\": \"07be96edb58420923d5d110684404f579f265d0b\", \"display_unittests\": \"e7d9570f2ce1b6d3d11b02c347e1a211b3a5c259\", \"elevation_service_unittests\": \"879f3c7edff1b4641e59790444969dc2cb428017\", \"events_unittests\": \"d99590df10f9ca8255e75865cc346714f1005d37\", \"extensions_browsertests\": \"524592be3ffe29b0dc972e0658e8d52bff395df2\", \"extensions_unittests\": \"444a737ffeb7ec9b353bd64490152ae608677fea\", \"filesystem_service_unittests\": \"054e3af884e4aec0309e6c5c9ee5fbf24d0f96fd\", \"gcm_unit_tests\": \"79e3c7947b24e609b45fe361986c54bcd3ce6196\", \"gcp_unittests\": \"162694bf28c8fabdacea9b9f931bc8887878b1d8\", \"gfx_unittests\": \"f791ce50a11ae034f478ce11fb724d6d752a4a73\", \"gin_unittests\": \"00373cd894af73192557d93de92617d59544704e\", \"google_apis_unittests\": \"244f45b0fc2035993bf3a217eef754042e8d8208\", \"gpu_unittests\": \"64046faa2d77aa9ba70d436aa5b8566c5b605c49\", \"gwp_asan_unittests\": \"bd2050e739a9c1ca2f650e277081b275d401bf6b\", \"headless_browsertests\": \"f232d857f2b66ee01a852d3124cd825cd71420f1\", \"headless_unittests\": \"1eb6eddf6a07b649c65dfcc5a4db4f83e9774569\", \"install_static_unittests\": \"79ceb9fc3dc9eb2f452ed6fb1e350cc531b36458\", \"installer_util_unittests\": \"53430fa9fc4c8f6091995a86ba888190e0fa020c\", \"interactive_ui_tests\": \"4b28393dd72c025bb07c1e5d1dd7bc42a938c681\", \"ipc_tests\": \"e8066ad1f15963f0f2267657bca913486335f441\", \"jingle_unittests\": \"9925049e31020be48eb4d51a7ac12a06f988f6ce\", \"latency_unittests\": \"5f951a39924b943528dac4770175675c2652e2c0\", \"libjingle_xmpp_unittests\": \"533d0b1fb7f1a79e90590ff2d2cbbdda77cec928\", \"liburlpattern_unittests\": \"7bf9751cfdf075723a505ee6f888c9b074ac7cb3\", \"media_blink_unittests\": \"d45c02682c250473e71d541d1f3deef18bafd4ed\", \"media_unittests\": \"255bad856c39f59835f4ba792562b9b964635994\", \"message_center_unittests\": \"44069dc4b579d526a0655f49f66491472093d211\", \"midi_unittests\": \"1728b4b9609f80e5c4220af086c5197601814bba\", \"mojo_core_unittests\": \"0b5311396c2b6b0f461358c8151e1de5f636ae78\", \"mojo_unittests\": \"9ceffb1829fe973266f8ef5636501d1976f22ef7\", \"nacl_loader_unittests\": \"9ff6e666f0d72f9bcbc1a9e924c89f527d640d05\", \"native_theme_unittests\": \"e63312d1bba2a6e1e5df63267e493bd0f7e83c90\", \"net_unittests\": \"b4c876770bce40fea66a443efb574593741318dc\", \"notification_helper_unittests\": \"b815fbe27c00513e72b699ef2f5d35cf41f97360\", \"pdf_unittests\": \"32625283e44bab72cd5166d9b301356737719936\", \"perfetto_unittests\": \"3026fcd73535a98a10507d1b79358438adc5d119\", \"ppapi_unittests\": \"3c0ff88b4a47514cd796d03a8a25257fcc98e1b9\", \"printing_unittests\": \"9ea74c39c62ca2beec3f0b915b7459706743a872\", \"remoting_unittests\": \"aa6293aecd1ee37a7b5a8aea417dea9e9b810f4a\", \"sbox_integration_tests\": \"95b4a80e25710e1bd0ed079323681430cacff4c8\", \"sbox_unittests\": \"6607023b9c67f30f3baca41f9012e8c361111728\", \"sbox_validation_tests\": \"9d08ef556e079a35685c634c72d9d316ec7b5fc6\", \"service_manager_unittests\": \"a788382c8289385edbbe2d293074dde93b662683\", \"services_unittests\": \"7cad88e129cd0fc09c0ca059debc0d2f49dd7faa\", \"setup_unittests\": \"7f49e729a888e8d7d756562e3ed0ded85cc0f9c6\", \"shell_dialogs_unittests\": \"757b1c9639ce5da58c7ebc0aa0a9947cc429a150\", \"skia_unittests\": \"2155e82bb0c47cdfd604cc003381e1defcef6ac7\", \"snapshot_unittests\": \"20682606e089f3dd090d074461c97cc962942d32\", \"sql_unittests\": \"aea9d02a3af808fc52ae17c05dd75dc8a1341f79\", \"storage_unittests\": \"9f6d69c56811a0fe459de8d32ff7f71de153b9b9\", \"sync_integration_tests\": \"dc9169d0ed636acce3d5f512da4734a1a0d5ce5e\", \"traffic_annotation_auditor_unittests\": \"9dfc8da3dd5a98cdf259abe580d28b13e7456e5b\", \"ui_base_unittests\": \"d2cf7570d3ecc318e35127fe0277c14779202399\", \"ui_touch_selection_unittests\": \"03e131590e299051274ebb83734288d59e5adb61\", \"unit_tests\": \"2937ee4f060dfae7d1db84f851361a3df2413d55\", \"updater_tests\": \"9d6a1e38466c96c3de79f7291761dad0827cacfa\", \"url_unittests\": \"285f4bcad73b9fa76f43347ddea1d76084f8ee98\", \"views_unittests\": \"690c66dba90bb154dd478231dbba8974eb82bb11\", \"viz_unittests\": \"4cb671bfa2b577b507c2e77048f08a63cfd7c2a5\", \"vr_common_unittests\": \"b63a3f22d43f03e047be65ca8ab6b562fd895ac6\", \"vr_pixeltests\": \"eec7f807f1510d7bc4ea4d9f34de02319a4fff13\", \"weblayer_browsertests\": \"426b88e5ce4b3b862859c4a377e0b3d432344876\", \"weblayer_unittests\": \"7d105d1c024bd0c5bca97412e4961d1abb99fb51\", \"wm_unittests\": \"d25a6d499822559562300393309985d9dfe60aca\", \"wtf_unittests\": \"380e290dc02db46f4ddc08d37aa9fe6b0c2ce772\", \"zlib_unittests\": \"276d33b2463d02da2da4d1644dadc736dd66c22e\", \"zucchini_unittests\": \"80a2a380ecc706ad9fa3e29e1cdd3a91753f8ea4\"}}, \"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-8-6zek\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5635-1756fdb\"], \"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": "1605704911065114",
"status": "COMPLETED",
"status_changed_ts": "1605708226156688",
"tags": [
"build_address:luci.chromium.ci/win-asan/15705",
"builder:win-asan",
"buildset:commit/git/69cb7c65ad845cdab1cd5f4256237e72fceba2dd",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/69cb7c65ad845cdab1cd5f4256237e72fceba2dd",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028720146740831232",
"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/8863290084694342976/+/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:4ff44a0deebe3810",
"user_agent:luci-scheduler"
],
"updated_ts": "1605708226174788",
"url": "https://ci.chromium.org/b/8863290084694342976",
"utcnow_ts": "1605708229484429"
}
}
[14:03:49.503] Invocation finished in 55m21.262470642s with status SUCCEEDED