[02:34:41.356] New invocation is queued and will start shortly
[02:34:42.454] Starting the invocation (attempt 1)
[02:34:42.503] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:34:42.509] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:34:42.509] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030390766232449520",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"2df92bc7b4cd7358d21cd5aaec048176ecbb5ebc\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9030390766232449520",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/2df92bc7b4cd7358d21cd5aaec048176ecbb5ebc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2df92bc7b4cd7358d21cd5aaec048176ecbb5ebc",
"gitiles_ref:refs/heads/master"
]
}
[02:34:43.744] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604111682678898",
"id": "8864960704182750528",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2df92bc7b4cd7358d21cd5aaec048176ecbb5ebc\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604111683580912",
"tags": [
"build_address:luci.chromium.ci/win-asan/15376",
"builder:win-asan",
"buildset:commit/git/2df92bc7b4cd7358d21cd5aaec048176ecbb5ebc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2df92bc7b4cd7358d21cd5aaec048176ecbb5ebc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030390766232449520",
"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/8864960704182750528/+/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": "1604111683581028",
"url": "https://ci.chromium.org/b/8864960704182750528",
"utcnow_ts": "1604111683734715"
}
}
[02:34:43.744] Task URL: https://ci.chromium.org/b/8864960704182750528
[02:34:43.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:2:0) after 1m0s
[02:35:43.749] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:2:0)
[02:35:43.749] Timer tick, asking Buildbucket for the build status
[02:35:43.857] Build 8864960704182750528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:35:43.857] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:3:0) after 1m0s
[02:36:43.888] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:3:0)
[02:36:43.888] Timer tick, asking Buildbucket for the build status
[02:36:43.983] Build 8864960704182750528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:36:43.983] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:4:0) after 1m0s
[02:37:44.071] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:4:0)
[02:37:44.071] Timer tick, asking Buildbucket for the build status
[02:37:44.563] Build 8864960704182750528: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:37:44.563] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:5:0) after 1m0s
[02:38:39.432] Received PubSub notification, asking Buildbucket for the build status
[02:38:39.668] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:44.621] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:5:0)
[02:38:44.621] Timer tick, asking Buildbucket for the build status
[02:38:44.717] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:44.717] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:7:0) after 1m0s
[02:39:44.743] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:7:0)
[02:39:44.743] Timer tick, asking Buildbucket for the build status
[02:39:44.823] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:44.823] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:8:0) after 1m0s
[02:40:44.925] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:8:0)
[02:40:44.925] Timer tick, asking Buildbucket for the build status
[02:40:45.141] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:45.141] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:9:0) after 1m0s
[02:41:45.225] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:9:0)
[02:41:45.225] Timer tick, asking Buildbucket for the build status
[02:41:45.592] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:45.592] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:10:0) after 1m0s
[02:42:45.612] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:10:0)
[02:42:45.612] Timer tick, asking Buildbucket for the build status
[02:42:46.064] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:46.064] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:11:0) after 1m0s
[02:43:46.109] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:11:0)
[02:43:46.109] Timer tick, asking Buildbucket for the build status
[02:43:46.175] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:46.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:12:0) after 1m0s
[02:44:46.196] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:12:0)
[02:44:46.196] Timer tick, asking Buildbucket for the build status
[02:44:46.672] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:46.672] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:13:0) after 1m0s
[02:45:46.725] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:13:0)
[02:45:46.725] Timer tick, asking Buildbucket for the build status
[02:45:46.942] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:46.942] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:14:0) after 1m0s
[02:46:47.043] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:14:0)
[02:46:47.043] Timer tick, asking Buildbucket for the build status
[02:46:47.115] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:47.115] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:15:0) after 1m0s
[02:47:47.143] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:15:0)
[02:47:47.143] Timer tick, asking Buildbucket for the build status
[02:47:47.526] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:47.526] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:16:0) after 1m0s
[02:48:47.536] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:16:0)
[02:48:47.536] Timer tick, asking Buildbucket for the build status
[02:48:47.647] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:47.647] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:17:0) after 1m0s
[02:49:47.665] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:17:0)
[02:49:47.665] Timer tick, asking Buildbucket for the build status
[02:49:47.855] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:47.856] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:18:0) after 1m0s
[02:50:47.907] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:18:0)
[02:50:47.907] Timer tick, asking Buildbucket for the build status
[02:50:48.028] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:48.028] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:19:0) after 1m0s
[02:51:48.057] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:19:0)
[02:51:48.057] Timer tick, asking Buildbucket for the build status
[02:51:48.237] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:48.237] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:20:0) after 1m0s
[02:52:48.306] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:20:0)
[02:52:48.306] Timer tick, asking Buildbucket for the build status
[02:52:48.431] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:48.431] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:21:0) after 1m0s
[02:53:48.456] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:21:0)
[02:53:48.456] Timer tick, asking Buildbucket for the build status
[02:53:48.535] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:48.535] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:22:0) after 1m0s
[02:54:48.583] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:22:0)
[02:54:48.583] Timer tick, asking Buildbucket for the build status
[02:54:48.722] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:48.722] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:23:0) after 1m0s
[02:55:48.744] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:23:0)
[02:55:48.744] Timer tick, asking Buildbucket for the build status
[02:55:48.870] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:48.870] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:24:0) after 1m0s
[02:56:48.893] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:24:0)
[02:56:48.893] Timer tick, asking Buildbucket for the build status
[02:56:48.958] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:48.958] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:25:0) after 1m0s
[02:57:48.997] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:25:0)
[02:57:48.997] Timer tick, asking Buildbucket for the build status
[02:57:49.066] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:49.066] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:26:0) after 1m0s
[02:58:49.096] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:26:0)
[02:58:49.096] Timer tick, asking Buildbucket for the build status
[02:58:49.156] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:49.156] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:27:0) after 1m0s
[02:59:49.216] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:27:0)
[02:59:49.216] Timer tick, asking Buildbucket for the build status
[02:59:49.573] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:49.573] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:28:0) after 1m0s
[03:00:49.583] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:28:0)
[03:00:49.583] Timer tick, asking Buildbucket for the build status
[03:00:49.709] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:49.709] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:29:0) after 1m0s
[03:01:49.765] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:29:0)
[03:01:49.765] Timer tick, asking Buildbucket for the build status
[03:01:49.839] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:49.839] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:30:0) after 1m0s
[03:02:49.895] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:30:0)
[03:02:49.895] Timer tick, asking Buildbucket for the build status
[03:02:49.959] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:49.959] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:31:0) after 1m0s
[03:03:49.997] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:31:0)
[03:03:49.997] Timer tick, asking Buildbucket for the build status
[03:03:50.074] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:50.074] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:32:0) after 1m0s
[03:04:50.101] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:32:0)
[03:04:50.101] Timer tick, asking Buildbucket for the build status
[03:04:50.276] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:50.276] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:33:0) after 1m0s
[03:05:50.388] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:33:0)
[03:05:50.388] Timer tick, asking Buildbucket for the build status
[03:05:50.786] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:50.786] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:34:0) after 1m0s
[03:06:50.806] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:34:0)
[03:06:50.806] Timer tick, asking Buildbucket for the build status
[03:06:50.883] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:50.883] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:35:0) after 1m0s
[03:07:50.903] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:35:0)
[03:07:50.903] Timer tick, asking Buildbucket for the build status
[03:07:51.072] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:51.072] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:36:0) after 1m0s
[03:08:51.102] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:36:0)
[03:08:51.102] Timer tick, asking Buildbucket for the build status
[03:08:51.278] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:51.278] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:37:0) after 1m0s
[03:09:51.322] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:37:0)
[03:09:51.322] Timer tick, asking Buildbucket for the build status
[03:09:51.431] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:51.431] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:38:0) after 1m0s
[03:10:51.445] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:38:0)
[03:10:51.445] Timer tick, asking Buildbucket for the build status
[03:10:51.514] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:51.515] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:39:0) after 1m0s
[03:11:51.545] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:39:0)
[03:11:51.545] Timer tick, asking Buildbucket for the build status
[03:11:51.765] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:51.765] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:40:0) after 1m0s
[03:12:51.799] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:40:0)
[03:12:51.799] Timer tick, asking Buildbucket for the build status
[03:12:51.859] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:51.859] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:41:0) after 1m0s
[03:13:51.882] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:41:0)
[03:13:51.882] Timer tick, asking Buildbucket for the build status
[03:13:52.054] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:52.054] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:42:0) after 1m0s
[03:14:52.082] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:42:0)
[03:14:52.082] Timer tick, asking Buildbucket for the build status
[03:14:52.392] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:52.392] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:43:0) after 1m0s
[03:15:52.451] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:43:0)
[03:15:52.451] Timer tick, asking Buildbucket for the build status
[03:15:52.556] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:52.556] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:44:0) after 1m0s
[03:16:52.614] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:44:0)
[03:16:52.614] Timer tick, asking Buildbucket for the build status
[03:16:52.695] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:52.695] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:45:0) after 1m0s
[03:17:52.750] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:45:0)
[03:17:52.750] Timer tick, asking Buildbucket for the build status
[03:17:53.183] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:53.183] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:46:0) after 1m0s
[03:18:53.258] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:46:0)
[03:18:53.258] Timer tick, asking Buildbucket for the build status
[03:18:53.369] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:53.369] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:47:0) after 1m0s
[03:19:53.579] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:47:0)
[03:19:53.579] Timer tick, asking Buildbucket for the build status
[03:19:53.705] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:53.705] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:48:0) after 1m0s
[03:20:53.805] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:48:0)
[03:20:53.805] Timer tick, asking Buildbucket for the build status
[03:20:53.896] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:53.896] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:49:0) after 1m0s
[03:21:54.024] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:49:0)
[03:21:54.024] Timer tick, asking Buildbucket for the build status
[03:21:54.092] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:54.092] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:50:0) after 1m0s
[03:22:54.135] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:50:0)
[03:22:54.135] Timer tick, asking Buildbucket for the build status
[03:22:54.336] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:54.336] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:51:0) after 1m0s
[03:23:54.367] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:51:0)
[03:23:54.367] Timer tick, asking Buildbucket for the build status
[03:23:54.513] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:54.513] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:52:0) after 1m0s
[03:24:54.551] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:52:0)
[03:24:54.551] Timer tick, asking Buildbucket for the build status
[03:24:54.714] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:54.714] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:53:0) after 1m0s
[03:25:54.805] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:53:0)
[03:25:54.805] Timer tick, asking Buildbucket for the build status
[03:25:55.529] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:55.529] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:54:0) after 1m0s
[03:26:55.588] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:54:0)
[03:26:55.588] Timer tick, asking Buildbucket for the build status
[03:26:55.696] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:55.696] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:55:0) after 1m0s
[03:27:55.718] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:55:0)
[03:27:55.719] Timer tick, asking Buildbucket for the build status
[03:27:55.882] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:55.882] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:56:0) after 1m0s
[03:28:55.960] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:56:0)
[03:28:55.960] Timer tick, asking Buildbucket for the build status
[03:28:56.093] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:56.093] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:57:0) after 1m0s
[03:29:56.296] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:57:0)
[03:29:56.296] Timer tick, asking Buildbucket for the build status
[03:29:56.418] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:56.418] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:58:0) after 1m0s
[03:30:56.557] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:58:0)
[03:30:56.557] Timer tick, asking Buildbucket for the build status
[03:30:56.634] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:56.634] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:59:0) after 1m0s
[03:31:56.769] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:59:0)
[03:31:56.769] Timer tick, asking Buildbucket for the build status
[03:31:56.841] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:56.841] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:60:0) after 1m0s
[03:32:56.879] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:60:0)
[03:32:56.879] Timer tick, asking Buildbucket for the build status
[03:32:57.019] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:57.019] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:61:0) after 1m0s
[03:33:57.043] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:61:0)
[03:33:57.043] Timer tick, asking Buildbucket for the build status
[03:33:57.881] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:57.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:62:0) after 1m0s
[03:34:58.039] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:62:0)
[03:34:58.039] Timer tick, asking Buildbucket for the build status
[03:34:58.150] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:58.150] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:63:0) after 1m0s
[03:35:58.183] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:63:0)
[03:35:58.183] Timer tick, asking Buildbucket for the build status
[03:35:58.287] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:58.287] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:64:0) after 1m0s
[03:36:58.310] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:64:0)
[03:36:58.310] Timer tick, asking Buildbucket for the build status
[03:36:58.429] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:58.429] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:65:0) after 1m0s
[03:37:58.454] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:65:0)
[03:37:58.454] Timer tick, asking Buildbucket for the build status
[03:37:58.778] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:58.778] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:66:0) after 1m0s
[03:38:58.795] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:66:0)
[03:38:58.795] Timer tick, asking Buildbucket for the build status
[03:38:59.104] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:59.104] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:67:0) after 1m0s
[03:39:59.145] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:67:0)
[03:39:59.145] Timer tick, asking Buildbucket for the build status
[03:39:59.254] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:59.254] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:68:0) after 1m0s
[03:40:59.362] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:68:0)
[03:40:59.362] Timer tick, asking Buildbucket for the build status
[03:40:59.613] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:59.613] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:69:0) after 1m0s
[03:41:59.649] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:69:0)
[03:41:59.649] Timer tick, asking Buildbucket for the build status
[03:42:00.204] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:00.204] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:70:0) after 1m0s
[03:43:00.222] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:70:0)
[03:43:00.222] Timer tick, asking Buildbucket for the build status
[03:43:00.536] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:00.536] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:71:0) after 1m0s
[03:44:00.561] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:71:0)
[03:44:00.561] Timer tick, asking Buildbucket for the build status
[03:44:00.704] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:00.704] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:72:0) after 1m0s
[03:45:00.736] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:72:0)
[03:45:00.736] Timer tick, asking Buildbucket for the build status
[03:45:01.285] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:01.285] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:73:0) after 1m0s
[03:46:02.087] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:73:0)
[03:46:02.087] Timer tick, asking Buildbucket for the build status
[03:46:02.272] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:02.272] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:74:0) after 1m0s
[03:47:02.654] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:74:0)
[03:47:02.654] Timer tick, asking Buildbucket for the build status
[03:47:02.765] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:02.765] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:75:0) after 1m0s
[03:48:02.899] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:75:0)
[03:48:02.899] Timer tick, asking Buildbucket for the build status
[03:48:03.145] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:03.145] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:76:0) after 1m0s
[03:49:03.172] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:76:0)
[03:49:03.172] Timer tick, asking Buildbucket for the build status
[03:49:03.454] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:03.454] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:77:0) after 1m0s
[03:50:03.608] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:77:0)
[03:50:03.608] Timer tick, asking Buildbucket for the build status
[03:50:03.945] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:03.945] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:78:0) after 1m0s
[03:51:03.980] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:78:0)
[03:51:03.980] Timer tick, asking Buildbucket for the build status
[03:51:04.060] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:04.060] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:79:0) after 1m0s
[03:52:04.087] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:79:0)
[03:52:04.087] Timer tick, asking Buildbucket for the build status
[03:52:04.155] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:04.155] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:80:0) after 1m0s
[03:53:04.197] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:80:0)
[03:53:04.197] Timer tick, asking Buildbucket for the build status
[03:53:04.409] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:04.409] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:81:0) after 1m0s
[03:54:04.444] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:81:0)
[03:54:04.444] Timer tick, asking Buildbucket for the build status
[03:54:04.619] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:04.619] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:82:0) after 1m0s
[03:55:04.619] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:82:0)
[03:55:04.619] Timer tick, asking Buildbucket for the build status
[03:55:04.748] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:04.748] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:83:0) after 1m0s
[03:56:04.901] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:83:0)
[03:56:04.901] Timer tick, asking Buildbucket for the build status
[03:56:05.092] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:05.092] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:84:0) after 1m0s
[03:57:05.177] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:84:0)
[03:57:05.177] Timer tick, asking Buildbucket for the build status
[03:57:05.312] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:05.312] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:85:0) after 1m0s
[03:58:05.441] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:85:0)
[03:58:05.441] Timer tick, asking Buildbucket for the build status
[03:58:05.512] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:05.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:86:0) after 1m0s
[03:59:06.007] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:86:0)
[03:59:06.007] Timer tick, asking Buildbucket for the build status
[03:59:06.129] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:06.129] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:87:0) after 1m0s
[04:00:06.223] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:87:0)
[04:00:06.223] Timer tick, asking Buildbucket for the build status
[04:00:06.464] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:06.464] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:88:0) after 1m0s
[04:01:07.087] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:88:0)
[04:01:07.087] Timer tick, asking Buildbucket for the build status
[04:01:07.179] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:07.179] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:89:0) after 1m0s
[04:02:07.380] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:89:0)
[04:02:07.380] Timer tick, asking Buildbucket for the build status
[04:02:07.460] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:07.460] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:90:0) after 1m0s
[04:03:07.477] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:90:0)
[04:03:07.477] Timer tick, asking Buildbucket for the build status
[04:03:07.603] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:07.603] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:91:0) after 1m0s
[04:04:07.630] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:91:0)
[04:04:07.630] Timer tick, asking Buildbucket for the build status
[04:04:07.769] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:07.769] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:92:0) after 1m0s
[04:05:07.809] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:92:0)
[04:05:07.809] Timer tick, asking Buildbucket for the build status
[04:05:07.929] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:07.929] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:93:0) after 1m0s
[04:06:08.042] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:93:0)
[04:06:08.042] Timer tick, asking Buildbucket for the build status
[04:06:08.166] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:08.166] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:94:0) after 1m0s
[04:07:08.311] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:94:0)
[04:07:08.311] Timer tick, asking Buildbucket for the build status
[04:07:08.591] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:08.591] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:95:0) after 1m0s
[04:08:08.668] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:95:0)
[04:08:08.668] Timer tick, asking Buildbucket for the build status
[04:08:08.966] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:08.966] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:96:0) after 1m0s
[04:09:09.001] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:96:0)
[04:09:09.001] Timer tick, asking Buildbucket for the build status
[04:09:09.086] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:09.086] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:97:0) after 1m0s
[04:10:09.186] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:97:0)
[04:10:09.186] Timer tick, asking Buildbucket for the build status
[04:10:09.606] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:09.606] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:98:0) after 1m0s
[04:11:09.620] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:98:0)
[04:11:09.620] Timer tick, asking Buildbucket for the build status
[04:11:09.706] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:09.706] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:99:0) after 1m0s
[04:12:09.788] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:99:0)
[04:12:09.788] Timer tick, asking Buildbucket for the build status
[04:12:09.937] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:09.938] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:100:0) after 1m0s
[04:13:10.026] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:100:0)
[04:13:10.026] Timer tick, asking Buildbucket for the build status
[04:13:10.103] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:10.103] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:101:0) after 1m0s
[04:14:10.218] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:101:0)
[04:14:10.218] Timer tick, asking Buildbucket for the build status
[04:14:10.302] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:10.302] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:102:0) after 1m0s
[04:15:10.441] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:102:0)
[04:15:10.441] Timer tick, asking Buildbucket for the build status
[04:15:10.637] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:10.637] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:103:0) after 1m0s
[04:16:13.417] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:103:0)
[04:16:13.417] Timer tick, asking Buildbucket for the build status
[04:16:13.660] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:13.660] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:104:0) after 1m0s
[04:17:13.971] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:104:0)
[04:17:13.971] Timer tick, asking Buildbucket for the build status
[04:17:14.056] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:14.056] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:105:0) after 1m0s
[04:18:14.198] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:105:0)
[04:18:14.198] Timer tick, asking Buildbucket for the build status
[04:18:14.517] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:14.517] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:106:0) after 1m0s
[04:19:14.612] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:106:0)
[04:19:14.612] Timer tick, asking Buildbucket for the build status
[04:19:14.680] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:14.680] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:107:0) after 1m0s
[04:20:14.820] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:107:0)
[04:20:14.820] Timer tick, asking Buildbucket for the build status
[04:20:14.942] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:14.942] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:108:0) after 1m0s
[04:21:14.966] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:108:0)
[04:21:14.966] Timer tick, asking Buildbucket for the build status
[04:21:15.038] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:15.038] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:109:0) after 1m0s
[04:22:15.131] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:109:0)
[04:22:15.131] Timer tick, asking Buildbucket for the build status
[04:22:15.219] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:15.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:110:0) after 1m0s
[04:23:15.288] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:110:0)
[04:23:15.288] Timer tick, asking Buildbucket for the build status
[04:23:15.370] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:15.370] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:111:0) after 1m0s
[04:24:15.407] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:111:0)
[04:24:15.407] Timer tick, asking Buildbucket for the build status
[04:24:15.539] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:15.539] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:112:0) after 1m0s
[04:25:15.608] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:112:0)
[04:25:15.608] Timer tick, asking Buildbucket for the build status
[04:25:15.920] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:15.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:113:0) after 1m0s
[04:26:15.896] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:113:0)
[04:26:15.896] Timer tick, asking Buildbucket for the build status
[04:26:16.487] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:16.487] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:114:0) after 1m0s
[04:27:16.535] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:114:0)
[04:27:16.535] Timer tick, asking Buildbucket for the build status
[04:27:16.609] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:16.609] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:115:0) after 1m0s
[04:28:16.650] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:115:0)
[04:28:16.650] Timer tick, asking Buildbucket for the build status
[04:28:16.725] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:16.725] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:116:0) after 1m0s
[04:29:16.742] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:116:0)
[04:29:16.742] Timer tick, asking Buildbucket for the build status
[04:29:16.825] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:16.825] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:117:0) after 1m0s
[04:30:16.900] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:117:0)
[04:30:16.900] Timer tick, asking Buildbucket for the build status
[04:30:17.086] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:17.086] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:118:0) after 1m0s
[04:31:17.149] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:118:0)
[04:31:17.149] Timer tick, asking Buildbucket for the build status
[04:31:17.488] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:17.488] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:119:0) after 1m0s
[04:32:17.511] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:119:0)
[04:32:17.511] Timer tick, asking Buildbucket for the build status
[04:32:17.980] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:17.980] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:120:0) after 1m0s
[04:33:18.003] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:120:0)
[04:33:18.003] Timer tick, asking Buildbucket for the build status
[04:33:18.110] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:18.110] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:121:0) after 1m0s
[04:34:18.145] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:121:0)
[04:34:18.145] Timer tick, asking Buildbucket for the build status
[04:34:18.293] Build 8864960704182750528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:18.293] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030390766232449520:122:0) after 1m0s
[04:34:36.334] Received PubSub notification, asking Buildbucket for the build status
[04:34:36.671] Build 8864960704182750528: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[04:34:36.671] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604118875358539",
"created_by": "project:chromium",
"created_ts": "1604111682678898",
"failure_reason": "BUILD_FAILURE",
"id": "8864960704182750528",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2df92bc7b4cd7358d21cd5aaec048176ecbb5ebc\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**gcp_unittests** failed because of:\\n\\n- All/AssociatedUserValidatorUserAccessBlockingTest.BlockUserAccessAsNeeded/21519\\n\\n- All/AssociatedUserValidatorUserAccessBlockingTest.BlockUserAccessAsNeeded/21518\\n\\n- All/AssociatedUserValidatorUserAccessBlockingTest.BlockUserAccessAsNeeded/21515\\n\\n- All/AssociatedUserValidatorUserAccessBlockingTest.BlockUserAccessAsNeeded/21514\\n\\n- ...27471 more failure(s) (27475 total)...\"}, \"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\": \"2df92bc7b4cd7358d21cd5aaec048176ecbb5ebc\", \"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-9-6o02\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15376, \"clang_revision\": \"llvmorg-12-init-5627-gf086e85e-2\", \"got_angle_revision\": \"42ad027982404039e6c9a921b2f6354f55b65a2e\", \"got_dawn_revision\": \"0a374dce665328391ab3b68fd9e667b018dd9dcd\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"2df92bc7b4cd7358d21cd5aaec048176ecbb5ebc\", \"got_revision_cp\": \"refs/heads/master@{#822930}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"e0de282e678b72dac25b81f8d25305231aec01f8\", \"got_v8_revision\": \"96789f0aa67d93ea125191724666dab1be5a639c\", \"got_v8_revision_cp\": \"refs/heads/8.8.213@{#1}\", \"got_webrtc_revision\": \"ee24eb66d23ffea5ef729dc340e1fc4381c72a4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32507}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2df92bc7b4cd7358d21cd5aaec048176ecbb5ebc\", \"swarm_hashes_refs/heads/master(at){#822930}_without_patch\": {\"absl_hardening_tests\": \"2e87095e0cfd1a019732f4e3df2144ba0d1d1193\", \"accessibility_unittests\": \"f8e47ac80cffdb7b63c3b3647496d0c32e1adfe3\", \"angle_unittests\": \"e7c519629863f357e86274b60a8f9645b7e2aa6a\", \"app_shell_unittests\": \"284f07d388ae6408ae54619c33bbbec824801a92\", \"aura_unittests\": \"d0eb94120f838abfc5dd4b41f79512bfb7c759f6\", \"base_unittests\": \"135d627fc108413670741f797f7d4ec839401137\", \"base_util_unittests\": \"2f655ed18611b9e4f9479582570ce148a5318f10\", \"blink_common_unittests\": \"9642e5377db17bd22fd52cf7f7aa5987cac9b29f\", \"blink_fuzzer_unittests\": \"56569adf2b8bc0bd14baa8043a38e179a9af0d0b\", \"blink_heap_unittests\": \"38fba36cb69dc72df7391defa23b90e9c40e8ebd\", \"blink_platform_unittests\": \"39016600c2a87cf87d5bc15349826e54e6d31e4e\", \"blink_unittests\": \"643ae706431d26595c5af24daa6b3b69b27e8214\", \"boringssl_crypto_tests\": \"f954a0474e0c951eabf71a0ecd3ace7945442ac1\", \"boringssl_ssl_tests\": \"25afe0e19165337e666298d56c5f05655a054e61\", \"browser_switcher_bho_unittests\": \"e8449b36a0d138079c37936084f57e2d505af067\", \"browser_tests\": \"4d3817f407ec15572605b0b3e3c23728bf802d6d\", \"capture_unittests\": \"f432c98a67696421064b048e0be3ed6582ce696b\", \"cast_unittests\": \"92909ea084d0d702ac8e23c832ba01c784e21263\", \"cc_unittests\": \"7a6df4895e6efb96a55acc650525e45299cdf2a9\", \"chrome_app_unittests\": \"9590f5216e5e22736068242aa5fe3242e124272a\", \"chrome_cleaner_unittests\": \"2820c868eac44bab925d2fef1febf953a5aff504\", \"chrome_elf_unittests\": \"4b8973994377404a5ceaf9905f7b5ae58a414f31\", \"chromedriver_unittests\": \"22d96a4b769374759890b6c3ec972908d2eb84cf\", \"components_browsertests\": \"4a97e756eae862f1d345395749939ceb295cf794\", \"components_unittests\": \"c428394d673b14c4b4c82363523307e3a813ed2f\", \"compositor_unittests\": \"5f4a9dea273eac4f7b212944b63cef2196034f59\", \"content_browsertests\": \"a0211ac4a954326e62b01764d51cb7e4b722061c\", \"content_unittests\": \"92f56538b1f256ba62568959a2909ac2d2b57d18\", \"courgette_unittests\": \"e1851874035fad09eede300f69e440e426cc9a84\", \"crashpad_tests\": \"6adbadaf0746ee76b1be2857abd178e23a6ac968\", \"cronet_tests\": \"024ef5b05141dc0c1af8e183015b584b03a5fbf1\", \"cronet_unittests\": \"335920b99b58a47b0907ad902a326532d6282de8\", \"crypto_unittests\": \"97c26779384144af2f8ef63ce6d0317cecc21130\", \"delayloads_unittests\": \"f42b1d0364a5aed06894a9548e8070ce5ad17c7d\", \"device_unittests\": \"13da2431af88c9538e56bb8350f042ea029b264a\", \"display_unittests\": \"13b2597abcf451c3ab19bafa9ae05b7967256219\", \"elevation_service_unittests\": \"c8816f6576387d452f601e6fff2832b5740bc85d\", \"events_unittests\": \"545d37ed0a4856d47049b9f75699a21d04978bfa\", \"extensions_browsertests\": \"251ca4d87ad8956058e6b7450e7d61bf6395f975\", \"extensions_unittests\": \"499e6bfcc90c34335bb02f8aa2baff4134a3dc63\", \"filesystem_service_unittests\": \"d15fe72eb08faf348dbbdf307cfe5fd648f87915\", \"gcm_unit_tests\": \"473b338928855de36c73d712a292e002e21990f3\", \"gcp_unittests\": \"a993779c84297a3a3cd8beed0ba80cd7673ba675\", \"gfx_unittests\": \"fdb98004cdd190191c57b6d076da2a318c53fd1c\", \"gin_unittests\": \"ff7b75cfb89aec54dc51fb25c56bf0bbd32ee597\", \"google_apis_unittests\": \"b1dc5a43e2c0b8da7ad50c07bd08217347aa841e\", \"gpu_unittests\": \"3f654e8d00cb5679cb619a9d3ed9d1fa91b10e06\", \"gwp_asan_unittests\": \"f9d8bd400a75a882e1db54b1ccfc7bdf09c893c7\", \"headless_browsertests\": \"1ec5ec0d035faa10dc45a7b276e085bbd5acb2bb\", \"headless_unittests\": \"f18a8b4632fa03357e222d102a8c5754516b6c0e\", \"install_static_unittests\": \"2e4f35970ad34784dbfb5673ede6872569982636\", \"installer_util_unittests\": \"20ff69b22da4899a4aed0ed7843547eb213cda9a\", \"interactive_ui_tests\": \"bd5e121a1827c7268caf94fe6aaf50c5eadc5b65\", \"ipc_tests\": \"ec9c7e77369afd93901baf4dd4a2053b3f2c5644\", \"jingle_unittests\": \"b8f85286a1b660db401beae77b731be3b5e9587b\", \"latency_unittests\": \"699a9ccf10b708542d2e4c1bafa3a86231b8262b\", \"libjingle_xmpp_unittests\": \"d5b38e2a48632994941b722a9f847a1c4351acd9\", \"liburlpattern_unittests\": \"571557cd2869ce025cae59516e1568c8e727f443\", \"media_blink_unittests\": \"bed063cecbe0ee4bfc58bb9e543aaf4ce2fc56af\", \"media_unittests\": \"d2932f302175d6c505b2ee16bb53d2703efecf03\", \"message_center_unittests\": \"c7765bd29a0c1fbbf6ee975790405fb2cccf9912\", \"midi_unittests\": \"812fefecc99d63bda09bf1357deb70046e562f5a\", \"mojo_core_unittests\": \"036371f1d20a0aaf7c0687c8c67c3d752aeef641\", \"mojo_unittests\": \"ed6a95cc36c3c5d83851130d86dd22cf03454510\", \"nacl_loader_unittests\": \"0ae190120ac627a8f0a3b72571782bcb4838211f\", \"native_theme_unittests\": \"6dfb56e92d86fde6c722e6cba7d12c6b85d69f61\", \"net_unittests\": \"ad8ef919a84abfb52dcec3be9a5070de62ad6de9\", \"notification_helper_unittests\": \"63fb813f2173054dd77cdd3b5563565fc6fac373\", \"pdf_unittests\": \"060514166c619b5c2d6c6089753a66a402b82b92\", \"perfetto_unittests\": \"02bc4e682caffe0df7a165fa5d5cbca04ae3a334\", \"ppapi_unittests\": \"30da43de2febf3cca97c68a7e182dad70beed250\", \"printing_unittests\": \"66e449ff7d560b5e6465a793b0e5ad1549eaf400\", \"remoting_unittests\": \"046b709644bc935aee911157a41c2cf9aa79ea71\", \"sbox_integration_tests\": \"70079cef1b6e6d92358e111d64b4fca831d53218\", \"sbox_unittests\": \"7bc463a504b666d16a56e2d8ef385ef7eadfa45b\", \"sbox_validation_tests\": \"13ffa381e23f0df3dffd5c54d87330229d90de26\", \"service_manager_unittests\": \"f32fa209c883cd55c671ae984c827adc7d006496\", \"services_unittests\": \"98072d196b4e05cdf73d8b16c6a16670f771ef8f\", \"setup_unittests\": \"833bde0d7d5afd49d7721f65f0327ce9c1ebb633\", \"shell_dialogs_unittests\": \"e837008bad25b243b15e1ff0a9d4e6a25747457a\", \"skia_unittests\": \"1351b6f5093c0360b001be807549324d239844e0\", \"snapshot_unittests\": \"bc29ffc952443cb186832926d8dc445cda1ea7e6\", \"sql_unittests\": \"99a34037fc236b9e774fdda1c598529f8f61666b\", \"storage_unittests\": \"ee0226e896df102082f81fa85b88dfdfd6b97530\", \"sync_integration_tests\": \"ff24fd6bea965ef5fa8c4783c5419b2f921514c0\", \"traffic_annotation_auditor_unittests\": \"c20080a1dbd8ff6ae66f82a1b6ae04da9c1b5855\", \"ui_base_unittests\": \"b90f96da5cc29652285e1f9d5c824d94dbabf593\", \"ui_touch_selection_unittests\": \"e9d92db14a59843b6f1175916c364cbfff604a42\", \"unit_tests\": \"30e84362069d1fa06dc61317d35a3dbd60816882\", \"updater_tests\": \"3fa13f1dd2bb96d99b0b6dd8ffde04bb075b1fbe\", \"url_unittests\": \"f200faac86020c16f13b51293e548cdbd1e21026\", \"views_unittests\": \"80209d775e5210f25421f9c107030efb8d9fdd99\", \"viz_unittests\": \"7846d8f9a5bb3b4ea636dca9afe6be12249c0b8d\", \"vr_common_unittests\": \"4089db88a5a592169a5847b7062c81194241c47c\", \"vr_pixeltests\": \"b31d02085b4c0bf8d33477319321ab66a732f90b\", \"weblayer_browsertests\": \"6a5174f67b9e13fdc39e99b83676eafe89e8ade7\", \"weblayer_unittests\": \"96267fe0166cafcc7409442fde8045d7fe108538\", \"wm_unittests\": \"224ccc16ad7cab3dbcf1a0a1e4b6bf997dd03c26\", \"wtf_unittests\": \"248521d3496215efbc5f5c35cbb54a1e6b0ff4da\", \"zlib_unittests\": \"8fe9ed9c79fd1ffe3851bdfe39929c98a15a5da0\", \"zucchini_unittests\": \"6f1776b1906677f2577d20dd753e7b8b83883057\"}}, \"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-9-6o02\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**gcp_unittests** failed because of:\\n\\n- All/AssociatedUserValidatorUserAccessBlockingTest.BlockUserAccessAsNeeded/21519\\n\\n- All/AssociatedUserValidatorUserAccessBlockingTest.BlockUserAccessAsNeeded/21518\\n\\n- All/AssociatedUserValidatorUserAccessBlockingTest.BlockUserAccessAsNeeded/21515\\n\\n- All/AssociatedUserValidatorUserAccessBlockingTest.BlockUserAccessAsNeeded/21514\\n\\n- ...27471 more failure(s) (27475 total)...\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604111918904958",
"status": "COMPLETED",
"status_changed_ts": "1604111919247975",
"tags": [
"build_address:luci.chromium.ci/win-asan/15376",
"builder:win-asan",
"buildset:commit/git/2df92bc7b4cd7358d21cd5aaec048176ecbb5ebc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2df92bc7b4cd7358d21cd5aaec048176ecbb5ebc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030390766232449520",
"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/8864960704182750528/+/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:4f955359f40ccb10",
"user_agent:luci-scheduler"
],
"updated_ts": "1604118875644508",
"url": "https://ci.chromium.org/b/8864960704182750528",
"utcnow_ts": "1604118876648832"
}
}
[04:34:36.671] Invocation finished in 1h59m55.331886052s with status FAILED