[09:03:16.255] New invocation is queued and will start shortly
[09:03:17.304] Starting the invocation (attempt 1)
[09:03:17.340] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:03:17.340] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:03:17.340] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027557812829189952",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"03a4f3150e82f709e58095adbacb8b616d1d8842\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9027557812829189952",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/03a4f3150e82f709e58095adbacb8b616d1d8842",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/03a4f3150e82f709e58095adbacb8b616d1d8842",
"gitiles_ref:refs/heads/master"
]
}
[09:03:18.047] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606813397431896",
"id": "8862127750933504160",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"03a4f3150e82f709e58095adbacb8b616d1d8842\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606813397931408",
"tags": [
"build_address:luci.chromium.ci/win-asan/15964",
"builder:win-asan",
"buildset:commit/git/03a4f3150e82f709e58095adbacb8b616d1d8842",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/03a4f3150e82f709e58095adbacb8b616d1d8842",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027557812829189952",
"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/8862127750933504160/+/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": "1606813397931527",
"url": "https://ci.chromium.org/b/8862127750933504160",
"utcnow_ts": "1606813398040052"
}
}
[09:03:18.047] Task URL: https://ci.chromium.org/b/8862127750933504160
[09:03:18.047] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:2:0) after 1m0s
[09:03:20.923] Received PubSub notification, asking Buildbucket for the build status
[09:03:20.996] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:18.068] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:2:0)
[09:04:18.068] Timer tick, asking Buildbucket for the build status
[09:04:18.159] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:18.159] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:4:0) after 1m0s
[09:05:18.177] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:4:0)
[09:05:18.177] Timer tick, asking Buildbucket for the build status
[09:05:18.302] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:18.302] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:5:0) after 1m0s
[09:06:18.340] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:5:0)
[09:06:18.340] Timer tick, asking Buildbucket for the build status
[09:06:18.472] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:18.472] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:6:0) after 1m0s
[09:07:18.518] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:6:0)
[09:07:18.518] Timer tick, asking Buildbucket for the build status
[09:07:18.760] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:18.760] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:7:0) after 1m0s
[09:08:18.790] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:7:0)
[09:08:18.790] Timer tick, asking Buildbucket for the build status
[09:08:18.990] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:18.990] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:8:0) after 1m0s
[09:09:19.057] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:8:0)
[09:09:19.057] Timer tick, asking Buildbucket for the build status
[09:09:19.292] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:19.292] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:9:0) after 1m0s
[09:10:19.325] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:9:0)
[09:10:19.325] Timer tick, asking Buildbucket for the build status
[09:10:19.539] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:19.539] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:10:0) after 1m0s
[09:11:19.592] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:10:0)
[09:11:19.592] Timer tick, asking Buildbucket for the build status
[09:11:19.803] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:19.803] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:11:0) after 1m0s
[09:12:19.825] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:11:0)
[09:12:19.825] Timer tick, asking Buildbucket for the build status
[09:12:19.891] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:19.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:12:0) after 1m0s
[09:13:19.913] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:12:0)
[09:13:19.913] Timer tick, asking Buildbucket for the build status
[09:13:20.033] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:20.033] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:13:0) after 1m0s
[09:14:20.037] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:13:0)
[09:14:20.037] Timer tick, asking Buildbucket for the build status
[09:14:20.415] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:20.415] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:14:0) after 1m0s
[09:15:20.481] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:14:0)
[09:15:20.481] Timer tick, asking Buildbucket for the build status
[09:15:20.631] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:20.631] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:15:0) after 1m0s
[09:16:20.629] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:15:0)
[09:16:20.629] Timer tick, asking Buildbucket for the build status
[09:16:20.802] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:20.802] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:16:0) after 1m0s
[09:17:20.815] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:16:0)
[09:17:20.815] Timer tick, asking Buildbucket for the build status
[09:17:27.002] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:27.002] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:17:0) after 1m0s
[09:18:27.055] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:17:0)
[09:18:27.055] Timer tick, asking Buildbucket for the build status
[09:18:27.206] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:27.206] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:18:0) after 1m0s
[09:19:27.316] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:18:0)
[09:19:27.316] Timer tick, asking Buildbucket for the build status
[09:19:27.492] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:27.492] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:19:0) after 1m0s
[09:20:27.558] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:19:0)
[09:20:27.558] Timer tick, asking Buildbucket for the build status
[09:20:27.902] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:27.902] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:20:0) after 1m0s
[09:21:28.142] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:20:0)
[09:21:28.142] Timer tick, asking Buildbucket for the build status
[09:21:28.299] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:28.299] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:21:0) after 1m0s
[09:22:28.479] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:21:0)
[09:22:28.479] Timer tick, asking Buildbucket for the build status
[09:22:28.632] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:28.632] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:22:0) after 1m0s
[09:23:28.771] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:22:0)
[09:23:28.771] Timer tick, asking Buildbucket for the build status
[09:23:28.898] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:28.898] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:23:0) after 1m0s
[09:24:28.971] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:23:0)
[09:24:28.971] Timer tick, asking Buildbucket for the build status
[09:24:29.200] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:29.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:24:0) after 1m0s
[09:25:29.270] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:24:0)
[09:25:29.270] Timer tick, asking Buildbucket for the build status
[09:25:29.394] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:29.394] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:25:0) after 1m0s
[09:26:29.395] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:25:0)
[09:26:29.395] Timer tick, asking Buildbucket for the build status
[09:26:29.546] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:29.546] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:26:0) after 1m0s
[09:27:29.646] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:26:0)
[09:27:29.646] Timer tick, asking Buildbucket for the build status
[09:27:30.153] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:30.153] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:27:0) after 1m0s
[09:28:30.217] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:27:0)
[09:28:30.217] Timer tick, asking Buildbucket for the build status
[09:28:30.325] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:30.325] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:28:0) after 1m0s
[09:29:30.375] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:28:0)
[09:29:30.375] Timer tick, asking Buildbucket for the build status
[09:29:30.560] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:30.560] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:29:0) after 1m0s
[09:30:34.085] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:29:0)
[09:30:34.085] Timer tick, asking Buildbucket for the build status
[09:30:34.338] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:34.338] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:30:0) after 1m0s
[09:31:34.517] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:30:0)
[09:31:34.517] Timer tick, asking Buildbucket for the build status
[09:31:34.590] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:34.590] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:31:0) after 1m0s
[09:32:34.663] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:31:0)
[09:32:34.663] Timer tick, asking Buildbucket for the build status
[09:32:34.768] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:34.768] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:32:0) after 1m0s
[09:33:34.851] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:32:0)
[09:33:34.851] Timer tick, asking Buildbucket for the build status
[09:33:34.972] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:34.972] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:33:0) after 1m0s
[09:34:35.108] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:33:0)
[09:34:35.108] Timer tick, asking Buildbucket for the build status
[09:34:35.292] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:35.292] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:34:0) after 1m0s
[09:35:35.328] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:34:0)
[09:35:35.328] Timer tick, asking Buildbucket for the build status
[09:35:35.561] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:35.561] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:35:0) after 1m0s
[09:36:35.585] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:35:0)
[09:36:35.585] Timer tick, asking Buildbucket for the build status
[09:36:37.796] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:37.796] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:36:0) after 1m0s
[09:37:37.892] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:36:0)
[09:37:37.892] Timer tick, asking Buildbucket for the build status
[09:37:37.962] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:37.962] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:37:0) after 1m0s
[09:38:38.047] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:37:0)
[09:38:38.047] Timer tick, asking Buildbucket for the build status
[09:38:38.169] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:38.169] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:38:0) after 1m0s
[09:39:38.229] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:38:0)
[09:39:38.229] Timer tick, asking Buildbucket for the build status
[09:39:38.306] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:38.306] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:39:0) after 1m0s
[09:40:38.429] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:39:0)
[09:40:38.429] Timer tick, asking Buildbucket for the build status
[09:40:38.527] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:38.527] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:40:0) after 1m0s
[09:41:38.613] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:40:0)
[09:41:38.613] Timer tick, asking Buildbucket for the build status
[09:41:38.685] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:38.685] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:41:0) after 1m0s
[09:42:38.886] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:41:0)
[09:42:38.886] Timer tick, asking Buildbucket for the build status
[09:42:38.995] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:38.995] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:42:0) after 1m0s
[09:43:39.150] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:42:0)
[09:43:39.150] Timer tick, asking Buildbucket for the build status
[09:43:39.908] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:39.908] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:43:0) after 1m0s
[09:44:39.962] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:43:0)
[09:44:39.963] Timer tick, asking Buildbucket for the build status
[09:44:40.107] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:40.108] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:44:0) after 1m0s
[09:45:40.155] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:44:0)
[09:45:40.155] Timer tick, asking Buildbucket for the build status
[09:45:40.256] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:40.256] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:45:0) after 1m0s
[09:46:40.321] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:45:0)
[09:46:40.321] Timer tick, asking Buildbucket for the build status
[09:46:40.407] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:40.407] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:46:0) after 1m0s
[09:47:40.436] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:46:0)
[09:47:40.436] Timer tick, asking Buildbucket for the build status
[09:47:40.563] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:40.563] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:47:0) after 1m0s
[09:48:40.621] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:47:0)
[09:48:40.621] Timer tick, asking Buildbucket for the build status
[09:48:42.370] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:42.370] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:48:0) after 1m0s
[09:49:42.389] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:48:0)
[09:49:42.389] Timer tick, asking Buildbucket for the build status
[09:49:43.063] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:43.063] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:49:0) after 1m0s
[09:50:43.110] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:49:0)
[09:50:43.110] Timer tick, asking Buildbucket for the build status
[09:50:43.277] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:43.277] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:50:0) after 1m0s
[09:51:43.384] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:50:0)
[09:51:43.384] Timer tick, asking Buildbucket for the build status
[09:51:43.535] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:43.535] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:51:0) after 1m0s
[09:52:43.582] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:51:0)
[09:52:43.582] Timer tick, asking Buildbucket for the build status
[09:52:43.841] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:43.841] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:52:0) after 1m0s
[09:53:43.874] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:52:0)
[09:53:43.874] Timer tick, asking Buildbucket for the build status
[09:53:44.005] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:44.005] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:53:0) after 1m0s
[09:54:44.019] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:53:0)
[09:54:44.019] Timer tick, asking Buildbucket for the build status
[09:54:44.320] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:44.320] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:54:0) after 1m0s
[09:55:44.329] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:54:0)
[09:55:44.329] Timer tick, asking Buildbucket for the build status
[09:55:44.620] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:44.620] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:55:0) after 1m0s
[09:56:44.669] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:55:0)
[09:56:44.669] Timer tick, asking Buildbucket for the build status
[09:56:44.750] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:44.750] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:56:0) after 1m0s
[09:57:44.800] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:56:0)
[09:57:44.800] Timer tick, asking Buildbucket for the build status
[09:57:44.934] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:44.935] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:57:0) after 1m0s
[09:58:44.965] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:57:0)
[09:58:44.965] Timer tick, asking Buildbucket for the build status
[09:58:45.123] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:45.123] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:58:0) after 1m0s
[09:59:45.144] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:58:0)
[09:59:45.144] Timer tick, asking Buildbucket for the build status
[09:59:45.305] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:45.305] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:59:0) after 1m0s
[10:00:45.426] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:59:0)
[10:00:45.426] Timer tick, asking Buildbucket for the build status
[10:00:45.691] Build 8862127750933504160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:45.692] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027557812829189952:60:0) after 1m0s
[10:01:01.618] Received PubSub notification, asking Buildbucket for the build status
[10:01:01.991] Build 8862127750933504160: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:01:01.991] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606816859259425",
"created_by": "project:chromium",
"created_ts": "1606813397431896",
"id": "8862127750933504160",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"03a4f3150e82f709e58095adbacb8b616d1d8842\"}}",
"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\": \"03a4f3150e82f709e58095adbacb8b616d1d8842\", \"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-10-eupo\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15964, \"clang_revision\": \"llvmorg-12-init-12923-g6ee22ca6-1\", \"got_angle_revision\": \"ccd0b7e15e47bb07cf393d725d2b987672ccfb24\", \"got_dawn_revision\": \"a827aa2c29aa41346e95e6ac58a752709beb5977\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"03a4f3150e82f709e58095adbacb8b616d1d8842\", \"got_revision_cp\": \"refs/heads/master@{#832258}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"1eadcfb3be99c2eca944774a78c4e3c16132958b\", \"got_v8_revision\": \"f1e2bbd80f2e2eacf7e043e18ee55f0b8cf22171\", \"got_v8_revision_cp\": \"refs/heads/8.9.71@{#1}\", \"got_webrtc_revision\": \"bcca3b08a90fccaa6dd8d86f6079f0ca0553ab4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32715}\", \"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\": \"03a4f3150e82f709e58095adbacb8b616d1d8842\", \"swarm_hashes_refs/heads/master(at){#832258}_without_patch\": {\"absl_hardening_tests\": \"a46c58e7b26fe663bbb3e2a6410a5ef074e84ccf\", \"accessibility_unittests\": \"0768147a6e1e96ca92d745d398978c369f16950c\", \"angle_unittests\": \"9c84867100556836d24e173ff09adeb93fefa29d\", \"app_shell_unittests\": \"b9fa76ef9bdcf6eaa22509d13245784659c87490\", \"aura_unittests\": \"ee7b24ed1ad5e20812c15501401d673204bb5350\", \"base_unittests\": \"a6d04eae8606d99258dcc9ae7546263636b990a7\", \"base_util_unittests\": \"a472347e2c8cc48a19df07ba192f583c3d34acb9\", \"blink_common_unittests\": \"e6e5748ef2a8f444e16c4a2e4fe73cc2f5276c3f\", \"blink_fuzzer_unittests\": \"4cab7eedc897021ee524e1d36723ca168400457d\", \"blink_heap_unittests\": \"1a89dd1cb2086c69431e9ec8cf51bfce46041071\", \"blink_platform_unittests\": \"6f306c033cb646e2bf9a4a1515c754c6f9ea75f6\", \"blink_unittests\": \"0b8c282df647f97da1934c88a13a58aed3a1dede\", \"boringssl_crypto_tests\": \"10dc9f721d0a41d098a266dff9f1196da6bfbe40\", \"boringssl_ssl_tests\": \"e903ed21b1df04649ee90cde37d4d360e41b2de8\", \"browser_switcher_bho_unittests\": \"3bb341c7d6c92978a824d8d7bee0e4023d7aaf2b\", \"browser_tests\": \"f2feea0d6ad4d4dd813a4dac23a97b98410d62f8\", \"capture_unittests\": \"4e60b176286387956de77675927bfea5c01052f3\", \"cast_unittests\": \"e762f7d5fab473678303597bf9d655e10a82df13\", \"cc_unittests\": \"9835a79dec08f854f0b393fe3435ccabf84cabd3\", \"chrome_app_unittests\": \"05e3699382f8feb907957246be74a89961f063fb\", \"chrome_cleaner_unittests\": \"31768a653d908bef6f2ffcf0b7ddb8bc41c24c52\", \"chrome_elf_unittests\": \"03f78d2f7223728050960980b4e14ccba993ad9e\", \"chromedriver_unittests\": \"738b583f6e530e39199bc6f312398dfba22d9ec1\", \"components_browsertests\": \"be8d64b9b9fb49dbd6f91fecae94256bd00fa1a9\", \"components_unittests\": \"1ffdd600940703dfb2bb7efdec58373bd31fd439\", \"compositor_unittests\": \"c9b27c6939bf3bc6c543bd04cde09793b24fe199\", \"content_browsertests\": \"6180da63697a6d844ba2fdac3ffab8135b16712a\", \"content_unittests\": \"76737be8f3fee0978139761d3c41cd3e5384d91b\", \"courgette_unittests\": \"1e170551d86feb2e0efad232e058852d9efe48f1\", \"crashpad_tests\": \"213c52b6839941607cf9942d69583e0d8e185867\", \"cronet_tests\": \"cb7118a4c8e5bb734e25beff887ff45531928031\", \"cronet_unittests\": \"7145b99bdb9eeabf90b60a14e968f62fd5c84dbf\", \"crypto_unittests\": \"47b69d2f240f9c4368214f5f5fe0d3f8323832c3\", \"delayloads_unittests\": \"d36527f47607bba5679988d9dc52ff66133cf2a3\", \"device_unittests\": \"d890ec2789358b8e1be098515280deb78275441a\", \"display_unittests\": \"0622fa372eaef56b4143185d54976c6478142ca3\", \"elevation_service_unittests\": \"22af1bc825f431f94ab33a4791408c2fb5295835\", \"events_unittests\": \"eac557674e8026d353c752b3d1b7b6be2293c2ef\", \"extensions_browsertests\": \"38828d8c286d3a18e0ffb74550794da29cf563c8\", \"extensions_unittests\": \"778b430c519c8efd05171c2b85ebc01158a7ddba\", \"filesystem_service_unittests\": \"7f91c09b01101582d1dadcbc7660577924b7d752\", \"gcm_unit_tests\": \"09542b60c1cf6827ef38c579d420a6546ce7d69b\", \"gcp_unittests\": \"b1275bdeac5281797c049abad248658e0083aa55\", \"gfx_unittests\": \"bae04247df3f3fc88b13e7f42df0c46618daca58\", \"gin_unittests\": \"6d370391af84fe31aefb1dc03731fba2ad203e80\", \"google_apis_unittests\": \"50c94948f9c23bb0e86a836ba0288d525a951ab3\", \"gpu_unittests\": \"3f40484ab9e3889abdb9b33140fc1bb850bd4840\", \"gwp_asan_unittests\": \"56d0b45c50fa0d46d9f677c5f25b5c0755b90dfd\", \"headless_browsertests\": \"72a4f07218b973c97f5c042ef001c7b5c87154a3\", \"headless_unittests\": \"05c19d9bf9c0bbfcf9ac8f621e1129394ff6b08f\", \"install_static_unittests\": \"d6a99b81f9b3405d5dcdf976fb486fe1d1343a6b\", \"installer_util_unittests\": \"b4f800c7b8ad6d07cf8ba0a656cbdd61ec05bc8f\", \"interactive_ui_tests\": \"62a6c835ddf4782d45e295e66e718d36d51f1bbd\", \"ipc_tests\": \"514df5bcb673e8cd2d8f073f664d2a38a484f8e3\", \"jingle_unittests\": \"5254585db7ba3cd95aada8979a0712c7fbb4ffac\", \"latency_unittests\": \"006d68c652c2b73169c8583e36769d37fe42581f\", \"libjingle_xmpp_unittests\": \"5a1b795a174b763f955002b4c0b365aca078abcd\", \"liburlpattern_unittests\": \"02391d14c3f1e446c4498413c74793b28a8adeeb\", \"media_blink_unittests\": \"2ddb3ac6beaebf4509f1c7f4a985537eaf6bff54\", \"media_unittests\": \"b74881e4133e60ad694ccddb452d1ba8209bb826\", \"message_center_unittests\": \"10be774f7622ceb754b9e64d1976a12c82ee8b39\", \"midi_unittests\": \"38ba41d9d087297b41e333ee4107cdf89d69bca4\", \"mojo_core_unittests\": \"eb3dcc6aff1e4123b4a6440f9c953ee6b92ed028\", \"mojo_unittests\": \"8f52ab5356a049dd3b7fe3a3ecb82d892b22542c\", \"nacl_loader_unittests\": \"3e6f6c1b518c9fc7e1b36fdc0c7c63af7379c3ab\", \"native_theme_unittests\": \"30ec59c3c59fbe8814b3112193e66d158a43d5e7\", \"net_unittests\": \"7a2a6c92b15d97c9cae3f3cb8a42992422724e14\", \"notification_helper_unittests\": \"36ab0116bf3f33107a2fbe43c0ea048a5f0cc17e\", \"pdf_unittests\": \"3c8dc0fa107cb3fc526d8ce64c44927ae5c5cc05\", \"perfetto_unittests\": \"0df840b2d7a5de929fca4475c830c19759d23cef\", \"ppapi_unittests\": \"002c63ba86e96c27f401a719cc23dd96811197a7\", \"printing_unittests\": \"7793e0fa39bde82ed65991eaf004676eb5c4eaaa\", \"remoting_unittests\": \"5c963cd0b27447dc7fe209c44fd01fb628fe91ca\", \"sbox_integration_tests\": \"737cef9f4aad291bb979be73acb9e91580582482\", \"sbox_unittests\": \"63f8ae59cccd65f386503fed8af7793a37ab6dab\", \"sbox_validation_tests\": \"15b5eda17dc7070d2378cdea2c806da31e0e11c9\", \"service_manager_unittests\": \"e4c2ef73bafe48ad3dc99835f521ee46e50772ac\", \"services_unittests\": \"eae0002201af08da7679c6ef657eda1ee1f5233f\", \"setup_unittests\": \"a6990c84481480e7868111f68194cb665b5eb1eb\", \"shell_dialogs_unittests\": \"e532a9ef70f9ecaae1a14cb69ecc0e959b047ed1\", \"skia_unittests\": \"eb7dfe6a30d0bf4ed282cbb395ad343f6618b10c\", \"snapshot_unittests\": \"a99ef1a758886bc1dee524435e5dd7bc4b46269b\", \"sql_unittests\": \"c1fa1e5246c440472ffaf34f3ee04b60f1571672\", \"storage_unittests\": \"3143fb6dae6d42f69d2e8750f47949f80aa38a24\", \"sync_integration_tests\": \"ccc82871a8910c5a03c5cefefe2ca64b1f46d37f\", \"traffic_annotation_auditor_unittests\": \"ac030209f039bb8bf336dbe4879e0ebd1132a681\", \"ui_base_unittests\": \"eb4d5e6b9d2a770d28997706cbcb02e3df5ad22f\", \"ui_touch_selection_unittests\": \"ec3ab53f8237b3ea56b266b68c59aea9feddd320\", \"unit_tests\": \"21b8f2a474b593b0d9b3860bd28d811b84467ac9\", \"updater_tests\": \"287fe42d55c10d635a839e9c4f29d2d53d17bd8b\", \"url_unittests\": \"9ef7a8a8a0f11ca49cfcace5f07578d9ee1b7eb0\", \"views_unittests\": \"243f5d7e4691bfc7095a61de969f3f57249327c9\", \"viz_unittests\": \"5a77df32b77acfe4c30e0dfc478d22e7370a7ec2\", \"vr_common_unittests\": \"7c454b952ac1a64a1bfaaecac7365cc6a1812b90\", \"vr_pixeltests\": \"7677a05bd09f16cb8661b2fd56a8925f22549b09\", \"weblayer_browsertests\": \"19c78f56dfd542d5a041aba1ef8d1eb23f776e47\", \"weblayer_unittests\": \"71640f58d0d9f13a0efda443cc2b4425ab89f72a\", \"wm_unittests\": \"167b0d6ec9c9fc0232f37790681c947c4f91baa3\", \"wtf_unittests\": \"c0e2491e3397e7dcfc0ea03e827ba7bb5422e334\", \"zlib_unittests\": \"b453f0ff79bfc1c1b58daedfca05ea854c768f97\", \"zucchini_unittests\": \"ff097ad93a53e093c7e6e6b1e71317a8309c3648\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_91b2ef8341586e76bd64fa3093e74ce43aef344c2e2134fb3b046b47c3d4bcdb_v2\", \"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-10-eupo\"], \"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\": [\"5640-d0eb544\"], \"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": "1606813399777585",
"status": "COMPLETED",
"status_changed_ts": "1606816859813162",
"tags": [
"build_address:luci.chromium.ci/win-asan/15964",
"builder:win-asan",
"buildset:commit/git/03a4f3150e82f709e58095adbacb8b616d1d8842",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/03a4f3150e82f709e58095adbacb8b616d1d8842",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027557812829189952",
"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/8862127750933504160/+/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:50365c3cb6956c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1606816859826472",
"url": "https://ci.chromium.org/b/8862127750933504160",
"utcnow_ts": "1606816861953138"
}
}
[10:01:01.991] Invocation finished in 57m45.751626483s with status SUCCEEDED