[15:47:56.272] New invocation is queued and will start shortly
[15:47:57.353] Starting the invocation (attempt 1)
[15:47:57.412] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:47:57.412] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:47:57.412] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021734147552998192",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"0b8454f2ce450c42174b4705ea3f9e8e9534ddde\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9021734147552998192",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/0b8454f2ce450c42174b4705ea3f9e8e9534ddde",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0b8454f2ce450c42174b4705ea3f9e8e9534ddde",
"gitiles_ref:refs/heads/master"
]
}
[15:48:00.293] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612367277639045",
"id": "8856304085440212624",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0b8454f2ce450c42174b4705ea3f9e8e9534ddde\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612367279407567",
"tags": [
"build_address:luci.chromium.ci/win-asan/17150",
"builder:win-asan",
"buildset:commit/git/0b8454f2ce450c42174b4705ea3f9e8e9534ddde",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0b8454f2ce450c42174b4705ea3f9e8e9534ddde",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021734147552998192",
"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/8856304085440212624/+/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": "1612367279409648",
"url": "https://ci.chromium.org/b/8856304085440212624",
"utcnow_ts": "1612367279976554"
}
}
[15:48:00.293] Task URL: https://ci.chromium.org/b/8856304085440212624
[15:48:00.293] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:2:0) after 1m0s
[15:48:02.993] Received PubSub notification, asking Buildbucket for the build status
[15:48:03.623] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:00.403] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:2:0)
[15:49:00.404] Timer tick, asking Buildbucket for the build status
[15:49:00.555] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:00.555] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:4:0) after 1m0s
[15:50:01.113] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:4:0)
[15:50:01.113] Timer tick, asking Buildbucket for the build status
[15:50:01.335] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:01.335] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:5:0) after 1m0s
[15:51:01.981] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:5:0)
[15:51:01.981] Timer tick, asking Buildbucket for the build status
[15:51:02.466] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:02.466] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:6:0) after 1m0s
[15:52:02.650] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:6:0)
[15:52:02.650] Timer tick, asking Buildbucket for the build status
[15:52:02.754] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:02.754] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:7:0) after 1m0s
[15:53:02.916] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:7:0)
[15:53:02.916] Timer tick, asking Buildbucket for the build status
[15:53:03.344] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:03.344] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:8:0) after 1m0s
[15:54:03.395] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:8:0)
[15:54:03.395] Timer tick, asking Buildbucket for the build status
[15:54:03.493] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:03.493] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:9:0) after 1m0s
[15:55:03.533] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:9:0)
[15:55:03.533] Timer tick, asking Buildbucket for the build status
[15:55:03.999] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:03.999] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:10:0) after 1m0s
[15:56:04.135] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:10:0)
[15:56:04.135] Timer tick, asking Buildbucket for the build status
[15:56:04.278] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:04.278] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:11:0) after 1m0s
[15:57:04.335] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:11:0)
[15:57:04.335] Timer tick, asking Buildbucket for the build status
[15:57:04.451] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:04.451] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:12:0) after 1m0s
[15:58:04.480] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:12:0)
[15:58:04.480] Timer tick, asking Buildbucket for the build status
[15:58:04.586] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:04.586] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:13:0) after 1m0s
[15:59:04.635] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:13:0)
[15:59:04.635] Timer tick, asking Buildbucket for the build status
[15:59:04.723] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:04.723] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:14:0) after 1m0s
[16:00:04.820] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:14:0)
[16:00:04.820] Timer tick, asking Buildbucket for the build status
[16:00:04.939] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:04.939] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:15:0) after 1m0s
[16:01:05.226] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:15:0)
[16:01:05.226] Timer tick, asking Buildbucket for the build status
[16:01:05.501] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:05.501] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:16:0) after 1m0s
[16:02:05.553] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:16:0)
[16:02:05.553] Timer tick, asking Buildbucket for the build status
[16:02:05.631] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:05.631] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:17:0) after 1m0s
[16:03:05.653] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:17:0)
[16:03:05.653] Timer tick, asking Buildbucket for the build status
[16:03:05.762] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:05.762] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:18:0) after 1m0s
[16:04:05.808] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:18:0)
[16:04:05.808] Timer tick, asking Buildbucket for the build status
[16:04:05.935] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:05.936] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:19:0) after 1m0s
[16:05:05.941] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:19:0)
[16:05:05.941] Timer tick, asking Buildbucket for the build status
[16:05:06.035] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:06.035] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:20:0) after 1m0s
[16:06:06.099] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:20:0)
[16:06:06.099] Timer tick, asking Buildbucket for the build status
[16:06:06.368] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:06.368] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:21:0) after 1m0s
[16:07:06.376] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:21:0)
[16:07:06.376] Timer tick, asking Buildbucket for the build status
[16:07:06.489] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:06.489] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:22:0) after 1m0s
[16:08:06.567] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:22:0)
[16:08:06.567] Timer tick, asking Buildbucket for the build status
[16:08:06.691] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:06.691] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:23:0) after 1m0s
[16:09:06.772] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:23:0)
[16:09:06.772] Timer tick, asking Buildbucket for the build status
[16:09:07.067] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:07.067] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:24:0) after 1m0s
[16:10:07.092] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:24:0)
[16:10:07.092] Timer tick, asking Buildbucket for the build status
[16:10:07.816] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:07.816] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:25:0) after 1m0s
[16:11:07.933] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:25:0)
[16:11:07.933] Timer tick, asking Buildbucket for the build status
[16:11:08.046] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:08.047] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:26:0) after 1m0s
[16:12:08.117] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:26:0)
[16:12:08.117] Timer tick, asking Buildbucket for the build status
[16:12:08.739] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:08.739] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:27:0) after 1m0s
[16:13:08.736] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:27:0)
[16:13:08.736] Timer tick, asking Buildbucket for the build status
[16:13:08.846] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:08.846] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:28:0) after 1m0s
[16:14:08.916] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:28:0)
[16:14:08.916] Timer tick, asking Buildbucket for the build status
[16:14:09.452] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:09.452] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:29:0) after 1m0s
[16:15:09.602] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:29:0)
[16:15:09.602] Timer tick, asking Buildbucket for the build status
[16:15:09.857] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:09.857] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:30:0) after 1m0s
[16:16:09.914] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:30:0)
[16:16:09.914] Timer tick, asking Buildbucket for the build status
[16:16:10.035] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:10.036] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:31:0) after 1m0s
[16:17:10.145] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:31:0)
[16:17:10.145] Timer tick, asking Buildbucket for the build status
[16:17:10.452] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:10.452] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:32:0) after 1m0s
[16:18:10.500] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:32:0)
[16:18:10.500] Timer tick, asking Buildbucket for the build status
[16:18:10.717] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:10.717] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:33:0) after 1m0s
[16:19:10.882] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:33:0)
[16:19:10.882] Timer tick, asking Buildbucket for the build status
[16:19:11.003] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:11.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:34:0) after 1m0s
[16:20:11.053] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:34:0)
[16:20:11.053] Timer tick, asking Buildbucket for the build status
[16:20:11.215] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:11.215] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:35:0) after 1m0s
[16:21:11.240] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:35:0)
[16:21:11.240] Timer tick, asking Buildbucket for the build status
[16:21:11.386] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:11.386] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:36:0) after 1m0s
[16:22:11.443] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:36:0)
[16:22:11.443] Timer tick, asking Buildbucket for the build status
[16:22:11.843] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:11.843] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:37:0) after 1m0s
[16:23:11.958] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:37:0)
[16:23:11.958] Timer tick, asking Buildbucket for the build status
[16:23:12.082] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:12.082] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:38:0) after 1m0s
[16:24:12.239] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:38:0)
[16:24:12.239] Timer tick, asking Buildbucket for the build status
[16:24:12.325] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:12.325] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:39:0) after 1m0s
[16:25:12.381] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:39:0)
[16:25:12.381] Timer tick, asking Buildbucket for the build status
[16:25:12.699] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:12.699] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:40:0) after 1m0s
[16:26:12.787] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:40:0)
[16:26:12.787] Timer tick, asking Buildbucket for the build status
[16:26:12.887] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:12.887] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:41:0) after 1m0s
[16:27:12.971] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:41:0)
[16:27:12.971] Timer tick, asking Buildbucket for the build status
[16:27:13.071] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:13.071] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:42:0) after 1m0s
[16:28:13.162] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:42:0)
[16:28:13.162] Timer tick, asking Buildbucket for the build status
[16:28:13.269] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:13.269] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:43:0) after 1m0s
[16:29:13.326] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:43:0)
[16:29:13.326] Timer tick, asking Buildbucket for the build status
[16:29:13.398] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:13.398] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:44:0) after 1m0s
[16:30:13.803] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:44:0)
[16:30:13.803] Timer tick, asking Buildbucket for the build status
[16:30:13.993] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:13.993] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:45:0) after 1m0s
[16:31:14.153] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:45:0)
[16:31:14.153] Timer tick, asking Buildbucket for the build status
[16:31:14.287] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:14.287] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:46:0) after 1m0s
[16:32:14.380] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:46:0)
[16:32:14.380] Timer tick, asking Buildbucket for the build status
[16:32:14.466] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:14.466] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:47:0) after 1m0s
[16:33:14.578] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:47:0)
[16:33:14.578] Timer tick, asking Buildbucket for the build status
[16:33:14.696] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:14.696] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:48:0) after 1m0s
[16:34:14.839] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:48:0)
[16:34:14.839] Timer tick, asking Buildbucket for the build status
[16:34:14.953] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:14.953] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:49:0) after 1m0s
[16:35:14.995] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:49:0)
[16:35:14.995] Timer tick, asking Buildbucket for the build status
[16:35:15.285] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:15.285] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:50:0) after 1m0s
[16:36:15.310] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:50:0)
[16:36:15.310] Timer tick, asking Buildbucket for the build status
[16:36:15.393] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:15.393] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:51:0) after 1m0s
[16:37:15.436] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:51:0)
[16:37:15.436] Timer tick, asking Buildbucket for the build status
[16:37:15.732] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:15.732] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:52:0) after 1m0s
[16:38:15.889] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:52:0)
[16:38:15.889] Timer tick, asking Buildbucket for the build status
[16:38:16.023] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:16.023] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:53:0) after 1m0s
[16:39:16.203] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:53:0)
[16:39:16.203] Timer tick, asking Buildbucket for the build status
[16:39:16.323] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:16.323] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:54:0) after 1m0s
[16:40:16.429] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:54:0)
[16:40:16.429] Timer tick, asking Buildbucket for the build status
[16:40:16.608] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:16.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:55:0) after 1m0s
[16:41:16.632] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:55:0)
[16:41:16.632] Timer tick, asking Buildbucket for the build status
[16:41:16.707] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:16.707] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:56:0) after 1m0s
[16:42:16.726] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:56:0)
[16:42:16.726] Timer tick, asking Buildbucket for the build status
[16:42:16.805] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:16.805] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:57:0) after 1m0s
[16:43:16.941] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:57:0)
[16:43:16.942] Timer tick, asking Buildbucket for the build status
[16:43:17.083] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:17.083] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:58:0) after 1m0s
[16:44:17.157] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:58:0)
[16:44:17.157] Timer tick, asking Buildbucket for the build status
[16:44:17.811] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:17.811] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:59:0) after 1m0s
[16:45:17.835] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:59:0)
[16:45:17.835] Timer tick, asking Buildbucket for the build status
[16:45:17.910] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:17.910] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:60:0) after 1m0s
[16:46:17.978] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:60:0)
[16:46:17.978] Timer tick, asking Buildbucket for the build status
[16:46:18.122] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:18.122] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:61:0) after 1m0s
[16:47:18.227] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:61:0)
[16:47:18.227] Timer tick, asking Buildbucket for the build status
[16:47:18.305] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:18.305] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:62:0) after 1m0s
[16:48:18.397] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:62:0)
[16:48:18.397] Timer tick, asking Buildbucket for the build status
[16:48:18.730] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:18.730] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:63:0) after 1m0s
[16:49:18.855] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:63:0)
[16:49:18.855] Timer tick, asking Buildbucket for the build status
[16:49:18.940] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:18.940] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:64:0) after 1m0s
[16:50:19.024] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:64:0)
[16:50:19.024] Timer tick, asking Buildbucket for the build status
[16:50:19.239] Build 8856304085440212624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:19.239] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:65:0) after 1m0s
[16:51:19.282] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021734147552998192:65:0)
[16:51:19.282] Timer tick, asking Buildbucket for the build status
[16:51:19.433] Build 8856304085440212624: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:51:19.433] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612371077883910",
"created_by": "project:chromium",
"created_ts": "1612367277639045",
"id": "8856304085440212624",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0b8454f2ce450c42174b4705ea3f9e8e9534ddde\"}}",
"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\": \"0b8454f2ce450c42174b4705ea3f9e8e9534ddde\", \"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-0-be5b\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17150, \"clang_revision\": \"llvmorg-12-init-17251-g6de48655-1\", \"got_angle_revision\": \"2e54a1e7fc49e1c1c659d7be659b832954112106\", \"got_dawn_revision\": \"fd5fd05db039710c797ee8bac5e6d999173e5fc3\", \"got_nacl_revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\", \"got_revision\": \"0b8454f2ce450c42174b4705ea3f9e8e9534ddde\", \"got_revision_cp\": \"refs/heads/master@{#850123}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"14dcbed947ce755af1fcbfb3ba8e643b4e769860\", \"got_v8_revision\": \"53720ace941d84ac17ae67a94166a363dcf0cacf\", \"got_v8_revision_cp\": \"refs/heads/9.0.123@{#1}\", \"got_webrtc_revision\": \"e7c79fd3d66e0f6c54c027f880a8b1682ebae58a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33124}\", \"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\": \"0b8454f2ce450c42174b4705ea3f9e8e9534ddde\", \"swarm_hashes_refs/heads/master(at){#850123}_without_patch\": {\"absl_hardening_tests\": \"ef0f0cae7e28001006a2443cec323a7d24a8a4e8\", \"accessibility_unittests\": \"6e9a9e0a3e01d4187d0950ce9908fcca9d029f03\", \"angle_unittests\": \"0334848c4f1cb9f97180ddc91da1a49b7b746e6d\", \"app_shell_unittests\": \"ada6c14064708bee57c0eea7810d544fa662dbf9\", \"aura_unittests\": \"d647c444ad49bf70d048b3fbad114f37982d543d\", \"base_unittests\": \"8fe8110750397c2c6fae1444bb07f4179bf92e8d\", \"base_util_unittests\": \"d9c740eaf7e7c6048b3a0bf5a289f266fb26845d\", \"blink_common_unittests\": \"4eb93807c53219fd103beaefe157f98abdebdd31\", \"blink_fuzzer_unittests\": \"bc6397782a18082de5668996284ba463c19ede18\", \"blink_heap_unittests\": \"ec056030727e2780c7da3ec2d46ac8a953311b7a\", \"blink_platform_unittests\": \"cb0e6208129ed8056f63e48345eb27853821c1b0\", \"blink_unittests\": \"8c6edbd7515270e5870c2eb0bb70967a7778fd97\", \"boringssl_crypto_tests\": \"cb4ab8d3aa503d1cf9849357cd9ba463daddb12c\", \"boringssl_ssl_tests\": \"bf53ed4d3dd905a6eec6811075e10c11b2c4bd0a\", \"browser_switcher_bho_unittests\": \"895382379f79d1b8bb4a82c67d1b006ed4cb183b\", \"browser_tests\": \"139c401da4a1e5a5de1eb38f1a606755584ff133\", \"capture_unittests\": \"faace51a3773e53c1feb799a0ff441d90bd168f7\", \"cast_unittests\": \"f33d7bb043faf1b6b7d0f7c10ead400600ecbeb2\", \"cc_unittests\": \"badeb38f19857f3939737cce84cfeb83ee0bc7f7\", \"chrome_app_unittests\": \"d350c1b6336aa63f85f8dde3de489c4059a31dc1\", \"chrome_cleaner_unittests\": \"fa172a3af9ff0be6dd96ad7f4e06ef10efaa2165\", \"chrome_elf_unittests\": \"2ec767ba7d902c5c079a2854e2fb5ccba7b224b4\", \"chromedriver_unittests\": \"03669f7dd9e995bd89502666eb748fd5670f54ad\", \"components_browsertests\": \"4a84c4ba9d6c1f9db78062aa8887235628147980\", \"components_unittests\": \"cf7857b747d8776c575d1213de5b5298be689638\", \"compositor_unittests\": \"79e50d04733d2b556078499485b5fd88ab8cde69\", \"content_browsertests\": \"1bb860b082262416ece4437f13cd391cfcb7e22f\", \"content_unittests\": \"3d7875cd7903cba9a15d469de0d7809d4183be97\", \"courgette_unittests\": \"06c99485e43463543152fc4491f30df936287b94\", \"crashpad_tests\": \"4c4a59fa5c52a6675a238ae6209f535b123acfc8\", \"cronet_tests\": \"45d342ec29f7424b4f03ef91f9ac3906e4b0bc28\", \"cronet_unittests\": \"275b4c913aa4471a0e0ceab3ad6c75739bf03320\", \"crypto_unittests\": \"e5fc234e041d0cb32f779233b2c3e67e2f083c12\", \"delayloads_unittests\": \"c059327b596fbb5c8fa7bbdeb1aae4d9579234c7\", \"device_unittests\": \"f99f87d00063159e07f08b3b9ef002d65028d659\", \"display_unittests\": \"09d64d8e230d0b2b9e0c173c321a341312a0ffec\", \"elevation_service_unittests\": \"cb50c966950a5a78b02732d6d8e6e8de4b7073cc\", \"events_unittests\": \"5d316483309d3c356af9b6d94ee4e311bf0b5ff7\", \"extensions_browsertests\": \"f50806d94cff6cf13253f7c25cd481e3f851c8d7\", \"extensions_unittests\": \"3562c9995f29fe418c7367aa7847bd6b594292b4\", \"filesystem_service_unittests\": \"ed7031f729fffd3567046db54a3362f414c7283b\", \"gcm_unit_tests\": \"4466c524108a4419112543bc2e20b57e6db21934\", \"gcp_unittests\": \"e7a12846b24a999e6bfee13d6ecc4625fe5dff60\", \"gfx_unittests\": \"ede3c6679659c6dbfb8086bf0031e87652501f0b\", \"gin_unittests\": \"38e77e059184d89dfaa20982d4fb55d8cea3bc83\", \"google_apis_unittests\": \"946cdc0f9e598a3cc3c4d4697b080b48b49a2662\", \"gpu_unittests\": \"341ebb50120cbd508a4fa64d30ab019e2b9b16f4\", \"gwp_asan_unittests\": \"2b6651f2b5ea6163ef11e13d88fe428b0cbc29ee\", \"headless_browsertests\": \"3922f77cf212288113cbe2ad0c0c039a49c1df16\", \"headless_unittests\": \"ee2ffa164918347f4568f31cda8f63bee9bfb486\", \"install_static_unittests\": \"6fb847eaf6ccc6c46183ba64fc38624fe20e059c\", \"installer_util_unittests\": \"2038698c06fcd40f089e6c607aca9d7d257a15c5\", \"interactive_ui_tests\": \"05471c4e7611c83565e1a11a01a49a9337cf244c\", \"ipc_tests\": \"e583722c5faa944461304e7cd2ff9c66bba4f0b2\", \"jingle_unittests\": \"9db98cdc4bb581387a2cb0282f63c4cfdc3c5c9c\", \"latency_unittests\": \"68f25751f9691946b5e13ee935aa3c091edf58aa\", \"libjingle_xmpp_unittests\": \"90b8be5ee803631065db1ca1c9d16289ecf1a945\", \"liburlpattern_unittests\": \"4096642b1adba5dac7408bbf5a351d5b34fb255c\", \"media_blink_unittests\": \"100ce42e7333f9fbbe5d038dad1b66f64ef8f31c\", \"media_unittests\": \"8d29c2838cc183e84b7454c7d9ed6d87d4785af4\", \"message_center_unittests\": \"53a95e1eef55a1b8fbafc7962b3473ce45668bd5\", \"midi_unittests\": \"ab37c98b0fdd5a4c6e350f767eed919798b891bd\", \"mojo_core_unittests\": \"d6f5fddefab74ef862c799a5fe287f873c0371da\", \"mojo_unittests\": \"1b5329e81960a3ffab624370d217883a41a2bb42\", \"nacl_loader_unittests\": \"8d0ccdc24834af4fc107c52c9dab23bb149306f2\", \"native_theme_unittests\": \"bc3ff9d1d93c8bf3a1e227cf62284e8dcc559517\", \"net_unittests\": \"1e68d1e3a0979eb6360d97b9f0d7103b8ed0dcb2\", \"notification_helper_unittests\": \"9fa1c3b0f46028c25b5baf4b3e3027f5751fad90\", \"pdf_unittests\": \"9c22a7e64ccb9c9359bc650792d26e89768e2700\", \"perfetto_unittests\": \"964e9ec93e61bc86c4b2b62fff0b0712e188bec7\", \"ppapi_unittests\": \"49850e0622d53a68fb17cb37e622c949f3428379\", \"printing_unittests\": \"c6f75080df40242293075030d4d05ed044834789\", \"remoting_unittests\": \"5824c876672edf98c29c56d9af10f743bc249fe3\", \"sbox_integration_tests\": \"8375df4cb3fbda329af263122143e9a807b50409\", \"sbox_unittests\": \"cef2d797f9e90ad27e522621bf68a22c2fb7db3b\", \"sbox_validation_tests\": \"f4587c8b5479278cfa3d0944391b5080c5ad3ea3\", \"service_manager_unittests\": \"173c68e49c131668772c34d453b05efd58821a7e\", \"services_unittests\": \"6587c59692fc5998d81fa46f9fe3c8afc313ce3c\", \"setup_unittests\": \"97a93cbf30481681de3979aa934d8c9d67d25f31\", \"shell_dialogs_unittests\": \"49c9ccd20b7baae3748f4ef67ff842b23d44df25\", \"skia_unittests\": \"48e09d1cfaf203b0d7c02468b560deea2ebd31e0\", \"snapshot_unittests\": \"59a07c180822d0309acfbddddca9f8cb26251def\", \"sql_unittests\": \"9e1e10669dda097c5f6f126ad2a98998bd3b627c\", \"storage_unittests\": \"f69f7ccc0df767b9ac90f2107a513247c513c888\", \"sync_integration_tests\": \"3818f545fe427d55a1b76f065e737d48f87bc0ad\", \"traffic_annotation_auditor_unittests\": \"001d4bedd253c0b5630b8916a79cbdd6f6f89f98\", \"ui_base_unittests\": \"4642cb5a15def06430b9f293c87d5646a6cd69e4\", \"ui_touch_selection_unittests\": \"a1531f795ce3ab366f15c34d631c53ae0e265c18\", \"unit_tests\": \"c503d262318f3410b3aaa04992877a65aa85f6b3\", \"updater_tests\": \"2b0d463bced4a421f9eef1f282a38de0dded63d6\", \"url_unittests\": \"662f2ee333d2a1da15423b9652d930471a519b11\", \"views_unittests\": \"d4a795bb635e6c6299a7ccd76369b2cf1fa88356\", \"viz_unittests\": \"d165258ed766e4a2aba27b5a72de4afbedf6b785\", \"vr_common_unittests\": \"46f4ba175410aa306fedec156533470d7d28ec9c\", \"vr_pixeltests\": \"e0754d31fc65fa077124d80b24667a87ae6a8964\", \"weblayer_browsertests\": \"90d15a070106668ffd53aae0d9377c8f9aa9cb91\", \"weblayer_unittests\": \"06ab9f75ba7fb2b64fe4bc11501a2298fa032668\", \"wm_unittests\": \"39fb13b49ec65f13f3915bb19323ee934677d082\", \"wtf_unittests\": \"16e7bb8ae30d065c117e93e67b9579c718af3f9d\", \"zlib_unittests\": \"9029971070ef5d8a2b031544a1208b8a3c525f65\", \"zucchini_unittests\": \"603e16d24f2aa87cb99e7c2e5c7f08a04de8d130\"}}, \"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-0-be5b\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5676-c76598c\"], \"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": "1612367281648562",
"status": "COMPLETED",
"status_changed_ts": "1612371078152656",
"tags": [
"build_address:luci.chromium.ci/win-asan/17150",
"builder:win-asan",
"buildset:commit/git/0b8454f2ce450c42174b4705ea3f9e8e9534ddde",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0b8454f2ce450c42174b4705ea3f9e8e9534ddde",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021734147552998192",
"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/8856304085440212624/+/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:518165c15c14f810",
"user_agent:luci-scheduler"
],
"updated_ts": "1612371078157007",
"url": "https://ci.chromium.org/b/8856304085440212624",
"utcnow_ts": "1612371079420466"
}
}
[16:51:19.433] Invocation finished in 1h3m23.192415607s with status SUCCEEDED