[10:16:44.670] New invocation is queued and will start shortly
[10:16:45.853] Starting the invocation (attempt 1)
[10:16:45.897] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:16:45.897] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:16:45.898] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022932744984739104",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"c4182b366dac90de78119e03e204667ac3fb6c21\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9022932744984739104",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/c4182b366dac90de78119e03e204667ac3fb6c21",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c4182b366dac90de78119e03e204667ac3fb6c21",
"gitiles_ref:refs/heads/master"
]
}
[10:16:47.413] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611224205992766",
"id": "8857502682936352784",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c4182b366dac90de78119e03e204667ac3fb6c21\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611224207041518",
"tags": [
"build_address:luci.chromium.ci/win-asan/16929",
"builder:win-asan",
"buildset:commit/git/c4182b366dac90de78119e03e204667ac3fb6c21",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c4182b366dac90de78119e03e204667ac3fb6c21",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022932744984739104",
"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/8857502682936352784/+/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": "1611224207041625",
"url": "https://ci.chromium.org/b/8857502682936352784",
"utcnow_ts": "1611224207341585"
}
}
[10:16:47.413] Task URL: https://ci.chromium.org/b/8857502682936352784
[10:16:47.413] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:2:0) after 1m0s
[10:16:48.602] Received PubSub notification, asking Buildbucket for the build status
[10:16:48.847] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:47.572] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:2:0)
[10:17:47.572] Timer tick, asking Buildbucket for the build status
[10:17:47.686] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:47.686] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:4:0) after 1m0s
[10:18:47.745] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:4:0)
[10:18:47.745] Timer tick, asking Buildbucket for the build status
[10:18:47.960] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:47.960] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:5:0) after 1m0s
[10:19:48.027] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:5:0)
[10:19:48.027] Timer tick, asking Buildbucket for the build status
[10:19:48.172] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:48.172] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:6:0) after 1m0s
[10:20:48.186] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:6:0)
[10:20:48.186] Timer tick, asking Buildbucket for the build status
[10:20:48.313] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:48.313] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:7:0) after 1m0s
[10:21:48.332] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:7:0)
[10:21:48.332] Timer tick, asking Buildbucket for the build status
[10:21:48.469] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:48.469] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:8:0) after 1m0s
[10:22:48.522] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:8:0)
[10:22:48.522] Timer tick, asking Buildbucket for the build status
[10:22:48.631] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:48.631] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:9:0) after 1m0s
[10:23:48.657] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:9:0)
[10:23:48.657] Timer tick, asking Buildbucket for the build status
[10:23:48.718] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:48.718] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:10:0) after 1m0s
[10:24:48.809] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:10:0)
[10:24:48.810] Timer tick, asking Buildbucket for the build status
[10:24:48.903] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:48.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:11:0) after 1m0s
[10:25:48.968] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:11:0)
[10:25:48.968] Timer tick, asking Buildbucket for the build status
[10:25:49.091] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:49.091] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:12:0) after 1m0s
[10:26:49.121] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:12:0)
[10:26:49.121] Timer tick, asking Buildbucket for the build status
[10:26:49.230] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:49.230] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:13:0) after 1m0s
[10:27:49.311] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:13:0)
[10:27:49.311] Timer tick, asking Buildbucket for the build status
[10:27:49.387] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:49.387] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:14:0) after 1m0s
[10:28:49.435] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:14:0)
[10:28:49.435] Timer tick, asking Buildbucket for the build status
[10:28:49.567] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:49.567] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:15:0) after 1m0s
[10:29:49.553] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:15:0)
[10:29:49.553] Timer tick, asking Buildbucket for the build status
[10:29:49.670] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:49.670] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:16:0) after 1m0s
[10:30:49.802] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:16:0)
[10:30:49.802] Timer tick, asking Buildbucket for the build status
[10:30:49.930] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:49.930] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:17:0) after 1m0s
[10:31:50.029] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:17:0)
[10:31:50.029] Timer tick, asking Buildbucket for the build status
[10:31:50.138] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:50.139] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:18:0) after 1m0s
[10:32:50.193] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:18:0)
[10:32:50.193] Timer tick, asking Buildbucket for the build status
[10:32:50.546] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:50.546] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:19:0) after 1m0s
[10:33:50.578] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:19:0)
[10:33:50.578] Timer tick, asking Buildbucket for the build status
[10:33:51.013] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:51.013] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:20:0) after 1m0s
[10:34:51.086] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:20:0)
[10:34:51.086] Timer tick, asking Buildbucket for the build status
[10:34:51.447] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:51.447] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:21:0) after 1m0s
[10:35:51.476] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:21:0)
[10:35:51.476] Timer tick, asking Buildbucket for the build status
[10:35:52.069] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:52.069] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:22:0) after 1m0s
[10:36:52.096] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:22:0)
[10:36:52.096] Timer tick, asking Buildbucket for the build status
[10:36:52.912] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:52.912] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:23:0) after 1m0s
[10:37:52.947] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:23:0)
[10:37:52.947] Timer tick, asking Buildbucket for the build status
[10:37:53.102] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:53.102] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:24:0) after 1m0s
[10:38:53.124] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:24:0)
[10:38:53.124] Timer tick, asking Buildbucket for the build status
[10:38:53.477] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:53.477] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:25:0) after 1m0s
[10:39:53.504] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:25:0)
[10:39:53.504] Timer tick, asking Buildbucket for the build status
[10:39:53.570] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:53.570] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:26:0) after 1m0s
[10:40:53.630] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:26:0)
[10:40:53.630] Timer tick, asking Buildbucket for the build status
[10:40:54.108] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:54.108] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:27:0) after 1m0s
[10:41:54.286] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:27:0)
[10:41:54.286] Timer tick, asking Buildbucket for the build status
[10:41:54.388] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:54.388] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:28:0) after 1m0s
[10:42:54.416] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:28:0)
[10:42:54.416] Timer tick, asking Buildbucket for the build status
[10:42:54.504] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:54.504] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:29:0) after 1m0s
[10:43:54.489] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:29:0)
[10:43:54.489] Timer tick, asking Buildbucket for the build status
[10:43:54.561] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:54.561] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:30:0) after 1m0s
[10:44:54.620] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:30:0)
[10:44:54.620] Timer tick, asking Buildbucket for the build status
[10:44:54.699] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:54.699] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:31:0) after 1m0s
[10:45:54.722] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:31:0)
[10:45:54.722] Timer tick, asking Buildbucket for the build status
[10:45:55.236] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:55.236] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:32:0) after 1m0s
[10:46:55.246] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:32:0)
[10:46:55.246] Timer tick, asking Buildbucket for the build status
[10:46:55.623] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:55.623] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:33:0) after 1m0s
[10:47:55.618] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:33:0)
[10:47:55.618] Timer tick, asking Buildbucket for the build status
[10:47:56.051] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:56.051] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:34:0) after 1m0s
[10:48:56.197] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:34:0)
[10:48:56.197] Timer tick, asking Buildbucket for the build status
[10:48:56.377] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:56.377] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:35:0) after 1m0s
[10:49:56.401] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:35:0)
[10:49:56.401] Timer tick, asking Buildbucket for the build status
[10:49:56.596] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:56.596] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:36:0) after 1m0s
[10:50:56.656] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:36:0)
[10:50:56.656] Timer tick, asking Buildbucket for the build status
[10:50:56.777] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:56.777] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:37:0) after 1m0s
[10:51:56.805] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:37:0)
[10:51:56.805] Timer tick, asking Buildbucket for the build status
[10:51:56.912] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:56.912] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:38:0) after 1m0s
[10:52:56.971] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:38:0)
[10:52:56.971] Timer tick, asking Buildbucket for the build status
[10:52:57.192] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:57.192] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:39:0) after 1m0s
[10:53:57.247] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:39:0)
[10:53:57.247] Timer tick, asking Buildbucket for the build status
[10:53:57.388] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:57.388] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:40:0) after 1m0s
[10:54:57.585] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:40:0)
[10:54:57.585] Timer tick, asking Buildbucket for the build status
[10:54:57.681] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:57.681] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:41:0) after 1m0s
[10:55:57.782] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:41:0)
[10:55:57.782] Timer tick, asking Buildbucket for the build status
[10:55:58.199] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:58.199] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:42:0) after 1m0s
[10:56:58.288] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:42:0)
[10:56:58.288] Timer tick, asking Buildbucket for the build status
[10:56:58.414] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:58.414] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:43:0) after 1m0s
[10:57:58.514] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:43:0)
[10:57:58.514] Timer tick, asking Buildbucket for the build status
[10:57:58.656] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:58.656] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:44:0) after 1m0s
[10:58:58.731] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:44:0)
[10:58:58.731] Timer tick, asking Buildbucket for the build status
[10:58:58.902] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:58.902] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:45:0) after 1m0s
[10:59:59.027] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:45:0)
[10:59:59.027] Timer tick, asking Buildbucket for the build status
[10:59:59.088] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:59.088] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:46:0) after 1m0s
[11:00:59.159] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:46:0)
[11:00:59.159] Timer tick, asking Buildbucket for the build status
[11:00:59.559] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:59.559] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:47:0) after 1m0s
[11:01:59.616] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:47:0)
[11:01:59.616] Timer tick, asking Buildbucket for the build status
[11:01:59.720] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:59.720] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:48:0) after 1m0s
[11:02:59.817] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:48:0)
[11:02:59.817] Timer tick, asking Buildbucket for the build status
[11:02:59.895] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:59.895] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:49:0) after 1m0s
[11:03:59.918] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:49:0)
[11:03:59.918] Timer tick, asking Buildbucket for the build status
[11:03:59.992] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:59.992] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:50:0) after 1m0s
[11:05:00.026] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:50:0)
[11:05:00.026] Timer tick, asking Buildbucket for the build status
[11:05:00.265] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:00.266] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:51:0) after 1m0s
[11:06:00.285] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:51:0)
[11:06:00.285] Timer tick, asking Buildbucket for the build status
[11:06:00.440] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:00.440] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:52:0) after 1m0s
[11:07:00.476] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:52:0)
[11:07:00.476] Timer tick, asking Buildbucket for the build status
[11:07:01.099] Build 8857502682936352784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:01.099] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022932744984739104:53:0) after 1m0s
[11:07:18.755] Received PubSub notification, asking Buildbucket for the build status
[11:07:18.856] Build 8857502682936352784: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:07:18.856] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611227237449075",
"created_by": "project:chromium",
"created_ts": "1611224205992766",
"id": "8857502682936352784",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c4182b366dac90de78119e03e204667ac3fb6c21\"}}",
"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\": \"c4182b366dac90de78119e03e204667ac3fb6c21\", \"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-us-central1-b-32-0-gbsn\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16929, \"clang_revision\": \"llvmorg-12-init-16548-gf1d5cbbd-1\", \"got_angle_revision\": \"bb7660008b16bd0fea2bf114075aece585fbe1f1\", \"got_dawn_revision\": \"762814bd922932d3d9da9b220463b6ce5f167d76\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"c4182b366dac90de78119e03e204667ac3fb6c21\", \"got_revision_cp\": \"refs/heads/master@{#845580}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1d5174b9dc3be500d63daf227b163b5e86bbc7b5\", \"got_v8_revision\": \"ed78a10326a2854dcf8561c61c974270f8e01dbe\", \"got_v8_revision_cp\": \"refs/heads/9.0.34@{#1}\", \"got_webrtc_revision\": \"026ad9ac22051858ded71dc91f3ce7a3a5dd77e6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33049}\", \"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\": \"c4182b366dac90de78119e03e204667ac3fb6c21\", \"swarm_hashes_refs/heads/master(at){#845580}_without_patch\": {\"absl_hardening_tests\": \"dc35cb42963efcea80f33ed5c78fd03aed79fcb6\", \"accessibility_unittests\": \"09e1139fa610207da2a02e04f0384f0a8a18b254\", \"angle_unittests\": \"5723548142bdb8fbca4b7cf133d5656feb7da5d1\", \"app_shell_unittests\": \"d3df258d8b9f64779701980749a9aaa5f17fc634\", \"aura_unittests\": \"c9a29abfcd3f00681d26170b152e7080dd0a4244\", \"base_unittests\": \"17cf1e6082693145e29d58c8224f1bd42cb64c98\", \"base_util_unittests\": \"f9ad5889cc13f826ef49367cd1efeb2a3cae4d6f\", \"blink_common_unittests\": \"6fb6df4bfb0f239c05d5f0b9f2854c0f5de18dc8\", \"blink_fuzzer_unittests\": \"f111d56a1521dfc2c2268bbe825168ada3aea8bc\", \"blink_heap_unittests\": \"a17e8dd2fbd50e23fc0c426014600d7f1a12e992\", \"blink_platform_unittests\": \"545eb0785f3a3e5785dc54937dfe9ef3bf0b3d18\", \"blink_unittests\": \"568c7101ec66654991aeadb81a46a284cda93ed0\", \"boringssl_crypto_tests\": \"11c5024930a6fae2479d268bf8604e4fab4dc188\", \"boringssl_ssl_tests\": \"298fd77075a2fe073948e92c10bba7904588c176\", \"browser_switcher_bho_unittests\": \"cba2ae6ca042740a44508802432b5e656df7bb18\", \"browser_tests\": \"765ad83e8ac9ada232bfb1d742d36d29d6dfad57\", \"capture_unittests\": \"201a670638d2cf2edfa2c91d98855562d43ff08a\", \"cast_unittests\": \"f86392225975c475bec03c24570fbd4a045124f5\", \"cc_unittests\": \"5f04e689d46666e097b5e335e33fb30e4d419ace\", \"chrome_app_unittests\": \"9a3183896bbf3bc7972e0df00a1977971283f349\", \"chrome_cleaner_unittests\": \"0b9a577310301ac1ab026efc10f0d2e1e47fdd37\", \"chrome_elf_unittests\": \"9e03fea02d101b7b84845a338d3543e0033e3378\", \"chromedriver_unittests\": \"779296d4998d29b93bf12b48516697bea786e13f\", \"components_browsertests\": \"a122091ead464c713808218cb51923fd93392056\", \"components_unittests\": \"199f4893298c0a2eb10a6a27cc18533e41d8d508\", \"compositor_unittests\": \"05c1ecbe22ac77c306d569d26b020683b2d7a7b2\", \"content_browsertests\": \"1466c3f15c42da031d8bf659c7c9c445784f51d5\", \"content_unittests\": \"a113e58669c21a3cdec48329aa0ae80627a96a86\", \"courgette_unittests\": \"c725ca5979a190556e7436ce0f798af592d6e11c\", \"crashpad_tests\": \"cf582ac6f64b54b0cc25c81310e42ad4785f7d9d\", \"cronet_tests\": \"2d9bc014cc5c763164040b2b2e28354bac1fe6c6\", \"cronet_unittests\": \"ed605f551885e73cbfd4a417198d191e17b807c5\", \"crypto_unittests\": \"2bcd04804f9fe00c0a83eccfeb257815c980eea9\", \"delayloads_unittests\": \"8197cb2b0aa556b87d6d4382fe5a16e3c2832be6\", \"device_unittests\": \"b43145503aef5c501238906216ecc5016fed92b1\", \"display_unittests\": \"947ce1de50b7a73052aea86af5d7a63c26517498\", \"elevation_service_unittests\": \"5c5ccc2018ec5e8f73e4a8702e1de17e53df92d6\", \"events_unittests\": \"db30262c34d24a248577206e6f9ea9564b1d4956\", \"extensions_browsertests\": \"06325f803309aab53c21072d1065792b31630508\", \"extensions_unittests\": \"bc9b4a39dc7e0c7686eb567a8e45f7582c78d9d0\", \"filesystem_service_unittests\": \"4ddef985e5d547e38317d33a49633dea948cc036\", \"gcm_unit_tests\": \"3175e1efefc9e767ffea7d5627677d960b5e2f59\", \"gcp_unittests\": \"d2de87abc5817f4fcc0ca84fade5e5d09caaa706\", \"gfx_unittests\": \"b9b59b4570052676471d72714634c464c55dfdad\", \"gin_unittests\": \"b45773a3373b09b8a7f6bdff8680f13a890b359c\", \"google_apis_unittests\": \"2beb096ccf5ddf0deb852c8f277c79cbc1eea91b\", \"gpu_unittests\": \"85b8f2b4e634fc9a0ec8eb8554a6f31571ab159a\", \"gwp_asan_unittests\": \"bdb7e454615f0f8e7a5f185f1c890fdd2b3f1f65\", \"headless_browsertests\": \"1d585e7596af14cca99f43b48f91cf63b21449f7\", \"headless_unittests\": \"00a7b71ecec413986acdfb3fd22fa354d0e659de\", \"install_static_unittests\": \"67455bcc07270bdf99f1fc95187b28befd3c39cc\", \"installer_util_unittests\": \"1f73cefb96413e38c3823c076d40e815743331d6\", \"interactive_ui_tests\": \"47e099272e9de2ed4b2b868346695d8169d752ef\", \"ipc_tests\": \"8a17c5292863f44608cf0b2bde495f883e646890\", \"jingle_unittests\": \"b1fef33c26bfc13eeb47dc1997d621f6a77a5eae\", \"latency_unittests\": \"a536b1fe61cf3d56cf9b5286cd8fcc760d3b6c44\", \"libjingle_xmpp_unittests\": \"5c8d9044710bb65d9dba9c456f1ed03567481b05\", \"liburlpattern_unittests\": \"85603534e43c823ba89be9c73c2176c4a25ce960\", \"media_blink_unittests\": \"555bc8442707b64225c079dab5bb0a1d3e3eb2e2\", \"media_unittests\": \"61aabf483fa18b7d6f0ff9ed0f2bc6dfc8312fc0\", \"message_center_unittests\": \"d8be508dd1d943c1aebd8770dab8fe0d8cab2568\", \"midi_unittests\": \"7caa641f73ee1405bf557d28c3e6a702e07ad57b\", \"mojo_core_unittests\": \"e379fc39a7bf7c68630eb17deeaffc07e7e1525c\", \"mojo_unittests\": \"9e954ca6b399312a8512babbe47f6855920a1c44\", \"nacl_loader_unittests\": \"a621461298c7f50475ea6f8f426b95ec9b1bca6b\", \"native_theme_unittests\": \"54887ec934208a3c67eaa22151723142c1d14992\", \"net_unittests\": \"164743677f1fa2595f8613c3f9501eade17f3635\", \"notification_helper_unittests\": \"c8c1ac8c6fdc57e4b0eacda4b0bd34e9937fb965\", \"pdf_unittests\": \"53c5ba0808a0b54a7e226cac1d83a0cb1a571894\", \"perfetto_unittests\": \"0ff1711e5d1c49e41a523bcbcdcd0a8ab466d551\", \"ppapi_unittests\": \"f9caadefeff1db6b57711b59fc87d1b144af434f\", \"printing_unittests\": \"bf235dc21c53bee9585d87698d818e096d6a9b46\", \"remoting_unittests\": \"915fb0c1ff8031e3afa99571994de13385c6679d\", \"sbox_integration_tests\": \"93bcd74cc639c50c0250b77ad99610fc81dcf606\", \"sbox_unittests\": \"a91a6af93289d004a5c0a50bcc8095be039d02ac\", \"sbox_validation_tests\": \"5a8e8c365c88e928032cc2857c1e55f0c4eb819d\", \"service_manager_unittests\": \"8730515b75e09fcdc8956cfc28db37fff2056020\", \"services_unittests\": \"9d2a61b7c61f46b0cca6ac0e40b4ab8c637dfb00\", \"setup_unittests\": \"9e857b553cef8f834ca58e2b8965441f97f3537b\", \"shell_dialogs_unittests\": \"fd4e8c6580f8af518e4665fb08c1be2913dbdea7\", \"skia_unittests\": \"01653f77585e6573d59f49d9b581449dce8f37f5\", \"snapshot_unittests\": \"2d6a3187d06b7a248ca5c8ca96f361b5adfd9a0a\", \"sql_unittests\": \"7f6b83e752787be6b5beed8f2fc80218231bc6e2\", \"storage_unittests\": \"7513bc27b9171258713d9a7128a1fd5ea3b0a6ee\", \"sync_integration_tests\": \"dd65be7acc18a52613b509782134972a645fbd11\", \"traffic_annotation_auditor_unittests\": \"ed6d4efd2da86df36937643be0fcaff3b895ed18\", \"ui_base_unittests\": \"150c30eb09fa0cefb5380a597f98ff010e212a24\", \"ui_touch_selection_unittests\": \"af62e03387d23d1f208f8db99dd12f3980af1f1b\", \"unit_tests\": \"f50d84340660a4a6281ff21e3205d3ec8397c0c7\", \"updater_tests\": \"52f77311c426e8579555439fcc7b1466e8ccef8c\", \"url_unittests\": \"2da501f278a38ed18bd70d43d6dc16ff64c84779\", \"views_unittests\": \"421a599795223f7ada8406c806344464cfe8d3ac\", \"viz_unittests\": \"0e14160dc96d6200bd27a4b593611d9453d5db62\", \"vr_common_unittests\": \"bfbe0a4734e0fdd1992da0a4682222a530c03653\", \"vr_pixeltests\": \"2cd29a106fbedd0a0d3354e37a58f3de94b11b41\", \"weblayer_browsertests\": \"1d8554e7f41e2e8dc9f7d4004680b7d0e022d25e\", \"weblayer_unittests\": \"51d47958933acc379511fe93ce473d8f9d59ebce\", \"wm_unittests\": \"971d1c35ecbdd7f1d5f09ee4cc88f4a30cc69ffe\", \"wtf_unittests\": \"9728b76bb33d028d0379348c340672b3f842d1b1\", \"zlib_unittests\": \"27d2261a0214c40fe246bac81651fa22feaffd83\", \"zucchini_unittests\": \"6dee760ca2f9478f1ef0428c4cfd8e83df105bf1\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_27a86a15ec8feb386a5b02e9d1f544a49194bc134f7348519b0bd6cd38b20371_v2\", \"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-us-central1-b-32-0-gbsn\"], \"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\": [\"5671-1d9dea8\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611224207918947",
"status": "COMPLETED",
"status_changed_ts": "1611227237789987",
"tags": [
"build_address:luci.chromium.ci/win-asan/16929",
"builder:win-asan",
"buildset:commit/git/c4182b366dac90de78119e03e204667ac3fb6c21",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c4182b366dac90de78119e03e204667ac3fb6c21",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022932744984739104",
"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/8857502682936352784/+/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:513d43d8031b7a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1611227237796329",
"url": "https://ci.chromium.org/b/8857502682936352784",
"utcnow_ts": "1611227238847593"
}
}
[11:07:18.856] Invocation finished in 50m34.201251103s with status SUCCEEDED