[11:08:00.121] New invocation is queued and will start shortly
[11:08:01.628] Starting the invocation (attempt 1)
[11:08:01.676] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:08:01.676] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:08:01.677] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9026191010930757296",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b8e3c9a3ead700cbdea629c936b7570012e23a1b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9026191010930757296",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/b8e3c9a3ead700cbdea629c936b7570012e23a1b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b8e3c9a3ead700cbdea629c936b7570012e23a1b",
"gitiles_ref:refs/heads/master"
]
}
[11:08:02.285] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1608116881773036",
"id": "8860760948536340160",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b8e3c9a3ead700cbdea629c936b7570012e23a1b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1608116882149744",
"tags": [
"build_address:luci.chromium.ci/win-asan/16259",
"builder:win-asan",
"buildset:commit/git/b8e3c9a3ead700cbdea629c936b7570012e23a1b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b8e3c9a3ead700cbdea629c936b7570012e23a1b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026191010930757296",
"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/8860760948536340160/+/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": "1608116882149855",
"url": "https://ci.chromium.org/b/8860760948536340160",
"utcnow_ts": "1608116882277577"
}
}
[11:08:02.285] Task URL: https://ci.chromium.org/b/8860760948536340160
[11:08:02.285] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:2:0) after 1m0s
[11:08:04.457] Received PubSub notification, asking Buildbucket for the build status
[11:08:04.523] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:02.456] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:2:0)
[11:09:02.456] Timer tick, asking Buildbucket for the build status
[11:09:02.606] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:02.606] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:4:0) after 1m0s
[11:10:02.673] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:4:0)
[11:10:02.673] Timer tick, asking Buildbucket for the build status
[11:10:02.924] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:02.924] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:5:0) after 1m0s
[11:11:02.969] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:5:0)
[11:11:02.969] Timer tick, asking Buildbucket for the build status
[11:11:03.088] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:03.088] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:6:0) after 1m0s
[11:12:03.140] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:6:0)
[11:12:03.140] Timer tick, asking Buildbucket for the build status
[11:12:03.411] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:03.411] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:7:0) after 1m0s
[11:13:03.439] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:7:0)
[11:13:03.439] Timer tick, asking Buildbucket for the build status
[11:13:03.952] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:03.952] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:8:0) after 1m0s
[11:14:04.014] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:8:0)
[11:14:04.014] Timer tick, asking Buildbucket for the build status
[11:14:04.330] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:04.330] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:9:0) after 1m0s
[11:15:04.408] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:9:0)
[11:15:04.408] Timer tick, asking Buildbucket for the build status
[11:15:04.859] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:04.859] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:10:0) after 1m0s
[11:16:04.914] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:10:0)
[11:16:04.915] Timer tick, asking Buildbucket for the build status
[11:16:04.985] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:04.985] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:11:0) after 1m0s
[11:17:05.079] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:11:0)
[11:17:05.079] Timer tick, asking Buildbucket for the build status
[11:17:05.152] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:05.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:12:0) after 1m0s
[11:18:05.184] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:12:0)
[11:18:05.184] Timer tick, asking Buildbucket for the build status
[11:18:05.336] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:05.336] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:13:0) after 1m0s
[11:19:05.368] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:13:0)
[11:19:05.368] Timer tick, asking Buildbucket for the build status
[11:19:05.443] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:05.443] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:14:0) after 1m0s
[11:20:06.399] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:14:0)
[11:20:06.399] Timer tick, asking Buildbucket for the build status
[11:20:06.457] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:06.458] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:15:0) after 1m0s
[11:21:07.057] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:15:0)
[11:21:07.057] Timer tick, asking Buildbucket for the build status
[11:21:07.137] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:07.137] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:16:0) after 1m0s
[11:22:07.415] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:16:0)
[11:22:07.415] Timer tick, asking Buildbucket for the build status
[11:22:07.479] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:07.479] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:17:0) after 1m0s
[11:23:07.562] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:17:0)
[11:23:07.562] Timer tick, asking Buildbucket for the build status
[11:23:08.046] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:08.046] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:18:0) after 1m0s
[11:24:08.119] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:18:0)
[11:24:08.119] Timer tick, asking Buildbucket for the build status
[11:24:08.314] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:08.314] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:19:0) after 1m0s
[11:25:08.309] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:19:0)
[11:25:08.309] Timer tick, asking Buildbucket for the build status
[11:25:08.384] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:08.384] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:20:0) after 1m0s
[11:26:08.404] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:20:0)
[11:26:08.404] Timer tick, asking Buildbucket for the build status
[11:26:08.629] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:08.629] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:21:0) after 1m0s
[11:27:08.689] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:21:0)
[11:27:08.689] Timer tick, asking Buildbucket for the build status
[11:27:08.807] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:08.807] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:22:0) after 1m0s
[11:28:08.877] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:22:0)
[11:28:08.877] Timer tick, asking Buildbucket for the build status
[11:28:08.978] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:08.978] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:23:0) after 1m0s
[11:29:09.011] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:23:0)
[11:29:09.011] Timer tick, asking Buildbucket for the build status
[11:29:09.094] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:09.094] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:24:0) after 1m0s
[11:30:09.143] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:24:0)
[11:30:09.143] Timer tick, asking Buildbucket for the build status
[11:30:09.220] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:09.220] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:25:0) after 1m0s
[11:31:09.305] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:25:0)
[11:31:09.305] Timer tick, asking Buildbucket for the build status
[11:31:09.414] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:09.414] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:26:0) after 1m0s
[11:32:09.469] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:26:0)
[11:32:09.469] Timer tick, asking Buildbucket for the build status
[11:32:09.739] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:09.739] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:27:0) after 1m0s
[11:33:09.713] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:27:0)
[11:33:09.713] Timer tick, asking Buildbucket for the build status
[11:33:09.865] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:09.865] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:28:0) after 1m0s
[11:34:09.918] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:28:0)
[11:34:09.918] Timer tick, asking Buildbucket for the build status
[11:34:11.024] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:11.024] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:29:0) after 1m0s
[11:35:11.114] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:29:0)
[11:35:11.114] Timer tick, asking Buildbucket for the build status
[11:35:11.173] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:11.173] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:30:0) after 1m0s
[11:36:11.188] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:30:0)
[11:36:11.188] Timer tick, asking Buildbucket for the build status
[11:36:11.249] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:11.249] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:31:0) after 1m0s
[11:37:11.380] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:31:0)
[11:37:11.380] Timer tick, asking Buildbucket for the build status
[11:37:11.453] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:11.453] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:32:0) after 1m0s
[11:38:11.571] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:32:0)
[11:38:11.571] Timer tick, asking Buildbucket for the build status
[11:38:11.681] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:11.681] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:33:0) after 1m0s
[11:39:11.699] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:33:0)
[11:39:11.699] Timer tick, asking Buildbucket for the build status
[11:39:11.763] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:11.764] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:34:0) after 1m0s
[11:40:11.930] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:34:0)
[11:40:11.930] Timer tick, asking Buildbucket for the build status
[11:40:12.009] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:12.009] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:35:0) after 1m0s
[11:41:12.122] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:35:0)
[11:41:12.122] Timer tick, asking Buildbucket for the build status
[11:41:12.184] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:12.184] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:36:0) after 1m0s
[11:42:12.371] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:36:0)
[11:42:12.371] Timer tick, asking Buildbucket for the build status
[11:42:12.450] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:12.450] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:37:0) after 1m0s
[11:43:12.619] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:37:0)
[11:43:12.619] Timer tick, asking Buildbucket for the build status
[11:43:12.717] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:12.717] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:38:0) after 1m0s
[11:44:12.767] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:38:0)
[11:44:12.767] Timer tick, asking Buildbucket for the build status
[11:44:12.838] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:12.838] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:39:0) after 1m0s
[11:45:12.860] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:39:0)
[11:45:12.860] Timer tick, asking Buildbucket for the build status
[11:45:12.936] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:12.936] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:40:0) after 1m0s
[11:46:13.009] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:40:0)
[11:46:13.009] Timer tick, asking Buildbucket for the build status
[11:46:13.138] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:13.138] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:41:0) after 1m0s
[11:47:13.177] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:41:0)
[11:47:13.177] Timer tick, asking Buildbucket for the build status
[11:47:13.245] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:13.245] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:42:0) after 1m0s
[11:48:13.281] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:42:0)
[11:48:13.281] Timer tick, asking Buildbucket for the build status
[11:48:13.764] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:13.764] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:43:0) after 1m0s
[11:49:13.829] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:43:0)
[11:49:13.829] Timer tick, asking Buildbucket for the build status
[11:49:14.112] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:14.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:44:0) after 1m0s
[11:50:14.110] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:44:0)
[11:50:14.110] Timer tick, asking Buildbucket for the build status
[11:50:14.319] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:14.319] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:45:0) after 1m0s
[11:51:14.365] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:45:0)
[11:51:14.365] Timer tick, asking Buildbucket for the build status
[11:51:14.542] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:14.542] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:46:0) after 1m0s
[11:52:14.651] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:46:0)
[11:52:14.651] Timer tick, asking Buildbucket for the build status
[11:52:14.744] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:14.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:47:0) after 1m0s
[11:53:14.811] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:47:0)
[11:53:14.811] Timer tick, asking Buildbucket for the build status
[11:53:14.908] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:14.908] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:48:0) after 1m0s
[11:54:14.946] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:48:0)
[11:54:14.946] Timer tick, asking Buildbucket for the build status
[11:54:15.024] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:15.024] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:49:0) after 1m0s
[11:55:15.077] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:49:0)
[11:55:15.077] Timer tick, asking Buildbucket for the build status
[11:55:15.147] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:15.147] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:50:0) after 1m0s
[11:56:15.127] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:50:0)
[11:56:15.127] Timer tick, asking Buildbucket for the build status
[11:56:15.196] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:15.196] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:51:0) after 1m0s
[11:57:15.227] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:51:0)
[11:57:15.227] Timer tick, asking Buildbucket for the build status
[11:57:15.297] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:15.297] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:52:0) after 1m0s
[11:58:15.324] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:52:0)
[11:58:15.324] Timer tick, asking Buildbucket for the build status
[11:58:15.438] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:15.439] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:53:0) after 1m0s
[11:59:15.434] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:53:0)
[11:59:15.434] Timer tick, asking Buildbucket for the build status
[11:59:15.540] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:15.540] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:54:0) after 1m0s
[12:00:15.570] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:54:0)
[12:00:15.570] Timer tick, asking Buildbucket for the build status
[12:00:15.804] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:15.804] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:55:0) after 1m0s
[12:01:15.827] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:55:0)
[12:01:15.827] Timer tick, asking Buildbucket for the build status
[12:01:15.938] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:15.938] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:56:0) after 1m0s
[12:02:15.974] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:56:0)
[12:02:15.974] Timer tick, asking Buildbucket for the build status
[12:02:16.066] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:16.066] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:57:0) after 1m0s
[12:03:16.129] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:57:0)
[12:03:16.129] Timer tick, asking Buildbucket for the build status
[12:03:16.392] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:16.392] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:58:0) after 1m0s
[12:04:16.474] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:58:0)
[12:04:16.474] Timer tick, asking Buildbucket for the build status
[12:04:16.689] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:16.689] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:59:0) after 1m0s
[12:05:16.714] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:59:0)
[12:05:16.714] Timer tick, asking Buildbucket for the build status
[12:05:16.771] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:16.771] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:60:0) after 1m0s
[12:06:16.795] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:60:0)
[12:06:16.795] Timer tick, asking Buildbucket for the build status
[12:06:16.931] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:16.931] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:61:0) after 1m0s
[12:07:16.936] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:61:0)
[12:07:16.936] Timer tick, asking Buildbucket for the build status
[12:07:18.341] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:18.341] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:62:0) after 1m0s
[12:08:18.366] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:62:0)
[12:08:18.366] Timer tick, asking Buildbucket for the build status
[12:08:18.638] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:18.638] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:63:0) after 1m0s
[12:09:18.694] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:63:0)
[12:09:18.694] Timer tick, asking Buildbucket for the build status
[12:09:19.099] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:19.099] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:64:0) after 1m0s
[12:10:19.106] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:64:0)
[12:10:19.106] Timer tick, asking Buildbucket for the build status
[12:10:19.315] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:19.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:65:0) after 1m0s
[12:11:19.348] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:65:0)
[12:11:19.348] Timer tick, asking Buildbucket for the build status
[12:11:19.518] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:19.518] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:66:0) after 1m0s
[12:12:19.538] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:66:0)
[12:12:19.538] Timer tick, asking Buildbucket for the build status
[12:12:20.903] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:20.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:67:0) after 1m0s
[12:13:20.933] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:67:0)
[12:13:20.933] Timer tick, asking Buildbucket for the build status
[12:13:21.063] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:21.063] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:68:0) after 1m0s
[12:14:21.097] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:68:0)
[12:14:21.097] Timer tick, asking Buildbucket for the build status
[12:14:21.207] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:21.207] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:69:0) after 1m0s
[12:15:21.231] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:69:0)
[12:15:21.231] Timer tick, asking Buildbucket for the build status
[12:15:21.385] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:21.385] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:70:0) after 1m0s
[12:16:21.406] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:70:0)
[12:16:21.406] Timer tick, asking Buildbucket for the build status
[12:16:21.539] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:21.539] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:71:0) after 1m0s
[12:17:21.546] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:71:0)
[12:17:21.546] Timer tick, asking Buildbucket for the build status
[12:17:21.693] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:21.693] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:72:0) after 1m0s
[12:18:21.679] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:72:0)
[12:18:21.679] Timer tick, asking Buildbucket for the build status
[12:18:21.869] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:21.869] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:73:0) after 1m0s
[12:19:21.928] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:73:0)
[12:19:21.928] Timer tick, asking Buildbucket for the build status
[12:19:22.154] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:22.154] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:74:0) after 1m0s
[12:20:22.196] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:74:0)
[12:20:22.196] Timer tick, asking Buildbucket for the build status
[12:20:22.301] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:22.301] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:75:0) after 1m0s
[12:21:22.308] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:75:0)
[12:21:22.308] Timer tick, asking Buildbucket for the build status
[12:21:22.376] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:22.376] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:76:0) after 1m0s
[12:22:22.424] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:76:0)
[12:22:22.424] Timer tick, asking Buildbucket for the build status
[12:22:22.710] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:22.710] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:77:0) after 1m0s
[12:23:22.782] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:77:0)
[12:23:22.782] Timer tick, asking Buildbucket for the build status
[12:23:22.904] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:22.904] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:78:0) after 1m0s
[12:24:22.948] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:78:0)
[12:24:22.948] Timer tick, asking Buildbucket for the build status
[12:24:23.017] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:23.017] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:79:0) after 1m0s
[12:25:23.144] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:79:0)
[12:25:23.144] Timer tick, asking Buildbucket for the build status
[12:25:23.258] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:23.258] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:80:0) after 1m0s
[12:26:23.562] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:80:0)
[12:26:23.562] Timer tick, asking Buildbucket for the build status
[12:26:23.650] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:23.650] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:81:0) after 1m0s
[12:27:23.920] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:81:0)
[12:27:23.920] Timer tick, asking Buildbucket for the build status
[12:27:24.065] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:24.065] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:82:0) after 1m0s
[12:28:24.114] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:82:0)
[12:28:24.114] Timer tick, asking Buildbucket for the build status
[12:28:24.226] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:24.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:83:0) after 1m0s
[12:29:24.264] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:83:0)
[12:29:24.264] Timer tick, asking Buildbucket for the build status
[12:29:24.417] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:24.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:84:0) after 1m0s
[12:30:24.489] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:84:0)
[12:30:24.489] Timer tick, asking Buildbucket for the build status
[12:30:24.563] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:24.563] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:85:0) after 1m0s
[12:31:24.625] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:85:0)
[12:31:24.625] Timer tick, asking Buildbucket for the build status
[12:31:24.734] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:24.734] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:86:0) after 1m0s
[12:32:24.923] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:86:0)
[12:32:24.923] Timer tick, asking Buildbucket for the build status
[12:32:25.064] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:25.064] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:87:0) after 1m0s
[12:33:25.178] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:87:0)
[12:33:25.178] Timer tick, asking Buildbucket for the build status
[12:33:25.547] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:25.547] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:88:0) after 1m0s
[12:34:25.607] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:88:0)
[12:34:25.607] Timer tick, asking Buildbucket for the build status
[12:34:25.718] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:25.718] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:89:0) after 1m0s
[12:35:25.772] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:89:0)
[12:35:25.772] Timer tick, asking Buildbucket for the build status
[12:35:25.896] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:25.896] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:90:0) after 1m0s
[12:36:26.024] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:90:0)
[12:36:26.024] Timer tick, asking Buildbucket for the build status
[12:36:26.107] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:26.107] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:91:0) after 1m0s
[12:37:26.158] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:91:0)
[12:37:26.158] Timer tick, asking Buildbucket for the build status
[12:37:26.239] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:26.239] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:92:0) after 1m0s
[12:38:26.257] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:92:0)
[12:38:26.257] Timer tick, asking Buildbucket for the build status
[12:38:26.452] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:26.452] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:93:0) after 1m0s
[12:39:26.616] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:93:0)
[12:39:26.616] Timer tick, asking Buildbucket for the build status
[12:39:26.734] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:26.735] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:94:0) after 1m0s
[12:40:26.798] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:94:0)
[12:40:26.798] Timer tick, asking Buildbucket for the build status
[12:40:26.898] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:26.898] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:95:0) after 1m0s
[12:41:26.923] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:95:0)
[12:41:26.923] Timer tick, asking Buildbucket for the build status
[12:41:27.058] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:27.058] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:96:0) after 1m0s
[12:42:27.135] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:96:0)
[12:42:27.135] Timer tick, asking Buildbucket for the build status
[12:42:27.313] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:27.313] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:97:0) after 1m0s
[12:43:27.490] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:97:0)
[12:43:27.490] Timer tick, asking Buildbucket for the build status
[12:43:27.892] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:27.892] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:98:0) after 1m0s
[12:44:27.997] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:98:0)
[12:44:27.997] Timer tick, asking Buildbucket for the build status
[12:44:28.236] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:28.236] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:99:0) after 1m0s
[12:45:28.343] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:99:0)
[12:45:28.343] Timer tick, asking Buildbucket for the build status
[12:45:28.477] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:28.477] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:100:0) after 1m0s
[12:46:28.522] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:100:0)
[12:46:28.522] Timer tick, asking Buildbucket for the build status
[12:46:28.588] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:28.588] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:101:0) after 1m0s
[12:47:28.637] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:101:0)
[12:47:28.637] Timer tick, asking Buildbucket for the build status
[12:47:28.722] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:28.722] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:102:0) after 1m0s
[12:48:28.825] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:102:0)
[12:48:28.825] Timer tick, asking Buildbucket for the build status
[12:48:29.212] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:29.212] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:103:0) after 1m0s
[12:49:29.261] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:103:0)
[12:49:29.261] Timer tick, asking Buildbucket for the build status
[12:49:29.437] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:29.438] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:104:0) after 1m0s
[12:50:29.479] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:104:0)
[12:50:29.479] Timer tick, asking Buildbucket for the build status
[12:50:29.557] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:29.557] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:105:0) after 1m0s
[12:51:29.577] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:105:0)
[12:51:29.577] Timer tick, asking Buildbucket for the build status
[12:51:29.661] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:29.661] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:106:0) after 1m0s
[12:52:29.689] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:106:0)
[12:52:29.689] Timer tick, asking Buildbucket for the build status
[12:52:29.991] Build 8860760948536340160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:29.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026191010930757296:107:0) after 1m0s
[12:53:06.504] Received PubSub notification, asking Buildbucket for the build status
[12:53:06.639] Build 8860760948536340160: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:53:06.639] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1608123185725217",
"created_by": "project:chromium",
"created_ts": "1608116881773036",
"id": "8860760948536340160",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b8e3c9a3ead700cbdea629c936b7570012e23a1b\"}}",
"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\": \"b8e3c9a3ead700cbdea629c936b7570012e23a1b\", \"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-us-central1-b-32-1-qsbv\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16259, \"clang_revision\": \"llvmorg-12-init-12923-g6ee22ca6-1\", \"got_angle_revision\": \"328f72ae21cbc371431c3776718b3a2ebfbb79ca\", \"got_dawn_revision\": \"fea4c14580b11322b8ab0ced991dd42141ab4e89\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"b8e3c9a3ead700cbdea629c936b7570012e23a1b\", \"got_revision_cp\": \"refs/heads/master@{#837528}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1ca6504eb7bb9971d317cf8c8033b38b914036b7\", \"got_v8_revision\": \"24e738a6bc98c6971154c655e17f656297085c45\", \"got_v8_revision_cp\": \"refs/heads/8.9.157@{#1}\", \"got_webrtc_revision\": \"cf8ec1f6867651204d81b14a8c31a86e6eb97572\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32829}\", \"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\": \"b8e3c9a3ead700cbdea629c936b7570012e23a1b\", \"swarm_hashes_refs/heads/master(at){#837528}_without_patch\": {\"absl_hardening_tests\": \"9079251ff8746fad501cd85dc95ac5b66df5e626\", \"accessibility_unittests\": \"614ca0fabe65708687bbe259b00fb327d80722a7\", \"angle_unittests\": \"a31f2df9cb1258c8fa48a7fe1f4a1198e1849c5b\", \"app_shell_unittests\": \"47a373dbf5543ace23b7e1d49c56476ba01b901a\", \"aura_unittests\": \"ed6f8db5ded21946036065bd8b525fbf1fbed841\", \"base_unittests\": \"0f3e45be3030916253b39328ddf9c4a3212b668f\", \"base_util_unittests\": \"5ffeb1b8f320b926719a64a6180493ac2bf942ba\", \"blink_common_unittests\": \"9fdb4edebd2874a178a4e71d3503c66085b15591\", \"blink_fuzzer_unittests\": \"8af8330fb219fcfef572cd0aa416d8fa101e9304\", \"blink_heap_unittests\": \"211fface17c27a9ed2e69fa545ea422fa2ec871f\", \"blink_platform_unittests\": \"c8eddae0ee7659cc79ff36467f6ab16c8fc4cc3d\", \"blink_unittests\": \"b3eb626ae0841d9e3691584e76b18662478d2e7f\", \"boringssl_crypto_tests\": \"c44e9207a9109045a3d6c137fe735a9edecda310\", \"boringssl_ssl_tests\": \"d5cb9c582c9fe7d767fed19b5bc2ce1d2ddef435\", \"browser_switcher_bho_unittests\": \"7b8442ff482eb27141b63e4e31a746c81a732c04\", \"browser_tests\": \"7232d55edd98b5fc9397e28e420093f24e3a5ec7\", \"capture_unittests\": \"a2008630639877bb285a9a391e24e9ed782e0c27\", \"cast_unittests\": \"2159588885597a784a5ac314a7d47238cd12135a\", \"cc_unittests\": \"92db93d462590cd4b35d22fc45b647cb3658d257\", \"chrome_app_unittests\": \"b23790d627ca745a804988d0d37d18fbaf6d2b6c\", \"chrome_cleaner_unittests\": \"85c4b0c437c90878bb6281a3e93a67099de5b9b5\", \"chrome_elf_unittests\": \"aa5235a9c6f6a96bad4d0ab73e0e310c431f7b21\", \"chromedriver_unittests\": \"8ffa9e389f23e73e738022efdb3c1480d383e528\", \"components_browsertests\": \"7fe82ac072a904139941a358bc751b68a6e8f488\", \"components_unittests\": \"904802112d947d0e8e938fadcf0addbdcac1222a\", \"compositor_unittests\": \"7586249c5f523a9ce09aa2f8c2618ca31a541ab5\", \"content_browsertests\": \"706d0a8ad52a055ab4b4144416de706a6d3a1d42\", \"content_unittests\": \"3bcd92e9e9a724ab9f3088ef711d00f63461f68b\", \"courgette_unittests\": \"22b20b277d3147c660bd35fdaaa923a51147f5a4\", \"crashpad_tests\": \"018a5639af8f7753f65ef10172cc4f96e4b21f5f\", \"cronet_tests\": \"abf2093980ce2a5e74a469303a74223dbd467987\", \"cronet_unittests\": \"07f728e6600891e545d8b7b12c1a2ce9a89cf057\", \"crypto_unittests\": \"6538fe678bdd765c4f281e0b8c4b8882579ba553\", \"delayloads_unittests\": \"f884e12a0fe60dc04d6c2865991ea7491df21b40\", \"device_unittests\": \"0950bba377e38fc292988b66f41443d0af6ad114\", \"display_unittests\": \"f3d066273f1710851e3d6216000b08fb4becbe3c\", \"elevation_service_unittests\": \"eb537d04c219c53b7a59392db4580716a2d561e9\", \"events_unittests\": \"28012506f6c06e6812036456d2587bcdcacc245a\", \"extensions_browsertests\": \"1eb5a68bd1c5d6fb34c50521a0f0cee6a2213fb5\", \"extensions_unittests\": \"bcce35a025a4e565c510d194a7c44a22e39c8eb7\", \"filesystem_service_unittests\": \"cc573b2e61cc6c40cb1c793494e5937ec7d9e2e6\", \"gcm_unit_tests\": \"674b6d39f007f7eff0734b0ac24505fca32632ba\", \"gcp_unittests\": \"f30c2bca9de0f2cd3d56f3b4239ceb5f3c4877b7\", \"gfx_unittests\": \"0e0d5aa105d92b8d5a9e841dc8fa6549053beef6\", \"gin_unittests\": \"0d251d98fe4c8abdacf82b700def6deef04c404e\", \"google_apis_unittests\": \"861d134d056cc10ed26222eab68adb52b0897cfb\", \"gpu_unittests\": \"e80d92cd50c4a67cc153ba90e6d2124b67bcda39\", \"gwp_asan_unittests\": \"c0e8505c1449dba9fd7ed296915bf94a53c81a46\", \"headless_browsertests\": \"abb9153d73b0dc10d48d9364f0e18d824bc10bcb\", \"headless_unittests\": \"9726ed79da80177f35d399b2de5bdb7f2e3c62af\", \"install_static_unittests\": \"b0954bfd8c2a96a941fe760f4f22b98e5180b09a\", \"installer_util_unittests\": \"fd6c7d5f9f94dadc0f9d79cded0dbe4178252e1b\", \"interactive_ui_tests\": \"a067bed14b0a814419806f2183b08dad0817aac6\", \"ipc_tests\": \"635303ddc396d0f4e4cda1f07d2f71486c175004\", \"jingle_unittests\": \"1e7b8421c6aa10b5f8ecc105a05b2be17d0ab073\", \"latency_unittests\": \"bd7d5534ec65c3a4b34d43f862d5f8ea6c4ac99d\", \"libjingle_xmpp_unittests\": \"03191495b8579c6b954c1b6430f881e53e728a53\", \"liburlpattern_unittests\": \"e89f7174e49a791db2a5c638860968f62424d89f\", \"media_blink_unittests\": \"c3eae864105ecb81a132e193ac865bb02228a92d\", \"media_unittests\": \"54d2b82ee1678cb91ccaf885975e6d9ee64f5430\", \"message_center_unittests\": \"9b49e4554ea77b4ab9dd2dcb9e548c94d28b1cdb\", \"midi_unittests\": \"7ce8daecbc5366b7d992908e4c6773488f4f0572\", \"mojo_core_unittests\": \"d5e5549239150101b08de694d28a1054e3d8179f\", \"mojo_unittests\": \"0ed13195657d33e7da8a2ac9789a8dc9b7c4695d\", \"nacl_loader_unittests\": \"a4549e01528469f373009161c733dda5f71678b1\", \"native_theme_unittests\": \"16dc145ab7cea62632ff4613595b8de916f91eb1\", \"net_unittests\": \"da1fe1695ec419a02e22c8d086cf876e264a6bd9\", \"notification_helper_unittests\": \"12f4fcef7a4445ad360c1d342999f9a18ce4972c\", \"pdf_unittests\": \"2686023fb6649e41cf07d2ab179a726614844c1a\", \"perfetto_unittests\": \"3ba5a1795dde3ab5a7db33945cb7945d5c4c26b6\", \"ppapi_unittests\": \"09c205b7b7abb11caf494339bab58b750147f5b0\", \"printing_unittests\": \"df4850941582baa11e62961300b92c3a5943b7cc\", \"remoting_unittests\": \"39692ff218f2441c7f368acbadb401c7d02b5ec7\", \"sbox_integration_tests\": \"45cc3c9a6a46dee0ee9e2e00424b4dc7764f301b\", \"sbox_unittests\": \"5e9abb082de02c1172baa498437602d5e45fdb7c\", \"sbox_validation_tests\": \"b653e51b3a6f2399d8be6341e1f2598cf590baa2\", \"service_manager_unittests\": \"bc6fba877aaa97fba7114465e45374fb6a1431c3\", \"services_unittests\": \"2c02fe01d0643ac7fd6768cdb50c4b986b523515\", \"setup_unittests\": \"7f0cf6b894b1ecca35d33aff9e035225095f923b\", \"shell_dialogs_unittests\": \"af9034763f3b6fcc8006f14ca0f4bb6c21954495\", \"skia_unittests\": \"95007f0a5b202e2448311ef4e71e55ecc3f85c86\", \"snapshot_unittests\": \"7d98aa958db9c1aee5ecc46511b95ce90304e8d8\", \"sql_unittests\": \"a846f0853b1a4e8b4d1a4a2d32e7177340577831\", \"storage_unittests\": \"1e56f3d8fbb3e3912a2e663725b87ce771da67b9\", \"sync_integration_tests\": \"5853acb43149e5b8123a2d6574b6a4ed95539cc0\", \"traffic_annotation_auditor_unittests\": \"2e34c4b369d54ec85e794b748045e1ed9f9106b6\", \"ui_base_unittests\": \"957c8655e5c3750b0182be6a4318c4bb1cbd0a11\", \"ui_touch_selection_unittests\": \"1dd71d2fd45f00357a10d335b5ea4310ecc125f6\", \"unit_tests\": \"0f2e0f00b51e62c32c6697e4d34c08623ff93152\", \"updater_tests\": \"8b1f6211a7a92ca002a4fb84403fd28c202a5922\", \"url_unittests\": \"52fa2f48ffdeb27358d80e888d3328dbc863569c\", \"views_unittests\": \"dbbc2c31d8d6cd0275b9ce0e56821818fd521900\", \"viz_unittests\": \"9c9d6bfa8fd7a8ce03ee30a12c8857c63ba9a1a7\", \"vr_common_unittests\": \"611fa3b0fcefae77b631a66398847fe9fb0e26aa\", \"vr_pixeltests\": \"66271accd3ac2c46c07cdaa0ed073227f1b58242\", \"weblayer_browsertests\": \"e828e5097d1c6c9c660951649b3a80b28197668a\", \"weblayer_unittests\": \"efd00faffeba0bb9fd97f66f867dc0f1ba92896b\", \"wm_unittests\": \"b0813c65b5de9cf22f565d9ad5be533d206d5dfa\", \"wtf_unittests\": \"d835d75fa7baed3aeef45ef83f87e125ad205781\", \"zlib_unittests\": \"13bf1fb17b8fa2e0d29714362802ed63c29bc609\", \"zucchini_unittests\": \"ae143252da671d2628d07b3a48bfbd486233994e\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_91c730c3e6ead475130e2ae78bc3f03e09cb9dcb91c3469d4450b29020110401_v2\", \"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-us-central1-b-32-1-qsbv\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1608116883249127",
"status": "COMPLETED",
"status_changed_ts": "1608123186098642",
"tags": [
"build_address:luci.chromium.ci/win-asan/16259",
"builder:win-asan",
"buildset:commit/git/b8e3c9a3ead700cbdea629c936b7570012e23a1b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b8e3c9a3ead700cbdea629c936b7570012e23a1b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026191010930757296",
"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/8860760948536340160/+/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:50840dd42b158310",
"user_agent:luci-scheduler"
],
"updated_ts": "1608123186104382",
"url": "https://ci.chromium.org/b/8860760948536340160",
"utcnow_ts": "1608123186630547"
}
}
[12:53:06.639] Invocation finished in 1h45m6.53326948s with status SUCCEEDED