[14:34:22.831] New invocation is queued and will start shortly
[14:34:23.938] Starting the invocation (attempt 1)
[14:34:23.983] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:34:23.983] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:34:23.983] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019926836037136480",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"03c2f06aedbb76bac695b8e94d6f20ce051e4f7b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9019926836037136480",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/03c2f06aedbb76bac695b8e94d6f20ce051e4f7b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/03c2f06aedbb76bac695b8e94d6f20ce051e4f7b",
"gitiles_ref:refs/heads/master"
]
}
[14:34:24.889] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614090864096652",
"id": "8854496774048230528",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"03c2f06aedbb76bac695b8e94d6f20ce051e4f7b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614090864604148",
"tags": [
"build_address:luci.chromium.ci/win-asan/17492",
"builder:win-asan",
"buildset:commit/git/03c2f06aedbb76bac695b8e94d6f20ce051e4f7b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/03c2f06aedbb76bac695b8e94d6f20ce051e4f7b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019926836037136480",
"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/8854496774048230528/+/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": "1614090864604295",
"url": "https://ci.chromium.org/b/8854496774048230528",
"utcnow_ts": "1614090864876483"
}
}
[14:34:24.889] Task URL: https://ci.chromium.org/b/8854496774048230528
[14:34:24.889] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:2:0) after 1m0s
[14:35:24.912] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:2:0)
[14:35:24.912] Timer tick, asking Buildbucket for the build status
[14:35:25.493] Build 8854496774048230528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:35:25.493] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:3:0) after 1m0s
[14:36:25.545] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:3:0)
[14:36:25.545] Timer tick, asking Buildbucket for the build status
[14:36:25.734] Build 8854496774048230528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:36:25.734] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:4:0) after 1m0s
[14:36:51.393] Received PubSub notification, asking Buildbucket for the build status
[14:36:51.471] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:25.748] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:4:0)
[14:37:25.748] Timer tick, asking Buildbucket for the build status
[14:37:25.814] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:25.814] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:6:0) after 1m0s
[14:38:26.018] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:6:0)
[14:38:26.018] Timer tick, asking Buildbucket for the build status
[14:38:26.127] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:26.128] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:7:0) after 1m0s
[14:39:26.289] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:7:0)
[14:39:26.289] Timer tick, asking Buildbucket for the build status
[14:39:26.377] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:26.377] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:8:0) after 1m0s
[14:40:26.513] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:8:0)
[14:40:26.513] Timer tick, asking Buildbucket for the build status
[14:40:26.697] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:26.697] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:9:0) after 1m0s
[14:41:26.765] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:9:0)
[14:41:26.765] Timer tick, asking Buildbucket for the build status
[14:41:26.864] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:26.864] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:10:0) after 1m0s
[14:42:26.898] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:10:0)
[14:42:26.898] Timer tick, asking Buildbucket for the build status
[14:42:27.249] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:27.249] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:11:0) after 1m0s
[14:43:27.354] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:11:0)
[14:43:27.354] Timer tick, asking Buildbucket for the build status
[14:43:27.528] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:27.528] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:12:0) after 1m0s
[14:44:27.568] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:12:0)
[14:44:27.568] Timer tick, asking Buildbucket for the build status
[14:44:27.663] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:27.663] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:13:0) after 1m0s
[14:45:27.809] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:13:0)
[14:45:27.810] Timer tick, asking Buildbucket for the build status
[14:45:28.023] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:28.023] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:14:0) after 1m0s
[14:46:28.430] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:14:0)
[14:46:28.430] Timer tick, asking Buildbucket for the build status
[14:46:28.741] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:28.741] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:15:0) after 1m0s
[14:47:28.841] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:15:0)
[14:47:28.841] Timer tick, asking Buildbucket for the build status
[14:47:28.935] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:28.935] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:16:0) after 1m0s
[14:48:28.997] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:16:0)
[14:48:28.997] Timer tick, asking Buildbucket for the build status
[14:48:29.134] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:29.134] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:17:0) after 1m0s
[14:49:29.155] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:17:0)
[14:49:29.155] Timer tick, asking Buildbucket for the build status
[14:49:29.333] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:29.333] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:18:0) after 1m0s
[14:50:29.389] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:18:0)
[14:50:29.389] Timer tick, asking Buildbucket for the build status
[14:50:29.634] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:29.634] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:19:0) after 1m0s
[14:51:29.698] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:19:0)
[14:51:29.698] Timer tick, asking Buildbucket for the build status
[14:51:29.800] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:29.800] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:20:0) after 1m0s
[14:52:29.856] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:20:0)
[14:52:29.856] Timer tick, asking Buildbucket for the build status
[14:52:30.058] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:30.058] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:21:0) after 1m0s
[14:53:30.147] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:21:0)
[14:53:30.147] Timer tick, asking Buildbucket for the build status
[14:53:30.230] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:30.230] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:22:0) after 1m0s
[14:54:30.333] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:22:0)
[14:54:30.333] Timer tick, asking Buildbucket for the build status
[14:54:30.416] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:30.416] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:23:0) after 1m0s
[14:55:30.444] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:23:0)
[14:55:30.444] Timer tick, asking Buildbucket for the build status
[14:55:30.740] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:30.740] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:24:0) after 1m0s
[14:56:30.759] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:24:0)
[14:56:30.759] Timer tick, asking Buildbucket for the build status
[14:56:30.839] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:30.839] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:25:0) after 1m0s
[14:57:30.902] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:25:0)
[14:57:30.902] Timer tick, asking Buildbucket for the build status
[14:57:30.970] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:30.970] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:26:0) after 1m0s
[14:58:31.027] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:26:0)
[14:58:31.027] Timer tick, asking Buildbucket for the build status
[14:58:31.121] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:31.121] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:27:0) after 1m0s
[14:59:31.140] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:27:0)
[14:59:31.140] Timer tick, asking Buildbucket for the build status
[14:59:31.254] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:31.254] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:28:0) after 1m0s
[15:00:31.363] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:28:0)
[15:00:31.363] Timer tick, asking Buildbucket for the build status
[15:00:31.615] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:31.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:29:0) after 1m0s
[15:01:31.600] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:29:0)
[15:01:31.600] Timer tick, asking Buildbucket for the build status
[15:01:31.922] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:31.922] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:30:0) after 1m0s
[15:02:31.984] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:30:0)
[15:02:31.984] Timer tick, asking Buildbucket for the build status
[15:02:32.333] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:32.333] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:31:0) after 1m0s
[15:03:32.329] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:31:0)
[15:03:32.329] Timer tick, asking Buildbucket for the build status
[15:03:32.426] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:32.426] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:32:0) after 1m0s
[15:04:32.463] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:32:0)
[15:04:32.463] Timer tick, asking Buildbucket for the build status
[15:04:32.562] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:32.562] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:33:0) after 1m0s
[15:05:32.656] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:33:0)
[15:05:32.656] Timer tick, asking Buildbucket for the build status
[15:05:32.947] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:32.947] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:34:0) after 1m0s
[15:06:32.990] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:34:0)
[15:06:32.990] Timer tick, asking Buildbucket for the build status
[15:06:33.207] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:33.207] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:35:0) after 1m0s
[15:07:33.223] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:35:0)
[15:07:33.223] Timer tick, asking Buildbucket for the build status
[15:07:33.482] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:33.482] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:36:0) after 1m0s
[15:08:33.604] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:36:0)
[15:08:33.605] Timer tick, asking Buildbucket for the build status
[15:08:33.679] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:33.679] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:37:0) after 1m0s
[15:09:33.721] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:37:0)
[15:09:33.721] Timer tick, asking Buildbucket for the build status
[15:09:33.810] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:33.810] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:38:0) after 1m0s
[15:10:33.853] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:38:0)
[15:10:33.853] Timer tick, asking Buildbucket for the build status
[15:10:33.932] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:33.932] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:39:0) after 1m0s
[15:11:34.006] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:39:0)
[15:11:34.006] Timer tick, asking Buildbucket for the build status
[15:11:34.099] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:34.099] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:40:0) after 1m0s
[15:12:34.501] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:40:0)
[15:12:34.501] Timer tick, asking Buildbucket for the build status
[15:12:34.580] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:34.580] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:41:0) after 1m0s
[15:13:34.611] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:41:0)
[15:13:34.611] Timer tick, asking Buildbucket for the build status
[15:13:34.691] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:34.691] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:42:0) after 1m0s
[15:14:34.726] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:42:0)
[15:14:34.726] Timer tick, asking Buildbucket for the build status
[15:14:35.106] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:35.106] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:43:0) after 1m0s
[15:15:35.147] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:43:0)
[15:15:35.147] Timer tick, asking Buildbucket for the build status
[15:15:35.598] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:35.598] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:44:0) after 1m0s
[15:16:35.618] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:44:0)
[15:16:35.618] Timer tick, asking Buildbucket for the build status
[15:16:35.687] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:35.687] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:45:0) after 1m0s
[15:17:35.728] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:45:0)
[15:17:35.728] Timer tick, asking Buildbucket for the build status
[15:17:35.798] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:35.798] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:46:0) after 1m0s
[15:18:35.819] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:46:0)
[15:18:35.819] Timer tick, asking Buildbucket for the build status
[15:18:35.941] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:35.941] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:47:0) after 1m0s
[15:19:35.994] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:47:0)
[15:19:35.994] Timer tick, asking Buildbucket for the build status
[15:19:36.081] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:36.081] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:48:0) after 1m0s
[15:20:36.102] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:48:0)
[15:20:36.102] Timer tick, asking Buildbucket for the build status
[15:20:36.238] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:36.238] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:49:0) after 1m0s
[15:21:36.279] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:49:0)
[15:21:36.279] Timer tick, asking Buildbucket for the build status
[15:21:36.528] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:36.528] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:50:0) after 1m0s
[15:22:36.542] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:50:0)
[15:22:36.542] Timer tick, asking Buildbucket for the build status
[15:22:36.603] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:36.603] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:51:0) after 1m0s
[15:23:36.648] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:51:0)
[15:23:36.648] Timer tick, asking Buildbucket for the build status
[15:23:36.715] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:36.715] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:52:0) after 1m0s
[15:24:36.803] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:52:0)
[15:24:36.803] Timer tick, asking Buildbucket for the build status
[15:24:36.897] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:36.897] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:53:0) after 1m0s
[15:25:36.946] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:53:0)
[15:25:36.946] Timer tick, asking Buildbucket for the build status
[15:25:37.109] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:37.109] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:54:0) after 1m0s
[15:26:37.132] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:54:0)
[15:26:37.132] Timer tick, asking Buildbucket for the build status
[15:26:37.241] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:37.241] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:55:0) after 1m0s
[15:27:37.249] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:55:0)
[15:27:37.249] Timer tick, asking Buildbucket for the build status
[15:27:37.501] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:37.501] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:56:0) after 1m0s
[15:28:37.481] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:56:0)
[15:28:37.481] Timer tick, asking Buildbucket for the build status
[15:28:37.552] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:37.552] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:57:0) after 1m0s
[15:29:37.587] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:57:0)
[15:29:37.587] Timer tick, asking Buildbucket for the build status
[15:29:37.771] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:37.771] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:58:0) after 1m0s
[15:30:37.793] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:58:0)
[15:30:37.793] Timer tick, asking Buildbucket for the build status
[15:30:37.866] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:37.866] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:59:0) after 1m0s
[15:31:37.939] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:59:0)
[15:31:37.939] Timer tick, asking Buildbucket for the build status
[15:31:38.012] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:38.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:60:0) after 1m0s
[15:32:38.015] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:60:0)
[15:32:38.015] Timer tick, asking Buildbucket for the build status
[15:32:38.341] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:38.341] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:61:0) after 1m0s
[15:33:38.390] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:61:0)
[15:33:38.390] Timer tick, asking Buildbucket for the build status
[15:33:38.657] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:38.657] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:62:0) after 1m0s
[15:34:38.745] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:62:0)
[15:34:38.745] Timer tick, asking Buildbucket for the build status
[15:34:38.849] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:38.849] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:63:0) after 1m0s
[15:35:39.131] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:63:0)
[15:35:39.131] Timer tick, asking Buildbucket for the build status
[15:35:39.219] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:39.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:64:0) after 1m0s
[15:36:39.446] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:64:0)
[15:36:39.446] Timer tick, asking Buildbucket for the build status
[15:36:39.905] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:39.905] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:65:0) after 1m0s
[15:37:39.921] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:65:0)
[15:37:39.921] Timer tick, asking Buildbucket for the build status
[15:37:40.313] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:40.313] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:66:0) after 1m0s
[15:38:40.384] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:66:0)
[15:38:40.384] Timer tick, asking Buildbucket for the build status
[15:38:40.465] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:40.465] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:67:0) after 1m0s
[15:39:40.503] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:67:0)
[15:39:40.503] Timer tick, asking Buildbucket for the build status
[15:39:40.594] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:40.594] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:68:0) after 1m0s
[15:40:40.606] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:68:0)
[15:40:40.606] Timer tick, asking Buildbucket for the build status
[15:40:40.898] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:40.898] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:69:0) after 1m0s
[15:41:40.967] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:69:0)
[15:41:40.967] Timer tick, asking Buildbucket for the build status
[15:41:41.058] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:41.058] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:70:0) after 1m0s
[15:42:41.057] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:70:0)
[15:42:41.057] Timer tick, asking Buildbucket for the build status
[15:42:41.131] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:41.131] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:71:0) after 1m0s
[15:43:41.318] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:71:0)
[15:43:41.318] Timer tick, asking Buildbucket for the build status
[15:43:42.010] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:42.010] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:72:0) after 1m0s
[15:44:42.045] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:72:0)
[15:44:42.045] Timer tick, asking Buildbucket for the build status
[15:44:42.148] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:42.148] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:73:0) after 1m0s
[15:45:42.165] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:73:0)
[15:45:42.165] Timer tick, asking Buildbucket for the build status
[15:45:42.316] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:42.316] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:74:0) after 1m0s
[15:46:42.389] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:74:0)
[15:46:42.389] Timer tick, asking Buildbucket for the build status
[15:46:42.712] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:42.712] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:75:0) after 1m0s
[15:47:42.825] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:75:0)
[15:47:42.825] Timer tick, asking Buildbucket for the build status
[15:47:43.945] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:43.945] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:76:0) after 1m0s
[15:48:43.982] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:76:0)
[15:48:43.982] Timer tick, asking Buildbucket for the build status
[15:48:44.153] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:44.153] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:77:0) after 1m0s
[15:49:44.166] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:77:0)
[15:49:44.166] Timer tick, asking Buildbucket for the build status
[15:49:44.806] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:44.806] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:78:0) after 1m0s
[15:50:44.879] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:78:0)
[15:50:44.879] Timer tick, asking Buildbucket for the build status
[15:50:46.346] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:46.346] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:79:0) after 1m0s
[15:51:46.445] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:79:0)
[15:51:46.445] Timer tick, asking Buildbucket for the build status
[15:51:46.535] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:46.535] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:80:0) after 1m0s
[15:52:46.570] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:80:0)
[15:52:46.570] Timer tick, asking Buildbucket for the build status
[15:52:46.802] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:46.802] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:81:0) after 1m0s
[15:53:46.846] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:81:0)
[15:53:46.846] Timer tick, asking Buildbucket for the build status
[15:53:46.947] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:46.947] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:82:0) after 1m0s
[15:54:46.965] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:82:0)
[15:54:46.965] Timer tick, asking Buildbucket for the build status
[15:54:47.530] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:47.530] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:83:0) after 1m0s
[15:55:47.538] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:83:0)
[15:55:47.538] Timer tick, asking Buildbucket for the build status
[15:55:47.653] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:47.653] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:84:0) after 1m0s
[15:56:47.679] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:84:0)
[15:56:47.679] Timer tick, asking Buildbucket for the build status
[15:56:47.983] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:47.983] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:85:0) after 1m0s
[15:57:48.004] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:85:0)
[15:57:48.004] Timer tick, asking Buildbucket for the build status
[15:57:48.333] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:48.333] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:86:0) after 1m0s
[15:58:48.397] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:86:0)
[15:58:48.397] Timer tick, asking Buildbucket for the build status
[15:58:48.474] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:48.474] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:87:0) after 1m0s
[15:59:48.474] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:87:0)
[15:59:48.474] Timer tick, asking Buildbucket for the build status
[15:59:48.577] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:48.578] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:88:0) after 1m0s
[16:00:48.636] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:88:0)
[16:00:48.636] Timer tick, asking Buildbucket for the build status
[16:00:48.730] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:48.730] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:89:0) after 1m0s
[16:01:48.871] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:89:0)
[16:01:48.871] Timer tick, asking Buildbucket for the build status
[16:01:49.020] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:49.020] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:90:0) after 1m0s
[16:02:49.132] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:90:0)
[16:02:49.132] Timer tick, asking Buildbucket for the build status
[16:02:49.511] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:49.511] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:91:0) after 1m0s
[16:03:49.615] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:91:0)
[16:03:49.615] Timer tick, asking Buildbucket for the build status
[16:03:49.717] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:49.717] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:92:0) after 1m0s
[16:04:49.824] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:92:0)
[16:04:49.824] Timer tick, asking Buildbucket for the build status
[16:04:50.413] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:50.413] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:93:0) after 1m0s
[16:05:50.446] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:93:0)
[16:05:50.446] Timer tick, asking Buildbucket for the build status
[16:05:50.804] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:50.804] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:94:0) after 1m0s
[16:06:50.867] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:94:0)
[16:06:50.867] Timer tick, asking Buildbucket for the build status
[16:06:50.971] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:50.971] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:95:0) after 1m0s
[16:07:51.091] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:95:0)
[16:07:51.091] Timer tick, asking Buildbucket for the build status
[16:07:51.183] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:51.183] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:96:0) after 1m0s
[16:08:51.214] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:96:0)
[16:08:51.214] Timer tick, asking Buildbucket for the build status
[16:08:51.309] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:51.309] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:97:0) after 1m0s
[16:09:51.383] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:97:0)
[16:09:51.383] Timer tick, asking Buildbucket for the build status
[16:09:51.526] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:51.526] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:98:0) after 1m0s
[16:10:51.625] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:98:0)
[16:10:51.626] Timer tick, asking Buildbucket for the build status
[16:10:56.111] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:56.111] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:99:0) after 1m0s
[16:11:56.135] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:99:0)
[16:11:56.135] Timer tick, asking Buildbucket for the build status
[16:11:57.999] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:57.999] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:100:0) after 1m0s
[16:12:58.054] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:100:0)
[16:12:58.054] Timer tick, asking Buildbucket for the build status
[16:12:58.507] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:58.508] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:101:0) after 1m0s
[16:13:58.540] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:101:0)
[16:13:58.540] Timer tick, asking Buildbucket for the build status
[16:13:58.820] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:58.820] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:102:0) after 1m0s
[16:14:58.877] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:102:0)
[16:14:58.877] Timer tick, asking Buildbucket for the build status
[16:14:59.193] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:59.193] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:103:0) after 1m0s
[16:15:59.220] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:103:0)
[16:15:59.220] Timer tick, asking Buildbucket for the build status
[16:15:59.313] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:59.313] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:104:0) after 1m0s
[16:16:59.465] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:104:0)
[16:16:59.465] Timer tick, asking Buildbucket for the build status
[16:16:59.561] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:59.561] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:105:0) after 1m0s
[16:17:59.599] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:105:0)
[16:17:59.599] Timer tick, asking Buildbucket for the build status
[16:18:00.112] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:00.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:106:0) after 1m0s
[16:19:00.167] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:106:0)
[16:19:00.167] Timer tick, asking Buildbucket for the build status
[16:19:00.264] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:00.264] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:107:0) after 1m0s
[16:20:00.388] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:107:0)
[16:20:00.388] Timer tick, asking Buildbucket for the build status
[16:20:00.524] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:00.524] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:108:0) after 1m0s
[16:21:01.128] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:108:0)
[16:21:01.128] Timer tick, asking Buildbucket for the build status
[16:21:01.217] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:01.217] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:109:0) after 1m0s
[16:22:01.819] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:109:0)
[16:22:01.819] Timer tick, asking Buildbucket for the build status
[16:22:01.905] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:01.905] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:110:0) after 1m0s
[16:23:01.929] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:110:0)
[16:23:01.929] Timer tick, asking Buildbucket for the build status
[16:23:02.220] Build 8854496774048230528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:02.220] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019926836037136480:111:0) after 1m0s
[16:23:05.675] Received PubSub notification, asking Buildbucket for the build status
[16:23:05.782] Build 8854496774048230528: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:23:05.782] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614097383701089",
"created_by": "project:chromium",
"created_ts": "1614090864096652",
"id": "8854496774048230528",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"03c2f06aedbb76bac695b8e94d6f20ce051e4f7b\"}}",
"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\": \"03c2f06aedbb76bac695b8e94d6f20ce051e4f7b\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-win10-32-3-xpf4\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17492, \"clang_revision\": \"llvmorg-13-init-1559-g01b87444-2\", \"got_angle_revision\": \"1a70e5a04584ce3586c9ce7243b419f0df7b052f\", \"got_dawn_revision\": \"76a94b17be3c6cfc7e88d30b90e99d7b89c8f30b\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"03c2f06aedbb76bac695b8e94d6f20ce051e4f7b\", \"got_revision_cp\": \"refs/heads/master@{#856666}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"22186f076bf3bbe1a818792bde93b297e3773f7e\", \"got_v8_revision\": \"4120b5f2509821e8dd460b1d033708397520750a\", \"got_v8_revision_cp\": \"refs/heads/9.0.238@{#1}\", \"got_webrtc_revision\": \"e5caa9e2d3c7e402dd62892b1de6bd4be6f6aaf5\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33321}\", \"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\": \"03c2f06aedbb76bac695b8e94d6f20ce051e4f7b\", \"swarm_hashes_refs/heads/master(at){#856666}_without_patch\": {\"absl_hardening_tests\": \"ff86ed83e3c8637be064ff13c2a8db8b8a5db700\", \"accessibility_unittests\": \"55716ec3a04d4c52c59b3f0c49734e4a04aeb7af\", \"angle_unittests\": \"004de667d1e72178808a259cb782a477d51716ad\", \"app_shell_unittests\": \"3ab6ec34b7030e13491b46d730cffb217ef32392\", \"aura_unittests\": \"b6b93493a2cb9c116db6dd101ce0211aab62d677\", \"base_unittests\": \"e877406a289d3671be0cba87aa67eb9ceee3fcdf\", \"base_util_unittests\": \"8b885a489ee938c933a51162c828d85e2c6dcd93\", \"blink_common_unittests\": \"05b6bad0aa3d24cde189b70b334ff254108bf6a2\", \"blink_fuzzer_unittests\": \"574211fd7a0cde917a7a5684a26126e7bcfc1d09\", \"blink_heap_unittests\": \"56aacb3b24d81bfa30ecccba590cdf5637d60983\", \"blink_platform_unittests\": \"86f9791881ea1daf5553401fe484540ffd82cf59\", \"blink_unittests\": \"f68fe9198a9c084d54f137f7021b859402b76c9a\", \"boringssl_crypto_tests\": \"4d4ceac071b3c0a5497eefdca828a6905d048318\", \"boringssl_ssl_tests\": \"f4cfdce64a04c197a0ed6a073bfc6ac28735dcc6\", \"browser_switcher_bho_unittests\": \"2d160e786f1b09920e0de49b5d08a5e289249ab7\", \"browser_tests\": \"11edb848f70a9252ed3f7bf580162653b21d71ae\", \"capture_unittests\": \"6e012c469d2be78d252cd885f95b29438f559d2c\", \"cast_unittests\": \"073d0f576051113cda2c8d433f4e74925f510c43\", \"cc_unittests\": \"a8d37eab9cc6ca5708747f909b536017bdd0ec11\", \"chrome_app_unittests\": \"d70556869fb0e4ef31814f7d0ed0241ab63c2637\", \"chrome_cleaner_unittests\": \"77af751bdb71792718288a07e65b56e599f44121\", \"chrome_elf_unittests\": \"3469434202d85a243d44a0154f56ff62c2c506f4\", \"chromedriver_unittests\": \"aa2be9e9e474d8cb4bd5ec88c4a1a42640bcffca\", \"components_browsertests\": \"a48b16fd9c532aad395a6f35dc56194c5fdc91ad\", \"components_unittests\": \"a525f083c88da32a16621b4d37eafde964bf2fd4\", \"compositor_unittests\": \"5768bcd0fdc97e4909a6868172e632820ef9a432\", \"content_browsertests\": \"182c89e3cbe9fe3d4e77b8c5e3fd8c37fa4a3ece\", \"content_unittests\": \"b0bff3b8a93dac799686bf518f1c2c2a0e65e1ec\", \"courgette_unittests\": \"43d17fc70c469f0b96f5a9733009a091877948e9\", \"crashpad_tests\": \"10e0b18b7aa28d3230feb152559b908da302f18b\", \"cronet_tests\": \"2ee81777c90eacb03cdb468d17ead270dcafab3f\", \"cronet_unittests\": \"a7a1ca934a0cf12c58083d1a415dbfa51a2e69c8\", \"crypto_unittests\": \"0beb40b2590a323f961eea3c209c9323114bde88\", \"delayloads_unittests\": \"c13d17adcc3d19e8ec9bfc213e2cb39ce9ee8f20\", \"device_unittests\": \"57e97bc1d1a9dbb61cb068061cf2577e7b0994b0\", \"display_unittests\": \"817e550257c0761815fe0d529bf017b703dc25be\", \"elevation_service_unittests\": \"504d221577323c4389f0617768475c3789d4525e\", \"events_unittests\": \"14b29f33822dfd4b890dd84c6b862efac5785fa7\", \"extensions_browsertests\": \"db60e25c5beb3abff25c262bca9005a0b8a55d58\", \"extensions_unittests\": \"37069819da294ce947cfdceeffb8aea8f2d576f9\", \"filesystem_service_unittests\": \"01b4119ce4143ff485d4376aeb3f10b6db42e30c\", \"gcm_unit_tests\": \"49a4f0ad80894d180fbf9a7426ac6215f1ec5356\", \"gcp_unittests\": \"9afb495b13d190478ffc33dbc33b237419fddbb3\", \"gfx_unittests\": \"fdf29a5bb640362553ea8729ba68704c97965588\", \"gin_unittests\": \"8b63ead018e4d0302f5006f9a2a8171c1f584424\", \"google_apis_unittests\": \"c9994bdaaa89c0d4166c11f54ba7f8e1af041ae9\", \"gpu_unittests\": \"943969914dc5e1575e1086cd9b9f091b922058fa\", \"gwp_asan_unittests\": \"60de31a9e27fb42f5c408d87c07b470f6f4af4aa\", \"headless_browsertests\": \"f7c9d1b956f278d751f9c17a1af822310068d4c9\", \"headless_unittests\": \"5b4342de4157f9a41a7f908c4c29e816366c046b\", \"install_static_unittests\": \"6f3f0bdc979631ef162060f62b52215099178783\", \"installer_util_unittests\": \"a9c16fdda74a952e1973071ecff5bcec1b988398\", \"interactive_ui_tests\": \"0f1c83b6594adf55de8674389851f070a7a3f8d6\", \"ipc_tests\": \"61771d75e47bd290ddfd216c23ef3511b140b7a2\", \"jingle_unittests\": \"0918705690456ecd91dccca4e43878852f0d62e0\", \"latency_unittests\": \"8149b39260ca0f3e5f0c3042e6d960246c9a8943\", \"libjingle_xmpp_unittests\": \"8e4544426c485b2bd7dc9be4ed17fdcd4b2fecdb\", \"liburlpattern_unittests\": \"7045ead34cd4f8c9aa6d8692a2c6552fbae30587\", \"media_blink_unittests\": \"3c3703a8081714fdae1e28f9bd270ac2de705cee\", \"media_unittests\": \"d59e4e6a3cfc18a9c443b84b7b1bf6ef076843ff\", \"message_center_unittests\": \"979a4ba006514bf72b418cc8dce50eef55885791\", \"midi_unittests\": \"904e7fc5b9e7f108ec694a0238ed0a01e1008692\", \"mojo_core_unittests\": \"9d391fef68e74a2bd4bf22b428ec89f64124d1e9\", \"mojo_unittests\": \"5ffe6e5aca1e464bcc918301b9b051e31839c4ff\", \"nacl_loader_unittests\": \"ab45ce5a7dd073a05a8094347181cd012c826502\", \"native_theme_unittests\": \"51d104f2a4eb06a44b3633053f40924b6e3462e0\", \"net_unittests\": \"472fd922a83f68052f194683b5a194994614020e\", \"notification_helper_unittests\": \"8bdf35d0d6634d2accafd94f633e294100b34c0d\", \"pdf_unittests\": \"0a596be00b5e1df7c06c5ac9e8d56884b1a78516\", \"perfetto_unittests\": \"d13d8fd067ee5a1e51ddc4d53b50eb595b20c671\", \"ppapi_unittests\": \"a4ab56fd2bef63cd953cfcca628325a3fa4bf8f1\", \"printing_unittests\": \"bab4201037a502873e559024d76ab0a5df33de9e\", \"remoting_unittests\": \"bd5ee3f54e2fb3a057baa23bea0179c1a9d5cd31\", \"sbox_integration_tests\": \"4bffaebc75e556fae6528456b1fb52794b0f0606\", \"sbox_unittests\": \"dca737e4ddb0719f83d09df733c39200d4093be2\", \"sbox_validation_tests\": \"290e9cd52442bbe516208385eaf7c77ca7f67f26\", \"service_manager_unittests\": \"aad29bc591e1872b69990ef1e81e3a2b10f876da\", \"services_unittests\": \"2ccdd7b70fd86ffa2f0a6cc856ec28b446f01c1b\", \"setup_unittests\": \"3b49221361bab5529470343da2f52693506381dd\", \"shell_dialogs_unittests\": \"ec4117e5c5515869ea4e6041d2f40aa922625a1e\", \"skia_unittests\": \"55ea53db28a6355df92db9b856e99c110bf9ceeb\", \"snapshot_unittests\": \"885a5ef9dfcd8f8b598c7e3a4a50f88aa2dd469a\", \"sql_unittests\": \"cccc64906dc60413850394f82e75938f4e01ce75\", \"storage_unittests\": \"351e4afffa416148bf0e9bbb4772699bc5167ab6\", \"sync_integration_tests\": \"7b5b1ff04c983148d47df35181c04f300c6eb44e\", \"traffic_annotation_auditor_unittests\": \"17f77c5d900181b10715c28cf130b39c970ee375\", \"ui_base_unittests\": \"ff9a8c9ed039549defc3915000ffa8b509a0d795\", \"ui_touch_selection_unittests\": \"210edf6f942a17df612313e42eb630a16b3224c1\", \"unit_tests\": \"940dd9e645dbaab61b8b0b890b8c0ad21922a8c8\", \"updater_tests\": \"4c0110072ba5b739cba59115616bcfe89f06ee96\", \"url_unittests\": \"35b6e8d4a955757770a442f4706b10dadd57e98d\", \"views_unittests\": \"9f5291ea43f83908147268fbd34cea3d28103a8e\", \"viz_unittests\": \"442c24f5c6de98cfc2e5a75c753811ff6916f5fb\", \"vr_common_unittests\": \"3a2e7b76bde37ac7e32a33dc74203ca755cfe68e\", \"vr_pixeltests\": \"8891d5fb5d4ac944d913872ee67ccb02b744a77c\", \"weblayer_browsertests\": \"0fe169917dd4de140c30cb961b5c68ae0fd2b92a\", \"weblayer_unittests\": \"3c58fb8e2b5ddf985c7c333030042a4ece81f86f\", \"wm_unittests\": \"813c79826bcf2b8c4a5c3fde4809ba46bb8cb042\", \"wtf_unittests\": \"86bae5dd714915752b16358e3d2a55a01c617cb8\", \"zlib_unittests\": \"b7c4859649c3d3ee63b95a0c48ba33247f6f096f\", \"zucchini_unittests\": \"3a2316f516805ac8eb2afd6749fb5529ef233390\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-3-xpf4\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5706-397711c\"], \"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": "1614091010545008",
"status": "COMPLETED",
"status_changed_ts": "1614097384011947",
"tags": [
"build_address:luci.chromium.ci/win-asan/17492",
"builder:win-asan",
"buildset:commit/git/03c2f06aedbb76bac695b8e94d6f20ce051e4f7b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/03c2f06aedbb76bac695b8e94d6f20ce051e4f7b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019926836037136480",
"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/8854496774048230528/+/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:51e82191e249c910",
"user_agent:luci-scheduler"
],
"updated_ts": "1614097384198010",
"url": "https://ci.chromium.org/b/8854496774048230528",
"utcnow_ts": "1614097385768717"
}
}
[16:23:05.782] Invocation finished in 1h48m42.966597214s with status SUCCEEDED