[08:26:56.683] New invocation is queued and will start shortly
[08:26:57.888] Starting the invocation (attempt 1)
[08:26:57.921] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:26:57.921] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:26:57.921] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018681595587912304",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"dc3b0ddaecf1f8b200e0a7043cc6ba0d453b163d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9018681595587912304",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/dc3b0ddaecf1f8b200e0a7043cc6ba0d453b163d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dc3b0ddaecf1f8b200e0a7043cc6ba0d453b163d",
"gitiles_ref:refs/heads/master"
]
}
[08:26:58.512] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615278417990733",
"id": "8853251533536469728",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dc3b0ddaecf1f8b200e0a7043cc6ba0d453b163d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615278418391387",
"tags": [
"build_address:luci.chromium.ci/win-asan/17716",
"builder:win-asan",
"buildset:commit/git/dc3b0ddaecf1f8b200e0a7043cc6ba0d453b163d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dc3b0ddaecf1f8b200e0a7043cc6ba0d453b163d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018681595587912304",
"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/8853251533536469728/+/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": "1615278418391617",
"url": "https://ci.chromium.org/b/8853251533536469728",
"utcnow_ts": "1615278418504155"
}
}
[08:26:58.512] Task URL: https://ci.chromium.org/b/8853251533536469728
[08:26:58.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:2:0) after 1m0s
[08:27:22.851] Received PubSub notification, asking Buildbucket for the build status
[08:27:22.941] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:58.500] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:2:0)
[08:27:58.500] Timer tick, asking Buildbucket for the build status
[08:27:58.576] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:58.576] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:4:0) after 1m0s
[08:28:58.665] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:4:0)
[08:28:58.665] Timer tick, asking Buildbucket for the build status
[08:28:59.573] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:59.573] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:5:0) after 1m0s
[08:29:59.652] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:5:0)
[08:29:59.652] Timer tick, asking Buildbucket for the build status
[08:29:59.857] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:59.857] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:6:0) after 1m0s
[08:30:59.895] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:6:0)
[08:30:59.895] Timer tick, asking Buildbucket for the build status
[08:31:00.208] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:00.208] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:7:0) after 1m0s
[08:32:00.254] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:7:0)
[08:32:00.254] Timer tick, asking Buildbucket for the build status
[08:32:00.323] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:00.323] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:8:0) after 1m0s
[08:33:00.375] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:8:0)
[08:33:00.375] Timer tick, asking Buildbucket for the build status
[08:33:00.471] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:00.471] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:9:0) after 1m0s
[08:34:00.505] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:9:0)
[08:34:00.505] Timer tick, asking Buildbucket for the build status
[08:34:00.584] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:00.584] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:10:0) after 1m0s
[08:35:00.573] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:10:0)
[08:35:00.573] Timer tick, asking Buildbucket for the build status
[08:35:00.639] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:00.639] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:11:0) after 1m0s
[08:36:01.592] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:11:0)
[08:36:01.592] Timer tick, asking Buildbucket for the build status
[08:36:01.669] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:01.670] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:12:0) after 1m0s
[08:37:01.922] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:12:0)
[08:37:01.922] Timer tick, asking Buildbucket for the build status
[08:37:02.203] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:02.203] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:13:0) after 1m0s
[08:38:02.230] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:13:0)
[08:38:02.230] Timer tick, asking Buildbucket for the build status
[08:38:02.320] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:02.320] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:14:0) after 1m0s
[08:39:02.340] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:14:0)
[08:39:02.340] Timer tick, asking Buildbucket for the build status
[08:39:02.634] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:02.634] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:15:0) after 1m0s
[08:40:02.645] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:15:0)
[08:40:02.645] Timer tick, asking Buildbucket for the build status
[08:40:02.733] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:02.733] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:16:0) after 1m0s
[08:41:02.742] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:16:0)
[08:41:02.742] Timer tick, asking Buildbucket for the build status
[08:41:02.953] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:02.953] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:17:0) after 1m0s
[08:42:02.962] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:17:0)
[08:42:02.962] Timer tick, asking Buildbucket for the build status
[08:42:03.035] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:03.035] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:18:0) after 1m0s
[08:43:03.127] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:18:0)
[08:43:03.127] Timer tick, asking Buildbucket for the build status
[08:43:03.318] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:03.318] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:19:0) after 1m0s
[08:44:03.344] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:19:0)
[08:44:03.344] Timer tick, asking Buildbucket for the build status
[08:44:03.747] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:03.747] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:20:0) after 1m0s
[08:45:03.793] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:20:0)
[08:45:03.793] Timer tick, asking Buildbucket for the build status
[08:45:03.864] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:03.864] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:21:0) after 1m0s
[08:46:03.909] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:21:0)
[08:46:03.909] Timer tick, asking Buildbucket for the build status
[08:46:04.010] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:04.010] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:22:0) after 1m0s
[08:47:04.108] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:22:0)
[08:47:04.108] Timer tick, asking Buildbucket for the build status
[08:47:04.299] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:04.299] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:23:0) after 1m0s
[08:48:04.333] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:23:0)
[08:48:04.333] Timer tick, asking Buildbucket for the build status
[08:48:04.417] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:04.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:24:0) after 1m0s
[08:49:04.475] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:24:0)
[08:49:04.475] Timer tick, asking Buildbucket for the build status
[08:49:04.727] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:04.727] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:25:0) after 1m0s
[08:50:04.746] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:25:0)
[08:50:04.746] Timer tick, asking Buildbucket for the build status
[08:50:04.848] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:04.848] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:26:0) after 1m0s
[08:51:04.883] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:26:0)
[08:51:04.883] Timer tick, asking Buildbucket for the build status
[08:51:04.985] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:04.985] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:27:0) after 1m0s
[08:52:05.110] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:27:0)
[08:52:05.110] Timer tick, asking Buildbucket for the build status
[08:52:05.292] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:05.292] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:28:0) after 1m0s
[08:53:05.366] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:28:0)
[08:53:05.366] Timer tick, asking Buildbucket for the build status
[08:53:05.554] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:05.554] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:29:0) after 1m0s
[08:54:05.572] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:29:0)
[08:54:05.572] Timer tick, asking Buildbucket for the build status
[08:54:05.660] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:05.660] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:30:0) after 1m0s
[08:55:05.684] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:30:0)
[08:55:05.684] Timer tick, asking Buildbucket for the build status
[08:55:05.763] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:05.763] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:31:0) after 1m0s
[08:56:05.778] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:31:0)
[08:56:05.778] Timer tick, asking Buildbucket for the build status
[08:56:05.871] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:05.871] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:32:0) after 1m0s
[08:57:05.937] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:32:0)
[08:57:05.937] Timer tick, asking Buildbucket for the build status
[08:57:06.003] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:06.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:33:0) after 1m0s
[08:58:06.211] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:33:0)
[08:58:06.211] Timer tick, asking Buildbucket for the build status
[08:58:06.306] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:06.306] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:34:0) after 1m0s
[08:59:06.386] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:34:0)
[08:59:06.386] Timer tick, asking Buildbucket for the build status
[08:59:06.515] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:06.515] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:35:0) after 1m0s
[09:00:06.526] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:35:0)
[09:00:06.526] Timer tick, asking Buildbucket for the build status
[09:00:06.595] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:06.595] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:36:0) after 1m0s
[09:01:06.738] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:36:0)
[09:01:06.738] Timer tick, asking Buildbucket for the build status
[09:01:06.869] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:06.869] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:37:0) after 1m0s
[09:02:06.996] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:37:0)
[09:02:06.996] Timer tick, asking Buildbucket for the build status
[09:02:07.307] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:07.307] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:38:0) after 1m0s
[09:03:07.293] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:38:0)
[09:03:07.293] Timer tick, asking Buildbucket for the build status
[09:03:07.438] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:07.438] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:39:0) after 1m0s
[09:04:07.463] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:39:0)
[09:04:07.463] Timer tick, asking Buildbucket for the build status
[09:04:07.532] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:07.532] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:40:0) after 1m0s
[09:05:07.538] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:40:0)
[09:05:07.538] Timer tick, asking Buildbucket for the build status
[09:05:07.642] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:07.642] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:41:0) after 1m0s
[09:06:07.652] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:41:0)
[09:06:07.652] Timer tick, asking Buildbucket for the build status
[09:06:07.822] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:07.822] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:42:0) after 1m0s
[09:07:07.928] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:42:0)
[09:07:07.928] Timer tick, asking Buildbucket for the build status
[09:07:08.746] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:08.746] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:43:0) after 1m0s
[09:08:08.775] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:43:0)
[09:08:08.775] Timer tick, asking Buildbucket for the build status
[09:08:09.013] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:09.013] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:44:0) after 1m0s
[09:09:09.036] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:44:0)
[09:09:09.036] Timer tick, asking Buildbucket for the build status
[09:09:09.729] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:09.729] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:45:0) after 1m0s
[09:10:09.727] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:45:0)
[09:10:09.727] Timer tick, asking Buildbucket for the build status
[09:10:09.804] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:09.804] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:46:0) after 1m0s
[09:11:09.823] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:46:0)
[09:11:09.823] Timer tick, asking Buildbucket for the build status
[09:11:09.967] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:09.967] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:47:0) after 1m0s
[09:12:10.020] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:47:0)
[09:12:10.020] Timer tick, asking Buildbucket for the build status
[09:12:10.109] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:10.109] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:48:0) after 1m0s
[09:13:10.153] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:48:0)
[09:13:10.153] Timer tick, asking Buildbucket for the build status
[09:13:10.243] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:10.243] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:49:0) after 1m0s
[09:14:10.293] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:49:0)
[09:14:10.293] Timer tick, asking Buildbucket for the build status
[09:14:10.494] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:10.494] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:50:0) after 1m0s
[09:15:10.564] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:50:0)
[09:15:10.564] Timer tick, asking Buildbucket for the build status
[09:15:10.636] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:10.636] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:51:0) after 1m0s
[09:16:10.656] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:51:0)
[09:16:10.656] Timer tick, asking Buildbucket for the build status
[09:16:10.762] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:10.762] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:52:0) after 1m0s
[09:17:10.784] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:52:0)
[09:17:10.784] Timer tick, asking Buildbucket for the build status
[09:17:10.879] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:10.879] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:53:0) after 1m0s
[09:18:10.897] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:53:0)
[09:18:10.897] Timer tick, asking Buildbucket for the build status
[09:18:10.982] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:10.982] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:54:0) after 1m0s
[09:19:11.032] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:54:0)
[09:19:11.032] Timer tick, asking Buildbucket for the build status
[09:19:11.142] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:11.142] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:55:0) after 1m0s
[09:20:11.161] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:55:0)
[09:20:11.161] Timer tick, asking Buildbucket for the build status
[09:20:11.250] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:11.250] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:56:0) after 1m0s
[09:21:11.267] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:56:0)
[09:21:11.267] Timer tick, asking Buildbucket for the build status
[09:21:11.359] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:11.359] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:57:0) after 1m0s
[09:22:11.368] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:57:0)
[09:22:11.368] Timer tick, asking Buildbucket for the build status
[09:22:11.477] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:11.477] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:58:0) after 1m0s
[09:23:11.507] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:58:0)
[09:23:11.507] Timer tick, asking Buildbucket for the build status
[09:23:11.598] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:11.598] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:59:0) after 1m0s
[09:24:11.609] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:59:0)
[09:24:11.609] Timer tick, asking Buildbucket for the build status
[09:24:11.690] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:11.690] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:60:0) after 1m0s
[09:25:11.714] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:60:0)
[09:25:11.714] Timer tick, asking Buildbucket for the build status
[09:25:11.792] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:11.792] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:61:0) after 1m0s
[09:26:11.834] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:61:0)
[09:26:11.834] Timer tick, asking Buildbucket for the build status
[09:26:11.911] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:11.911] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:62:0) after 1m0s
[09:27:11.941] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:62:0)
[09:27:11.941] Timer tick, asking Buildbucket for the build status
[09:27:12.022] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:12.022] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:63:0) after 1m0s
[09:28:12.098] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:63:0)
[09:28:12.098] Timer tick, asking Buildbucket for the build status
[09:28:14.965] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:14.965] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:64:0) after 1m0s
[09:29:15.151] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:64:0)
[09:29:15.151] Timer tick, asking Buildbucket for the build status
[09:29:15.248] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:15.248] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:65:0) after 1m0s
[09:30:15.218] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:65:0)
[09:30:15.218] Timer tick, asking Buildbucket for the build status
[09:30:15.298] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:15.298] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:66:0) after 1m0s
[09:31:15.284] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:66:0)
[09:31:15.284] Timer tick, asking Buildbucket for the build status
[09:31:15.689] Build 8853251533536469728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:15.689] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018681595587912304:67:0) after 1m0s
[09:31:46.569] Received PubSub notification, asking Buildbucket for the build status
[09:31:46.655] Build 8853251533536469728: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:31:46.655] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615282298552425",
"created_by": "project:chromium",
"created_ts": "1615278417990733",
"id": "8853251533536469728",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dc3b0ddaecf1f8b200e0a7043cc6ba0d453b163d\"}}",
"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\": \"dc3b0ddaecf1f8b200e0a7043cc6ba0d453b163d\", \"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-8-2xaw\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17716, \"clang_revision\": \"llvmorg-13-init-3462-gfe5c2c3c-1\", \"got_angle_revision\": \"9bc9ac8df8df59031e5da1aad936a91b4a36a607\", \"got_dawn_revision\": \"7c3b5740db6be782ca4d2e78139568b67db1fc0f\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"dc3b0ddaecf1f8b200e0a7043cc6ba0d453b163d\", \"got_revision_cp\": \"refs/heads/master@{#861064}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"023914a27b634063766fee96f2e6763513f5b059\", \"got_v8_revision\": \"5c86b9ed5fdab5a53c326ae37b77effcef0b67ff\", \"got_v8_revision_cp\": \"refs/heads/9.1.75@{#1}\", \"got_webrtc_revision\": \"3208bf102b75e8ec1eaa6640dfa3b545310b1e02\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33382}\", \"is_cached\": true, \"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\": \"dc3b0ddaecf1f8b200e0a7043cc6ba0d453b163d\", \"swarm_hashes_refs/heads/master(at){#861064}_without_patch\": {\"absl_hardening_tests\": \"32a3990fda00cbcf2ac9468b5e363e003606f8e4\", \"accessibility_unittests\": \"2cddc2a04d034b56aec10dbb0c2d92a02179ab52\", \"angle_unittests\": \"d3b85a0922fe71c643fadd0d5240365d8940af0f\", \"app_shell_unittests\": \"76624e71cf9fd7c84aa431c7e7697a33903e470e\", \"aura_unittests\": \"c0c34d0f2a9b1fbc5bfe3c88fc1bf578f7344f05\", \"base_unittests\": \"604319fdf0bc365b99860835677287e97bb23316\", \"base_util_unittests\": \"25bae4fd66d5a3154d926837bae43a8d3c43eb17\", \"blink_common_unittests\": \"28b02af45487f14658b2221015b8301d66221c14\", \"blink_fuzzer_unittests\": \"fe79814609d4fef6cf1c4dda0b2191e82ced538c\", \"blink_heap_unittests\": \"c21d8b541e078801ea217701d61be31d03d3cf32\", \"blink_platform_unittests\": \"7bb8e3b48ad199bc1d062e8bb15cf147fccfa845\", \"blink_unittests\": \"7be2353d59473a74f39f7daf3f4e7eae9699b1f8\", \"boringssl_crypto_tests\": \"9725dea516d4d9e053b81da6d813f8f221f60b2f\", \"boringssl_ssl_tests\": \"fc2d39f2f6f6429dcbe3d0a16ed337baacc44c95\", \"browser_switcher_bho_unittests\": \"a49319d1daa57e6c62abee2078bb8d6438a2ca90\", \"browser_tests\": \"6798183d3ef334e20bd65880c58a76eb44c83edb\", \"capture_unittests\": \"ce79fcd279595958eb63d3ee6f93af77e9022fb2\", \"cast_unittests\": \"eac865e6c7dd1a2598927f1237372bb950ac001d\", \"cc_unittests\": \"fbd61f955b86fb96775e653b7b0e4f2efc6e96dc\", \"chrome_app_unittests\": \"d00d33b11cc8b6a6661d21419e4669529291ed32\", \"chrome_cleaner_unittests\": \"5d13cf4ef3336484c8f5ff03b9071f8211ece417\", \"chrome_elf_unittests\": \"ed224bdce24ce35cd4e82b4e23b76f8aea78517d\", \"chromedriver_unittests\": \"fe5c878a85057e22361bedbf6c6add64432f2ac9\", \"color_unittests\": \"72a7324cd699744b0e1099ad2c481a56fd929f9f\", \"components_browsertests\": \"8ec35b7938bc5ad1d1236085d4c3197f04163b54\", \"components_unittests\": \"6ed530f0f2779adff43b9b88cb44563b5a742ba4\", \"compositor_unittests\": \"10a965f9c25e9cc9f9dee6a77b85f74c189046d2\", \"content_browsertests\": \"dd730e73db915f6e9e49565c1943dd3a57dc73bc\", \"content_unittests\": \"0bf4070abfa49586b30759341fe84e820611cb4d\", \"courgette_unittests\": \"4682bd6886637493b6af4fbe7a7d0346ac686dde\", \"crashpad_tests\": \"21ea5d735e597ef89445d6a2758f8367902cb0c2\", \"cronet_tests\": \"6135dc4ae837dc5e1fb731f18337928cf4313f4d\", \"cronet_unittests\": \"f2b5a98c43529eb964b9afda969a34d51fe48e60\", \"crypto_unittests\": \"c1ea3a3a74e112f9d0a431b27c1a2b0ff545452a\", \"delayloads_unittests\": \"ed203aeea4a6fe17011b0a1a239a5dd85ad4302f\", \"device_unittests\": \"e200abbe69fc1968c0fb072c7c81e03802c40808\", \"display_unittests\": \"5b99bcc5d92c88023f3abc9313107ef088f22d1d\", \"elevation_service_unittests\": \"27b5a1bd7a891f922d281bfe7c96c9d073eef3ac\", \"events_unittests\": \"8167344f7238eef189288b4f81972055223306bc\", \"extensions_browsertests\": \"6e5100807fd03bd8896c47af0bd1c3d126ef4020\", \"extensions_unittests\": \"ef516928aedb43e3c1cbc63333cfbb6a31f8c054\", \"filesystem_service_unittests\": \"a7dfea68e5b98bab447736694cb012533cc32779\", \"gcm_unit_tests\": \"e10468c9e2dc532b288877ff50c9e7b1fabf1b0b\", \"gcp_unittests\": \"d90186e61f49a6a3fa4175643064edb5e480bfc7\", \"gfx_unittests\": \"384f37bcdbfe61984fc547908da79a046ade99cc\", \"gin_unittests\": \"1cae7602c4a2e9a4739030b7d8b743cf2f9bf031\", \"google_apis_unittests\": \"bd3919b23f99c3d989f08643902c2e2cba447676\", \"gpu_unittests\": \"7c3ac9f627fc3f699e01e6afb7d6090f53d0a664\", \"gwp_asan_unittests\": \"ea2ee3550d7b6906d650ee0ff8fb864eb567a7d5\", \"headless_browsertests\": \"c0acd7b167e651fc0647946aa738f1f7135fad19\", \"headless_unittests\": \"f6ef8587fb7974b87f993206287bbc7719b6dacb\", \"install_static_unittests\": \"0ab793fd0ea1b80acc8ac3f85fb304dc81d12d2a\", \"installer_util_unittests\": \"187720b6aebef56ca892a40a09e628d68f69cf5c\", \"interactive_ui_tests\": \"ca91765caebb46c9926163fc5ed203bfd52f06ef\", \"ipc_tests\": \"7ea7e0da72cf2bf7e86850f1b7b87b21cc026238\", \"jingle_unittests\": \"e8b02db3a7e27ad79623e75c44e9ae79792e33e0\", \"latency_unittests\": \"86c453c4edcc2ba3843882acc96bcee568e1c9a1\", \"libjingle_xmpp_unittests\": \"280aa5f004ad4e66d3b468303c5c42e7189d9434\", \"liburlpattern_unittests\": \"fcae43f5161dd9e607c5825db07c9193a1344c38\", \"media_blink_unittests\": \"82529a29229b76b65700ca22b4251897193b6a8b\", \"media_unittests\": \"bd66c1d880bc4a07aebdc3e3b907b1bb5def2bde\", \"message_center_unittests\": \"77971f86d36ea2dd3644aae86396da2265896a5b\", \"midi_unittests\": \"57136e4424c89422ed7ca185bf7e00f7495f255a\", \"mojo_core_unittests\": \"0008967b0b7e01f014a4830423b2d7c7c009d62c\", \"mojo_unittests\": \"6e6c2cec31db4da72d0e5e0834e8669c1526f75b\", \"nacl_loader_unittests\": \"d5d56750f91841bfedd79a49a9f4176204071d29\", \"native_theme_unittests\": \"2540b8226bb3ad222890a143cb5d1748566f5a9e\", \"net_unittests\": \"fe4c0f1c2daf9c5bbbf444189a7a7ff2b4f2f8ba\", \"notification_helper_unittests\": \"f863b7613979ef07171b1e9910616f4d4488d5d5\", \"pdf_unittests\": \"78d994f0ae28bcbe58b1616eaf26082795b84bbc\", \"perfetto_unittests\": \"622ee33523155edaf72c83dd1eab1c480c3bcb40\", \"ppapi_unittests\": \"8ffba9061b8ec78d87bc07b51d3c9d3b7610f4d9\", \"printing_unittests\": \"9e5f7a9f966f671e0e512a324ae853f451d1328c\", \"remoting_unittests\": \"4456d084413066abafbd2aaf5cacea9db79253c1\", \"sbox_integration_tests\": \"6d00fbff9f79ff6c5233571518914f519a0fcc3c\", \"sbox_unittests\": \"b21e7ca2e3775d7b70b9bbc7956108019b6ec7fa\", \"sbox_validation_tests\": \"7d9c44574b37804ed75465796799f72b80c4161f\", \"service_manager_unittests\": \"af2ee7f5904b7fa9a612d3d2ca0bc55c911a76e1\", \"services_unittests\": \"be81cb03d7b4747ef123a9554c1f2ad5a261c9fe\", \"setup_unittests\": \"4024eec8099ac004e32fe090ff2eedd27fb0dee8\", \"shell_dialogs_unittests\": \"d5be4beb06d53c79b81b6d5e4da172b7e0bdc410\", \"skia_unittests\": \"7e32119407d14dca0b6c4ba25ac7ba18190cd965\", \"snapshot_unittests\": \"a9a66c1b5c1b3a37ccb8f2096e72fc9bcf630a87\", \"sql_unittests\": \"ad9a8bd7b5f2fc800efc18e9a5c2de03bc3f7f45\", \"storage_unittests\": \"8f21a59aef4e3d3f97aa4a6a6cca2eec57a23731\", \"sync_integration_tests\": \"4da855085abca2f1588f46d5eafd88e0de317ab6\", \"traffic_annotation_auditor_unittests\": \"bc7746038af1fa7616c41872ca8e7f148cd0150f\", \"ui_base_unittests\": \"607c1b2b616284942d67de50844b9dcf92c1a23d\", \"ui_touch_selection_unittests\": \"b43684ec26e42f4f074110d9d905cf4c6fe8d06c\", \"unit_tests\": \"305cdfbc469614c62d2db8742bfa6ab6f2c632aa\", \"updater_tests\": \"5079dc864f1d8b889cfb65d00693a78b051b9aa4\", \"url_unittests\": \"85889979189acbfc643f466d361d770a18372287\", \"views_unittests\": \"d43ff96122a53a086ef2f19efe89f8c3b4342de7\", \"viz_unittests\": \"f70293c0df9388eb9612cd184d905fef7c968c46\", \"vr_common_unittests\": \"58150751e02c51d231d6ebbebaf84a37575f93eb\", \"vr_pixeltests\": \"06c785d449abb402a322e810cc51f86f0b4dc488\", \"weblayer_browsertests\": \"c899bb948cfb8ddb14efd6e51c5672cb0a9574ed\", \"weblayer_unittests\": \"8ec1b1282c840ed9587ae47ffa388f574d575d2f\", \"wm_unittests\": \"84b0fc3c4c6f69b502b52d77e3483497367c1a02\", \"wtf_unittests\": \"06f31750fdab3aca292dba7b772229b95ffd3804\", \"zlib_unittests\": \"f8900245f84f95044c76d403dea1e9a7fb26674e\", \"zucchini_unittests\": \"6631845479d018df6c4e056a205411227ca348a2\"}}, \"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-8-2xaw\"], \"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\": [\"5744-5c0a4b4\"], \"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": "1615278440171095",
"status": "COMPLETED",
"status_changed_ts": "1615282298907305",
"tags": [
"build_address:luci.chromium.ci/win-asan/17716",
"builder:win-asan",
"buildset:commit/git/dc3b0ddaecf1f8b200e0a7043cc6ba0d453b163d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dc3b0ddaecf1f8b200e0a7043cc6ba0d453b163d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018681595587912304",
"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/8853251533536469728/+/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:522eea329e590110",
"user_agent:luci-scheduler"
],
"updated_ts": "1615282298964481",
"url": "https://ci.chromium.org/b/8853251533536469728",
"utcnow_ts": "1615282306647954"
}
}
[09:31:46.655] Invocation finished in 1h4m50.004885966s with status SUCCEEDED