[23:56:26.545] New invocation is queued and will start shortly
[23:56:27.668] Starting the invocation (attempt 1)
[23:56:27.708] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:56:27.708] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:56:27.708] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022428189249558656",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"10767efbf7d9afec8d75062f137b6608c50225d1\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9022428189249558656",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/10767efbf7d9afec8d75062f137b6608c50225d1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/10767efbf7d9afec8d75062f137b6608c50225d1",
"gitiles_ref:refs/heads/master"
]
}
[23:56:29.098] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1611705387816325",
"id": "8856998127223773232",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"10767efbf7d9afec8d75062f137b6608c50225d1\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611705388763749",
"tags": [
"build_address:luci.chromium.ci/win-asan/17027",
"builder:win-asan",
"buildset:commit/git/10767efbf7d9afec8d75062f137b6608c50225d1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/10767efbf7d9afec8d75062f137b6608c50225d1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022428189249558656",
"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/8856998127223773232/+/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": "1611705388763950",
"url": "https://ci.chromium.org/b/8856998127223773232",
"utcnow_ts": "1611705389084361"
}
}
[23:56:29.098] Task URL: https://ci.chromium.org/b/8856998127223773232
[23:56:29.098] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:2:0) after 1m0s
[23:57:29.118] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:2:0)
[23:57:29.118] Timer tick, asking Buildbucket for the build status
[23:57:29.558] Build 8856998127223773232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:57:29.558] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:3:0) after 1m0s
[23:58:29.660] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:3:0)
[23:58:29.660] Timer tick, asking Buildbucket for the build status
[23:58:29.861] Build 8856998127223773232: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:58:29.861] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:4:0) after 1m0s
[23:59:04.112] Received PubSub notification, asking Buildbucket for the build status
[23:59:04.212] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:29.884] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:4:0)
[23:59:29.884] Timer tick, asking Buildbucket for the build status
[23:59:29.984] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:29.984] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:6:0) after 1m0s
[00:00:30.055] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:6:0)
[00:00:30.056] Timer tick, asking Buildbucket for the build status
[00:00:30.619] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:30.619] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:7:0) after 1m0s
[00:01:30.641] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:7:0)
[00:01:30.641] Timer tick, asking Buildbucket for the build status
[00:01:30.768] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:30.768] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:8:0) after 1m0s
[00:02:30.798] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:8:0)
[00:02:30.799] Timer tick, asking Buildbucket for the build status
[00:02:31.647] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:31.647] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:9:0) after 1m0s
[00:03:31.712] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:9:0)
[00:03:31.712] Timer tick, asking Buildbucket for the build status
[00:03:31.837] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:31.837] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:10:0) after 1m0s
[00:04:31.904] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:10:0)
[00:04:31.904] Timer tick, asking Buildbucket for the build status
[00:04:31.991] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:31.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:11:0) after 1m0s
[00:05:32.026] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:11:0)
[00:05:32.026] Timer tick, asking Buildbucket for the build status
[00:05:32.108] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:32.108] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:12:0) after 1m0s
[00:06:32.128] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:12:0)
[00:06:32.128] Timer tick, asking Buildbucket for the build status
[00:06:32.272] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:32.272] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:13:0) after 1m0s
[00:07:32.272] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:13:0)
[00:07:32.272] Timer tick, asking Buildbucket for the build status
[00:07:32.406] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:32.406] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:14:0) after 1m0s
[00:08:32.491] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:14:0)
[00:08:32.491] Timer tick, asking Buildbucket for the build status
[00:08:32.821] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:32.821] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:15:0) after 1m0s
[00:09:32.916] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:15:0)
[00:09:32.916] Timer tick, asking Buildbucket for the build status
[00:09:33.036] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:33.036] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:16:0) after 1m0s
[00:10:33.025] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:16:0)
[00:10:33.025] Timer tick, asking Buildbucket for the build status
[00:10:33.271] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:33.271] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:17:0) after 1m0s
[00:11:33.348] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:17:0)
[00:11:33.348] Timer tick, asking Buildbucket for the build status
[00:11:34.539] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:34.539] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:18:0) after 1m0s
[00:12:34.604] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:18:0)
[00:12:34.604] Timer tick, asking Buildbucket for the build status
[00:12:34.807] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:34.807] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:19:0) after 1m0s
[00:13:34.983] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:19:0)
[00:13:34.983] Timer tick, asking Buildbucket for the build status
[00:13:35.097] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:35.097] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:20:0) after 1m0s
[00:14:35.198] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:20:0)
[00:14:35.198] Timer tick, asking Buildbucket for the build status
[00:14:35.479] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:35.479] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:21:0) after 1m0s
[00:15:35.488] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:21:0)
[00:15:35.488] Timer tick, asking Buildbucket for the build status
[00:15:36.557] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:36.557] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:22:0) after 1m0s
[00:16:36.684] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:22:0)
[00:16:36.684] Timer tick, asking Buildbucket for the build status
[00:16:36.780] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:36.780] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:23:0) after 1m0s
[00:17:36.854] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:23:0)
[00:17:36.854] Timer tick, asking Buildbucket for the build status
[00:17:37.011] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:37.011] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:24:0) after 1m0s
[00:18:37.059] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:24:0)
[00:18:37.059] Timer tick, asking Buildbucket for the build status
[00:18:37.918] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:37.918] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:25:0) after 1m0s
[00:19:38.099] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:25:0)
[00:19:38.099] Timer tick, asking Buildbucket for the build status
[00:19:38.276] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:38.276] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:26:0) after 1m0s
[00:20:38.344] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:26:0)
[00:20:38.344] Timer tick, asking Buildbucket for the build status
[00:20:38.445] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:38.445] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:27:0) after 1m0s
[00:21:38.515] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:27:0)
[00:21:38.515] Timer tick, asking Buildbucket for the build status
[00:21:38.750] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:38.750] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:28:0) after 1m0s
[00:22:38.892] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:28:0)
[00:22:38.892] Timer tick, asking Buildbucket for the build status
[00:22:39.111] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:39.111] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:29:0) after 1m0s
[00:23:39.174] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:29:0)
[00:23:39.174] Timer tick, asking Buildbucket for the build status
[00:23:39.298] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:39.298] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:30:0) after 1m0s
[00:24:39.307] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:30:0)
[00:24:39.307] Timer tick, asking Buildbucket for the build status
[00:24:39.404] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:39.404] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:31:0) after 1m0s
[00:25:39.428] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:31:0)
[00:25:39.428] Timer tick, asking Buildbucket for the build status
[00:25:39.715] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:39.716] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:32:0) after 1m0s
[00:26:39.765] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:32:0)
[00:26:39.765] Timer tick, asking Buildbucket for the build status
[00:26:39.892] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:39.892] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:33:0) after 1m0s
[00:27:40.370] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:33:0)
[00:27:40.370] Timer tick, asking Buildbucket for the build status
[00:27:40.481] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:40.481] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:34:0) after 1m0s
[00:28:40.810] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:34:0)
[00:28:40.810] Timer tick, asking Buildbucket for the build status
[00:28:40.915] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:40.915] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:35:0) after 1m0s
[00:29:40.939] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:35:0)
[00:29:40.939] Timer tick, asking Buildbucket for the build status
[00:29:41.020] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:41.020] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:36:0) after 1m0s
[00:30:41.370] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:36:0)
[00:30:41.370] Timer tick, asking Buildbucket for the build status
[00:30:41.467] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:41.467] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:37:0) after 1m0s
[00:31:41.573] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:37:0)
[00:31:41.573] Timer tick, asking Buildbucket for the build status
[00:31:41.686] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:41.686] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:38:0) after 1m0s
[00:32:41.719] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:38:0)
[00:32:41.719] Timer tick, asking Buildbucket for the build status
[00:32:41.821] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:41.821] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:39:0) after 1m0s
[00:33:41.851] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:39:0)
[00:33:41.851] Timer tick, asking Buildbucket for the build status
[00:33:41.967] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:41.968] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:40:0) after 1m0s
[00:34:41.993] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:40:0)
[00:34:41.993] Timer tick, asking Buildbucket for the build status
[00:34:42.242] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:42.242] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:41:0) after 1m0s
[00:35:42.281] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:41:0)
[00:35:42.281] Timer tick, asking Buildbucket for the build status
[00:35:42.408] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:42.408] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:42:0) after 1m0s
[00:36:42.485] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:42:0)
[00:36:42.485] Timer tick, asking Buildbucket for the build status
[00:36:42.745] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:42.746] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:43:0) after 1m0s
[00:37:42.799] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:43:0)
[00:37:42.799] Timer tick, asking Buildbucket for the build status
[00:37:42.911] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:42.911] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:44:0) after 1m0s
[00:38:42.957] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:44:0)
[00:38:42.957] Timer tick, asking Buildbucket for the build status
[00:38:43.211] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:43.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:45:0) after 1m0s
[00:39:43.391] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:45:0)
[00:39:43.391] Timer tick, asking Buildbucket for the build status
[00:39:43.813] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:43.813] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:46:0) after 1m0s
[00:40:43.843] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:46:0)
[00:40:43.843] Timer tick, asking Buildbucket for the build status
[00:40:43.916] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:43.916] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:47:0) after 1m0s
[00:41:44.005] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:47:0)
[00:41:44.005] Timer tick, asking Buildbucket for the build status
[00:41:44.154] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:44.154] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:48:0) after 1m0s
[00:42:44.237] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:48:0)
[00:42:44.237] Timer tick, asking Buildbucket for the build status
[00:42:44.417] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:44.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:49:0) after 1m0s
[00:43:44.459] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:49:0)
[00:43:44.459] Timer tick, asking Buildbucket for the build status
[00:43:44.553] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:44.553] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:50:0) after 1m0s
[00:44:44.631] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:50:0)
[00:44:44.631] Timer tick, asking Buildbucket for the build status
[00:44:44.772] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:44.772] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:51:0) after 1m0s
[00:45:44.954] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:51:0)
[00:45:44.954] Timer tick, asking Buildbucket for the build status
[00:45:45.054] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:45.054] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:52:0) after 1m0s
[00:46:45.228] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:52:0)
[00:46:45.228] Timer tick, asking Buildbucket for the build status
[00:46:45.395] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:45.395] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:53:0) after 1m0s
[00:47:45.629] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:53:0)
[00:47:45.629] Timer tick, asking Buildbucket for the build status
[00:47:45.739] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:45.739] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:54:0) after 1m0s
[00:48:45.965] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:54:0)
[00:48:45.966] Timer tick, asking Buildbucket for the build status
[00:48:46.123] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:46.123] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:55:0) after 1m0s
[00:49:46.166] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:55:0)
[00:49:46.166] Timer tick, asking Buildbucket for the build status
[00:49:46.261] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:46.261] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:56:0) after 1m0s
[00:50:46.418] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:56:0)
[00:50:46.418] Timer tick, asking Buildbucket for the build status
[00:50:46.531] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:46.533] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:57:0) after 1m0s
[00:51:46.593] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:57:0)
[00:51:46.593] Timer tick, asking Buildbucket for the build status
[00:51:47.196] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:47.196] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:58:0) after 1m0s
[00:52:47.265] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:58:0)
[00:52:47.265] Timer tick, asking Buildbucket for the build status
[00:52:47.764] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:47.764] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:59:0) after 1m0s
[00:53:47.788] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:59:0)
[00:53:47.788] Timer tick, asking Buildbucket for the build status
[00:53:48.082] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:48.082] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:60:0) after 1m0s
[00:54:48.196] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:60:0)
[00:54:48.196] Timer tick, asking Buildbucket for the build status
[00:54:48.268] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:48.268] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:61:0) after 1m0s
[00:55:48.287] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:61:0)
[00:55:48.287] Timer tick, asking Buildbucket for the build status
[00:55:48.353] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:48.353] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:62:0) after 1m0s
[00:56:48.373] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:62:0)
[00:56:48.373] Timer tick, asking Buildbucket for the build status
[00:56:48.728] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:48.728] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:63:0) after 1m0s
[00:57:48.750] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:63:0)
[00:57:48.750] Timer tick, asking Buildbucket for the build status
[00:57:48.835] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:48.835] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:64:0) after 1m0s
[00:58:48.875] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:64:0)
[00:58:48.875] Timer tick, asking Buildbucket for the build status
[00:58:49.359] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:49.359] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:65:0) after 1m0s
[00:59:49.680] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:65:0)
[00:59:49.680] Timer tick, asking Buildbucket for the build status
[00:59:50.399] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:50.399] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:66:0) after 1m0s
[01:00:50.436] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:66:0)
[01:00:50.436] Timer tick, asking Buildbucket for the build status
[01:00:51.154] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:51.154] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:67:0) after 1m0s
[01:01:51.147] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:67:0)
[01:01:51.147] Timer tick, asking Buildbucket for the build status
[01:01:51.297] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:51.297] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:68:0) after 1m0s
[01:02:51.386] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:68:0)
[01:02:51.386] Timer tick, asking Buildbucket for the build status
[01:02:51.585] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:51.585] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:69:0) after 1m0s
[01:03:51.610] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:69:0)
[01:03:51.610] Timer tick, asking Buildbucket for the build status
[01:03:51.789] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:51.789] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:70:0) after 1m0s
[01:04:51.814] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:70:0)
[01:04:51.814] Timer tick, asking Buildbucket for the build status
[01:04:51.976] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:51.976] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:71:0) after 1m0s
[01:05:52.108] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:71:0)
[01:05:52.108] Timer tick, asking Buildbucket for the build status
[01:05:53.148] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:53.148] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:72:0) after 1m0s
[01:06:53.159] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:72:0)
[01:06:53.159] Timer tick, asking Buildbucket for the build status
[01:06:53.326] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:53.326] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:73:0) after 1m0s
[01:07:53.421] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:73:0)
[01:07:53.421] Timer tick, asking Buildbucket for the build status
[01:07:53.851] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:53.851] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:74:0) after 1m0s
[01:08:53.885] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:74:0)
[01:08:53.885] Timer tick, asking Buildbucket for the build status
[01:08:54.022] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:54.022] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:75:0) after 1m0s
[01:09:54.073] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:75:0)
[01:09:54.073] Timer tick, asking Buildbucket for the build status
[01:09:54.239] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:54.239] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:76:0) after 1m0s
[01:10:54.306] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:76:0)
[01:10:54.306] Timer tick, asking Buildbucket for the build status
[01:10:54.774] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:54.774] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:77:0) after 1m0s
[01:11:54.794] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:77:0)
[01:11:54.794] Timer tick, asking Buildbucket for the build status
[01:11:54.955] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:54.955] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:78:0) after 1m0s
[01:12:54.993] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:78:0)
[01:12:54.993] Timer tick, asking Buildbucket for the build status
[01:12:55.099] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:55.099] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:79:0) after 1m0s
[01:13:55.152] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:79:0)
[01:13:55.152] Timer tick, asking Buildbucket for the build status
[01:13:55.901] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:55.901] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:80:0) after 1m0s
[01:14:56.031] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:80:0)
[01:14:56.031] Timer tick, asking Buildbucket for the build status
[01:14:56.122] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:56.122] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:81:0) after 1m0s
[01:15:56.198] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:81:0)
[01:15:56.198] Timer tick, asking Buildbucket for the build status
[01:15:56.286] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:56.286] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:82:0) after 1m0s
[01:16:56.332] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:82:0)
[01:16:56.333] Timer tick, asking Buildbucket for the build status
[01:16:56.517] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:56.517] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:83:0) after 1m0s
[01:17:56.592] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:83:0)
[01:17:56.592] Timer tick, asking Buildbucket for the build status
[01:17:56.761] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:56.761] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:84:0) after 1m0s
[01:18:56.792] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:84:0)
[01:18:56.792] Timer tick, asking Buildbucket for the build status
[01:18:56.924] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:56.924] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:85:0) after 1m0s
[01:19:56.956] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:85:0)
[01:19:56.956] Timer tick, asking Buildbucket for the build status
[01:19:57.121] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:57.121] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:86:0) after 1m0s
[01:20:57.209] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:86:0)
[01:20:57.209] Timer tick, asking Buildbucket for the build status
[01:20:57.385] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:57.385] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:87:0) after 1m0s
[01:21:57.451] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:87:0)
[01:21:57.451] Timer tick, asking Buildbucket for the build status
[01:21:57.622] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:57.622] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:88:0) after 1m0s
[01:22:57.683] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:88:0)
[01:22:57.683] Timer tick, asking Buildbucket for the build status
[01:22:57.938] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:57.938] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:89:0) after 1m0s
[01:23:57.978] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:89:0)
[01:23:57.978] Timer tick, asking Buildbucket for the build status
[01:23:58.184] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:58.184] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:90:0) after 1m0s
[01:24:58.355] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:90:0)
[01:24:58.355] Timer tick, asking Buildbucket for the build status
[01:24:58.467] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:58.467] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:91:0) after 1m0s
[01:25:58.496] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:91:0)
[01:25:58.496] Timer tick, asking Buildbucket for the build status
[01:25:58.675] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:58.675] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:92:0) after 1m0s
[01:26:58.716] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:92:0)
[01:26:58.716] Timer tick, asking Buildbucket for the build status
[01:26:59.565] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:59.565] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:93:0) after 1m0s
[01:27:59.598] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:93:0)
[01:27:59.598] Timer tick, asking Buildbucket for the build status
[01:28:00.229] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:00.229] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:94:0) after 1m0s
[01:29:00.327] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:94:0)
[01:29:00.327] Timer tick, asking Buildbucket for the build status
[01:29:00.472] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:00.472] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:95:0) after 1m0s
[01:30:00.516] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:95:0)
[01:30:00.516] Timer tick, asking Buildbucket for the build status
[01:30:00.675] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:00.675] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:96:0) after 1m0s
[01:31:00.917] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:96:0)
[01:31:00.917] Timer tick, asking Buildbucket for the build status
[01:31:01.058] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:01.058] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:97:0) after 1m0s
[01:32:01.403] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:97:0)
[01:32:01.403] Timer tick, asking Buildbucket for the build status
[01:32:02.001] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:02.001] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:98:0) after 1m0s
[01:33:02.137] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:98:0)
[01:33:02.137] Timer tick, asking Buildbucket for the build status
[01:33:02.331] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:02.331] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:99:0) after 1m0s
[01:34:02.351] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:99:0)
[01:34:02.351] Timer tick, asking Buildbucket for the build status
[01:34:03.789] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:03.789] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:100:0) after 1m0s
[01:35:03.769] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:100:0)
[01:35:03.769] Timer tick, asking Buildbucket for the build status
[01:35:03.874] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:03.874] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:101:0) after 1m0s
[01:36:03.904] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:101:0)
[01:36:03.904] Timer tick, asking Buildbucket for the build status
[01:36:04.051] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:04.051] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:102:0) after 1m0s
[01:37:04.099] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:102:0)
[01:37:04.099] Timer tick, asking Buildbucket for the build status
[01:37:04.330] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:04.330] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:103:0) after 1m0s
[01:38:04.381] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:103:0)
[01:38:04.381] Timer tick, asking Buildbucket for the build status
[01:38:04.680] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:04.680] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:104:0) after 1m0s
[01:39:04.698] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:104:0)
[01:39:04.698] Timer tick, asking Buildbucket for the build status
[01:39:04.765] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:04.765] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:105:0) after 1m0s
[01:40:04.849] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:105:0)
[01:40:04.849] Timer tick, asking Buildbucket for the build status
[01:40:05.486] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:05.486] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:106:0) after 1m0s
[01:41:05.526] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:106:0)
[01:41:05.526] Timer tick, asking Buildbucket for the build status
[01:41:05.680] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:05.680] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:107:0) after 1m0s
[01:42:05.763] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:107:0)
[01:42:05.763] Timer tick, asking Buildbucket for the build status
[01:42:05.997] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:05.997] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:108:0) after 1m0s
[01:43:06.070] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:108:0)
[01:43:06.070] Timer tick, asking Buildbucket for the build status
[01:43:06.686] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:06.686] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:109:0) after 1m0s
[01:44:06.792] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:109:0)
[01:44:06.792] Timer tick, asking Buildbucket for the build status
[01:44:06.889] Build 8856998127223773232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:06.889] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022428189249558656:110:0) after 1m0s
[01:44:15.520] Received PubSub notification, asking Buildbucket for the build status
[01:44:15.601] Build 8856998127223773232: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:44:15.601] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1611711854707631",
"created_by": "project:chromium",
"created_ts": "1611705387816325",
"id": "8856998127223773232",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"10767efbf7d9afec8d75062f137b6608c50225d1\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"10767efbf7d9afec8d75062f137b6608c50225d1\", \"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-1-o1ts\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17027, \"clang_revision\": \"llvmorg-12-init-17251-g6de48655-1\", \"got_angle_revision\": \"50f7d64610097f0a1eeef27e6e35612ad52b1023\", \"got_dawn_revision\": \"2fe8cab10aeb3956b619a6c0c062417e05aa95d3\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"10767efbf7d9afec8d75062f137b6608c50225d1\", \"got_revision_cp\": \"refs/heads/master@{#847392}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"aec0826aba0db51914209ec85a515d3a99311f07\", \"got_v8_revision\": \"5a85731e276fbb3987991ebe9a695a6113055373\", \"got_v8_revision_cp\": \"refs/heads/9.0.75@{#1}\", \"got_webrtc_revision\": \"c57089a97a3df454f4356d882cc8df173e8b3ead\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33072}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.win:win-asan\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"10767efbf7d9afec8d75062f137b6608c50225d1\", \"swarm_hashes_refs/heads/master(at){#847392}_without_patch\": {\"absl_hardening_tests\": \"f2b3d2369f1e57fb0dc2d63169a580efd7ea4cc8\", \"accessibility_unittests\": \"67cf05d9f498b1a7ddb2bc7afdb811663ff2d011\", \"angle_unittests\": \"f4772a0b746f27ee421b27022628ea7e72ab428d\", \"app_shell_unittests\": \"fa47838c3378702d9408f7bdbec842330f90bb1a\", \"aura_unittests\": \"42077472e7aea10b28d39d65adeda9a44a98e8aa\", \"base_unittests\": \"680c5b6023e1f2e2d58a221255dfa46250ad0ec4\", \"base_util_unittests\": \"b6111740d03c4cf13bbcc8e0e3878c38b081f14f\", \"blink_common_unittests\": \"047d605e22c8bc394e069783cfc246c418ae3805\", \"blink_fuzzer_unittests\": \"685a9dc85807eec2a06671fa61425c6eb8a298be\", \"blink_heap_unittests\": \"1d1a62c032b0919eda8ed2f71a8920ce1a3acffb\", \"blink_platform_unittests\": \"8a817a87a9a5a315bd21a40a693da1ca01534ce4\", \"blink_unittests\": \"0f471ba8411921009c9a22dddb99682da9cc6d98\", \"boringssl_crypto_tests\": \"1fd97029472434ce9a7218837c9acaf5aa8f320e\", \"boringssl_ssl_tests\": \"c8f9ae0c6d9f34f503d438570a0954496d23c1af\", \"browser_switcher_bho_unittests\": \"332b0df9eb2db043197e0f18cc7ded1a231aab3e\", \"browser_tests\": \"479bb934d851227d325a4e677b7f0e5ce68cf11a\", \"capture_unittests\": \"f00ed3add2342fb861ea10aaf42d3adb4ef5332a\", \"cast_unittests\": \"3dc31409da59d3484ee67ea1da40c86dd5376121\", \"cc_unittests\": \"5aedf14c21567cff12a31a44999753d826f35574\", \"chrome_app_unittests\": \"e78811e18b09fb3f7d109411448596d2ab68dfca\", \"chrome_cleaner_unittests\": \"02856f9fdfa47bbadb2db656f380cdc33fed2201\", \"chrome_elf_unittests\": \"f4b2808b0fb78439441c7faa15a987d45aa90b1e\", \"chromedriver_unittests\": \"d462442da209751f1a6891a783590901396dbc49\", \"components_browsertests\": \"e91a1b742fcc2b4f3e2a364c302fd44598d269e5\", \"components_unittests\": \"ebc03a95f55093cc1878d14d2f21291d1fcfa1e6\", \"compositor_unittests\": \"ebe6552acf30e5028f0c795e532894037a881f03\", \"content_browsertests\": \"1146f4ce8fca02d2dbe125166c1423c78d45dbd0\", \"content_unittests\": \"826dfdbf1177b4fc4b11bfd840962ed35ff68090\", \"courgette_unittests\": \"abdc4f93464fdaa75f78846cd0fe895d1a361f84\", \"crashpad_tests\": \"4ec04a0a1976cd4d343e93c3c0d4d5d838ee82cc\", \"cronet_tests\": \"d011ed91a10433aa0133d50edcc521930f689395\", \"cronet_unittests\": \"a5e9a677067ae42764cf5e478a889449d5088f1c\", \"crypto_unittests\": \"df59acb2ccf8e63fd9fdf37f2296a8cde334ca53\", \"delayloads_unittests\": \"d96caf22fc13a9fa24c3dfeabd5137cdc5abcc8f\", \"device_unittests\": \"221ed79aec17ab50b39697ec6d9ff54d597fe8ac\", \"display_unittests\": \"c8bffc1a583f1e377c11bc2bf99b1456fa0bc4a5\", \"elevation_service_unittests\": \"ccd81cbff050322bbf06a072517c0745e370610c\", \"events_unittests\": \"bd7c3e85c5fa5fd7a553c8f9b04c1b1063343ae7\", \"extensions_browsertests\": \"2e731edc5ed8db6a518d071e86cfb8667dbbda7d\", \"extensions_unittests\": \"422d16518f664eb4d6c7ccb699cc60b38c69901f\", \"filesystem_service_unittests\": \"3b695bc36d74619b14cc5e3defc6d53e4b9675da\", \"gcm_unit_tests\": \"ffee112fe4f4f46a662c0ba0fff2a4dd6ffc7391\", \"gcp_unittests\": \"d9784b0195e60ac975677d7496053a73ca170ca1\", \"gfx_unittests\": \"21b7b7f553e761c2e1b2985fc0492e4978f4418d\", \"gin_unittests\": \"5f311b29bd9a840b45017ded387fc35d7417d25e\", \"google_apis_unittests\": \"a0156af010a78ab96fa84bb3b8cf5c094e9a064b\", \"gpu_unittests\": \"a9bf65bbcfe5cf888c0cac24aa04b1db3bc082bf\", \"gwp_asan_unittests\": \"3acef4cb32a9c6bb7db19dfdbabb7743d4e6037c\", \"headless_browsertests\": \"fb722bff4aa516208f132494ddc94c60e38d36d9\", \"headless_unittests\": \"7fb9589d1e133ef2401510dcfd21a2fc85814c85\", \"install_static_unittests\": \"380fe8fbcd79bc50b36e4371e4cb889e43e9fa64\", \"installer_util_unittests\": \"12140f91a5be700c295125b05f309b82307e817f\", \"interactive_ui_tests\": \"2f76a9bc77571f5ade3c8fdc6059449adf0fb4ed\", \"ipc_tests\": \"7af8a043cc96907dcf9897a89e79388e7d46f788\", \"jingle_unittests\": \"112c0a4a2d7a238a14907df6d7ec52428c7f3112\", \"latency_unittests\": \"5903d00cc9ecd337f061250d37f376875a924ed9\", \"libjingle_xmpp_unittests\": \"e188cbcf3b0f6ee263a75a18a52b353e8bf07a43\", \"liburlpattern_unittests\": \"13afe348bdd57e17f89426fbe362c04073e36d00\", \"media_blink_unittests\": \"325c94a7d84bc4601637fe91bc3d1693ba1069d7\", \"media_unittests\": \"2791949dc58d60d1bb3c3ff1b4566842b501c007\", \"message_center_unittests\": \"11dc0f9add7e66d6dedfba44551744fe6f4788d2\", \"midi_unittests\": \"e593a349c46e169e25895cca2c1669acb8d5414f\", \"mojo_core_unittests\": \"b4a6cc4ec623c9615d7ca52097b90f9eaeae3370\", \"mojo_unittests\": \"de2a2aaf9817fe50caa758727795ae38d1f56958\", \"nacl_loader_unittests\": \"febd352c70a5ad05f7955236ef54cf92d2e3e6c9\", \"native_theme_unittests\": \"0dae0a0eee1d6894c76fa89d4a7f3f245f33937a\", \"net_unittests\": \"593954a355c60da06dd61e66eb8e746d4024af1c\", \"notification_helper_unittests\": \"ea81b083b23e022136281c63aa338e73d397047f\", \"pdf_unittests\": \"e9fde960fb7ae9280990d3c0ed58ff1d12698227\", \"perfetto_unittests\": \"1ad8e40429697f9d42301eb0b1c10aa318ab1335\", \"ppapi_unittests\": \"2f18892f3cd17164780e047631b475d556867d18\", \"printing_unittests\": \"1da3bf7e3d99f7dddf185cc11b930f1e2e2c1f22\", \"remoting_unittests\": \"012fdddc56914e182bc27be0b54b2f86e87fb12a\", \"sbox_integration_tests\": \"c9fd488b8a2a2c249447e233e9c469138299d886\", \"sbox_unittests\": \"f0c3b891ba442b153db3ff83f4e4d391ecc0ebbb\", \"sbox_validation_tests\": \"3f549d94820a87e09c8905474672a2e97aa4b2af\", \"service_manager_unittests\": \"77abb0adee02fe98cf7fcec7893988df20276abb\", \"services_unittests\": \"b4a953eb976cdeea7244e617e9e8bb11d81f92c9\", \"setup_unittests\": \"5a11090702273bcdd901ac9aa71da5fbd5c8c4e1\", \"shell_dialogs_unittests\": \"cce46f995cd14ed6380c0bbdf1eac92bba74b458\", \"skia_unittests\": \"1a330473a23f11227128087c3ea4440ee1d53966\", \"snapshot_unittests\": \"36126fe790207792bdbd661a9006c0b5107b66ec\", \"sql_unittests\": \"ca56921939df7fd32d36548eb8d9a844962c15f3\", \"storage_unittests\": \"980523c6b0a687b9d8df6eba116942588568b551\", \"sync_integration_tests\": \"c8b85d87a1055be8b6313796835e39aaeecaabaa\", \"traffic_annotation_auditor_unittests\": \"4c34a37d3cf8e73db920bff70c18e8252b7ab338\", \"ui_base_unittests\": \"4c8a06b050942d24bc1607b23ce217bfeccc0ead\", \"ui_touch_selection_unittests\": \"f1eb332e3f1d94f1524887853e766c7b486a6ecb\", \"unit_tests\": \"f17bdb943ad6cb48d5fb789ec1027ee4e2e820be\", \"updater_tests\": \"51f464f0d9a74d37cb671019d105ee6a0fd1d019\", \"url_unittests\": \"df3831c9d8058db9590e1cdaaadb5ca4e8b1fb8b\", \"views_unittests\": \"6b3354a289ebe057fac7ef2b240cb1fcf838376f\", \"viz_unittests\": \"d8e689217dacadb399aa459d89bd656646932cb5\", \"vr_common_unittests\": \"6cabfec066d8f988a038a8623e4edbc752c9d421\", \"vr_pixeltests\": \"9f3a19097e0a6bd3128b43c2298309011d5fdc65\", \"weblayer_browsertests\": \"c46ae13e1c98b74c7f1cc77e38bd9e724af08b4a\", \"weblayer_unittests\": \"2919219d4f5fe043cc72cb8990addee1d1a6e15f\", \"wm_unittests\": \"0ed3806eedc89444e3c76ce1d3a4a24eca672cb6\", \"wtf_unittests\": \"bb702ce4ba859eeb02b4cd921bcb3c2218273985\", \"zlib_unittests\": \"e15236d285e06b46d0337bc95dc10fc40d2e20b5\", \"zucchini_unittests\": \"ea203de4e3c3df844c3b3ed9d2929026afe63f4f\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_ba2591630e3c492a7f8bed019e3d41c3ae1f8879793a1bf71c3be1367a2696d6_v2\", \"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-1-o1ts\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5672-4713de1\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611705543120188",
"status": "COMPLETED",
"status_changed_ts": "1611711855075208",
"tags": [
"build_address:luci.chromium.ci/win-asan/17027",
"builder:win-asan",
"buildset:commit/git/10767efbf7d9afec8d75062f137b6608c50225d1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/10767efbf7d9afec8d75062f137b6608c50225d1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022428189249558656",
"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/8856998127223773232/+/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:5159f2199112c910",
"user_agent:luci-scheduler"
],
"updated_ts": "1611711855080887",
"url": "https://ci.chromium.org/b/8856998127223773232",
"utcnow_ts": "1611711855584147"
}
}
[01:44:15.601] Invocation finished in 1h47m49.100508467s with status SUCCEEDED