[02:46:16.082] New invocation is queued and will start shortly
[02:46:17.164] Starting the invocation (attempt 1)
[02:46:17.211] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:46:17.211] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:46:17.211] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9068893748481624160",
"parameters_json": "{\"builder_name\":\"CrWinAsan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"78c473c9edd03cad13eeab706965478a4ec2c0c2\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:CrWinAsan",
"scheduler_invocation_id:9068893748481624160",
"scheduler_job_id:chromium/CrWinAsan",
"user_agent:luci-scheduler",
"buildset:commit/git/78c473c9edd03cad13eeab706965478a4ec2c0c2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/78c473c9edd03cad13eeab706965478a4ec2c0c2",
"gitiles_ref:refs/heads/master"
]
}
[02:46:18.418] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1567392377538775",
"id": "8903463686289352944",
"parameters_json": "{\"builder_name\": \"CrWinAsan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"78c473c9edd03cad13eeab706965478a4ec2c0c2\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1567392378126312",
"tags": [
"build_address:luci.chromium.ci/CrWinAsan/3835",
"builder:CrWinAsan",
"buildset:commit/git/78c473c9edd03cad13eeab706965478a4ec2c0c2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/78c473c9edd03cad13eeab706965478a4ec2c0c2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9068893748481624160",
"scheduler_job_id:chromium/CrWinAsan",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8903463686289352944/+/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": "1567392378126957",
"url": "https://ci.chromium.org/b/8903463686289352944",
"utcnow_ts": "1567392378408923"
}
}
[02:46:18.418] Task URL: https://ci.chromium.org/b/8903463686289352944
[02:46:18.418] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:2:0) after 1m0s
[02:47:18.404] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:2:0)
[02:47:18.404] Timer tick, asking Buildbucket for the build status
[02:47:18.929] Build 8903463686289352944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:47:18.930] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:3:0) after 1m0s
[02:48:18.951] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:3:0)
[02:48:18.951] Timer tick, asking Buildbucket for the build status
[02:48:19.138] Build 8903463686289352944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:48:19.138] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:4:0) after 1m0s
[02:49:19.165] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:4:0)
[02:49:19.165] Timer tick, asking Buildbucket for the build status
[02:49:19.753] Build 8903463686289352944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:49:19.753] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:5:0) after 1m0s
[02:50:19.839] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:5:0)
[02:50:19.839] Timer tick, asking Buildbucket for the build status
[02:50:20.455] Build 8903463686289352944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:50:20.455] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:6:0) after 1m0s
[02:51:20.481] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:6:0)
[02:51:20.482] Timer tick, asking Buildbucket for the build status
[02:51:20.935] Build 8903463686289352944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:51:20.936] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:7:0) after 1m0s
[02:51:52.542] Received PubSub notification, asking Buildbucket for the build status
[02:51:52.675] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:21.000] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:7:0)
[02:52:21.000] Timer tick, asking Buildbucket for the build status
[02:52:23.386] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:23.386] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:9:0) after 1m0s
[02:53:23.589] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:9:0)
[02:53:23.589] Timer tick, asking Buildbucket for the build status
[02:53:24.511] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:24.511] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:10:0) after 1m0s
[02:54:24.539] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:10:0)
[02:54:24.539] Timer tick, asking Buildbucket for the build status
[02:54:24.699] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:24.699] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:11:0) after 1m0s
[02:55:24.779] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:11:0)
[02:55:24.779] Timer tick, asking Buildbucket for the build status
[02:55:25.628] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:25.628] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:12:0) after 1m0s
[02:56:25.716] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:12:0)
[02:56:25.716] Timer tick, asking Buildbucket for the build status
[02:56:25.881] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:25.881] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:13:0) after 1m0s
[02:57:25.970] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:13:0)
[02:57:25.970] Timer tick, asking Buildbucket for the build status
[02:57:26.449] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:26.449] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:14:0) after 1m0s
[02:58:26.583] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:14:0)
[02:58:26.583] Timer tick, asking Buildbucket for the build status
[02:58:27.363] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:27.363] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:15:0) after 1m0s
[02:59:27.483] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:15:0)
[02:59:27.483] Timer tick, asking Buildbucket for the build status
[02:59:27.734] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:27.734] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:16:0) after 1m0s
[03:00:28.018] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:16:0)
[03:00:28.018] Timer tick, asking Buildbucket for the build status
[03:00:28.260] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:28.261] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:17:0) after 1m0s
[03:01:28.298] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:17:0)
[03:01:28.298] Timer tick, asking Buildbucket for the build status
[03:01:29.094] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:29.094] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:18:0) after 1m0s
[03:02:29.145] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:18:0)
[03:02:29.145] Timer tick, asking Buildbucket for the build status
[03:02:30.015] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:30.015] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:19:0) after 1m0s
[03:03:30.127] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:19:0)
[03:03:30.127] Timer tick, asking Buildbucket for the build status
[03:03:30.427] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:30.427] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:20:0) after 1m0s
[03:04:30.445] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:20:0)
[03:04:30.445] Timer tick, asking Buildbucket for the build status
[03:04:31.881] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:31.881] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:21:0) after 1m0s
[03:05:31.910] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:21:0)
[03:05:31.910] Timer tick, asking Buildbucket for the build status
[03:05:32.819] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:32.819] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:22:0) after 1m0s
[03:06:32.891] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:22:0)
[03:06:32.891] Timer tick, asking Buildbucket for the build status
[03:06:33.276] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:33.276] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:23:0) after 1m0s
[03:07:33.331] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:23:0)
[03:07:33.331] Timer tick, asking Buildbucket for the build status
[03:07:33.523] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:33.523] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:24:0) after 1m0s
[03:08:33.551] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:24:0)
[03:08:33.551] Timer tick, asking Buildbucket for the build status
[03:08:33.775] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:33.775] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:25:0) after 1m0s
[03:09:33.795] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:25:0)
[03:09:33.795] Timer tick, asking Buildbucket for the build status
[03:09:33.973] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:33.973] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:26:0) after 1m0s
[03:10:34.000] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:26:0)
[03:10:34.000] Timer tick, asking Buildbucket for the build status
[03:10:34.739] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:34.739] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:27:0) after 1m0s
[03:11:34.814] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:27:0)
[03:11:34.814] Timer tick, asking Buildbucket for the build status
[03:11:35.118] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:35.118] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:28:0) after 1m0s
[03:12:35.147] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:28:0)
[03:12:35.147] Timer tick, asking Buildbucket for the build status
[03:12:35.859] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:35.859] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:29:0) after 1m0s
[03:13:35.903] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:29:0)
[03:13:35.903] Timer tick, asking Buildbucket for the build status
[03:13:36.533] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:36.534] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:30:0) after 1m0s
[03:14:36.510] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:30:0)
[03:14:36.510] Timer tick, asking Buildbucket for the build status
[03:14:37.322] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:37.322] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:31:0) after 1m0s
[03:15:37.341] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:31:0)
[03:15:37.341] Timer tick, asking Buildbucket for the build status
[03:15:37.569] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:37.569] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:32:0) after 1m0s
[03:16:37.611] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:32:0)
[03:16:37.611] Timer tick, asking Buildbucket for the build status
[03:16:38.016] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:38.016] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:33:0) after 1m0s
[03:17:38.136] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:33:0)
[03:17:38.136] Timer tick, asking Buildbucket for the build status
[03:17:39.875] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:39.875] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:34:0) after 1m0s
[03:18:39.928] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:34:0)
[03:18:39.928] Timer tick, asking Buildbucket for the build status
[03:18:40.563] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:40.564] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:35:0) after 1m0s
[03:19:40.648] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:35:0)
[03:19:40.648] Timer tick, asking Buildbucket for the build status
[03:19:41.164] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:41.164] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:36:0) after 1m0s
[03:20:41.185] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:36:0)
[03:20:41.185] Timer tick, asking Buildbucket for the build status
[03:20:41.330] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:41.330] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:37:0) after 1m0s
[03:21:41.353] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:37:0)
[03:21:41.353] Timer tick, asking Buildbucket for the build status
[03:21:42.227] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:42.227] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:38:0) after 1m0s
[03:22:42.426] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:38:0)
[03:22:42.426] Timer tick, asking Buildbucket for the build status
[03:22:42.657] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:42.657] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:39:0) after 1m0s
[03:23:42.827] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:39:0)
[03:23:42.827] Timer tick, asking Buildbucket for the build status
[03:23:43.028] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:43.028] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:40:0) after 1m0s
[03:24:43.113] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:40:0)
[03:24:43.113] Timer tick, asking Buildbucket for the build status
[03:24:43.288] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:43.288] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:41:0) after 1m0s
[03:25:43.339] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:41:0)
[03:25:43.339] Timer tick, asking Buildbucket for the build status
[03:25:43.767] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:43.767] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:42:0) after 1m0s
[03:26:43.789] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:42:0)
[03:26:43.789] Timer tick, asking Buildbucket for the build status
[03:26:44.143] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:44.143] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:43:0) after 1m0s
[03:27:44.217] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:43:0)
[03:27:44.217] Timer tick, asking Buildbucket for the build status
[03:27:44.749] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:44.750] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:44:0) after 1m0s
[03:28:44.773] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:44:0)
[03:28:44.773] Timer tick, asking Buildbucket for the build status
[03:28:44.933] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:44.933] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:45:0) after 1m0s
[03:29:44.971] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:45:0)
[03:29:44.971] Timer tick, asking Buildbucket for the build status
[03:29:45.121] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:45.121] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:46:0) after 1m0s
[03:30:45.145] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:46:0)
[03:30:45.145] Timer tick, asking Buildbucket for the build status
[03:30:45.354] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:45.354] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:47:0) after 1m0s
[03:31:45.459] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:47:0)
[03:31:45.459] Timer tick, asking Buildbucket for the build status
[03:31:46.396] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:46.396] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:48:0) after 1m0s
[03:32:46.478] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:48:0)
[03:32:46.478] Timer tick, asking Buildbucket for the build status
[03:32:47.457] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:47.457] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:49:0) after 1m0s
[03:33:47.481] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:49:0)
[03:33:47.481] Timer tick, asking Buildbucket for the build status
[03:33:47.747] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:47.747] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:50:0) after 1m0s
[03:34:47.825] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:50:0)
[03:34:47.825] Timer tick, asking Buildbucket for the build status
[03:34:47.998] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:47.998] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:51:0) after 1m0s
[03:35:48.081] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:51:0)
[03:35:48.081] Timer tick, asking Buildbucket for the build status
[03:35:48.655] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:48.655] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:52:0) after 1m0s
[03:36:48.718] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:52:0)
[03:36:48.718] Timer tick, asking Buildbucket for the build status
[03:36:49.549] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:49.549] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:53:0) after 1m0s
[03:37:49.569] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:53:0)
[03:37:49.569] Timer tick, asking Buildbucket for the build status
[03:37:49.796] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:49.796] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:54:0) after 1m0s
[03:38:49.925] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:54:0)
[03:38:49.925] Timer tick, asking Buildbucket for the build status
[03:38:50.117] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:50.117] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:55:0) after 1m0s
[03:39:50.148] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:55:0)
[03:39:50.148] Timer tick, asking Buildbucket for the build status
[03:39:51.306] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:51.306] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:56:0) after 1m0s
[03:40:51.344] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:56:0)
[03:40:51.344] Timer tick, asking Buildbucket for the build status
[03:40:51.717] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:51.717] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:57:0) after 1m0s
[03:41:51.771] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:57:0)
[03:41:51.771] Timer tick, asking Buildbucket for the build status
[03:41:52.131] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:52.131] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:58:0) after 1m0s
[03:42:52.210] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:58:0)
[03:42:52.210] Timer tick, asking Buildbucket for the build status
[03:42:52.391] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:52.392] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:59:0) after 1m0s
[03:43:52.869] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:59:0)
[03:43:52.869] Timer tick, asking Buildbucket for the build status
[03:43:53.047] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:53.047] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:60:0) after 1m0s
[03:44:53.144] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:60:0)
[03:44:53.144] Timer tick, asking Buildbucket for the build status
[03:44:53.334] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:53.334] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:61:0) after 1m0s
[03:45:53.473] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:61:0)
[03:45:53.473] Timer tick, asking Buildbucket for the build status
[03:45:53.864] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:53.864] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:62:0) after 1m0s
[03:46:54.006] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:62:0)
[03:46:54.006] Timer tick, asking Buildbucket for the build status
[03:46:54.188] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:54.188] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:63:0) after 1m0s
[03:47:54.289] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:63:0)
[03:47:54.289] Timer tick, asking Buildbucket for the build status
[03:47:54.477] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:54.477] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:64:0) after 1m0s
[03:48:54.590] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:64:0)
[03:48:54.590] Timer tick, asking Buildbucket for the build status
[03:48:55.662] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:55.662] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:65:0) after 1m0s
[03:49:55.745] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:65:0)
[03:49:55.745] Timer tick, asking Buildbucket for the build status
[03:49:55.950] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:55.950] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:66:0) after 1m0s
[03:50:56.028] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:66:0)
[03:50:56.028] Timer tick, asking Buildbucket for the build status
[03:50:56.235] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:56.235] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:67:0) after 1m0s
[03:51:56.292] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:67:0)
[03:51:56.292] Timer tick, asking Buildbucket for the build status
[03:51:57.201] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:57.201] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:68:0) after 1m0s
[03:52:57.272] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:68:0)
[03:52:57.272] Timer tick, asking Buildbucket for the build status
[03:52:58.220] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:58.220] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:69:0) after 1m0s
[03:53:58.308] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:69:0)
[03:53:58.308] Timer tick, asking Buildbucket for the build status
[03:53:58.964] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:58.964] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:70:0) after 1m0s
[03:54:58.991] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:70:0)
[03:54:58.991] Timer tick, asking Buildbucket for the build status
[03:54:59.632] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:59.632] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:71:0) after 1m0s
[03:55:59.633] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:71:0)
[03:55:59.633] Timer tick, asking Buildbucket for the build status
[03:56:01.989] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:01.989] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:72:0) after 1m0s
[03:57:01.968] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:72:0)
[03:57:01.968] Timer tick, asking Buildbucket for the build status
[03:57:02.139] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:02.139] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:73:0) after 1m0s
[03:58:08.325] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:73:0)
[03:58:08.325] Timer tick, asking Buildbucket for the build status
[03:58:08.954] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:08.954] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:74:0) after 1m0s
[03:59:09.069] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:74:0)
[03:59:09.069] Timer tick, asking Buildbucket for the build status
[03:59:09.558] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:09.558] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:75:0) after 1m0s
[04:00:09.673] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:75:0)
[04:00:09.673] Timer tick, asking Buildbucket for the build status
[04:00:09.861] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:09.861] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:76:0) after 1m0s
[04:01:09.845] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:76:0)
[04:01:09.845] Timer tick, asking Buildbucket for the build status
[04:01:10.624] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:10.624] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:77:0) after 1m0s
[04:02:10.846] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:77:0)
[04:02:10.846] Timer tick, asking Buildbucket for the build status
[04:02:11.551] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:11.551] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:78:0) after 1m0s
[04:03:11.666] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:78:0)
[04:03:11.666] Timer tick, asking Buildbucket for the build status
[04:03:11.929] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:11.929] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:79:0) after 1m0s
[04:04:12.001] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:79:0)
[04:04:12.001] Timer tick, asking Buildbucket for the build status
[04:04:12.157] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:12.157] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:80:0) after 1m0s
[04:05:12.334] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:80:0)
[04:05:12.334] Timer tick, asking Buildbucket for the build status
[04:05:13.446] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:13.446] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:81:0) after 1m0s
[04:06:13.546] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:81:0)
[04:06:13.546] Timer tick, asking Buildbucket for the build status
[04:06:14.527] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:14.527] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:82:0) after 1m0s
[04:07:14.686] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:82:0)
[04:07:14.686] Timer tick, asking Buildbucket for the build status
[04:07:15.412] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:15.412] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:83:0) after 1m0s
[04:08:15.617] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:83:0)
[04:08:15.617] Timer tick, asking Buildbucket for the build status
[04:08:15.987] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:15.987] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:84:0) after 1m0s
[04:09:16.065] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:84:0)
[04:09:16.065] Timer tick, asking Buildbucket for the build status
[04:09:16.367] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:16.367] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:85:0) after 1m0s
[04:10:16.441] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:85:0)
[04:10:16.441] Timer tick, asking Buildbucket for the build status
[04:10:16.647] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:16.647] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:86:0) after 1m0s
[04:11:16.672] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:86:0)
[04:11:16.673] Timer tick, asking Buildbucket for the build status
[04:11:17.094] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:17.094] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:87:0) after 1m0s
[04:12:17.139] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:87:0)
[04:12:17.139] Timer tick, asking Buildbucket for the build status
[04:12:17.836] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:17.836] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:88:0) after 1m0s
[04:13:17.898] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:88:0)
[04:13:17.898] Timer tick, asking Buildbucket for the build status
[04:13:18.045] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:18.045] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:89:0) after 1m0s
[04:14:18.071] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:89:0)
[04:14:18.071] Timer tick, asking Buildbucket for the build status
[04:14:18.729] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:18.729] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:90:0) after 1m0s
[04:15:18.752] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:90:0)
[04:15:18.752] Timer tick, asking Buildbucket for the build status
[04:15:18.948] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:18.948] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:91:0) after 1m0s
[04:16:18.974] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:91:0)
[04:16:18.974] Timer tick, asking Buildbucket for the build status
[04:16:19.399] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:19.399] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:92:0) after 1m0s
[04:17:19.465] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:92:0)
[04:17:19.465] Timer tick, asking Buildbucket for the build status
[04:17:19.981] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:19.981] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:93:0) after 1m0s
[04:18:20.032] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:93:0)
[04:18:20.032] Timer tick, asking Buildbucket for the build status
[04:18:20.299] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:20.299] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:94:0) after 1m0s
[04:19:20.345] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:94:0)
[04:19:20.345] Timer tick, asking Buildbucket for the build status
[04:19:20.525] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:20.525] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:95:0) after 1m0s
[04:20:20.592] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:95:0)
[04:20:20.592] Timer tick, asking Buildbucket for the build status
[04:20:20.821] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:20.821] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:96:0) after 1m0s
[04:21:20.887] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:96:0)
[04:21:20.887] Timer tick, asking Buildbucket for the build status
[04:21:21.408] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:21.408] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:97:0) after 1m0s
[04:22:21.485] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:97:0)
[04:22:21.485] Timer tick, asking Buildbucket for the build status
[04:22:21.635] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:21.635] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:98:0) after 1m0s
[04:23:21.684] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:98:0)
[04:23:21.684] Timer tick, asking Buildbucket for the build status
[04:23:21.902] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:21.902] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:99:0) after 1m0s
[04:24:21.926] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:99:0)
[04:24:21.926] Timer tick, asking Buildbucket for the build status
[04:24:22.076] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:22.076] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:100:0) after 1m0s
[04:25:22.132] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:100:0)
[04:25:22.132] Timer tick, asking Buildbucket for the build status
[04:25:22.284] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:22.285] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:101:0) after 1m0s
[04:26:22.319] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:101:0)
[04:26:22.319] Timer tick, asking Buildbucket for the build status
[04:26:22.652] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:22.652] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:102:0) after 1m0s
[04:27:22.757] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:102:0)
[04:27:22.757] Timer tick, asking Buildbucket for the build status
[04:27:22.929] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:22.929] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:103:0) after 1m0s
[04:28:23.072] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:103:0)
[04:28:23.072] Timer tick, asking Buildbucket for the build status
[04:28:23.814] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:23.814] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:104:0) after 1m0s
[04:29:23.948] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:104:0)
[04:29:23.948] Timer tick, asking Buildbucket for the build status
[04:29:24.146] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:24.146] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:105:0) after 1m0s
[04:30:24.286] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:105:0)
[04:30:24.286] Timer tick, asking Buildbucket for the build status
[04:30:24.483] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:24.483] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:106:0) after 1m0s
[04:31:24.599] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:106:0)
[04:31:24.599] Timer tick, asking Buildbucket for the build status
[04:31:26.944] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:26.944] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:107:0) after 1m0s
[04:32:26.970] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:107:0)
[04:32:26.970] Timer tick, asking Buildbucket for the build status
[04:32:27.223] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:27.223] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:108:0) after 1m0s
[04:33:27.309] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:108:0)
[04:33:27.309] Timer tick, asking Buildbucket for the build status
[04:33:27.486] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:27.486] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:109:0) after 1m0s
[04:34:27.741] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:109:0)
[04:34:27.741] Timer tick, asking Buildbucket for the build status
[04:34:28.029] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:28.029] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:110:0) after 1m0s
[04:35:28.238] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:110:0)
[04:35:28.238] Timer tick, asking Buildbucket for the build status
[04:35:29.436] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:29.436] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:111:0) after 1m0s
[04:36:29.524] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:111:0)
[04:36:29.524] Timer tick, asking Buildbucket for the build status
[04:36:29.749] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:29.749] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:112:0) after 1m0s
[04:37:29.791] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:112:0)
[04:37:29.791] Timer tick, asking Buildbucket for the build status
[04:37:30.119] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:30.119] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:113:0) after 1m0s
[04:38:30.155] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:113:0)
[04:38:30.155] Timer tick, asking Buildbucket for the build status
[04:38:30.446] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:30.446] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:114:0) after 1m0s
[04:39:30.482] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:114:0)
[04:39:30.482] Timer tick, asking Buildbucket for the build status
[04:39:30.681] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:30.681] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:115:0) after 1m0s
[04:40:30.788] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:115:0)
[04:40:30.788] Timer tick, asking Buildbucket for the build status
[04:40:31.018] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:31.018] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:116:0) after 1m0s
[04:41:31.059] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:116:0)
[04:41:31.059] Timer tick, asking Buildbucket for the build status
[04:41:31.293] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:31.293] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:117:0) after 1m0s
[04:42:31.321] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:117:0)
[04:42:31.321] Timer tick, asking Buildbucket for the build status
[04:42:31.505] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:31.505] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:118:0) after 1m0s
[04:43:31.528] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:118:0)
[04:43:31.528] Timer tick, asking Buildbucket for the build status
[04:43:31.767] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:31.767] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:119:0) after 1m0s
[04:44:31.796] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:119:0)
[04:44:31.796] Timer tick, asking Buildbucket for the build status
[04:44:33.317] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:33.317] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:120:0) after 1m0s
[04:45:33.384] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:120:0)
[04:45:33.384] Timer tick, asking Buildbucket for the build status
[04:45:33.567] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:33.567] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:121:0) after 1m0s
[04:46:33.638] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:121:0)
[04:46:33.638] Timer tick, asking Buildbucket for the build status
[04:46:33.865] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:33.865] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:122:0) after 1m0s
[04:47:33.890] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:122:0)
[04:47:33.890] Timer tick, asking Buildbucket for the build status
[04:47:34.771] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:34.771] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:123:0) after 1m0s
[04:48:34.795] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:123:0)
[04:48:34.795] Timer tick, asking Buildbucket for the build status
[04:48:35.178] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:35.178] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:124:0) after 1m0s
[04:49:35.204] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:124:0)
[04:49:35.204] Timer tick, asking Buildbucket for the build status
[04:49:35.400] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:35.400] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:125:0) after 1m0s
[04:50:35.428] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:125:0)
[04:50:35.428] Timer tick, asking Buildbucket for the build status
[04:50:35.628] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:35.628] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:126:0) after 1m0s
[04:51:35.856] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:126:0)
[04:51:35.856] Timer tick, asking Buildbucket for the build status
[04:51:36.053] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:36.053] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:127:0) after 1m0s
[04:52:36.214] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:127:0)
[04:52:36.214] Timer tick, asking Buildbucket for the build status
[04:52:37.430] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:37.430] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:128:0) after 1m0s
[04:53:37.435] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:128:0)
[04:53:37.435] Timer tick, asking Buildbucket for the build status
[04:53:38.030] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:38.030] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:129:0) after 1m0s
[04:54:38.142] Handling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:129:0)
[04:54:38.142] Timer tick, asking Buildbucket for the build status
[04:54:38.992] Build 8903463686289352944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:38.992] Scheduling timer "check-buildbucket-build-status" (chromium/CrWinAsan:9068893748481624160:130:0) after 1m0s
[04:55:15.960] Received PubSub notification, asking Buildbucket for the build status
[04:55:16.765] Build 8903463686289352944: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[04:55:16.765] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1567400105708163",
"created_by": "project:chromium",
"created_ts": "1567392377538775",
"failure_reason": "BUILD_FAILURE",
"id": "8903463686289352944",
"parameters_json": "{\"builder_name\": \"CrWinAsan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"78c473c9edd03cad13eeab706965478a4ec2c0c2\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"#### Step _compile_ failed. Error logs are shown below:\\n```\\n[27067/59006] CXX obj/components/password_manager/core/browser/form_parsing/unit_tests/form_parser_unittest.obj\\nFAILED: obj/components/password_manager/core/browser/form_parsing/unit_tests/form_parser_unittest.obj\\n..\\\\..\\\\third_party\\\\llvm-build\\\\Release+Asserts\\\\bin\\\\clang-cl.exe /nologo /showIncludes -imsvc..\\\\..\\\\thir...(too long)\\n../../components/password_manager/core/browser/form_parsing/form_parser_unittest.cc(447,11): warning: mixture of designated and non-designated initializers in the same initializer list is a C99 extension [-Wc99-designator]\\n.number_of_all_possible_passwords = 1,\\n^~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~\\n```\\n##### ...The message was too long...\\n#### More information in raw_io.output[failure_summary]\"}, \"properties\": {\"$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-yuf7\", \"branch\": \"refs/heads/master\", \"buildername\": \"CrWinAsan\", \"buildnumber\": 3835, \"got_angle_revision\": \"791ad7b8774a06c996467eb9e6e5137b1e4ef452\", \"got_clang_revision\": \"370620-3ab21086-0\", \"got_dawn_revision\": \"824424fa351be2b2eccd78b2f31de1d5d1ad4183\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"78c473c9edd03cad13eeab706965478a4ec2c0c2\", \"got_revision_cp\": \"refs/heads/master@{#692390}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"69d20d247f62a3378d15ce0956ed8bf9665e6a44\", \"got_v8_revision_cp\": \"refs/heads/7.8.243@{#1}\", \"got_webrtc_revision\": \"ce6a0c8fb3f3a19caa797d5913b7e7c8ecf3ca9b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29029}\", \"mastername\": \"chromium.clang\", \"path_config\": \"generic\", \"perf_dashboard_machine_group\": \"ChromiumClang\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"78c473c9edd03cad13eeab706965478a4ec2c0c2\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"git\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-3-yuf7\"], \"image\": [\"chrome-win10-1703-19072400-fedda89f1f1\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"4397-8786906\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}, \"ui\": {\"info\": \"#### Step _compile_ failed. Error logs are shown below:\\n```\\n[27067/59006] CXX obj/components/password_manager/core/browser/form_parsing/unit_tests/form_parser_unittest.obj\\nFAILED: obj/components/password_manager/core/browser/form_parsing/unit_tests/form_parser_unittest.obj\\n..\\\\..\\\\third_party\\\\llvm-build\\\\Release+Asserts\\\\bin\\\\clang-cl.exe /nologo /showIncludes -imsvc..\\\\..\\\\thir...(too long)\\n../../components/password_manager/core/browser/form_parsing/form_parser_unittest.cc(447,11): warning: mixture of designated and non-designated initializers in the same initializer list is a C99 extension [-Wc99-designator]\\n.number_of_all_possible_passwords = 1,\\n^~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~\\n```\\n##### ...The message was too long...\\n#### More information in raw_io.output[failure_summary]\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1567392711799102",
"status": "COMPLETED",
"status_changed_ts": "1567392712124155",
"tags": [
"build_address:luci.chromium.ci/CrWinAsan/3835",
"builder:CrWinAsan",
"buildset:commit/git/78c473c9edd03cad13eeab706965478a4ec2c0c2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/78c473c9edd03cad13eeab706965478a4ec2c0c2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9068893748481624160",
"scheduler_job_id:chromium/CrWinAsan",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8903463686289352944/+/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:4708af370fe34410",
"user_agent:luci-scheduler"
],
"updated_ts": "1567400106012882",
"url": "https://ci.chromium.org/b/8903463686289352944",
"utcnow_ts": "1567400116753016"
}
}
[04:55:16.765] Invocation finished in 2h9m0.702159163s with status FAILED