[10:38:28.883] New invocation is queued and will start shortly
[10:38:30.226] Starting the invocation (attempt 1)
[10:38:30.262] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:38:30.262] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:38:30.262] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028004807537314688",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d874c5445ee3fa14b66220b24d56e61322549554\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9028004807537314688",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/d874c5445ee3fa14b66220b24d56e61322549554",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d874c5445ee3fa14b66220b24d56e61322549554",
"gitiles_ref:refs/heads/master"
]
}
[10:38:31.148] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606387110415552",
"id": "8862574745267810496",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d874c5445ee3fa14b66220b24d56e61322549554\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606387110996347",
"tags": [
"build_address:luci.chromium.ci/win-asan/15861",
"builder:win-asan",
"buildset:commit/git/d874c5445ee3fa14b66220b24d56e61322549554",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d874c5445ee3fa14b66220b24d56e61322549554",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028004807537314688",
"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/8862574745267810496/+/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": "1606387110996571",
"url": "https://ci.chromium.org/b/8862574745267810496",
"utcnow_ts": "1606387111138999"
}
}
[10:38:31.148] Task URL: https://ci.chromium.org/b/8862574745267810496
[10:38:31.148] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:2:0) after 1m0s
[10:38:34.874] Received PubSub notification, asking Buildbucket for the build status
[10:38:35.372] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:31.176] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:2:0)
[10:39:31.176] Timer tick, asking Buildbucket for the build status
[10:39:31.275] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:31.275] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:4:0) after 1m0s
[10:40:31.378] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:4:0)
[10:40:31.378] Timer tick, asking Buildbucket for the build status
[10:40:31.491] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:31.491] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:5:0) after 1m0s
[10:41:31.681] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:5:0)
[10:41:31.681] Timer tick, asking Buildbucket for the build status
[10:41:31.933] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:31.933] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:6:0) after 1m0s
[10:42:33.179] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:6:0)
[10:42:33.179] Timer tick, asking Buildbucket for the build status
[10:42:33.280] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:33.280] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:7:0) after 1m0s
[10:43:33.324] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:7:0)
[10:43:33.324] Timer tick, asking Buildbucket for the build status
[10:43:33.447] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:33.447] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:8:0) after 1m0s
[10:44:33.495] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:8:0)
[10:44:33.495] Timer tick, asking Buildbucket for the build status
[10:44:33.572] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:33.572] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:9:0) after 1m0s
[10:45:33.559] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:9:0)
[10:45:33.559] Timer tick, asking Buildbucket for the build status
[10:45:33.643] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:33.643] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:10:0) after 1m0s
[10:46:33.661] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:10:0)
[10:46:33.661] Timer tick, asking Buildbucket for the build status
[10:46:33.720] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:33.720] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:11:0) after 1m0s
[10:47:33.745] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:11:0)
[10:47:33.745] Timer tick, asking Buildbucket for the build status
[10:47:33.808] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:33.808] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:12:0) after 1m0s
[10:48:34.217] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:12:0)
[10:48:34.217] Timer tick, asking Buildbucket for the build status
[10:48:34.315] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:34.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:13:0) after 1m0s
[10:49:34.389] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:13:0)
[10:49:34.389] Timer tick, asking Buildbucket for the build status
[10:49:34.804] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:34.804] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:14:0) after 1m0s
[10:50:35.565] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:14:0)
[10:50:35.565] Timer tick, asking Buildbucket for the build status
[10:50:35.642] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:35.642] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:15:0) after 1m0s
[10:51:35.786] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:15:0)
[10:51:35.786] Timer tick, asking Buildbucket for the build status
[10:51:35.900] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:35.900] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:16:0) after 1m0s
[10:52:36.147] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:16:0)
[10:52:36.147] Timer tick, asking Buildbucket for the build status
[10:52:37.331] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:37.331] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:17:0) after 1m0s
[10:53:37.383] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:17:0)
[10:53:37.383] Timer tick, asking Buildbucket for the build status
[10:53:37.556] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:37.556] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:18:0) after 1m0s
[10:54:37.677] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:18:0)
[10:54:37.677] Timer tick, asking Buildbucket for the build status
[10:54:37.845] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:37.846] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:19:0) after 1m0s
[10:55:37.838] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:19:0)
[10:55:37.838] Timer tick, asking Buildbucket for the build status
[10:55:38.243] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:38.243] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:20:0) after 1m0s
[10:56:38.266] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:20:0)
[10:56:38.266] Timer tick, asking Buildbucket for the build status
[10:56:38.387] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:38.387] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:21:0) after 1m0s
[10:57:38.484] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:21:0)
[10:57:38.484] Timer tick, asking Buildbucket for the build status
[10:57:38.643] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:38.643] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:22:0) after 1m0s
[10:58:38.697] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:22:0)
[10:58:38.697] Timer tick, asking Buildbucket for the build status
[10:58:38.857] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:38.857] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:23:0) after 1m0s
[10:59:38.856] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:23:0)
[10:59:38.856] Timer tick, asking Buildbucket for the build status
[10:59:39.197] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:39.197] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:24:0) after 1m0s
[11:00:39.260] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:24:0)
[11:00:39.260] Timer tick, asking Buildbucket for the build status
[11:00:39.494] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:39.494] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:25:0) after 1m0s
[11:01:40.876] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:25:0)
[11:01:40.876] Timer tick, asking Buildbucket for the build status
[11:01:41.800] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:41.800] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:26:0) after 1m0s
[11:02:41.876] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:26:0)
[11:02:41.876] Timer tick, asking Buildbucket for the build status
[11:02:42.262] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:42.262] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:27:0) after 1m0s
[11:03:42.361] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:27:0)
[11:03:42.361] Timer tick, asking Buildbucket for the build status
[11:03:42.476] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:42.476] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:28:0) after 1m0s
[11:04:42.603] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:28:0)
[11:04:42.603] Timer tick, asking Buildbucket for the build status
[11:04:42.957] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:42.957] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:29:0) after 1m0s
[11:05:43.000] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:29:0)
[11:05:43.000] Timer tick, asking Buildbucket for the build status
[11:05:43.081] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:43.081] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:30:0) after 1m0s
[11:06:43.105] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:30:0)
[11:06:43.105] Timer tick, asking Buildbucket for the build status
[11:06:43.222] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:43.222] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:31:0) after 1m0s
[11:07:43.245] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:31:0)
[11:07:43.245] Timer tick, asking Buildbucket for the build status
[11:07:43.556] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:43.556] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:32:0) after 1m0s
[11:08:43.606] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:32:0)
[11:08:43.606] Timer tick, asking Buildbucket for the build status
[11:08:44.031] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:44.031] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:33:0) after 1m0s
[11:09:44.079] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:33:0)
[11:09:44.079] Timer tick, asking Buildbucket for the build status
[11:09:44.270] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:44.270] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:34:0) after 1m0s
[11:10:44.294] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:34:0)
[11:10:44.294] Timer tick, asking Buildbucket for the build status
[11:10:44.372] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:44.372] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:35:0) after 1m0s
[11:11:44.398] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:35:0)
[11:11:44.398] Timer tick, asking Buildbucket for the build status
[11:11:44.525] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:44.525] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:36:0) after 1m0s
[11:12:44.549] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:36:0)
[11:12:44.549] Timer tick, asking Buildbucket for the build status
[11:12:44.633] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:44.633] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:37:0) after 1m0s
[11:13:44.695] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:37:0)
[11:13:44.695] Timer tick, asking Buildbucket for the build status
[11:13:44.817] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:44.817] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:38:0) after 1m0s
[11:14:44.873] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:38:0)
[11:14:44.873] Timer tick, asking Buildbucket for the build status
[11:14:44.945] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:44.945] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:39:0) after 1m0s
[11:15:44.976] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:39:0)
[11:15:44.976] Timer tick, asking Buildbucket for the build status
[11:15:45.047] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:45.047] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:40:0) after 1m0s
[11:16:45.091] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:40:0)
[11:16:45.091] Timer tick, asking Buildbucket for the build status
[11:16:46.044] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:46.044] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:41:0) after 1m0s
[11:17:46.095] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:41:0)
[11:17:46.095] Timer tick, asking Buildbucket for the build status
[11:17:46.219] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:46.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:42:0) after 1m0s
[11:18:46.272] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:42:0)
[11:18:46.272] Timer tick, asking Buildbucket for the build status
[11:18:46.432] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:46.432] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:43:0) after 1m0s
[11:19:46.452] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:43:0)
[11:19:46.452] Timer tick, asking Buildbucket for the build status
[11:19:46.565] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:46.565] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:44:0) after 1m0s
[11:20:46.590] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:44:0)
[11:20:46.590] Timer tick, asking Buildbucket for the build status
[11:20:47.138] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:47.138] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:45:0) after 1m0s
[11:21:47.180] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:45:0)
[11:21:47.180] Timer tick, asking Buildbucket for the build status
[11:21:47.361] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:47.361] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:46:0) after 1m0s
[11:22:47.381] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:46:0)
[11:22:47.381] Timer tick, asking Buildbucket for the build status
[11:22:47.784] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:47.784] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:47:0) after 1m0s
[11:23:47.802] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:47:0)
[11:23:47.802] Timer tick, asking Buildbucket for the build status
[11:23:47.912] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:47.912] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:48:0) after 1m0s
[11:24:47.916] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:48:0)
[11:24:47.916] Timer tick, asking Buildbucket for the build status
[11:24:48.026] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:48.026] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:49:0) after 1m0s
[11:25:48.097] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:49:0)
[11:25:48.097] Timer tick, asking Buildbucket for the build status
[11:25:48.535] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:48.535] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:50:0) after 1m0s
[11:26:48.544] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:50:0)
[11:26:48.544] Timer tick, asking Buildbucket for the build status
[11:26:48.613] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:48.613] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:51:0) after 1m0s
[11:27:48.656] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:51:0)
[11:27:48.656] Timer tick, asking Buildbucket for the build status
[11:27:48.718] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:48.718] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:52:0) after 1m0s
[11:28:48.734] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:52:0)
[11:28:48.734] Timer tick, asking Buildbucket for the build status
[11:28:48.925] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:48.925] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:53:0) after 1m0s
[11:29:48.980] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:53:0)
[11:29:48.980] Timer tick, asking Buildbucket for the build status
[11:29:49.366] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:49.366] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:54:0) after 1m0s
[11:30:49.408] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:54:0)
[11:30:49.408] Timer tick, asking Buildbucket for the build status
[11:30:49.480] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:49.480] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:55:0) after 1m0s
[11:31:49.552] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:55:0)
[11:31:49.552] Timer tick, asking Buildbucket for the build status
[11:31:49.619] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:49.619] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:56:0) after 1m0s
[11:32:49.672] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:56:0)
[11:32:49.672] Timer tick, asking Buildbucket for the build status
[11:32:49.815] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:49.815] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:57:0) after 1m0s
[11:33:49.896] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:57:0)
[11:33:49.896] Timer tick, asking Buildbucket for the build status
[11:33:50.006] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:50.006] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:58:0) after 1m0s
[11:34:50.036] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:58:0)
[11:34:50.037] Timer tick, asking Buildbucket for the build status
[11:34:50.224] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:50.224] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:59:0) after 1m0s
[11:35:50.270] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:59:0)
[11:35:50.270] Timer tick, asking Buildbucket for the build status
[11:35:50.331] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:50.331] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:60:0) after 1m0s
[11:36:50.377] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:60:0)
[11:36:50.377] Timer tick, asking Buildbucket for the build status
[11:36:51.056] Build 8862574745267810496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:51.056] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028004807537314688:61:0) after 1m0s
[11:37:39.369] Received PubSub notification, asking Buildbucket for the build status
[11:37:39.518] Build 8862574745267810496: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:37:39.518] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606390658570655",
"created_by": "project:chromium",
"created_ts": "1606387110415552",
"id": "8862574745267810496",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d874c5445ee3fa14b66220b24d56e61322549554\"}}",
"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\": \"d874c5445ee3fa14b66220b24d56e61322549554\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-win10-32-6-2gr3\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15861, \"clang_revision\": \"llvmorg-12-init-12083-g94e4ec64-1\", \"got_angle_revision\": \"5850c748b480ae13159323ce2b3a09a36355711b\", \"got_dawn_revision\": \"9175f00eec91c6c9b3c3e264d6d8ec7879881844\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"d874c5445ee3fa14b66220b24d56e61322549554\", \"got_revision_cp\": \"refs/heads/master@{#831302}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"43bb60e1fa119d80b449c6550dd2b72328b101b9\", \"got_v8_revision\": \"1166840df5216851f3f7d9f6e16f5d0ee3c08cbe\", \"got_v8_revision_cp\": \"refs/heads/8.9.54@{#1}\", \"got_webrtc_revision\": \"b1f929cd8f32d41ee91dbcef6e16c5bea61a76c7\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32697}\", \"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\": \"d874c5445ee3fa14b66220b24d56e61322549554\", \"swarm_hashes_refs/heads/master(at){#831302}_without_patch\": {\"absl_hardening_tests\": \"4918cbf3c3edab1c87acb76a873882c9292f27b4\", \"accessibility_unittests\": \"230f4c63b924fc3d8d3f9f7bbaf76d9c8cc4d063\", \"angle_unittests\": \"7ec223fbb3c8a3b555bbedfcf36a41eeb702bfa1\", \"app_shell_unittests\": \"eab89d11bb90abfb6f7c82eb4ac4f4dd16e92e97\", \"aura_unittests\": \"c1dcdac6a4e8b3f31dc92be657f361b14ade32b4\", \"base_unittests\": \"f80780370bdf5921f2bd12680fde8ff65b675c1f\", \"base_util_unittests\": \"f2faad506e8960d05b5a556e4601ca50481753c0\", \"blink_common_unittests\": \"b0629d12671d084b94ded9f9e54659c6dfbf1bc5\", \"blink_fuzzer_unittests\": \"862d4737254d1edcdcbe859a1f8696560497a34a\", \"blink_heap_unittests\": \"c2215ecfd0bf378a8b6a1bc06200c07e0fb6de45\", \"blink_platform_unittests\": \"21dcd57ed807830ad29c8d28f4a2d9ad56b5b6ae\", \"blink_unittests\": \"1c310b385138c1ae6f8578a4ee5c3804f0b30362\", \"boringssl_crypto_tests\": \"0e827e55fc4e902fa13394e2f03e33411768509b\", \"boringssl_ssl_tests\": \"f5bafeaad5a9507e0f4a3d43b17cad33e6abed40\", \"browser_switcher_bho_unittests\": \"a5bb0313c3a39326e0b81dcd07d392ff5108f11d\", \"browser_tests\": \"6cddbe7440f9dcf93a62bd6cfeeccb6ae9cd0d71\", \"capture_unittests\": \"12dfc095f103a13ce3f7243142a707bbbdb3da98\", \"cast_unittests\": \"2288ed37a3881e2906afe675096c4bbf45a71d8d\", \"cc_unittests\": \"3f34ad56ac8205f917a2ca79ac283ba92bf2705f\", \"chrome_app_unittests\": \"932912955ac280ec709240cfc66be9c654903190\", \"chrome_cleaner_unittests\": \"e7fec739ca8d4226646617c0d77a551c2524fa6a\", \"chrome_elf_unittests\": \"0aee646d46f62081aaaf5aa911c055bcd56fc102\", \"chromedriver_unittests\": \"c03eceec9c5e947107fd6cc7af69c5d59d44ab9d\", \"components_browsertests\": \"f5afddc5b2caf5e6b3f74af8bf060aff74933dad\", \"components_unittests\": \"3bb1c846bbb33e13ebc12a639ac7e6cfa54c1d3b\", \"compositor_unittests\": \"0b6d1703a80774b38d1e95f840bc3352d804835d\", \"content_browsertests\": \"d5beb7accfcbe66bf8e598f2c33033c74c52f48a\", \"content_unittests\": \"fd960fa7f9cad2abe047a8aaaac93555197224c1\", \"courgette_unittests\": \"284223375255c857f179d5b5d744b7d8c7e0a7da\", \"crashpad_tests\": \"4911d21512ce5f37058f487327aac13a35b0f9b0\", \"cronet_tests\": \"54b472d33e8451fa4f3257aba70ce09fc49f8a87\", \"cronet_unittests\": \"1bf70783610d4292df3233518fc3519c004f4573\", \"crypto_unittests\": \"b60c8b269ab5cbd5d16515aed6b5c6eb80a9d8cf\", \"delayloads_unittests\": \"5e385f4778c067d680531e6ae366cb09383ceae9\", \"device_unittests\": \"6a85c3f8c9377ba205d68363b8d0c56c9091f5ab\", \"display_unittests\": \"5e54cc9caed28fc9023e9ccde9accfa16d4d354d\", \"elevation_service_unittests\": \"a1cd238d0b0144059d4c2711ee4b1cf680a191dc\", \"events_unittests\": \"881b15d5e0aed5b195c8354939bf37e10b5b303b\", \"extensions_browsertests\": \"53055185f8042ac6f33429b6e07dd2c43b1c25c8\", \"extensions_unittests\": \"43e25ab45656d9ea555c12656abfb1338ad4fc7a\", \"filesystem_service_unittests\": \"a9f9e7617bccdc1fd98da88c5146c0a3ab9e894e\", \"gcm_unit_tests\": \"526ab814a773f84984854ef7e9e59eb390e9b3a7\", \"gcp_unittests\": \"8c264ad3c400f4114e3760673a6bd462e9f3fc39\", \"gfx_unittests\": \"063f02bd52d013f19789a390f6e10da7052d6347\", \"gin_unittests\": \"bdd822e9069b06ad317a92cfa993b2dc84f0f104\", \"google_apis_unittests\": \"510e27788b6d5af428fa62b357690e8a10a95ab0\", \"gpu_unittests\": \"050a2ffe503e6cc7b8af9569ae335bc40a1004ad\", \"gwp_asan_unittests\": \"442cc9d9695a33aa9e4b47cfe7691a62ac1cff6a\", \"headless_browsertests\": \"9b7746fc5d2b420638a4e2d78c20a4078c2558a1\", \"headless_unittests\": \"40380f780c50132ab0b173f0a3f69b0a15b618c6\", \"install_static_unittests\": \"299d718239d35cbe735db999f57ae89df5fdd449\", \"installer_util_unittests\": \"d3e2dedc46cc28e1de0063932a4047ad903b9691\", \"interactive_ui_tests\": \"fcf53cac43486e07f3473cec143222d7f4e498cf\", \"ipc_tests\": \"e77ce0d30e157e5ea79679b1aaf0fcce3ced4e53\", \"jingle_unittests\": \"80beef372c53eb07ee1f805b9459b6da412002a4\", \"latency_unittests\": \"92624af10b5bf05c18a0fcb15a587c31b8bf3da7\", \"libjingle_xmpp_unittests\": \"759ec4fdee3ffbe0bbd6b1fd0ffdc33a1144b9a2\", \"liburlpattern_unittests\": \"addd143253a68b70bd267c328dc7b278ce399bdc\", \"media_blink_unittests\": \"572af1cd52b8ddddf402baa293cdcbafeab8f3eb\", \"media_unittests\": \"57e76dc6c3993e12eb2893aa1d8f2c15a335a75a\", \"message_center_unittests\": \"1783ac3a21b8c28106ac4f6013d2a2577ca70265\", \"midi_unittests\": \"a3ca27adf3bd4281c1d88b19df3887b3622adaaf\", \"mojo_core_unittests\": \"8f53b1c31ac6bb56abeae484e1c934caadfd284e\", \"mojo_unittests\": \"a49b8a838a2f37eae1e20f9edd11d1dc167e383e\", \"nacl_loader_unittests\": \"265689646ac76018df54aa7a04f4773962c92903\", \"native_theme_unittests\": \"7305b15180256090e76491f618853cea8d8be96b\", \"net_unittests\": \"5308ab86ed24ecf29c35a2938281e119cc260b3a\", \"notification_helper_unittests\": \"40856bbec132a0f19093a525169b0eb738f83168\", \"pdf_unittests\": \"9fb18b5ddb76b7e99370c046a6437af8ebd4773e\", \"perfetto_unittests\": \"06cc46c36cb35a66cef349ece22cb4a4df0ae921\", \"ppapi_unittests\": \"8df08ff45ac664c5b9a181f5889feae3a6331217\", \"printing_unittests\": \"50837e028bfbcee3489852e45aea8956d0b4c1b4\", \"remoting_unittests\": \"72586372ca5f221f47762cdc2ed2b53819f9f596\", \"sbox_integration_tests\": \"3d05f8daa22b372a3695f6bba44e92f9c8ff2146\", \"sbox_unittests\": \"8ced15b44acad9236cb2cc4d34b0c9177a59a510\", \"sbox_validation_tests\": \"e774629355cfe75dc4a60b45f98235534d3c76ce\", \"service_manager_unittests\": \"b1d9f2101ea3e716470e8d4f07439fe47127bdb5\", \"services_unittests\": \"aae19e56428fddea387d5f2b5bae1eb30c33776b\", \"setup_unittests\": \"23f40427934e3705cb7810339e26ab71a53318f3\", \"shell_dialogs_unittests\": \"57c65491b804c7712b92ee67567514cd7a65507a\", \"skia_unittests\": \"0871cca4c158beff5fe65c914bea24f05fa03917\", \"snapshot_unittests\": \"f9d9fddaee4479a6188e1e7700cd349763eb55ac\", \"sql_unittests\": \"b8fc17e2e37ec3f190fc44c2997748515fe1d89e\", \"storage_unittests\": \"53011d3a32a667c7c99f6cfec130ecfd73e084cf\", \"sync_integration_tests\": \"fa2d614ca7cb5004de27fcfd82b7294c0c6c911f\", \"traffic_annotation_auditor_unittests\": \"722f4c7bbe420316c069fa9428bb68c1ee7218cc\", \"ui_base_unittests\": \"2648bb37201cf7bf15382932d97054343f2f69f4\", \"ui_touch_selection_unittests\": \"62ece42640769d2ff0bd58b7c49d568e4a147b52\", \"unit_tests\": \"80805bd5e6feeaede10e5e1b6bdef9c31ccea4ea\", \"updater_tests\": \"a9d145bc48b8244de5283a43a260b5978a09d5fb\", \"url_unittests\": \"df7e2dad1293c323f2e18a0b339b99bbd2ec33f8\", \"views_unittests\": \"4026303612fbec7864bfbbb5967d9412423a341b\", \"viz_unittests\": \"5be7f9f22dc53ec8873b36f14dfa94b6c6784209\", \"vr_common_unittests\": \"6c9546833c8d728c4bc4159488790cea995d5c5b\", \"vr_pixeltests\": \"8399f41e3aa56615ce39325ef9a30cd41c213bf0\", \"weblayer_browsertests\": \"65a76dc63a12eb2f42e92d7c2bb6171943ecb678\", \"weblayer_unittests\": \"45afbb5963064c2c4b248afd6dc0bf5489c86b07\", \"wm_unittests\": \"dbde22e11786896c52441bf239872d1972b28feb\", \"wtf_unittests\": \"cd8b61ea81f9402adfe1788120193fc58c7c1269\", \"zlib_unittests\": \"ae081cdc6616c7d5495bc914ec29510c4239628f\", \"zucchini_unittests\": \"431fa5b1301e96b6cba4757387fc4406e0a98d86\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_ba2591630e3c492a7f8bed019e3d41c3ae1f8879793a1bf71c3be1367a2696d6_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-6-2gr3\"], \"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": "1606387113913336",
"status": "COMPLETED",
"status_changed_ts": "1606390658874975",
"tags": [
"build_address:luci.chromium.ci/win-asan/15861",
"builder:win-asan",
"buildset:commit/git/d874c5445ee3fa14b66220b24d56e61322549554",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d874c5445ee3fa14b66220b24d56e61322549554",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028004807537314688",
"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/8862574745267810496/+/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:501cf39d9b0bbf10",
"user_agent:luci-scheduler"
],
"updated_ts": "1606390658879757",
"url": "https://ci.chromium.org/b/8862574745267810496",
"utcnow_ts": "1606390659462756"
}
}
[11:37:39.518] Invocation finished in 59m10.650694072s with status SUCCEEDED