[16:49:44.777] New invocation is queued and will start shortly
[16:49:47.283] Starting the invocation (attempt 1)
[16:49:47.340] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:49:47.340] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:49:47.340] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029883985870775920",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f34797ca38499634c8ac82508c4cb1944299088f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9029883985870775920",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/f34797ca38499634c8ac82508c4cb1944299088f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f34797ca38499634c8ac82508c4cb1944299088f",
"gitiles_ref:refs/heads/master"
]
}
[16:49:48.018] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604594987462851",
"id": "8864453922385796304",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f34797ca38499634c8ac82508c4cb1944299088f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604594987896648",
"tags": [
"build_address:luci.chromium.ci/win-asan/15481",
"builder:win-asan",
"buildset:commit/git/f34797ca38499634c8ac82508c4cb1944299088f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f34797ca38499634c8ac82508c4cb1944299088f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029883985870775920",
"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/8864453922385796304/+/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": "1604594987896864",
"url": "https://ci.chromium.org/b/8864453922385796304",
"utcnow_ts": "1604594988007828"
}
}
[16:49:48.018] Task URL: https://ci.chromium.org/b/8864453922385796304
[16:49:48.018] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:2:0) after 1m0s
[16:49:50.342] Received PubSub notification, asking Buildbucket for the build status
[16:49:50.434] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:48.311] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:2:0)
[16:50:48.311] Timer tick, asking Buildbucket for the build status
[16:50:48.455] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:48.455] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:4:0) after 1m0s
[16:51:48.608] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:4:0)
[16:51:48.608] Timer tick, asking Buildbucket for the build status
[16:51:48.709] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:48.710] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:5:0) after 1m0s
[16:52:48.721] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:5:0)
[16:52:48.721] Timer tick, asking Buildbucket for the build status
[16:52:49.027] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:49.027] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:6:0) after 1m0s
[16:53:49.177] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:6:0)
[16:53:49.177] Timer tick, asking Buildbucket for the build status
[16:53:49.314] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:49.314] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:7:0) after 1m0s
[16:54:49.534] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:7:0)
[16:54:49.534] Timer tick, asking Buildbucket for the build status
[16:54:49.887] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:49.887] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:8:0) after 1m0s
[16:55:49.914] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:8:0)
[16:55:49.914] Timer tick, asking Buildbucket for the build status
[16:55:49.984] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:49.984] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:9:0) after 1m0s
[16:56:50.346] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:9:0)
[16:56:50.346] Timer tick, asking Buildbucket for the build status
[16:56:50.426] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:50.426] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:10:0) after 1m0s
[16:57:50.512] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:10:0)
[16:57:50.512] Timer tick, asking Buildbucket for the build status
[16:57:50.588] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:50.588] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:11:0) after 1m0s
[16:58:50.652] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:11:0)
[16:58:50.652] Timer tick, asking Buildbucket for the build status
[16:58:50.868] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:50.868] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:12:0) after 1m0s
[16:59:51.015] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:12:0)
[16:59:51.015] Timer tick, asking Buildbucket for the build status
[16:59:51.143] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:51.143] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:13:0) after 1m0s
[17:00:51.239] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:13:0)
[17:00:51.239] Timer tick, asking Buildbucket for the build status
[17:00:51.357] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:51.357] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:14:0) after 1m0s
[17:01:51.388] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:14:0)
[17:01:51.388] Timer tick, asking Buildbucket for the build status
[17:01:51.458] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:51.458] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:15:0) after 1m0s
[17:02:51.629] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:15:0)
[17:02:51.629] Timer tick, asking Buildbucket for the build status
[17:02:51.758] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:51.758] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:16:0) after 1m0s
[17:03:51.863] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:16:0)
[17:03:51.864] Timer tick, asking Buildbucket for the build status
[17:03:55.273] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:55.273] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:17:0) after 1m0s
[17:04:55.394] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:17:0)
[17:04:55.394] Timer tick, asking Buildbucket for the build status
[17:04:55.723] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:55.723] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:18:0) after 1m0s
[17:05:55.841] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:18:0)
[17:05:55.841] Timer tick, asking Buildbucket for the build status
[17:05:56.204] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:56.204] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:19:0) after 1m0s
[17:06:56.260] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:19:0)
[17:06:56.260] Timer tick, asking Buildbucket for the build status
[17:06:56.385] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:56.385] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:20:0) after 1m0s
[17:07:56.454] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:20:0)
[17:07:56.454] Timer tick, asking Buildbucket for the build status
[17:07:56.593] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:56.593] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:21:0) after 1m0s
[17:08:57.141] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:21:0)
[17:08:57.141] Timer tick, asking Buildbucket for the build status
[17:08:57.597] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:57.597] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:22:0) after 1m0s
[17:09:57.749] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:22:0)
[17:09:57.749] Timer tick, asking Buildbucket for the build status
[17:09:58.059] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:58.059] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:23:0) after 1m0s
[17:10:58.062] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:23:0)
[17:10:58.062] Timer tick, asking Buildbucket for the build status
[17:10:58.194] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:58.194] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:24:0) after 1m0s
[17:11:58.371] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:24:0)
[17:11:58.371] Timer tick, asking Buildbucket for the build status
[17:11:58.809] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:58.809] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:25:0) after 1m0s
[17:12:58.996] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:25:0)
[17:12:58.996] Timer tick, asking Buildbucket for the build status
[17:12:59.116] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:59.116] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:26:0) after 1m0s
[17:13:59.181] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:26:0)
[17:13:59.181] Timer tick, asking Buildbucket for the build status
[17:13:59.311] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:59.311] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:27:0) after 1m0s
[17:14:59.395] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:27:0)
[17:14:59.396] Timer tick, asking Buildbucket for the build status
[17:14:59.572] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:59.572] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:28:0) after 1m0s
[17:15:59.628] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:28:0)
[17:15:59.628] Timer tick, asking Buildbucket for the build status
[17:15:59.776] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:59.776] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:29:0) after 1m0s
[17:16:59.793] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:29:0)
[17:16:59.793] Timer tick, asking Buildbucket for the build status
[17:16:59.922] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:59.922] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:30:0) after 1m0s
[17:17:59.984] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:30:0)
[17:17:59.984] Timer tick, asking Buildbucket for the build status
[17:18:00.177] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:00.177] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:31:0) after 1m0s
[17:19:00.241] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:31:0)
[17:19:00.241] Timer tick, asking Buildbucket for the build status
[17:19:00.473] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:00.473] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:32:0) after 1m0s
[17:20:01.227] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:32:0)
[17:20:01.227] Timer tick, asking Buildbucket for the build status
[17:20:01.628] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:01.628] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:33:0) after 1m0s
[17:21:01.687] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:33:0)
[17:21:01.687] Timer tick, asking Buildbucket for the build status
[17:21:01.822] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:01.822] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:34:0) after 1m0s
[17:22:01.901] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:34:0)
[17:22:01.901] Timer tick, asking Buildbucket for the build status
[17:22:02.552] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:02.552] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:35:0) after 1m0s
[17:23:02.579] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:35:0)
[17:23:02.579] Timer tick, asking Buildbucket for the build status
[17:23:03.275] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:03.275] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:36:0) after 1m0s
[17:24:03.329] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:36:0)
[17:24:03.329] Timer tick, asking Buildbucket for the build status
[17:24:03.584] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:03.584] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:37:0) after 1m0s
[17:25:03.638] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:37:0)
[17:25:03.640] Timer tick, asking Buildbucket for the build status
[17:25:04.393] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:04.393] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:38:0) after 1m0s
[17:26:04.392] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:38:0)
[17:26:04.392] Timer tick, asking Buildbucket for the build status
[17:26:04.860] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:04.860] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:39:0) after 1m0s
[17:27:04.843] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:39:0)
[17:27:04.843] Timer tick, asking Buildbucket for the build status
[17:27:05.037] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:05.037] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:40:0) after 1m0s
[17:28:05.055] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:40:0)
[17:28:05.055] Timer tick, asking Buildbucket for the build status
[17:28:05.386] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:05.386] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:41:0) after 1m0s
[17:29:05.416] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:41:0)
[17:29:05.416] Timer tick, asking Buildbucket for the build status
[17:29:05.520] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:05.520] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:42:0) after 1m0s
[17:30:05.593] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:42:0)
[17:30:05.593] Timer tick, asking Buildbucket for the build status
[17:30:05.747] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:05.747] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:43:0) after 1m0s
[17:31:05.965] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:43:0)
[17:31:05.965] Timer tick, asking Buildbucket for the build status
[17:31:06.495] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:06.495] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:44:0) after 1m0s
[17:32:06.584] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:44:0)
[17:32:06.584] Timer tick, asking Buildbucket for the build status
[17:32:06.752] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:06.752] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:45:0) after 1m0s
[17:33:06.934] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:45:0)
[17:33:06.934] Timer tick, asking Buildbucket for the build status
[17:33:07.788] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:07.788] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:46:0) after 1m0s
[17:34:07.960] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:46:0)
[17:34:07.960] Timer tick, asking Buildbucket for the build status
[17:34:08.094] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:08.094] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:47:0) after 1m0s
[17:35:08.317] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:47:0)
[17:35:08.317] Timer tick, asking Buildbucket for the build status
[17:35:08.490] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:08.490] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:48:0) after 1m0s
[17:36:08.530] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:48:0)
[17:36:08.530] Timer tick, asking Buildbucket for the build status
[17:36:08.687] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:08.687] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:49:0) after 1m0s
[17:37:08.736] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:49:0)
[17:37:08.736] Timer tick, asking Buildbucket for the build status
[17:37:08.924] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:08.924] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:50:0) after 1m0s
[17:38:09.013] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:50:0)
[17:38:09.013] Timer tick, asking Buildbucket for the build status
[17:38:09.175] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:09.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:51:0) after 1m0s
[17:39:09.205] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:51:0)
[17:39:09.205] Timer tick, asking Buildbucket for the build status
[17:39:09.352] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:09.352] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:52:0) after 1m0s
[17:40:09.523] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:52:0)
[17:40:09.523] Timer tick, asking Buildbucket for the build status
[17:40:09.764] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:09.764] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:53:0) after 1m0s
[17:41:09.883] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:53:0)
[17:41:09.883] Timer tick, asking Buildbucket for the build status
[17:41:14.997] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:14.997] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:54:0) after 1m0s
[17:42:15.065] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:54:0)
[17:42:15.065] Timer tick, asking Buildbucket for the build status
[17:42:16.277] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:16.277] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:55:0) after 1m0s
[17:43:16.406] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:55:0)
[17:43:16.406] Timer tick, asking Buildbucket for the build status
[17:43:16.483] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:16.483] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:56:0) after 1m0s
[17:44:16.554] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:56:0)
[17:44:16.554] Timer tick, asking Buildbucket for the build status
[17:44:17.620] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:17.620] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:57:0) after 1m0s
[17:45:17.694] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:57:0)
[17:45:17.694] Timer tick, asking Buildbucket for the build status
[17:45:17.939] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:17.939] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:58:0) after 1m0s
[17:46:17.972] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:58:0)
[17:46:17.972] Timer tick, asking Buildbucket for the build status
[17:46:18.056] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:18.056] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:59:0) after 1m0s
[17:47:18.121] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:59:0)
[17:47:18.121] Timer tick, asking Buildbucket for the build status
[17:47:18.227] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:18.227] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:60:0) after 1m0s
[17:48:18.293] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:60:0)
[17:48:18.294] Timer tick, asking Buildbucket for the build status
[17:48:18.454] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:18.454] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:61:0) after 1m0s
[17:49:18.557] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:61:0)
[17:49:18.557] Timer tick, asking Buildbucket for the build status
[17:49:18.643] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:18.643] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:62:0) after 1m0s
[17:50:18.691] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:62:0)
[17:50:18.691] Timer tick, asking Buildbucket for the build status
[17:50:18.830] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:18.830] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:63:0) after 1m0s
[17:51:18.878] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:63:0)
[17:51:18.878] Timer tick, asking Buildbucket for the build status
[17:51:18.990] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:18.990] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:64:0) after 1m0s
[17:52:19.026] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:64:0)
[17:52:19.026] Timer tick, asking Buildbucket for the build status
[17:52:19.151] Build 8864453922385796304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:19.151] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029883985870775920:65:0) after 1m0s
[17:52:30.324] Received PubSub notification, asking Buildbucket for the build status
[17:52:30.416] Build 8864453922385796304: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:52:30.416] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604598748556414",
"created_by": "project:chromium",
"created_ts": "1604594987462851",
"id": "8864453922385796304",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f34797ca38499634c8ac82508c4cb1944299088f\"}}",
"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\": \"f34797ca38499634c8ac82508c4cb1944299088f\", \"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-5-vrjs\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15481, \"clang_revision\": \"llvmorg-12-init-10666-gc9f69ee7-1\", \"got_angle_revision\": \"3942e801a65b780296f526f10704c9668d499942\", \"got_dawn_revision\": \"e87a8c466fb1652aedc2bfea464ae0b99782a357\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"f34797ca38499634c8ac82508c4cb1944299088f\", \"got_revision_cp\": \"refs/heads/master@{#824452}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"ad54c71632cc0f18584a7009f1e6fc44f5453bc7\", \"got_v8_revision\": \"937e42d5f246b3d04092869127d2888668de7acd\", \"got_v8_revision_cp\": \"refs/heads/8.8.239@{#1}\", \"got_webrtc_revision\": \"42cafa5696f516712bbe6709fedeedffac61544c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32540}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f34797ca38499634c8ac82508c4cb1944299088f\", \"swarm_hashes_refs/heads/master(at){#824452}_without_patch\": {\"absl_hardening_tests\": \"82904aa0b30adcc2075512e6bee412bbbb22829c\", \"accessibility_unittests\": \"7d6166e12b0b99a85177586837872ba4df6b7b50\", \"angle_unittests\": \"dff6e0862e73b6a2fc975d2f7549ee1cbea01492\", \"app_shell_unittests\": \"8c8db0b8c018d240b72111dc2d2e2b273d81c42c\", \"aura_unittests\": \"5da0f2e4223df079bbc1449173b08c385596d5b3\", \"base_unittests\": \"384eb1b732a7caba141b2e7f77925f8978150cdc\", \"base_util_unittests\": \"b153701ba40c088eec43c5e1170294b5db4f47ad\", \"blink_common_unittests\": \"591d7f1109d6cffb006e91b7e2c948b87b03a21a\", \"blink_fuzzer_unittests\": \"079ea91e7d615d994f7599ddb7ac5e8b88fcc9b7\", \"blink_heap_unittests\": \"e0bf2c7a87d95b223074c3595478aa7b9e1a9812\", \"blink_platform_unittests\": \"529802d11d0d495585423fa83cdb14e004a60240\", \"blink_unittests\": \"18d141afaa729d8dd167cfa33cdf15044b05762a\", \"boringssl_crypto_tests\": \"ba2ae9bba771b5163c933a0bf65e052ee25bd141\", \"boringssl_ssl_tests\": \"848e8c10319cd8e5be8c0841129dd4a66b23ef8c\", \"browser_switcher_bho_unittests\": \"1f46c3440c42110f9d293f6b8a38db34cc83635e\", \"browser_tests\": \"18fc9b1a3d2c3ed7e27553974e42d06875ab034d\", \"capture_unittests\": \"821c44baec68e0d97fc15f27c25ae2d4076150f7\", \"cast_unittests\": \"4906b14adf6b06256295d7bf6ccef58234b0ef0f\", \"cc_unittests\": \"56d903a57b998ddede389a48a9577087f8afdb26\", \"chrome_app_unittests\": \"ad14889c2db36c73d5ad0edc7eafdeebb8f5a7f1\", \"chrome_cleaner_unittests\": \"2f7e48752890de11e386c544c23bc0951326e922\", \"chrome_elf_unittests\": \"45af1652fa13b2016ceae8ca12ca23e4c219ec4d\", \"chromedriver_unittests\": \"ee2543e08727010e863bd89ce469fe13528b1904\", \"components_browsertests\": \"2fe395b1e5a60f59ca07b1dbfc34e213cb8e963e\", \"components_unittests\": \"7848f76c5089dedc6ae5adfb68320851abdbdc5d\", \"compositor_unittests\": \"8175f80b2396d8b83719c28d3aadfa71720485d3\", \"content_browsertests\": \"22bcdbe5b5966aa0a0f813a446beaf79d8629971\", \"content_unittests\": \"58e9a7c615a13cfbe85b052b9304a2ac529ba771\", \"courgette_unittests\": \"673bca7a6894485f4d07a68c5b4220d86654c277\", \"crashpad_tests\": \"f61ee89bd14e48315f859c9739b0a6a11735dbfd\", \"cronet_tests\": \"7029fa1ac23d2f779766a53d33e7c1033afbcd01\", \"cronet_unittests\": \"868f3398a9972a6475c87536c97030f69672d9d7\", \"crypto_unittests\": \"acce79b0f3df0b49b157b211886119aa16726e52\", \"delayloads_unittests\": \"0ad1d3a790a579b41a6db20e4a90e4ae888a1d95\", \"device_unittests\": \"50934d68156e2f3509960c36584584d2485a507b\", \"display_unittests\": \"45698dcbcc46e0a011ecd68b353381a93348b1c1\", \"elevation_service_unittests\": \"98ee144b7ae45e7f9c823c2c26da34b5c7ca552c\", \"events_unittests\": \"8e8eae7a06afbb7ec79091757acadffeafc8ce93\", \"extensions_browsertests\": \"7868ae131efe56b7d68a413284ad4d6bedb524a3\", \"extensions_unittests\": \"78d194cc4717876a9c6bc71467fc293d4f728d71\", \"filesystem_service_unittests\": \"68cbd6adc7b407f895c7402bf2d5e3acee522054\", \"gcm_unit_tests\": \"81292df0a32532cf26e3051db40b005047515217\", \"gcp_unittests\": \"48787f116d2ddeb9b6074f1b07224153978cbf32\", \"gfx_unittests\": \"d4c9381581e1d70869ed999597ada51121ada69b\", \"gin_unittests\": \"1d0e44c18ee9a19ea299e58517847d18b93cfc69\", \"google_apis_unittests\": \"8ddeef8658dbe2b930c14b3c00f93d85b4774f50\", \"gpu_unittests\": \"c53393b95bbd87d235a7aa3374b248c61708dd25\", \"gwp_asan_unittests\": \"e79990af7a4e285a18dca3210259b2d394548faf\", \"headless_browsertests\": \"0bbdf22b2214bef6d3c1e7aae3b3ea6f5a4e77c6\", \"headless_unittests\": \"cf2e23c5e9a0bc0c48a38f57bdfa4796971064f6\", \"install_static_unittests\": \"e23ea3ad586ffe6400f70ba5f4c44e7e294c7511\", \"installer_util_unittests\": \"febf921d92464827c7bca6835cd58081aef24cef\", \"interactive_ui_tests\": \"9abb081cc311f442f4325eb2cb0aa4332558c448\", \"ipc_tests\": \"17338e78cd66de4908685cfb2b29f87774995bbf\", \"jingle_unittests\": \"c7c7aa5e47ef92f6fc0323e563ea9cd82ebd0526\", \"latency_unittests\": \"a28f5bc6a2da0f77b33c92917c1a7edb54aedab6\", \"libjingle_xmpp_unittests\": \"b88f20401b2d471854e20f41b8fbd9721c960546\", \"liburlpattern_unittests\": \"48ea8a0cb041f7d91299eeb0c6c41581d3394d3f\", \"media_blink_unittests\": \"4a667cb3c2816b954072f66d593909940afed5e0\", \"media_unittests\": \"235c836a7dd338e86689606f3212d9e3a2cd95ff\", \"message_center_unittests\": \"106a2a3baeae8218b4a836abacccf94a89998714\", \"midi_unittests\": \"0cab752305c531c9ebe63369f7a0c3f2e9d6368e\", \"mojo_core_unittests\": \"0ab7cfccc4e758530884a98f7286001a9fbdc4b7\", \"mojo_unittests\": \"23f94c1865f6ce782b396418e2d8ee2099dcd3b4\", \"nacl_loader_unittests\": \"089bcd316cb3b05f0c2f23ddf31b0ac4ede6bd9e\", \"native_theme_unittests\": \"0d95ba2a8aef5fd11a8a0337dfa683bd3d1e7752\", \"net_unittests\": \"6d518a362e22f3d31299dd96069db226de077ae9\", \"notification_helper_unittests\": \"f4c0ff5364c89e5738602339aec6dfa3f8ea07cc\", \"pdf_unittests\": \"5f5fff160a31adeb8427fa88f103bf73c617162e\", \"perfetto_unittests\": \"545495c377bd8c4e6a9cc7fb9189565e63b45e6f\", \"ppapi_unittests\": \"e95198f0925d2430be8e04cba5814ea5300bcc13\", \"printing_unittests\": \"671b2711f87128eaecc57f6b9a6b9b48904ee37a\", \"remoting_unittests\": \"bb8315ec5349376d05e4b997ebc9b8a094f49ef6\", \"sbox_integration_tests\": \"46558932d35dde246790984e80fc68f898d4a28d\", \"sbox_unittests\": \"62b64dcc1c49afa4ab5b996aa71126145b343f05\", \"sbox_validation_tests\": \"ba53524c86ea42b2df4408b64533cb9ef05195cf\", \"service_manager_unittests\": \"75c591d1124a326de9c9a55b11c6b7bf7f27013c\", \"services_unittests\": \"a90b577f2a9039f526da92117ceaac28adb6a744\", \"setup_unittests\": \"df45a33eaaf4f9e15a45c082078c3e5324f26f16\", \"shell_dialogs_unittests\": \"7e161614d5f2d660bf2a71585e85da292cc29126\", \"skia_unittests\": \"e03ae70646809b914ce03c6d8b57ce8b9d1025fb\", \"snapshot_unittests\": \"b4c8cdb03d50ff7b04bcb2cb274fa3c9561cbf46\", \"sql_unittests\": \"29cc497e27be34ade13f742fef3a968e0344cbcd\", \"storage_unittests\": \"798da5485e0a383591cef78809cb21804ec09b5c\", \"sync_integration_tests\": \"014baec2ed9133d87d1976458a41b3ab77ff3298\", \"traffic_annotation_auditor_unittests\": \"48904d9888733e8b822f0f3871d7dd44a5c4fb9f\", \"ui_base_unittests\": \"f6aaa795ea3994c254f07e7fe56796316e2e889c\", \"ui_touch_selection_unittests\": \"b860475fee6f2b25ae862d0487dcdde03b887f64\", \"unit_tests\": \"bdd17220ebfc2fc673946cdc12dcc8b6b4434c30\", \"updater_tests\": \"201f607ead3b4c77fe8996b30dfe6b73d1a56514\", \"url_unittests\": \"c5a06def78f46b82724877ba6a3f36d1133e7dc0\", \"views_unittests\": \"67c3d71a54075f8e6eac284bf1a1f2f8938ce160\", \"viz_unittests\": \"7f10d48d05595b0e1a9946eb655e402ccb6d72ca\", \"vr_common_unittests\": \"ad37503907148b684fade826b73847ef7c5ea208\", \"vr_pixeltests\": \"64e498e733735140959ec62f8f10e121ec6e121f\", \"weblayer_browsertests\": \"efab1c1bd713ca9a8549fe17ff877cf3193e2406\", \"weblayer_unittests\": \"3375e22e6bbdb72a3ab9749ff7099e690a3ae08a\", \"wm_unittests\": \"a080eefeb3c496f047dedf1ece2317866f0c4747\", \"wtf_unittests\": \"c6393286f00183f32d7d13a9c55148412ba7d986\", \"zlib_unittests\": \"b9ba4e576ee6b585668d374b0c6bf26f7b9a08ab\", \"zucchini_unittests\": \"5a31a8fad1381bf5532faedb9e5ae6c4a03b0a64\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-5-vrjs\"], \"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-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604594989345655",
"status": "COMPLETED",
"status_changed_ts": "1604598749053014",
"tags": [
"build_address:luci.chromium.ci/win-asan/15481",
"builder:win-asan",
"buildset:commit/git/f34797ca38499634c8ac82508c4cb1944299088f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f34797ca38499634c8ac82508c4cb1944299088f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029883985870775920",
"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/8864453922385796304/+/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:4fb221fd1d580e10",
"user_agent:luci-scheduler"
],
"updated_ts": "1604598749246621",
"url": "https://ci.chromium.org/b/8864453922385796304",
"utcnow_ts": "1604598750404288"
}
}
[17:52:30.416] Invocation finished in 1h2m45.661596663s with status SUCCEEDED