[00:58:54.489] New invocation is queued and will start shortly
[00:58:55.745] Starting the invocation (attempt 1)
[00:58:55.807] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:58:55.812] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:58:55.813] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030215598329138880",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"99c85930f1456a64cae940bbc01b1fd0aca0e6b4\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9030215598329138880",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/99c85930f1456a64cae940bbc01b1fd0aca0e6b4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/99c85930f1456a64cae940bbc01b1fd0aca0e6b4",
"gitiles_ref:refs/heads/master"
]
}
[00:58:56.749] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604278736027659",
"id": "8864785536050124832",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"99c85930f1456a64cae940bbc01b1fd0aca0e6b4\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604278736595033",
"tags": [
"build_address:luci.chromium.ci/win-asan/15403",
"builder:win-asan",
"buildset:commit/git/99c85930f1456a64cae940bbc01b1fd0aca0e6b4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/99c85930f1456a64cae940bbc01b1fd0aca0e6b4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030215598329138880",
"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/8864785536050124832/+/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": "1604278736595182",
"url": "https://ci.chromium.org/b/8864785536050124832",
"utcnow_ts": "1604278736734532"
}
}
[00:58:56.750] Task URL: https://ci.chromium.org/b/8864785536050124832
[00:58:56.750] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:2:0) after 1m0s
[00:59:22.972] Received PubSub notification, asking Buildbucket for the build status
[00:59:25.011] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:56.855] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:2:0)
[00:59:56.855] Timer tick, asking Buildbucket for the build status
[00:59:56.983] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:56.983] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:4:0) after 1m0s
[01:00:57.105] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:4:0)
[01:00:57.105] Timer tick, asking Buildbucket for the build status
[01:00:57.207] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:57.208] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:5:0) after 1m0s
[01:01:58.174] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:5:0)
[01:01:58.174] Timer tick, asking Buildbucket for the build status
[01:01:58.342] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:58.342] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:6:0) after 1m0s
[01:02:58.421] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:6:0)
[01:02:58.421] Timer tick, asking Buildbucket for the build status
[01:02:58.684] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:58.684] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:7:0) after 1m0s
[01:03:58.769] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:7:0)
[01:03:58.769] Timer tick, asking Buildbucket for the build status
[01:03:58.873] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:58.873] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:8:0) after 1m0s
[01:04:59.088] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:8:0)
[01:04:59.088] Timer tick, asking Buildbucket for the build status
[01:04:59.353] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:59.353] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:9:0) after 1m0s
[01:05:59.472] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:9:0)
[01:05:59.472] Timer tick, asking Buildbucket for the build status
[01:05:59.608] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:59.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:10:0) after 1m0s
[01:06:59.938] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:10:0)
[01:06:59.938] Timer tick, asking Buildbucket for the build status
[01:07:00.125] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:00.125] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:11:0) after 1m0s
[01:08:00.342] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:11:0)
[01:08:00.342] Timer tick, asking Buildbucket for the build status
[01:08:00.575] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:00.575] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:12:0) after 1m0s
[01:09:00.675] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:12:0)
[01:09:00.675] Timer tick, asking Buildbucket for the build status
[01:09:00.916] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:00.916] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:13:0) after 1m0s
[01:10:01.890] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:13:0)
[01:10:01.890] Timer tick, asking Buildbucket for the build status
[01:10:01.964] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:01.964] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:14:0) after 1m0s
[01:11:02.531] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:14:0)
[01:11:02.531] Timer tick, asking Buildbucket for the build status
[01:11:02.647] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:02.647] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:15:0) after 1m0s
[01:12:02.721] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:15:0)
[01:12:02.721] Timer tick, asking Buildbucket for the build status
[01:12:02.924] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:02.924] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:16:0) after 1m0s
[01:13:02.960] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:16:0)
[01:13:02.960] Timer tick, asking Buildbucket for the build status
[01:13:03.238] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:03.238] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:17:0) after 1m0s
[01:14:03.303] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:17:0)
[01:14:03.303] Timer tick, asking Buildbucket for the build status
[01:14:03.432] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:03.432] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:18:0) after 1m0s
[01:15:03.564] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:18:0)
[01:15:03.564] Timer tick, asking Buildbucket for the build status
[01:15:03.702] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:03.702] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:19:0) after 1m0s
[01:16:03.987] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:19:0)
[01:16:03.987] Timer tick, asking Buildbucket for the build status
[01:16:04.453] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:04.453] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:20:0) after 1m0s
[01:17:04.642] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:20:0)
[01:17:04.642] Timer tick, asking Buildbucket for the build status
[01:17:04.774] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:04.774] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:21:0) after 1m0s
[01:18:04.990] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:21:0)
[01:18:04.990] Timer tick, asking Buildbucket for the build status
[01:18:05.469] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:05.469] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:22:0) after 1m0s
[01:19:05.739] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:22:0)
[01:19:05.739] Timer tick, asking Buildbucket for the build status
[01:19:05.863] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:05.863] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:23:0) after 1m0s
[01:20:05.887] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:23:0)
[01:20:05.887] Timer tick, asking Buildbucket for the build status
[01:20:06.094] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:06.094] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:24:0) after 1m0s
[01:21:06.200] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:24:0)
[01:21:06.200] Timer tick, asking Buildbucket for the build status
[01:21:06.333] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:06.333] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:25:0) after 1m0s
[01:22:06.531] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:25:0)
[01:22:06.531] Timer tick, asking Buildbucket for the build status
[01:22:06.812] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:06.812] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:26:0) after 1m0s
[01:23:06.883] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:26:0)
[01:23:06.883] Timer tick, asking Buildbucket for the build status
[01:23:07.409] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:07.409] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:27:0) after 1m0s
[01:24:07.654] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:27:0)
[01:24:07.654] Timer tick, asking Buildbucket for the build status
[01:24:07.894] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:07.894] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:28:0) after 1m0s
[01:25:07.921] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:28:0)
[01:25:07.921] Timer tick, asking Buildbucket for the build status
[01:25:08.003] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:08.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:29:0) after 1m0s
[01:26:08.073] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:29:0)
[01:26:08.073] Timer tick, asking Buildbucket for the build status
[01:26:08.139] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:08.139] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:30:0) after 1m0s
[01:27:08.354] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:30:0)
[01:27:08.354] Timer tick, asking Buildbucket for the build status
[01:27:08.441] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:08.442] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:31:0) after 1m0s
[01:28:08.647] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:31:0)
[01:28:08.647] Timer tick, asking Buildbucket for the build status
[01:28:08.729] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:08.729] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:32:0) after 1m0s
[01:29:08.934] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:32:0)
[01:29:08.934] Timer tick, asking Buildbucket for the build status
[01:29:09.616] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:09.616] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:33:0) after 1m0s
[01:30:09.688] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:33:0)
[01:30:09.688] Timer tick, asking Buildbucket for the build status
[01:30:09.824] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:09.824] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:34:0) after 1m0s
[01:31:11.588] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:34:0)
[01:31:11.588] Timer tick, asking Buildbucket for the build status
[01:31:12.126] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:12.126] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:35:0) after 1m0s
[01:32:12.186] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:35:0)
[01:32:12.186] Timer tick, asking Buildbucket for the build status
[01:32:12.444] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:12.444] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:36:0) after 1m0s
[01:33:12.564] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:36:0)
[01:33:12.564] Timer tick, asking Buildbucket for the build status
[01:33:12.803] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:12.803] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:37:0) after 1m0s
[01:34:12.873] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:37:0)
[01:34:12.873] Timer tick, asking Buildbucket for the build status
[01:34:12.980] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:12.980] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:38:0) after 1m0s
[01:35:13.106] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:38:0)
[01:35:13.106] Timer tick, asking Buildbucket for the build status
[01:35:13.189] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:13.189] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:39:0) after 1m0s
[01:36:13.272] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:39:0)
[01:36:13.272] Timer tick, asking Buildbucket for the build status
[01:36:13.504] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:13.504] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:40:0) after 1m0s
[01:37:13.588] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:40:0)
[01:37:13.588] Timer tick, asking Buildbucket for the build status
[01:37:13.725] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:13.725] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:41:0) after 1m0s
[01:38:13.775] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:41:0)
[01:38:13.775] Timer tick, asking Buildbucket for the build status
[01:38:14.056] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:14.056] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:42:0) after 1m0s
[01:39:14.376] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:42:0)
[01:39:14.376] Timer tick, asking Buildbucket for the build status
[01:39:14.741] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:14.741] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:43:0) after 1m0s
[01:40:14.890] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:43:0)
[01:40:14.890] Timer tick, asking Buildbucket for the build status
[01:40:14.965] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:14.965] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:44:0) after 1m0s
[01:41:15.086] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:44:0)
[01:41:15.086] Timer tick, asking Buildbucket for the build status
[01:41:15.583] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:15.583] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:45:0) after 1m0s
[01:42:15.704] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:45:0)
[01:42:15.704] Timer tick, asking Buildbucket for the build status
[01:42:16.109] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:16.109] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:46:0) after 1m0s
[01:43:16.099] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:46:0)
[01:43:16.099] Timer tick, asking Buildbucket for the build status
[01:43:16.165] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:16.165] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:47:0) after 1m0s
[01:44:16.247] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:47:0)
[01:44:16.247] Timer tick, asking Buildbucket for the build status
[01:44:16.372] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:16.372] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:48:0) after 1m0s
[01:45:16.404] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:48:0)
[01:45:16.404] Timer tick, asking Buildbucket for the build status
[01:45:16.771] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:16.771] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:49:0) after 1m0s
[01:46:16.792] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:49:0)
[01:46:16.792] Timer tick, asking Buildbucket for the build status
[01:46:17.134] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:17.134] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:50:0) after 1m0s
[01:47:17.293] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:50:0)
[01:47:17.293] Timer tick, asking Buildbucket for the build status
[01:47:17.585] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:17.585] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:51:0) after 1m0s
[01:48:17.730] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:51:0)
[01:48:17.730] Timer tick, asking Buildbucket for the build status
[01:48:18.273] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:18.273] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:52:0) after 1m0s
[01:49:18.337] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:52:0)
[01:49:18.337] Timer tick, asking Buildbucket for the build status
[01:49:18.446] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:18.446] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:53:0) after 1m0s
[01:50:18.531] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:53:0)
[01:50:18.531] Timer tick, asking Buildbucket for the build status
[01:50:18.694] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:18.694] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:54:0) after 1m0s
[01:51:18.866] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:54:0)
[01:51:18.866] Timer tick, asking Buildbucket for the build status
[01:51:18.946] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:18.946] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:55:0) after 1m0s
[01:52:19.055] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:55:0)
[01:52:19.055] Timer tick, asking Buildbucket for the build status
[01:52:19.124] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:19.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:56:0) after 1m0s
[01:53:19.153] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:56:0)
[01:53:19.153] Timer tick, asking Buildbucket for the build status
[01:53:19.259] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:19.259] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:57:0) after 1m0s
[01:54:19.343] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:57:0)
[01:54:19.343] Timer tick, asking Buildbucket for the build status
[01:54:19.685] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:19.685] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:58:0) after 1m0s
[01:55:19.783] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:58:0)
[01:55:19.783] Timer tick, asking Buildbucket for the build status
[01:55:19.860] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:19.860] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:59:0) after 1m0s
[01:56:19.885] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:59:0)
[01:56:19.885] Timer tick, asking Buildbucket for the build status
[01:56:20.274] Build 8864785536050124832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:20.274] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030215598329138880:60:0) after 1m0s
[01:56:50.503] Received PubSub notification, asking Buildbucket for the build status
[01:56:50.571] Build 8864785536050124832: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:56:50.571] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604282200420725",
"created_by": "project:chromium",
"created_ts": "1604278736027659",
"id": "8864785536050124832",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"99c85930f1456a64cae940bbc01b1fd0aca0e6b4\"}}",
"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\": \"99c85930f1456a64cae940bbc01b1fd0aca0e6b4\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-win10-us-central1-b-32-0-cki8\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15403, \"clang_revision\": \"llvmorg-12-init-5627-gf086e85e-2\", \"got_angle_revision\": \"068bb086e1c844161c18185a9110f9588f5b6e8a\", \"got_dawn_revision\": \"0a374dce665328391ab3b68fd9e667b018dd9dcd\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"99c85930f1456a64cae940bbc01b1fd0aca0e6b4\", \"got_revision_cp\": \"refs/heads/master@{#823039}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"e0de282e678b72dac25b81f8d25305231aec01f8\", \"got_v8_revision\": \"69c856dc816ff1dd65fcc536095b44399a7434b9\", \"got_v8_revision_cp\": \"refs/heads/8.8.214@{#1}\", \"got_webrtc_revision\": \"ee24eb66d23ffea5ef729dc340e1fc4381c72a4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32507}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"99c85930f1456a64cae940bbc01b1fd0aca0e6b4\", \"swarm_hashes_refs/heads/master(at){#823039}_without_patch\": {\"absl_hardening_tests\": \"d5a86944f2a750fb455a9a2699620e68bdd97190\", \"accessibility_unittests\": \"72cffc1abea1fc7c6e6a1cf3695c370a65c957f7\", \"angle_unittests\": \"93d666cacde050d6d11937c7c9a60a4141874ae2\", \"app_shell_unittests\": \"4aece4419de744d2982aff3c6ee9aeeaa76aab88\", \"aura_unittests\": \"22b5f5544874ec9f01fd18cf33e221a8e387b490\", \"base_unittests\": \"dff8dc06b5c39f36d1f7122678558135b60c9fdf\", \"base_util_unittests\": \"5ebd7ae8e2bf642902d1e8348fb5b7c271f5c80e\", \"blink_common_unittests\": \"edeb7a56571adc8b608dae88a517cf0fe5fd5fd0\", \"blink_fuzzer_unittests\": \"82409ae9e9e47aa7bafac3522f887238157acded\", \"blink_heap_unittests\": \"04dbf5fd1613e9b9ccce61cffe62a3865548c3ac\", \"blink_platform_unittests\": \"bd7c9e695b6a7362f107df7b2ec2fa8a673f0b5a\", \"blink_unittests\": \"c7f4184929036efbd63ca7bb2a6226bd64b09989\", \"boringssl_crypto_tests\": \"88cbfece12d9cb6fc9b8ac4db1e012d8775d31a2\", \"boringssl_ssl_tests\": \"bd1f7c2582a548a6144caa5ea57061db5d3159d5\", \"browser_switcher_bho_unittests\": \"1ed50446122794a2fa7b2c38f63f8972cffd5b8c\", \"browser_tests\": \"ba369828b6f16b97e6a027f31ee51604983228cd\", \"capture_unittests\": \"aefec2cc287c0a8c9cfdb3b79c2bfc67be208048\", \"cast_unittests\": \"b40284231802bc22ed1d3c032518981425673702\", \"cc_unittests\": \"b087bd03bebc401c160c824d3e3618b2ebc5f53d\", \"chrome_app_unittests\": \"b60d048c56cb1f8513d58094c7c72c5d3d0d9283\", \"chrome_cleaner_unittests\": \"1e0dedf30aeeeb53cb847f1cc601614763dacbae\", \"chrome_elf_unittests\": \"80d38deb5974344437c1cff766690f936ced5235\", \"chromedriver_unittests\": \"cae9245eb81928f55369d3684ab9a454b40e327d\", \"components_browsertests\": \"0dfa628befe7648ece9164c128c4b355e9996faa\", \"components_unittests\": \"d18e2845b3bd67ca76b634d00dc634a7c646bf4f\", \"compositor_unittests\": \"306ed677a6cca419816463f282cb65a69b23394b\", \"content_browsertests\": \"9ad0d4d5a52b9b2df403f1569d185a3f5da453e7\", \"content_unittests\": \"60d388b3a71b7226e6ba2660d7e5ef5c30b6e627\", \"courgette_unittests\": \"7d13ee8c04571136cc677c437e6d5ca9b3b07f6f\", \"crashpad_tests\": \"7d50ff645dde37d0f12477bec3b0ebc2ff9c6556\", \"cronet_tests\": \"a183f9d7ded73f7a8bbc7cad14b41e6ff315b9ef\", \"cronet_unittests\": \"411a97a8517d964f06e73ed4324b120669f909d3\", \"crypto_unittests\": \"6719b0c5b489d31b48daea1b5cdbee159cda404f\", \"delayloads_unittests\": \"8af210ea5a91191932530fc357dc36add87ab50b\", \"device_unittests\": \"9648ec453e7831de55d98da699f3dff76659c80d\", \"display_unittests\": \"48e36a521c81286942c8f880fef43a49e6ba4777\", \"elevation_service_unittests\": \"5039cb41f9d73bad9ea256a01d69cb585ec738d3\", \"events_unittests\": \"22b921ce9b5897ce4d70fbdfc4910c911e0c6914\", \"extensions_browsertests\": \"8846b42307ab272c92f613c6e26925af15b01ca0\", \"extensions_unittests\": \"3d2c12833ec8ecb1aab5b66e8e031154335c1999\", \"filesystem_service_unittests\": \"9c374d29a56855ec6ae163f0029e24a70d410591\", \"gcm_unit_tests\": \"c00762cd44e886fce30c449d32b8b2f37718a339\", \"gcp_unittests\": \"ed457912b5a3d719549926fa7f022ecc3fbf0843\", \"gfx_unittests\": \"d2d4df179d9a365f6eb0e3472b195eafcd6c19eb\", \"gin_unittests\": \"423efac58365bece43917c4d0cfdb4ab20899643\", \"google_apis_unittests\": \"774d50de00f1a2be2c513ebacea21ba3260ad53f\", \"gpu_unittests\": \"723d615613fb7da56f490eb204c2939ed2a68b9c\", \"gwp_asan_unittests\": \"38a832f8d8d57c9f0f126591410bd172beca474d\", \"headless_browsertests\": \"7493437096b3af6b811525fd8b13faade75689f8\", \"headless_unittests\": \"2f6e814bced4353a4c95e4f0488e1d119fca2fba\", \"install_static_unittests\": \"de9a576147d9ad241be3643d31a22b1cedac0913\", \"installer_util_unittests\": \"825103d7753a3ab7d06e2d2a6732a0b328a82533\", \"interactive_ui_tests\": \"d715ace590c804c14b378a7919af770e0a861f21\", \"ipc_tests\": \"89c1e1a2defac9d10303eb6380faaf4317215cec\", \"jingle_unittests\": \"1b75afbc7f281355562f5a6323060ba650b6b74b\", \"latency_unittests\": \"3606d3a957c7d7c3a6615288d727cf0146aba7f5\", \"libjingle_xmpp_unittests\": \"1b08636bc77c9f7b7932280b93f38f72c7560990\", \"liburlpattern_unittests\": \"9be2c250e7759e35a7fb76719aee63f52d108561\", \"media_blink_unittests\": \"b769c2a9a3357e143be3f4d156936949b80d5626\", \"media_unittests\": \"c77d9cd4cd0ebaf1d288dc2a660b5579dcd0dd1e\", \"message_center_unittests\": \"4083f28d1582e4b95ed4093c87f7f90f0852abd4\", \"midi_unittests\": \"19354b633ba0b200533e147034938a8d14948e36\", \"mojo_core_unittests\": \"e48c911080a6f5f560be8c1afea807a97a9275b0\", \"mojo_unittests\": \"8dc3bdb064a44ffb811a701707785554837fb4d4\", \"nacl_loader_unittests\": \"8eb8fb43c2e8af3509fe798a7bbab2052b8f57da\", \"native_theme_unittests\": \"5733d8be35da31eb4d371c5520cb706e8e0bb722\", \"net_unittests\": \"f25a0ab68735471605bc807c379e10ade0cf2b3b\", \"notification_helper_unittests\": \"c35f1b96de3525710bf5ad63f1b9aa78abfcd596\", \"pdf_unittests\": \"07c52506d9a1496e38d5e3e4d7d4c521d248cc62\", \"perfetto_unittests\": \"c95d5f0a9c3aa8a18b77d8ad5835e9a6b6f25c35\", \"ppapi_unittests\": \"4f1274e8e05025143d5cfa5702e624e54ea88ec4\", \"printing_unittests\": \"abd9bd087067c33cc8fe979704075e1119e8a0ef\", \"remoting_unittests\": \"fe3a0015739f4b76d0385f7769062576e7dfbd96\", \"sbox_integration_tests\": \"dbceea529608fd7babb570c35b15b1cbfb279d3c\", \"sbox_unittests\": \"b80b87758729672cffa9968eeb2c811496263cea\", \"sbox_validation_tests\": \"6769eb943f975f2910eab84bf63d18e826b46922\", \"service_manager_unittests\": \"ca742b4aa128b4f28bfa12a5c3fd0b9646900466\", \"services_unittests\": \"d0c20115244df10cd0355fba47f8749c542e4df5\", \"setup_unittests\": \"9207f9e46b53eb0ebf306b37f7eb0e70365687e7\", \"shell_dialogs_unittests\": \"160dddc44de97d532bddc8160fa22c50a0f281e7\", \"skia_unittests\": \"d9e0b36aeb1a6d5f1866db2fd0fa7a74e78343b0\", \"snapshot_unittests\": \"10ef7e141faab99101ef235e8d77eacd975e36ec\", \"sql_unittests\": \"37c52cd19638482955dd59cf4266d5d6cdb033e9\", \"storage_unittests\": \"f4164e6124a211926e3701a8979a889bed3cacae\", \"sync_integration_tests\": \"af4dfcd04d8541e01801bdea3a6aac498b8892a6\", \"traffic_annotation_auditor_unittests\": \"e883d2bab0d1d91bbc5b9d0e45555c915e32a196\", \"ui_base_unittests\": \"b55d1f5a6a59d8061c83d525521016f53d6ee0c8\", \"ui_touch_selection_unittests\": \"0d2df7cb3c662092aaab7d114e2ec1914713a303\", \"unit_tests\": \"f584a98a69b4d944e96d8dd4316f6757c7a68b1a\", \"updater_tests\": \"b8cdbc3963958ad59add711d294bfc3c2e11b456\", \"url_unittests\": \"bc76fda48236d5e774c3f008f91b448da7e31413\", \"views_unittests\": \"8e04441492424a2a0ff07fe76b2486d48972d9c4\", \"viz_unittests\": \"b329c616938ab277e46d362f3a37d2436c4b1bef\", \"vr_common_unittests\": \"4137f4dbca6ab0dd21f85d75a4544de84cf56001\", \"vr_pixeltests\": \"6af26f4a4f999c0f539c6f0df6716d1dba24ad80\", \"weblayer_browsertests\": \"8f7cb12f7483d592defa1a34c3eefb2a0d5c4ce6\", \"weblayer_unittests\": \"bcfa94f88f802a09034c40ba9daf595f058b4c38\", \"wm_unittests\": \"02ee4d7b3b00733a7f636a3206e17bcf9952ac7a\", \"wtf_unittests\": \"a805f0b7292e7e3ed1bd827646823cecc684c247\", \"zlib_unittests\": \"68dcde7ea2dc3f534e393188e9561c32ecd644c8\", \"zucchini_unittests\": \"944d862ac9b593887a7d63a508f6d5ea9e14c8e6\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_ba2591630e3c492a7f8bed019e3d41c3ae1f8879793a1bf71c3be1367a2696d6_v2\", \"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-us-central1-b-32-0-cki8\"], \"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\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604278739528769",
"status": "COMPLETED",
"status_changed_ts": "1604282200700098",
"tags": [
"build_address:luci.chromium.ci/win-asan/15403",
"builder:win-asan",
"buildset:commit/git/99c85930f1456a64cae940bbc01b1fd0aca0e6b4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/99c85930f1456a64cae940bbc01b1fd0aca0e6b4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030215598329138880",
"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/8864785536050124832/+/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:4f9f486070ae9410",
"user_agent:luci-scheduler"
],
"updated_ts": "1604282200716447",
"url": "https://ci.chromium.org/b/8864785536050124832",
"utcnow_ts": "1604282210562210"
}
}
[01:56:50.571] Invocation finished in 57m56.101167307s with status SUCCEEDED