[15:50:10.545] New invocation is queued and will start shortly
[15:50:11.608] Starting the invocation (attempt 1)
[15:50:11.645] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:50:11.645] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:50:11.645] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019106694715913232",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3025b5eb8a63870819141c3ea2b272a71f472147\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9019106694715913232",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/3025b5eb8a63870819141c3ea2b272a71f472147",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3025b5eb8a63870819141c3ea2b272a71f472147",
"gitiles_ref:refs/heads/master"
]
}
[15:50:12.735] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614873011767702",
"id": "8853676632771175088",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3025b5eb8a63870819141c3ea2b272a71f472147\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614873012450308",
"tags": [
"build_address:luci.chromium.ci/win-asan/17631",
"builder:win-asan",
"buildset:commit/git/3025b5eb8a63870819141c3ea2b272a71f472147",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3025b5eb8a63870819141c3ea2b272a71f472147",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019106694715913232",
"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/8853676632771175088/+/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": "1614873012450421",
"url": "https://ci.chromium.org/b/8853676632771175088",
"utcnow_ts": "1614873012720182"
}
}
[15:50:12.735] Task URL: https://ci.chromium.org/b/8853676632771175088
[15:50:12.735] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:2:0) after 1m0s
[15:50:19.249] Received PubSub notification, asking Buildbucket for the build status
[15:50:19.333] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:12.750] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:2:0)
[15:51:12.750] Timer tick, asking Buildbucket for the build status
[15:51:12.844] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:12.844] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:4:0) after 1m0s
[15:52:12.862] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:4:0)
[15:52:12.862] Timer tick, asking Buildbucket for the build status
[15:52:12.941] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:12.941] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:5:0) after 1m0s
[15:53:12.933] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:5:0)
[15:53:12.933] Timer tick, asking Buildbucket for the build status
[15:53:13.003] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:13.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:6:0) after 1m0s
[15:54:13.048] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:6:0)
[15:54:13.048] Timer tick, asking Buildbucket for the build status
[15:54:13.131] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:13.131] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:7:0) after 1m0s
[15:55:13.173] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:7:0)
[15:55:13.173] Timer tick, asking Buildbucket for the build status
[15:55:13.250] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:13.250] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:8:0) after 1m0s
[15:56:13.319] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:8:0)
[15:56:13.319] Timer tick, asking Buildbucket for the build status
[15:56:13.516] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:13.516] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:9:0) after 1m0s
[15:57:13.589] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:9:0)
[15:57:13.589] Timer tick, asking Buildbucket for the build status
[15:57:13.663] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:13.663] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:10:0) after 1m0s
[15:58:13.682] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:10:0)
[15:58:13.682] Timer tick, asking Buildbucket for the build status
[15:58:13.881] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:13.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:11:0) after 1m0s
[15:59:14.141] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:11:0)
[15:59:14.141] Timer tick, asking Buildbucket for the build status
[15:59:15.448] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:15.448] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:12:0) after 1m0s
[16:00:15.659] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:12:0)
[16:00:15.659] Timer tick, asking Buildbucket for the build status
[16:00:16.630] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:16.630] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:13:0) after 1m0s
[16:01:16.657] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:13:0)
[16:01:16.657] Timer tick, asking Buildbucket for the build status
[16:01:16.881] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:16.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:14:0) after 1m0s
[16:02:16.897] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:14:0)
[16:02:16.897] Timer tick, asking Buildbucket for the build status
[16:02:17.123] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:17.123] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:15:0) after 1m0s
[16:03:17.113] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:15:0)
[16:03:17.113] Timer tick, asking Buildbucket for the build status
[16:03:17.341] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:17.341] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:16:0) after 1m0s
[16:04:17.361] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:16:0)
[16:04:17.361] Timer tick, asking Buildbucket for the build status
[16:04:17.990] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:17.990] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:17:0) after 1m0s
[16:05:17.975] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:17:0)
[16:05:17.975] Timer tick, asking Buildbucket for the build status
[16:05:18.231] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:18.231] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:18:0) after 1m0s
[16:06:18.215] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:18:0)
[16:06:18.215] Timer tick, asking Buildbucket for the build status
[16:06:18.388] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:18.389] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:19:0) after 1m0s
[16:07:18.459] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:19:0)
[16:07:18.459] Timer tick, asking Buildbucket for the build status
[16:07:18.784] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:18.784] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:20:0) after 1m0s
[16:08:18.806] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:20:0)
[16:08:18.806] Timer tick, asking Buildbucket for the build status
[16:08:18.921] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:18.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:21:0) after 1m0s
[16:09:18.953] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:21:0)
[16:09:18.953] Timer tick, asking Buildbucket for the build status
[16:09:19.046] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:19.046] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:22:0) after 1m0s
[16:10:19.065] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:22:0)
[16:10:19.065] Timer tick, asking Buildbucket for the build status
[16:10:19.427] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:19.427] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:23:0) after 1m0s
[16:11:19.478] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:23:0)
[16:11:19.478] Timer tick, asking Buildbucket for the build status
[16:11:19.584] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:19.584] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:24:0) after 1m0s
[16:12:19.658] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:24:0)
[16:12:19.658] Timer tick, asking Buildbucket for the build status
[16:12:19.783] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:19.783] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:25:0) after 1m0s
[16:13:19.767] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:25:0)
[16:13:19.767] Timer tick, asking Buildbucket for the build status
[16:13:19.906] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:19.906] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:26:0) after 1m0s
[16:14:19.928] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:26:0)
[16:14:19.928] Timer tick, asking Buildbucket for the build status
[16:14:20.125] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:20.125] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:27:0) after 1m0s
[16:15:20.192] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:27:0)
[16:15:20.192] Timer tick, asking Buildbucket for the build status
[16:15:20.267] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:20.267] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:28:0) after 1m0s
[16:16:20.262] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:28:0)
[16:16:20.262] Timer tick, asking Buildbucket for the build status
[16:16:20.426] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:20.426] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:29:0) after 1m0s
[16:17:20.449] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:29:0)
[16:17:20.449] Timer tick, asking Buildbucket for the build status
[16:17:20.566] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:20.566] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:30:0) after 1m0s
[16:18:20.581] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:30:0)
[16:18:20.581] Timer tick, asking Buildbucket for the build status
[16:18:20.670] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:20.670] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:31:0) after 1m0s
[16:19:20.698] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:31:0)
[16:19:20.698] Timer tick, asking Buildbucket for the build status
[16:19:20.793] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:20.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:32:0) after 1m0s
[16:20:20.770] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:32:0)
[16:20:20.770] Timer tick, asking Buildbucket for the build status
[16:20:20.893] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:20.893] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:33:0) after 1m0s
[16:21:20.883] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:33:0)
[16:21:20.883] Timer tick, asking Buildbucket for the build status
[16:21:20.974] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:20.974] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:34:0) after 1m0s
[16:22:21.013] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:34:0)
[16:22:21.013] Timer tick, asking Buildbucket for the build status
[16:22:21.082] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:21.082] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:35:0) after 1m0s
[16:23:21.124] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:35:0)
[16:23:21.124] Timer tick, asking Buildbucket for the build status
[16:23:22.425] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:22.425] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:36:0) after 1m0s
[16:24:22.534] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:36:0)
[16:24:22.534] Timer tick, asking Buildbucket for the build status
[16:24:22.853] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:22.853] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:37:0) after 1m0s
[16:25:22.940] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:37:0)
[16:25:22.940] Timer tick, asking Buildbucket for the build status
[16:25:23.063] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:23.063] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:38:0) after 1m0s
[16:26:23.134] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:38:0)
[16:26:23.134] Timer tick, asking Buildbucket for the build status
[16:26:23.218] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:23.218] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:39:0) after 1m0s
[16:27:23.433] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:39:0)
[16:27:23.433] Timer tick, asking Buildbucket for the build status
[16:27:23.599] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:23.599] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:40:0) after 1m0s
[16:28:23.652] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:40:0)
[16:28:23.652] Timer tick, asking Buildbucket for the build status
[16:28:23.747] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:23.747] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:41:0) after 1m0s
[16:29:23.842] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:41:0)
[16:29:23.842] Timer tick, asking Buildbucket for the build status
[16:29:23.938] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:23.938] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:42:0) after 1m0s
[16:30:23.952] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:42:0)
[16:30:23.952] Timer tick, asking Buildbucket for the build status
[16:30:24.336] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:24.336] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:43:0) after 1m0s
[16:31:24.508] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:43:0)
[16:31:24.508] Timer tick, asking Buildbucket for the build status
[16:31:24.608] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:24.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:44:0) after 1m0s
[16:32:24.795] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:44:0)
[16:32:24.795] Timer tick, asking Buildbucket for the build status
[16:32:25.583] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:25.583] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:45:0) after 1m0s
[16:33:25.614] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:45:0)
[16:33:25.614] Timer tick, asking Buildbucket for the build status
[16:33:25.838] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:25.838] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:46:0) after 1m0s
[16:34:25.887] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:46:0)
[16:34:25.887] Timer tick, asking Buildbucket for the build status
[16:34:25.966] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:25.966] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:47:0) after 1m0s
[16:35:26.023] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:47:0)
[16:35:26.023] Timer tick, asking Buildbucket for the build status
[16:35:26.169] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:26.169] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:48:0) after 1m0s
[16:36:26.209] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:48:0)
[16:36:26.209] Timer tick, asking Buildbucket for the build status
[16:36:26.378] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:26.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:49:0) after 1m0s
[16:37:26.396] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:49:0)
[16:37:26.396] Timer tick, asking Buildbucket for the build status
[16:37:26.752] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:26.752] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:50:0) after 1m0s
[16:38:27.314] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:50:0)
[16:38:27.314] Timer tick, asking Buildbucket for the build status
[16:38:27.609] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:27.609] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:51:0) after 1m0s
[16:39:27.922] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:51:0)
[16:39:27.923] Timer tick, asking Buildbucket for the build status
[16:39:28.036] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:28.036] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:52:0) after 1m0s
[16:40:28.122] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:52:0)
[16:40:28.122] Timer tick, asking Buildbucket for the build status
[16:40:28.842] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:28.842] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:53:0) after 1m0s
[16:41:28.872] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:53:0)
[16:41:28.872] Timer tick, asking Buildbucket for the build status
[16:41:28.983] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:28.983] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:54:0) after 1m0s
[16:42:29.004] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:54:0)
[16:42:29.004] Timer tick, asking Buildbucket for the build status
[16:42:29.098] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:29.098] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:55:0) after 1m0s
[16:43:29.124] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:55:0)
[16:43:29.124] Timer tick, asking Buildbucket for the build status
[16:43:29.206] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:29.206] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:56:0) after 1m0s
[16:44:29.223] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:56:0)
[16:44:29.223] Timer tick, asking Buildbucket for the build status
[16:44:29.291] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:29.291] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:57:0) after 1m0s
[16:45:29.312] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:57:0)
[16:45:29.312] Timer tick, asking Buildbucket for the build status
[16:45:29.630] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:29.630] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:58:0) after 1m0s
[16:46:29.653] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:58:0)
[16:46:29.653] Timer tick, asking Buildbucket for the build status
[16:46:29.991] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:29.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:59:0) after 1m0s
[16:47:30.034] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:59:0)
[16:47:30.034] Timer tick, asking Buildbucket for the build status
[16:47:30.127] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:30.127] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:60:0) after 1m0s
[16:48:30.189] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:60:0)
[16:48:30.189] Timer tick, asking Buildbucket for the build status
[16:48:30.261] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:30.261] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:61:0) after 1m0s
[16:49:31.084] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:61:0)
[16:49:31.084] Timer tick, asking Buildbucket for the build status
[16:49:31.298] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:31.298] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:62:0) after 1m0s
[16:50:31.830] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:62:0)
[16:50:31.830] Timer tick, asking Buildbucket for the build status
[16:50:32.246] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:32.246] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:63:0) after 1m0s
[16:51:32.298] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:63:0)
[16:51:32.298] Timer tick, asking Buildbucket for the build status
[16:51:32.379] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:32.379] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:64:0) after 1m0s
[16:52:32.397] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:64:0)
[16:52:32.397] Timer tick, asking Buildbucket for the build status
[16:52:32.493] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:32.493] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:65:0) after 1m0s
[16:53:32.641] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:65:0)
[16:53:32.641] Timer tick, asking Buildbucket for the build status
[16:53:32.771] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:32.771] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:66:0) after 1m0s
[16:54:32.866] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:66:0)
[16:54:32.866] Timer tick, asking Buildbucket for the build status
[16:54:32.964] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:32.964] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:67:0) after 1m0s
[16:55:33.018] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:67:0)
[16:55:33.018] Timer tick, asking Buildbucket for the build status
[16:55:33.192] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:33.192] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:68:0) after 1m0s
[16:56:33.296] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:68:0)
[16:56:33.296] Timer tick, asking Buildbucket for the build status
[16:56:33.623] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:33.623] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:69:0) after 1m0s
[16:57:35.217] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:69:0)
[16:57:35.217] Timer tick, asking Buildbucket for the build status
[16:57:35.560] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:35.560] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:70:0) after 1m0s
[16:58:35.897] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:70:0)
[16:58:35.897] Timer tick, asking Buildbucket for the build status
[16:58:36.600] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:36.600] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:71:0) after 1m0s
[16:59:37.056] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:71:0)
[16:59:37.056] Timer tick, asking Buildbucket for the build status
[16:59:37.136] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:37.136] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:72:0) after 1m0s
[17:00:37.144] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:72:0)
[17:00:37.144] Timer tick, asking Buildbucket for the build status
[17:00:37.434] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:37.434] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:73:0) after 1m0s
[17:01:37.433] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:73:0)
[17:01:37.433] Timer tick, asking Buildbucket for the build status
[17:01:37.776] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:37.776] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:74:0) after 1m0s
[17:02:37.837] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:74:0)
[17:02:37.837] Timer tick, asking Buildbucket for the build status
[17:02:38.099] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:38.099] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:75:0) after 1m0s
[17:03:38.168] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:75:0)
[17:03:38.168] Timer tick, asking Buildbucket for the build status
[17:03:38.624] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:38.624] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:76:0) after 1m0s
[17:04:38.697] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:76:0)
[17:04:38.697] Timer tick, asking Buildbucket for the build status
[17:04:38.958] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:38.958] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:77:0) after 1m0s
[17:05:38.978] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:77:0)
[17:05:38.978] Timer tick, asking Buildbucket for the build status
[17:05:39.072] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:39.072] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:78:0) after 1m0s
[17:06:39.133] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:78:0)
[17:06:39.133] Timer tick, asking Buildbucket for the build status
[17:06:39.226] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:39.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:79:0) after 1m0s
[17:07:39.278] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:79:0)
[17:07:39.278] Timer tick, asking Buildbucket for the build status
[17:07:39.502] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:39.502] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:80:0) after 1m0s
[17:08:39.546] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:80:0)
[17:08:39.546] Timer tick, asking Buildbucket for the build status
[17:08:39.679] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:39.679] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:81:0) after 1m0s
[17:09:39.675] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:81:0)
[17:09:39.675] Timer tick, asking Buildbucket for the build status
[17:09:40.451] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:40.451] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:82:0) after 1m0s
[17:10:40.433] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:82:0)
[17:10:40.433] Timer tick, asking Buildbucket for the build status
[17:10:40.952] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:40.952] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:83:0) after 1m0s
[17:11:40.974] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:83:0)
[17:11:40.974] Timer tick, asking Buildbucket for the build status
[17:11:41.061] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:41.061] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:84:0) after 1m0s
[17:12:41.081] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:84:0)
[17:12:41.081] Timer tick, asking Buildbucket for the build status
[17:12:41.321] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:41.321] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:85:0) after 1m0s
[17:13:41.378] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:85:0)
[17:13:41.378] Timer tick, asking Buildbucket for the build status
[17:13:41.668] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:41.668] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:86:0) after 1m0s
[17:14:41.739] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:86:0)
[17:14:41.739] Timer tick, asking Buildbucket for the build status
[17:14:41.818] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:41.818] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:87:0) after 1m0s
[17:15:41.840] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:87:0)
[17:15:41.840] Timer tick, asking Buildbucket for the build status
[17:15:42.643] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:42.643] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:88:0) after 1m0s
[17:16:42.719] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:88:0)
[17:16:42.719] Timer tick, asking Buildbucket for the build status
[17:16:42.800] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:42.800] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:89:0) after 1m0s
[17:17:42.818] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:89:0)
[17:17:42.818] Timer tick, asking Buildbucket for the build status
[17:17:42.911] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:42.911] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:90:0) after 1m0s
[17:18:42.949] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:90:0)
[17:18:42.949] Timer tick, asking Buildbucket for the build status
[17:18:44.287] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:44.287] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:91:0) after 1m0s
[17:19:44.293] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:91:0)
[17:19:44.294] Timer tick, asking Buildbucket for the build status
[17:19:44.451] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:44.451] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:92:0) after 1m0s
[17:20:44.461] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:92:0)
[17:20:44.461] Timer tick, asking Buildbucket for the build status
[17:20:44.607] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:44.607] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:93:0) after 1m0s
[17:21:44.630] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:93:0)
[17:21:44.630] Timer tick, asking Buildbucket for the build status
[17:21:44.829] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:44.829] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:94:0) after 1m0s
[17:22:44.850] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:94:0)
[17:22:44.851] Timer tick, asking Buildbucket for the build status
[17:22:45.150] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:45.150] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:95:0) after 1m0s
[17:23:45.140] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:95:0)
[17:23:45.140] Timer tick, asking Buildbucket for the build status
[17:23:45.213] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:45.213] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:96:0) after 1m0s
[17:24:45.263] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:96:0)
[17:24:45.263] Timer tick, asking Buildbucket for the build status
[17:24:45.530] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:45.530] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:97:0) after 1m0s
[17:25:45.598] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:97:0)
[17:25:45.598] Timer tick, asking Buildbucket for the build status
[17:25:45.797] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:45.797] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:98:0) after 1m0s
[17:26:45.898] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:98:0)
[17:26:45.898] Timer tick, asking Buildbucket for the build status
[17:26:46.044] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:46.044] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:99:0) after 1m0s
[17:27:46.064] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:99:0)
[17:27:46.064] Timer tick, asking Buildbucket for the build status
[17:27:46.171] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:46.172] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:100:0) after 1m0s
[17:28:46.193] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:100:0)
[17:28:46.193] Timer tick, asking Buildbucket for the build status
[17:28:46.290] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:46.290] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:101:0) after 1m0s
[17:29:46.337] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:101:0)
[17:29:46.337] Timer tick, asking Buildbucket for the build status
[17:29:46.404] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:46.404] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:102:0) after 1m0s
[17:30:46.503] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:102:0)
[17:30:46.503] Timer tick, asking Buildbucket for the build status
[17:30:46.642] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:46.642] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:103:0) after 1m0s
[17:31:46.640] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:103:0)
[17:31:46.640] Timer tick, asking Buildbucket for the build status
[17:31:46.739] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:46.739] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:104:0) after 1m0s
[17:32:46.766] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:104:0)
[17:32:46.766] Timer tick, asking Buildbucket for the build status
[17:32:46.844] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:46.844] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:105:0) after 1m0s
[17:33:46.925] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:105:0)
[17:33:46.925] Timer tick, asking Buildbucket for the build status
[17:33:47.267] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:47.267] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:106:0) after 1m0s
[17:34:47.353] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:106:0)
[17:34:47.353] Timer tick, asking Buildbucket for the build status
[17:34:47.431] Build 8853676632771175088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:47.431] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019106694715913232:107:0) after 1m0s
[17:35:07.393] Received PubSub notification, asking Buildbucket for the build status
[17:35:07.606] Build 8853676632771175088: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:35:07.606] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614879305825425",
"created_by": "project:chromium",
"created_ts": "1614873011767702",
"id": "8853676632771175088",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3025b5eb8a63870819141c3ea2b272a71f472147\"}}",
"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\": \"3025b5eb8a63870819141c3ea2b272a71f472147\", \"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-6-55ju\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17631, \"clang_revision\": \"llvmorg-13-init-1559-g01b87444-3\", \"got_angle_revision\": \"90db604919ba6e3a5ffbdd43845ac33f91e7ddfa\", \"got_dawn_revision\": \"d9a96fb28648eaff2c54beca62f14c718f042217\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"3025b5eb8a63870819141c3ea2b272a71f472147\", \"got_revision_cp\": \"refs/heads/master@{#859775}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"084529f3a9b9992a0de73fe333f677bced7b8fdb\", \"got_v8_revision\": \"d8ce89b999efc8327bfb5e7b9be78b594df14f1c\", \"got_v8_revision_cp\": \"refs/heads/9.1.42@{#1}\", \"got_webrtc_revision\": \"3208bf102b75e8ec1eaa6640dfa3b545310b1e02\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33382}\", \"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\": \"3025b5eb8a63870819141c3ea2b272a71f472147\", \"swarm_hashes_refs/heads/master(at){#859775}_without_patch\": {\"absl_hardening_tests\": \"80494d8d211a0d7b6f2982163cbcb0d84e4b05ba\", \"accessibility_unittests\": \"edccd67b8a32deca34a3ea5b26669ddee946b931\", \"angle_unittests\": \"54d1738aa6e7992350efabcfbeb2c0058512d612\", \"app_shell_unittests\": \"86aaa1b5499f15f4b4f84a9fc00475dc2ad67d5c\", \"aura_unittests\": \"c3d373dcc24106c7cb2bfd7c7cdd39c67b47ba6b\", \"base_unittests\": \"2b201e5cc08286c87ac9ae1c90f367b7d58ba69c\", \"base_util_unittests\": \"424f0cb401ce40f22fc891ada0b14cf6b4883bc1\", \"blink_common_unittests\": \"e3324fac3860e5a194bf1eb62cc109cbd2e3f0b9\", \"blink_fuzzer_unittests\": \"6c641f8de083d970a8d52dcbf28d70ba5ca16e61\", \"blink_heap_unittests\": \"4d3f896c64e649b3fc41638b399f83d49dfec0fe\", \"blink_platform_unittests\": \"4d5cab1ca0a3f8fa882f93382809d2836dfefee3\", \"blink_unittests\": \"ef5d9f8504da106666c2da0b3f53b33cbbd5e7dc\", \"boringssl_crypto_tests\": \"93c5141d1a2e35d8c8020dd068f597c2b4ee23a9\", \"boringssl_ssl_tests\": \"ea77ff1162082784f30b94b9ed9e17ed91f7c0fe\", \"browser_switcher_bho_unittests\": \"9871e199d6ded1e46dcf2e68ce2836c274e532d9\", \"browser_tests\": \"b968ee410a982a03dc60586d2c12ad6c4ef68151\", \"capture_unittests\": \"9de7d33e75a30a98cae9b1dec1a8ceffd7e127bf\", \"cast_unittests\": \"5020e43b5d82746d5563140a341b9497dfbdef31\", \"cc_unittests\": \"aba1f3382ba3d64e4374f0951a98225d7d9f5b29\", \"chrome_app_unittests\": \"d84ee7e90206ba423bd45a2325500a92b90642c4\", \"chrome_cleaner_unittests\": \"f2562246a2e5048645f52c1e852ff7fbbffdfb0f\", \"chrome_elf_unittests\": \"61aba51f1fa054600d3e34acde45a7be7961dbe8\", \"chromedriver_unittests\": \"c89dfba3c8a853357381b18c2937fc913d593902\", \"color_unittests\": \"46ccfc7ad2ff9ccaae6370e63cc8992fa8bf9f91\", \"components_browsertests\": \"7c8b743a25beecb9fa8934971b1f3f790b3cdff8\", \"components_unittests\": \"536328906a07bdbc19c4757b1df3b087e5b56cca\", \"compositor_unittests\": \"a19cf8ad6e9e7acb4a3b0a03460df5ff21764df4\", \"content_browsertests\": \"6386987b1268c847b5578159349733847c11e889\", \"content_unittests\": \"98df357863c68fb11aedf38fa2e2f10e5a15531a\", \"courgette_unittests\": \"f0e8e460d6ea4e75a3b6fbf937e80d2fdc6a8b1b\", \"crashpad_tests\": \"3587f60df449f3b55e922a7f553bddab801fa578\", \"cronet_tests\": \"dd7bfb7202e499a1bfa217258b8fa028c052f8eb\", \"cronet_unittests\": \"91293b0cfccf84d943de76b3e701d138ecba3ace\", \"crypto_unittests\": \"53bbfe49e473ada824e02dc2a170344b7859bf74\", \"delayloads_unittests\": \"3ba20469f3815589b66fd974ba8a5d53f91cb918\", \"device_unittests\": \"8fd8b7adb309557c735bfaec83cb2f54dc349b89\", \"display_unittests\": \"0f606a911bc20b6329f7b715c0d27c5a99d5b45b\", \"elevation_service_unittests\": \"0b2c9a2f7ada310a6a6b43fc564253861d534e39\", \"events_unittests\": \"f201958a04b34b6e77238ee70aca716d1f27b920\", \"extensions_browsertests\": \"76db325d3dc33c947b647fd33e73b45e455c0fd8\", \"extensions_unittests\": \"5f96a1ab5d2cd938c20fdd68ce9383680545f299\", \"filesystem_service_unittests\": \"7ae18569c3283568a3f70f6b9ada949af9cd62d1\", \"gcm_unit_tests\": \"8331c63c9ee3b1271842bcea45727a1be41220c9\", \"gcp_unittests\": \"e76b978cba9097d48cb27f39211830d0b4ca6c1f\", \"gfx_unittests\": \"0694bb6878a4887edd07f14f8db987a3daf62def\", \"gin_unittests\": \"e81b970cc607d4d734998ce688bced899a9b2c64\", \"google_apis_unittests\": \"82b7fc03d3a70c823ba0579e46a88d809690eef4\", \"gpu_unittests\": \"242f3c78f0b3ad1172ae16476598886426e139be\", \"gwp_asan_unittests\": \"d6f6b6f03f033b91234a3d466d38602f71b5a250\", \"headless_browsertests\": \"bb50a3de949e8ef79949f56bc9cef826cc151bb5\", \"headless_unittests\": \"b77b20676be66ef3f9a8e0bdc260c2a49e3014ec\", \"install_static_unittests\": \"094ad166a7aaf5d2801ddd99b7393e11b230be87\", \"installer_util_unittests\": \"d05e2e64368b042a795ab673d44e902490094315\", \"interactive_ui_tests\": \"58a2a0bff29052c34badac5333b866225bb54959\", \"ipc_tests\": \"6455eeb7f8745776e7c10a6d2d258760c8d350bc\", \"jingle_unittests\": \"9e5c1378b5c54e74f07df1e5209f062ee95b8194\", \"latency_unittests\": \"7d7c41089f5dc2fc9456566145592c4a4bd342ee\", \"libjingle_xmpp_unittests\": \"f9c1ce2ab2d831b50a44cf1351cb7ef93a642fb7\", \"liburlpattern_unittests\": \"b0d1c8f688a977ee0aee9b6184dcc0a73eef63f0\", \"media_blink_unittests\": \"bf4d79b506445795e34f3f0608df565c5869fd7d\", \"media_unittests\": \"9169794c6cfea1b7f5d94b598746507047ee4f4a\", \"message_center_unittests\": \"e5e8f41d531570264e4b88adc7a6ea2eaa88ad42\", \"midi_unittests\": \"a5465dcbb15c797999a1b4dd52b9913fd332d13a\", \"mojo_core_unittests\": \"e558d685e509fbe09c2c529f5f89968484ff53c9\", \"mojo_unittests\": \"92dbec3304a12c5b072df41a4cae66663441dd07\", \"nacl_loader_unittests\": \"3629cf2725da103dc5679af2b844fedb2442e612\", \"native_theme_unittests\": \"d2c765c32a6f5e90c69d8b7d3b0b5ce6cc746b23\", \"net_unittests\": \"3d0bfd612bb0d5ba112d6f12c47e70f58fece297\", \"notification_helper_unittests\": \"9c33a98b6fe2f71c7c209222cada06dcbcb68646\", \"pdf_unittests\": \"36b9922c4441f775f36759992dfc926728b3bdce\", \"perfetto_unittests\": \"2a911a4dd9b799718794d4c3bd613c71234c8587\", \"ppapi_unittests\": \"2ef0e413beb2b331af2ac75ee0408d0275408850\", \"printing_unittests\": \"3829bc6168df71e020977a439ecaf8d840b0e4dc\", \"remoting_unittests\": \"be0b4b0a835301e31b8fd8340c717938fcc66ca1\", \"sbox_integration_tests\": \"57c633e06f62f71bab5cf91a27c9126f99b7c30e\", \"sbox_unittests\": \"a7c676e6793a99ee83281bb07776a0cca9a5ee20\", \"sbox_validation_tests\": \"cae4775353e1b68fc6257775868f27d6780396ae\", \"service_manager_unittests\": \"07c497872c249a726d8205acf55aff5a20a546e3\", \"services_unittests\": \"33b7cc874de1222c44768c51110728b2e1c6a28b\", \"setup_unittests\": \"0491a26fe763980cdc4b0807fac9eebca13d6787\", \"shell_dialogs_unittests\": \"c0c6e7fab39021bd64b047cd340ff03df6457a2b\", \"skia_unittests\": \"2c9f6501827d47c0ae2b79d4ec7d62d925ddb601\", \"snapshot_unittests\": \"065a095878169e3ef07de3eaf3d23df8c284847e\", \"sql_unittests\": \"fbe3fe2763e9061e53095224240c6e4bfed3e2f1\", \"storage_unittests\": \"f86ddfa4c5ee16f49215cb320bdc2603b535363d\", \"sync_integration_tests\": \"84045b10e2fc413a724a0fb9d51b32ddd58e300d\", \"traffic_annotation_auditor_unittests\": \"0c4fb8ada19ddc4d36c9cbb7174538e6c9715617\", \"ui_base_unittests\": \"cf872a40ef08a75138f1720edeb99c56052734d4\", \"ui_touch_selection_unittests\": \"df845f9018ccac5458b69b1ead89be974bce9570\", \"unit_tests\": \"c5c9d16b5af24859feb792ad0523aad4742fdf40\", \"updater_tests\": \"ea91e16fdcdd0ffc7b4ed2d96d20c7a6789028cc\", \"url_unittests\": \"f63fb7ac587e0cdc7bb236363c90bd77ba3a70c8\", \"views_unittests\": \"e1d7959c9957441e6b6714fdde833d513df376fd\", \"viz_unittests\": \"51d63ca307e11c3e5d2946fb9ffe2c5b10934180\", \"vr_common_unittests\": \"d2aa878baf1c406ed2f7be83dcddb51090730855\", \"vr_pixeltests\": \"02fee19cd2addf6a23d52ab816f34648fa321d7d\", \"weblayer_browsertests\": \"1020ee5cfd91da407f7377fc47c5ab21c2ed5125\", \"weblayer_unittests\": \"820d391e4bd511af14a83f78b05336722284d97e\", \"wm_unittests\": \"523239698065d905e6cf062c89efb03827e6961d\", \"wtf_unittests\": \"5094eb00eaa57899c0b24017a0acaa4c644163f6\", \"zlib_unittests\": \"4d3e6e913e5f249b95d89e0f15b9d0b76d7aaedb\", \"zucchini_unittests\": \"906041ba013389d29c09cb9afa65fe72cd10f58d\"}}, \"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-6-55ju\"], \"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\": [\"5725-1a0d85e\"], \"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": "1614873018050764",
"status": "COMPLETED",
"status_changed_ts": "1614879306250194",
"tags": [
"build_address:luci.chromium.ci/win-asan/17631",
"builder:win-asan",
"buildset:commit/git/3025b5eb8a63870819141c3ea2b272a71f472147",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3025b5eb8a63870819141c3ea2b272a71f472147",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019106694715913232",
"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/8853676632771175088/+/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:5216c0337c872c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1614879306270058",
"url": "https://ci.chromium.org/b/8853676632771175088",
"utcnow_ts": "1614879307591401"
}
}
[17:35:07.606] Invocation finished in 1h44m57.076513205s with status SUCCEEDED