[09:09:53.474] New invocation is queued and will start shortly
[09:09:54.645] Starting the invocation (attempt 1)
[09:09:54.698] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:09:54.699] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:09:54.699] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9024024114624568784",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"dab5e6bc11c54e0e3671e35bee34ccfaf536d7f5\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9024024114624568784",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/dab5e6bc11c54e0e3671e35bee34ccfaf536d7f5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dab5e6bc11c54e0e3671e35bee34ccfaf536d7f5",
"gitiles_ref:refs/heads/master"
]
}
[09:09:56.626] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610183394815046",
"id": "8858594052556847600",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dab5e6bc11c54e0e3671e35bee34ccfaf536d7f5\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610183396342800",
"tags": [
"build_address:luci.chromium.ci/win-asan/16711",
"builder:win-asan",
"buildset:commit/git/dab5e6bc11c54e0e3671e35bee34ccfaf536d7f5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dab5e6bc11c54e0e3671e35bee34ccfaf536d7f5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024024114624568784",
"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/8858594052556847600/+/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": "1610183396342910",
"url": "https://ci.chromium.org/b/8858594052556847600",
"utcnow_ts": "1610183396604947"
}
}
[09:09:56.626] Task URL: https://ci.chromium.org/b/8858594052556847600
[09:09:56.626] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:2:0) after 1m0s
[09:10:43.389] Received PubSub notification, asking Buildbucket for the build status
[09:10:43.463] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:57.341] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:2:0)
[09:10:57.341] Timer tick, asking Buildbucket for the build status
[09:10:57.454] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:57.454] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:4:0) after 1m0s
[09:11:57.588] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:4:0)
[09:11:57.588] Timer tick, asking Buildbucket for the build status
[09:11:57.687] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:57.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:5:0) after 1m0s
[09:12:57.703] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:5:0)
[09:12:57.703] Timer tick, asking Buildbucket for the build status
[09:12:57.802] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:57.802] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:6:0) after 1m0s
[09:13:57.782] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:6:0)
[09:13:57.782] Timer tick, asking Buildbucket for the build status
[09:13:57.907] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:57.907] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:7:0) after 1m0s
[09:14:58.061] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:7:0)
[09:14:58.061] Timer tick, asking Buildbucket for the build status
[09:14:58.169] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:58.169] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:8:0) after 1m0s
[09:15:58.436] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:8:0)
[09:15:58.436] Timer tick, asking Buildbucket for the build status
[09:15:58.545] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:58.545] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:9:0) after 1m0s
[09:16:58.866] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:9:0)
[09:16:58.866] Timer tick, asking Buildbucket for the build status
[09:16:58.920] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:58.920] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:10:0) after 1m0s
[09:17:59.039] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:10:0)
[09:17:59.039] Timer tick, asking Buildbucket for the build status
[09:17:59.146] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:59.146] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:11:0) after 1m0s
[09:18:59.209] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:11:0)
[09:18:59.209] Timer tick, asking Buildbucket for the build status
[09:18:59.314] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:59.314] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:12:0) after 1m0s
[09:19:59.333] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:12:0)
[09:19:59.333] Timer tick, asking Buildbucket for the build status
[09:19:59.431] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:59.431] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:13:0) after 1m0s
[09:20:59.454] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:13:0)
[09:20:59.454] Timer tick, asking Buildbucket for the build status
[09:20:59.545] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:59.545] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:14:0) after 1m0s
[09:21:59.564] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:14:0)
[09:21:59.564] Timer tick, asking Buildbucket for the build status
[09:21:59.719] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:59.719] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:15:0) after 1m0s
[09:22:59.735] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:15:0)
[09:22:59.735] Timer tick, asking Buildbucket for the build status
[09:23:02.780] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:02.780] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:16:0) after 1m0s
[09:24:02.794] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:16:0)
[09:24:02.795] Timer tick, asking Buildbucket for the build status
[09:24:02.989] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:02.989] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:17:0) after 1m0s
[09:25:03.023] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:17:0)
[09:25:03.023] Timer tick, asking Buildbucket for the build status
[09:25:03.515] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:03.515] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:18:0) after 1m0s
[09:26:03.548] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:18:0)
[09:26:03.548] Timer tick, asking Buildbucket for the build status
[09:26:03.891] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:03.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:19:0) after 1m0s
[09:27:03.924] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:19:0)
[09:27:03.924] Timer tick, asking Buildbucket for the build status
[09:27:04.002] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:04.002] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:20:0) after 1m0s
[09:28:04.042] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:20:0)
[09:28:04.042] Timer tick, asking Buildbucket for the build status
[09:28:04.522] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:04.522] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:21:0) after 1m0s
[09:29:04.570] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:21:0)
[09:29:04.570] Timer tick, asking Buildbucket for the build status
[09:29:04.793] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:04.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:22:0) after 1m0s
[09:30:04.822] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:22:0)
[09:30:04.822] Timer tick, asking Buildbucket for the build status
[09:30:05.092] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:05.092] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:23:0) after 1m0s
[09:31:05.430] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:23:0)
[09:31:05.430] Timer tick, asking Buildbucket for the build status
[09:31:06.405] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:06.405] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:24:0) after 1m0s
[09:32:06.442] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:24:0)
[09:32:06.442] Timer tick, asking Buildbucket for the build status
[09:32:06.618] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:06.618] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:25:0) after 1m0s
[09:33:06.612] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:25:0)
[09:33:06.612] Timer tick, asking Buildbucket for the build status
[09:33:07.106] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:07.106] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:26:0) after 1m0s
[09:34:07.175] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:26:0)
[09:34:07.175] Timer tick, asking Buildbucket for the build status
[09:34:07.280] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:07.280] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:27:0) after 1m0s
[09:35:07.321] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:27:0)
[09:35:07.321] Timer tick, asking Buildbucket for the build status
[09:35:07.586] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:07.586] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:28:0) after 1m0s
[09:36:07.606] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:28:0)
[09:36:07.606] Timer tick, asking Buildbucket for the build status
[09:36:07.790] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:07.790] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:29:0) after 1m0s
[09:37:07.814] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:29:0)
[09:37:07.814] Timer tick, asking Buildbucket for the build status
[09:37:07.950] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:07.950] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:30:0) after 1m0s
[09:38:07.982] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:30:0)
[09:38:07.982] Timer tick, asking Buildbucket for the build status
[09:38:08.312] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:08.312] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:31:0) after 1m0s
[09:39:08.332] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:31:0)
[09:39:08.332] Timer tick, asking Buildbucket for the build status
[09:39:08.402] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:08.402] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:32:0) after 1m0s
[09:40:08.383] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:32:0)
[09:40:08.383] Timer tick, asking Buildbucket for the build status
[09:40:08.934] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:08.934] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:33:0) after 1m0s
[09:41:08.953] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:33:0)
[09:41:08.953] Timer tick, asking Buildbucket for the build status
[09:41:09.372] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:09.372] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:34:0) after 1m0s
[09:42:09.441] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:34:0)
[09:42:09.441] Timer tick, asking Buildbucket for the build status
[09:42:09.523] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:09.523] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:35:0) after 1m0s
[09:43:09.544] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:35:0)
[09:43:09.544] Timer tick, asking Buildbucket for the build status
[09:43:09.663] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:09.663] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:36:0) after 1m0s
[09:44:09.684] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:36:0)
[09:44:09.684] Timer tick, asking Buildbucket for the build status
[09:44:09.760] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:09.761] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:37:0) after 1m0s
[09:45:09.753] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:37:0)
[09:45:09.753] Timer tick, asking Buildbucket for the build status
[09:45:10.013] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:10.013] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:38:0) after 1m0s
[09:46:10.027] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:38:0)
[09:46:10.027] Timer tick, asking Buildbucket for the build status
[09:46:10.297] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:10.297] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:39:0) after 1m0s
[09:47:10.316] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:39:0)
[09:47:10.316] Timer tick, asking Buildbucket for the build status
[09:47:10.413] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:10.413] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:40:0) after 1m0s
[09:48:10.467] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:40:0)
[09:48:10.467] Timer tick, asking Buildbucket for the build status
[09:48:10.570] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:10.570] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:41:0) after 1m0s
[09:49:10.594] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:41:0)
[09:49:10.594] Timer tick, asking Buildbucket for the build status
[09:49:10.863] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:10.863] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:42:0) after 1m0s
[09:50:10.887] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:42:0)
[09:50:10.887] Timer tick, asking Buildbucket for the build status
[09:50:10.986] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:10.986] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:43:0) after 1m0s
[09:51:11.084] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:43:0)
[09:51:11.084] Timer tick, asking Buildbucket for the build status
[09:51:11.208] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:11.208] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:44:0) after 1m0s
[09:52:11.282] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:44:0)
[09:52:11.282] Timer tick, asking Buildbucket for the build status
[09:52:11.694] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:11.694] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:45:0) after 1m0s
[09:53:11.665] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:45:0)
[09:53:11.665] Timer tick, asking Buildbucket for the build status
[09:53:11.832] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:11.832] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:46:0) after 1m0s
[09:54:11.885] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:46:0)
[09:54:11.885] Timer tick, asking Buildbucket for the build status
[09:54:12.031] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:12.031] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:47:0) after 1m0s
[09:55:12.107] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:47:0)
[09:55:12.107] Timer tick, asking Buildbucket for the build status
[09:55:12.294] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:12.294] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:48:0) after 1m0s
[09:56:12.318] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:48:0)
[09:56:12.318] Timer tick, asking Buildbucket for the build status
[09:56:12.505] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:12.505] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:49:0) after 1m0s
[09:57:12.571] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:49:0)
[09:57:12.571] Timer tick, asking Buildbucket for the build status
[09:57:12.650] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:12.650] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:50:0) after 1m0s
[09:58:12.645] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:50:0)
[09:58:12.645] Timer tick, asking Buildbucket for the build status
[09:58:12.736] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:12.736] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:51:0) after 1m0s
[09:59:12.757] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:51:0)
[09:59:12.757] Timer tick, asking Buildbucket for the build status
[09:59:12.820] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:12.820] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:52:0) after 1m0s
[10:00:12.896] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:52:0)
[10:00:12.896] Timer tick, asking Buildbucket for the build status
[10:00:13.103] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:13.103] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:53:0) after 1m0s
[10:01:13.159] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:53:0)
[10:01:13.159] Timer tick, asking Buildbucket for the build status
[10:01:13.231] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:13.231] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:54:0) after 1m0s
[10:02:13.240] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:54:0)
[10:02:13.240] Timer tick, asking Buildbucket for the build status
[10:02:13.346] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:13.346] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:55:0) after 1m0s
[10:03:13.369] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:55:0)
[10:03:13.369] Timer tick, asking Buildbucket for the build status
[10:03:13.501] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:13.501] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:56:0) after 1m0s
[10:04:13.556] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:56:0)
[10:04:13.556] Timer tick, asking Buildbucket for the build status
[10:04:14.206] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:14.206] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:57:0) after 1m0s
[10:05:14.222] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:57:0)
[10:05:14.222] Timer tick, asking Buildbucket for the build status
[10:05:16.670] Build 8858594052556847600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:16.670] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024024114624568784:58:0) after 1m0s
[10:05:19.936] Received PubSub notification, asking Buildbucket for the build status
[10:05:20.167] Build 8858594052556847600: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:05:20.167] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610186718626178",
"created_by": "project:chromium",
"created_ts": "1610183394815046",
"id": "8858594052556847600",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dab5e6bc11c54e0e3671e35bee34ccfaf536d7f5\"}}",
"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\": \"dab5e6bc11c54e0e3671e35bee34ccfaf536d7f5\", \"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-7-w73f\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16711, \"clang_revision\": \"llvmorg-12-init-15676-g5c951623-1\", \"got_angle_revision\": \"51603c63d1cb9e36afaf2069fc069e542ac2f3fb\", \"got_dawn_revision\": \"c9a22bcb93db27e200a184c1f7b9bf0f288815c7\", \"got_nacl_revision\": \"d28e6c52e05ea2f1b3231de473b6dbfce59bce40\", \"got_revision\": \"dab5e6bc11c54e0e3671e35bee34ccfaf536d7f5\", \"got_revision_cp\": \"refs/heads/master@{#841808}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"588d32cb3f172d1a6092c2b3c7e5a5c5d8b3b06e\", \"got_v8_revision\": \"6bb19707a491fda7a4dc04dbbeb188d48f6d641d\", \"got_v8_revision_cp\": \"refs/heads/8.9.225@{#1}\", \"got_webrtc_revision\": \"783278a3109df8d2e362861e52fd0deea851633c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32927}\", \"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\": \"dab5e6bc11c54e0e3671e35bee34ccfaf536d7f5\", \"swarm_hashes_refs/heads/master(at){#841808}_without_patch\": {\"absl_hardening_tests\": \"263a2bb1f83e7e3466c0b288cc1d2659da464fa3\", \"accessibility_unittests\": \"ee34648670a864a20f1ca0383879b1e8177416b0\", \"angle_unittests\": \"60751421c864e286a5b533cad8014018038046db\", \"app_shell_unittests\": \"60140990da9b742263be29e5b11c806f9af98067\", \"aura_unittests\": \"f9c97d7c5b642627ab0be98e03cbcc193c8c4459\", \"base_unittests\": \"918d47eab7f5258d7f810806a622148e4af87a6f\", \"base_util_unittests\": \"cf51485a34fa795fc8724b63d7ab7d89d13eb817\", \"blink_common_unittests\": \"fd45905a10a1b022ffb071543130db11956e4757\", \"blink_fuzzer_unittests\": \"0b9e65fb84cb99f34a40be2281ecfe4dba599fc1\", \"blink_heap_unittests\": \"b6e9f3a03bb4945214da18c484f27f88737015e6\", \"blink_platform_unittests\": \"2520f3006c93f6afd4ae46b4e2d87f6aaeaf7239\", \"blink_unittests\": \"64227418737cbd0571a29705971a9cfdb486ad29\", \"boringssl_crypto_tests\": \"7ce3b570ffdbdf77e800d94b7e4eb4f2fc2e6dce\", \"boringssl_ssl_tests\": \"b7fa7f4d2c184bb8778f54111768d535187d006b\", \"browser_switcher_bho_unittests\": \"13203f7ff96092eaa32a638298cc9cc849de9e64\", \"browser_tests\": \"c3747bd4a2dc4f0f8db1cd3e5610e6796a3883f2\", \"capture_unittests\": \"5e3b4fa3fd85d7aa112172ff1ea08f96f6052624\", \"cast_unittests\": \"081e58b852b17861c095c5138033e6bf0c9a07e9\", \"cc_unittests\": \"627ef9ab31fd56450e4a0b1e7a96716353d59664\", \"chrome_app_unittests\": \"da768e40a1b37cb84a6f2b23078c3491376d768e\", \"chrome_cleaner_unittests\": \"3784b78a9fa5d4dbb1e0cd73d59e77d23a1d2397\", \"chrome_elf_unittests\": \"f70b434a0e0cb047cd2c618acb02cced2d17d40c\", \"chromedriver_unittests\": \"1c52bd674636ceb6b54bd4a01d83e8b5a86583fc\", \"components_browsertests\": \"62689f2fe83230d9880d2b0daa81410254899127\", \"components_unittests\": \"ac54355fbc729eda2b25e140cc72654b9b5f1cf5\", \"compositor_unittests\": \"2599c9bb351aeee66038afd0ad3bf86c416b437a\", \"content_browsertests\": \"fd09f79a5e24de6411eeec98fc8a2e095455f16d\", \"content_unittests\": \"70f8ca84e39e1edb2da8952483619b1a73d7893a\", \"courgette_unittests\": \"4187f2d13b5f861ae1d1b51514badda04ade0ed8\", \"crashpad_tests\": \"d502bcec8b6a598327c5385e6bf6e118c8f779ef\", \"cronet_tests\": \"17033127b91003f6052ab71c76d328832d7c9235\", \"cronet_unittests\": \"b279c514006e14f2de5ac51238941d7e81a589f0\", \"crypto_unittests\": \"57026856aad1fbb82ab97a70a6fb43468277bc09\", \"delayloads_unittests\": \"1da5abc37d535d99f9a97dbae407832015bf1a0e\", \"device_unittests\": \"2851124ab65820a5fa874bdf57569023e2257902\", \"display_unittests\": \"cbb94d55d1754d2bec8bf189b9b3c8a3286e6706\", \"elevation_service_unittests\": \"ad6af0057d9599dc49175589dc09a12b225390ef\", \"events_unittests\": \"b1ac3c761c3e17b50eb860dc4ca2dd6cbbd97aae\", \"extensions_browsertests\": \"2225835a6af60302bff4f0a1bb4b5638a18b02d4\", \"extensions_unittests\": \"d18d78a949c9009760daae0f2bf6542befdf6465\", \"filesystem_service_unittests\": \"9cfa7901e0643be210200ed7d40e6c3473fa2ead\", \"gcm_unit_tests\": \"499642f90ce12df9425ce7e19f198e977b2b467e\", \"gcp_unittests\": \"75102165a9229f78c8a2b09adf6561e0f86d42c6\", \"gfx_unittests\": \"0d39dd57151a3eeb3458f62557886706e86c6c5c\", \"gin_unittests\": \"72397f2c615b6dafd54d8d773ce1c45deb7eca5e\", \"google_apis_unittests\": \"6834bdd6f7122831233392b5a8d37e3ed0d7cb9d\", \"gpu_unittests\": \"8e87fdcb5a14c9f3f068f0ef163e8279b27464e5\", \"gwp_asan_unittests\": \"c532943201f95285ffff105b15098c14aba5a9a0\", \"headless_browsertests\": \"89a91243626bde052ceabfaa15a0ee8e4ec47bb6\", \"headless_unittests\": \"112f9a18f2fdfc383c1ece41f2930d2bc8025145\", \"install_static_unittests\": \"efa57f838e92260c51c4b6c7159f305f356ca5e1\", \"installer_util_unittests\": \"f5f1c8c7b3e5725ee0e22cc7bc4f34c76a6863d7\", \"interactive_ui_tests\": \"7cd05515335cc056e2876d5a6f50b7ffd1e0564f\", \"ipc_tests\": \"4589f13dffa7cd8624ce109086fac1fc6bfd68b3\", \"jingle_unittests\": \"82650356d74fd2bddea35f61059e76217e269147\", \"latency_unittests\": \"8ddf8d976b2768149329092f3bf39e6ea36a4a26\", \"libjingle_xmpp_unittests\": \"951a8696c0ce92c1a9bfffb15adccd6391095199\", \"liburlpattern_unittests\": \"c873b6028142a0327d2a6b995de111159dbf54df\", \"media_blink_unittests\": \"43bb82f2dd6601f30b5975ead9e5363881f61e5a\", \"media_unittests\": \"e763d55965f9397d42f3440d00df65fb8d6a5be0\", \"message_center_unittests\": \"a947d7a68e9d47b092b8dc92e3d09c86cee63fc1\", \"midi_unittests\": \"e86bf65b73995d989d0a8e579796fbd2582d585c\", \"mojo_core_unittests\": \"61fdd7110655a1bd4e8e3a7b4d4a9238db7eb6bc\", \"mojo_unittests\": \"376e8cff7aae0be0e0abc2112214be9ecef08214\", \"nacl_loader_unittests\": \"b095446d0ab9de389d64a1eb8c6983e3ec572e78\", \"native_theme_unittests\": \"0f48665cefb75d2284d6a955f9fddb5d31266cf4\", \"net_unittests\": \"22d1bfd47a1b93d0fb3a120a133c4485f1380572\", \"notification_helper_unittests\": \"8d20adea8f6af6cb3b335a24ab0da797b8710c72\", \"pdf_unittests\": \"2726845eefb17f19491c1c999a7268efe444f551\", \"perfetto_unittests\": \"d956693d0cab28655fdd0ccff1cd2d952921a9bb\", \"ppapi_unittests\": \"05cf05ac4c7c95df25c8cfb39ff0826ca7443437\", \"printing_unittests\": \"4c86afbd70e8323acb5439f819a40af487bfea25\", \"remoting_unittests\": \"ee806369dde6e03ac88be4b1d16d6ae23fcd429a\", \"sbox_integration_tests\": \"1638ef3ea4e52bbafba3ba62b0e5fc8c708a9cfa\", \"sbox_unittests\": \"327163edbf124562c39110e07862fa88299ac951\", \"sbox_validation_tests\": \"7af29d15a8af9a0045e2da0349b0d275ba013016\", \"service_manager_unittests\": \"341e8d98f8505af3eaa0e71c5e04b3e2dae169b6\", \"services_unittests\": \"d4e28dc078d244fc893bdbe99f2f0748f6e6deea\", \"setup_unittests\": \"581ba0c8474dbb0bcd1983b3d1b3628d60a47700\", \"shell_dialogs_unittests\": \"0290df6edc9c5e3ef91a2f5a8fad4f666d3d0532\", \"skia_unittests\": \"264381169ac94475a55d220c7602d091cb628ea7\", \"snapshot_unittests\": \"f3985e9021f085cd721cd3ebc380547435343f9a\", \"sql_unittests\": \"b5c57c6691b922b73882152601541fcd9b1a411d\", \"storage_unittests\": \"64a071f042e279f68ccf8f0c8bf71d3a961607c8\", \"sync_integration_tests\": \"ad24616f7e53b9e485a0a7c228d4680e46f64d14\", \"traffic_annotation_auditor_unittests\": \"bfcc6dd7d1d2d85f15b891ceb16cc2943933f50b\", \"ui_base_unittests\": \"176a4602a7e59a3979154dd65622c8a627a7dff5\", \"ui_touch_selection_unittests\": \"a1da443b3bbff1b7dae7ab751d194c2d44d43281\", \"unit_tests\": \"0a92731dbd3dc0ef8ba7c8247256920d00c978aa\", \"updater_tests\": \"10d832c8705d25a9d401717ba2c4d0c482eef218\", \"url_unittests\": \"7ab10902c9980a2aefc4ef02d4d72c1f12468add\", \"views_unittests\": \"04223aec2568ba5c7ecf458701c38aac66cb1889\", \"viz_unittests\": \"a219aa2989be8146e909e160c405d72dd0604cf4\", \"vr_common_unittests\": \"00af95aeab35ea9ee1e79d8ceee6635ab720b57e\", \"vr_pixeltests\": \"aa1f9c53988061afa5e8af98cae60933145adc1a\", \"weblayer_browsertests\": \"9fc28b73c9a4650a88a7900187dac15387fab2b3\", \"weblayer_unittests\": \"b56f565f8dde853a1675aa931f21956d0ff4bd3a\", \"wm_unittests\": \"a7c6067f5b3e8754ca4614327ff882a6031a6d40\", \"wtf_unittests\": \"d019e936d51ba7f61156510a7608751677112bac\", \"zlib_unittests\": \"830d0834bbb812f50e90c5b7c59d5ad437289cf9\", \"zucchini_unittests\": \"00ebe21a752a5d428de2a77cdb979ead2f61ca14\"}}, \"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-7-w73f\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5657-0417a3f\"], \"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": "1610183441397359",
"status": "COMPLETED",
"status_changed_ts": "1610186719082972",
"tags": [
"build_address:luci.chromium.ci/win-asan/16711",
"builder:win-asan",
"buildset:commit/git/dab5e6bc11c54e0e3671e35bee34ccfaf536d7f5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dab5e6bc11c54e0e3671e35bee34ccfaf536d7f5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024024114624568784",
"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/8858594052556847600/+/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:50ff3a55d667f010",
"user_agent:luci-scheduler"
],
"updated_ts": "1610186719087031",
"url": "https://ci.chromium.org/b/8858594052556847600",
"utcnow_ts": "1610186720151256"
}
}
[10:05:20.167] Invocation finished in 55m26.708354628s with status SUCCEEDED