[14:21:20.876] New invocation is queued and will start shortly
[14:21:22.689] Starting the invocation (attempt 1)
[14:21:22.735] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:21:22.735] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:21:22.736] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029530934424703808",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"244f39433705a41a774716738f317ad396a90655\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9029530934424703808",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/244f39433705a41a774716738f317ad396a90655",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/244f39433705a41a774716738f317ad396a90655",
"gitiles_ref:refs/heads/master"
]
}
[14:21:23.518] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604931682868396",
"id": "8864100871663670128",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"244f39433705a41a774716738f317ad396a90655\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604931683308686",
"tags": [
"build_address:luci.chromium.ci/win-asan/15554",
"builder:win-asan",
"buildset:commit/git/244f39433705a41a774716738f317ad396a90655",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/244f39433705a41a774716738f317ad396a90655",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029530934424703808",
"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/8864100871663670128/+/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": "1604931683308851",
"url": "https://ci.chromium.org/b/8864100871663670128",
"utcnow_ts": "1604931683503769"
}
}
[14:21:23.518] Task URL: https://ci.chromium.org/b/8864100871663670128
[14:21:23.518] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:2:0) after 1m0s
[14:21:28.191] Received PubSub notification, asking Buildbucket for the build status
[14:21:28.299] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:23.555] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:2:0)
[14:22:23.555] Timer tick, asking Buildbucket for the build status
[14:22:23.672] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:23.672] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:4:0) after 1m0s
[14:23:23.765] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:4:0)
[14:23:23.765] Timer tick, asking Buildbucket for the build status
[14:23:23.879] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:23.879] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:5:0) after 1m0s
[14:24:23.954] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:5:0)
[14:24:23.954] Timer tick, asking Buildbucket for the build status
[14:24:24.332] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:24.332] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:6:0) after 1m0s
[14:25:24.401] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:6:0)
[14:25:24.401] Timer tick, asking Buildbucket for the build status
[14:25:24.506] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:24.506] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:7:0) after 1m0s
[14:26:24.539] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:7:0)
[14:26:24.539] Timer tick, asking Buildbucket for the build status
[14:26:24.737] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:24.737] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:8:0) after 1m0s
[14:27:24.841] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:8:0)
[14:27:24.841] Timer tick, asking Buildbucket for the build status
[14:27:24.947] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:24.947] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:9:0) after 1m0s
[14:28:25.052] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:9:0)
[14:28:25.052] Timer tick, asking Buildbucket for the build status
[14:28:25.186] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:25.186] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:10:0) after 1m0s
[14:29:25.314] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:10:0)
[14:29:25.314] Timer tick, asking Buildbucket for the build status
[14:29:25.554] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:25.554] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:11:0) after 1m0s
[14:30:25.629] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:11:0)
[14:30:25.629] Timer tick, asking Buildbucket for the build status
[14:30:25.720] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:25.720] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:12:0) after 1m0s
[14:31:25.906] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:12:0)
[14:31:25.906] Timer tick, asking Buildbucket for the build status
[14:31:26.016] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:26.016] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:13:0) after 1m0s
[14:32:26.342] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:13:0)
[14:32:26.344] Timer tick, asking Buildbucket for the build status
[14:32:26.586] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:26.586] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:14:0) after 1m0s
[14:33:26.772] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:14:0)
[14:33:26.772] Timer tick, asking Buildbucket for the build status
[14:33:26.830] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:26.831] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:15:0) after 1m0s
[14:34:26.944] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:15:0)
[14:34:26.944] Timer tick, asking Buildbucket for the build status
[14:34:27.019] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:27.019] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:16:0) after 1m0s
[14:35:27.275] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:16:0)
[14:35:27.275] Timer tick, asking Buildbucket for the build status
[14:35:27.347] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:27.347] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:17:0) after 1m0s
[14:36:27.413] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:17:0)
[14:36:27.413] Timer tick, asking Buildbucket for the build status
[14:36:27.579] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:27.579] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:18:0) after 1m0s
[14:37:27.727] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:18:0)
[14:37:27.727] Timer tick, asking Buildbucket for the build status
[14:37:27.796] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:27.796] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:19:0) after 1m0s
[14:38:27.849] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:19:0)
[14:38:27.850] Timer tick, asking Buildbucket for the build status
[14:38:27.942] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:27.942] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:20:0) after 1m0s
[14:39:28.171] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:20:0)
[14:39:28.171] Timer tick, asking Buildbucket for the build status
[14:39:28.291] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:28.291] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:21:0) after 1m0s
[14:40:28.364] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:21:0)
[14:40:28.364] Timer tick, asking Buildbucket for the build status
[14:40:28.741] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:28.741] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:22:0) after 1m0s
[14:41:28.781] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:22:0)
[14:41:28.781] Timer tick, asking Buildbucket for the build status
[14:41:28.909] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:28.910] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:23:0) after 1m0s
[14:42:28.959] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:23:0)
[14:42:28.959] Timer tick, asking Buildbucket for the build status
[14:42:29.058] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:29.058] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:24:0) after 1m0s
[14:43:29.114] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:24:0)
[14:43:29.114] Timer tick, asking Buildbucket for the build status
[14:43:29.844] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:29.844] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:25:0) after 1m0s
[14:44:29.885] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:25:0)
[14:44:29.885] Timer tick, asking Buildbucket for the build status
[14:44:30.178] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:30.178] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:26:0) after 1m0s
[14:45:30.247] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:26:0)
[14:45:30.247] Timer tick, asking Buildbucket for the build status
[14:45:30.364] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:30.364] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:27:0) after 1m0s
[14:46:30.431] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:27:0)
[14:46:30.431] Timer tick, asking Buildbucket for the build status
[14:46:30.569] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:30.569] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:28:0) after 1m0s
[14:47:30.665] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:28:0)
[14:47:30.665] Timer tick, asking Buildbucket for the build status
[14:47:31.096] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:31.096] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:29:0) after 1m0s
[14:48:31.133] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:29:0)
[14:48:31.133] Timer tick, asking Buildbucket for the build status
[14:48:31.387] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:31.387] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:30:0) after 1m0s
[14:49:31.473] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:30:0)
[14:49:31.473] Timer tick, asking Buildbucket for the build status
[14:49:31.619] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:31.619] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:31:0) after 1m0s
[14:50:31.722] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:31:0)
[14:50:31.722] Timer tick, asking Buildbucket for the build status
[14:50:31.939] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:31.939] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:32:0) after 1m0s
[14:51:32.108] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:32:0)
[14:51:32.108] Timer tick, asking Buildbucket for the build status
[14:51:32.239] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:32.239] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:33:0) after 1m0s
[14:52:32.270] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:33:0)
[14:52:32.270] Timer tick, asking Buildbucket for the build status
[14:52:32.442] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:32.442] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:34:0) after 1m0s
[14:53:32.498] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:34:0)
[14:53:32.498] Timer tick, asking Buildbucket for the build status
[14:53:32.790] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:32.790] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:35:0) after 1m0s
[14:54:33.174] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:35:0)
[14:54:33.174] Timer tick, asking Buildbucket for the build status
[14:54:33.299] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:33.299] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:36:0) after 1m0s
[14:55:33.419] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:36:0)
[14:55:33.419] Timer tick, asking Buildbucket for the build status
[14:55:33.533] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:33.533] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:37:0) after 1m0s
[14:56:33.603] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:37:0)
[14:56:33.603] Timer tick, asking Buildbucket for the build status
[14:56:33.798] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:33.798] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:38:0) after 1m0s
[14:57:33.885] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:38:0)
[14:57:33.885] Timer tick, asking Buildbucket for the build status
[14:57:33.962] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:33.962] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:39:0) after 1m0s
[14:58:34.101] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:39:0)
[14:58:34.101] Timer tick, asking Buildbucket for the build status
[14:58:34.202] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:34.202] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:40:0) after 1m0s
[14:59:34.329] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:40:0)
[14:59:34.329] Timer tick, asking Buildbucket for the build status
[14:59:34.412] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:34.412] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:41:0) after 1m0s
[15:00:34.520] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:41:0)
[15:00:34.520] Timer tick, asking Buildbucket for the build status
[15:00:34.674] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:34.674] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:42:0) after 1m0s
[15:01:34.781] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:42:0)
[15:01:34.781] Timer tick, asking Buildbucket for the build status
[15:01:34.898] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:34.898] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:43:0) after 1m0s
[15:02:34.928] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:43:0)
[15:02:34.928] Timer tick, asking Buildbucket for the build status
[15:02:35.201] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:35.201] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:44:0) after 1m0s
[15:03:35.302] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:44:0)
[15:03:35.302] Timer tick, asking Buildbucket for the build status
[15:03:35.610] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:35.610] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:45:0) after 1m0s
[15:04:35.600] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:45:0)
[15:04:35.600] Timer tick, asking Buildbucket for the build status
[15:04:35.734] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:35.734] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:46:0) after 1m0s
[15:05:35.765] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:46:0)
[15:05:35.765] Timer tick, asking Buildbucket for the build status
[15:05:35.832] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:35.832] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:47:0) after 1m0s
[15:06:35.880] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:47:0)
[15:06:35.880] Timer tick, asking Buildbucket for the build status
[15:06:35.998] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:35.998] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:48:0) after 1m0s
[15:07:36.025] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:48:0)
[15:07:36.025] Timer tick, asking Buildbucket for the build status
[15:07:36.510] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:36.510] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:49:0) after 1m0s
[15:08:36.572] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:49:0)
[15:08:36.572] Timer tick, asking Buildbucket for the build status
[15:08:36.794] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:36.794] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:50:0) after 1m0s
[15:09:36.867] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:50:0)
[15:09:36.867] Timer tick, asking Buildbucket for the build status
[15:09:37.276] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:37.276] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:51:0) after 1m0s
[15:10:37.304] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:51:0)
[15:10:37.304] Timer tick, asking Buildbucket for the build status
[15:10:37.409] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:37.409] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:52:0) after 1m0s
[15:11:37.452] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:52:0)
[15:11:37.452] Timer tick, asking Buildbucket for the build status
[15:11:37.931] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:37.931] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:53:0) after 1m0s
[15:12:37.999] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:53:0)
[15:12:37.999] Timer tick, asking Buildbucket for the build status
[15:12:38.333] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:38.333] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:54:0) after 1m0s
[15:13:38.429] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:54:0)
[15:13:38.429] Timer tick, asking Buildbucket for the build status
[15:13:38.804] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:38.804] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:55:0) after 1m0s
[15:14:38.831] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:55:0)
[15:14:38.831] Timer tick, asking Buildbucket for the build status
[15:14:38.952] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:38.952] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:56:0) after 1m0s
[15:15:39.089] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:56:0)
[15:15:39.089] Timer tick, asking Buildbucket for the build status
[15:15:39.455] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:39.459] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:57:0) after 1m0s
[15:16:39.670] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:57:0)
[15:16:39.670] Timer tick, asking Buildbucket for the build status
[15:16:39.904] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:39.905] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:58:0) after 1m0s
[15:17:40.022] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:58:0)
[15:17:40.022] Timer tick, asking Buildbucket for the build status
[15:17:40.161] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:40.161] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:59:0) after 1m0s
[15:18:40.240] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:59:0)
[15:18:40.240] Timer tick, asking Buildbucket for the build status
[15:18:40.711] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:40.711] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:60:0) after 1m0s
[15:19:40.762] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:60:0)
[15:19:40.762] Timer tick, asking Buildbucket for the build status
[15:19:40.921] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:40.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:61:0) after 1m0s
[15:20:41.015] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:61:0)
[15:20:41.016] Timer tick, asking Buildbucket for the build status
[15:20:42.117] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:42.117] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:62:0) after 1m0s
[15:21:42.202] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:62:0)
[15:21:42.202] Timer tick, asking Buildbucket for the build status
[15:21:42.610] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:42.610] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:63:0) after 1m0s
[15:22:42.636] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:63:0)
[15:22:42.636] Timer tick, asking Buildbucket for the build status
[15:22:42.709] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:42.710] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:64:0) after 1m0s
[15:23:42.739] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:64:0)
[15:23:42.739] Timer tick, asking Buildbucket for the build status
[15:23:42.989] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:42.989] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:65:0) after 1m0s
[15:24:43.009] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:65:0)
[15:24:43.009] Timer tick, asking Buildbucket for the build status
[15:24:43.093] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:43.093] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:66:0) after 1m0s
[15:25:43.175] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:66:0)
[15:25:43.176] Timer tick, asking Buildbucket for the build status
[15:25:43.523] Build 8864100871663670128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:43.523] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029530934424703808:67:0) after 1m0s
[15:26:05.607] Received PubSub notification, asking Buildbucket for the build status
[15:26:05.680] Build 8864100871663670128: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:26:05.680] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604935564570175",
"created_by": "project:chromium",
"created_ts": "1604931682868396",
"id": "8864100871663670128",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"244f39433705a41a774716738f317ad396a90655\"}}",
"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\": \"244f39433705a41a774716738f317ad396a90655\", \"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-8-b9eu\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15554, \"clang_revision\": \"llvmorg-12-init-11060-g118c3f3c-1\", \"got_angle_revision\": \"46f5f4386f7c7489a66884b9062287a7cb9798de\", \"got_dawn_revision\": \"3e17e33724b4d0b4c4fc1985340882e1f543e3a0\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"244f39433705a41a774716738f317ad396a90655\", \"got_revision_cp\": \"refs/heads/master@{#825327}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"4ed9d3498dcffa987acba1a8007ff8dec336f263\", \"got_v8_revision\": \"b01fdf67620796b3498f657b5ba71d34cfddccb1\", \"got_v8_revision_cp\": \"refs/heads/8.8.258@{#1}\", \"got_webrtc_revision\": \"9c99b7964fabb16a022293ffbd2804f9b46551f6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32565}\", \"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\": \"244f39433705a41a774716738f317ad396a90655\", \"swarm_hashes_refs/heads/master(at){#825327}_without_patch\": {\"absl_hardening_tests\": \"ee79bfaa29bcdd10911466145699030fb80c722f\", \"accessibility_unittests\": \"ca087c08936fd547c3620805ec855985786c35c3\", \"angle_unittests\": \"636c0eaba43a88b3c604f43137208c26e84d9f5c\", \"app_shell_unittests\": \"b3e844ebcfce23220c686ddc19c2130cf6a08e87\", \"aura_unittests\": \"cab1eea107a86b074bd9e299c1adc8cedbe4388c\", \"base_unittests\": \"dee5637bec3068ced164c712b94d217e8e746aae\", \"base_util_unittests\": \"a99f215351884080b3330fd246f76f5d79013210\", \"blink_common_unittests\": \"52d3c9ad203763d28d2d5b1526f728684704f6ec\", \"blink_fuzzer_unittests\": \"12d9b95cedc78a279801c8876b1cb1ceca0a239e\", \"blink_heap_unittests\": \"4d04b0f796681cb98093229ac4a3b4159be03285\", \"blink_platform_unittests\": \"9bdeaecc3cbcdbc29ec3177b3842e6044de902fd\", \"blink_unittests\": \"5c3d1227b95fcaa0a5bb5a7094ca1007a11ed241\", \"boringssl_crypto_tests\": \"7defc92d107ae16e36b9dafaf3a97f271535239f\", \"boringssl_ssl_tests\": \"45aa6383b735455fb60d267d49cf9f9dfee78ccc\", \"browser_switcher_bho_unittests\": \"587374da31cceeab21b7a0f54a1bdbdbf0d8db86\", \"browser_tests\": \"b5410861dd4bff244c48a04fb02053170f87eebb\", \"capture_unittests\": \"946f5976db0f4d4bf1618bb9dfe42a6679d0ac58\", \"cast_unittests\": \"a8cbc5d2651ec019e76824b053e289c8f8f96701\", \"cc_unittests\": \"7981f19760968e455c54cf85706bb6221af820a7\", \"chrome_app_unittests\": \"b362d17f62a8fd0f18b14e735b38d0b7bedb6e69\", \"chrome_cleaner_unittests\": \"11051b5361eab1deca53c59eef18896aacc5ba63\", \"chrome_elf_unittests\": \"65fb229023e5004456958b3ab54e1716089303da\", \"chromedriver_unittests\": \"11bb36455c4f23cdbfe6d7dbf74cb16be450ba34\", \"components_browsertests\": \"4aeab3ab3423a0e2e36fc6ab748112cd83a245a3\", \"components_unittests\": \"3bd46d6550ec88dd9428017facaf90049992205d\", \"compositor_unittests\": \"500ad33f11ba4bd45748610524d287069efe48de\", \"content_browsertests\": \"145845d2674758c46c57a1532f8f85eb1a101f77\", \"content_unittests\": \"27c97c99492a9a5a5a4e11f2cddfd30b12857d44\", \"courgette_unittests\": \"1bba1f92c68804d17affcc8f15605b5931255865\", \"crashpad_tests\": \"066da9dcf8a2da2f344bb542cc745bec7c13e5a6\", \"cronet_tests\": \"a4d112280ac249029edbaa88dfe26df833dac4a5\", \"cronet_unittests\": \"f1d9c8f692f3c9472b9f8df8c0e127d51073bf1c\", \"crypto_unittests\": \"8b7d37ec130a4e8c913b4c9818cbadab1ce5bdf1\", \"delayloads_unittests\": \"5e5278d00483d9740c677ac9e3d84db59609e690\", \"device_unittests\": \"3991cfaba125d6c2759a44ed8834834c867e107b\", \"display_unittests\": \"7a9afb494a204b3de23f39ce07b92e18aa9ad9ab\", \"elevation_service_unittests\": \"90fa0c114ced834507f084b0c6796ab135928337\", \"events_unittests\": \"00fa647ca20b41f6b548925861907fa353e2f449\", \"extensions_browsertests\": \"c2727c8ab0e912ed3fcfbd61f8482bd037a9ae18\", \"extensions_unittests\": \"7106bbda42b9c719c25b3871db1ec73c3aba4b46\", \"filesystem_service_unittests\": \"b749727c037f1cf13abefcb9d5ddf651d49227d5\", \"gcm_unit_tests\": \"150dfce9aa33faa73ff97ffa54ffa0ec94fcfc3d\", \"gcp_unittests\": \"c1e3dde09495bef068d1bd96c66417613714ae85\", \"gfx_unittests\": \"3893bdde116e02abc1def2a5fc1195daa60e56f5\", \"gin_unittests\": \"8e8a4fdb5d1260e52c00ef5fd0d3db7450481b01\", \"google_apis_unittests\": \"e5cd620b60e978efe306a25d11ddf7ce9b3fd758\", \"gpu_unittests\": \"f9776f75a0978b05c5e1add1aaaeb0ecb7c8fec5\", \"gwp_asan_unittests\": \"ab83069d9473f1d0d3d7878ea0564312f148ee36\", \"headless_browsertests\": \"57896d4040ed9a9d8ea59dc7fe880ec8c8857a45\", \"headless_unittests\": \"f07ac91b402dd5941e87c0c041a9b0b8059e78f0\", \"install_static_unittests\": \"de80a0325bb0610e5ccc2f22874d9d2fef9497c4\", \"installer_util_unittests\": \"b9899ccec60d854f4c184bc5c0811b47db6916c5\", \"interactive_ui_tests\": \"eddaaa2430ed12e8d9af3d6cb4e47594b4876f7c\", \"ipc_tests\": \"b40e492353d50d37bb72568596e56ef5998b8314\", \"jingle_unittests\": \"2f25c23e14104140640fe3134684b92af8d2fbb7\", \"latency_unittests\": \"137e1107b22153eedba168b82931d983d3dddeba\", \"libjingle_xmpp_unittests\": \"710bbd747f07bf2cf76b4c64f132268aec288d65\", \"liburlpattern_unittests\": \"2130683bce035f690e7c6e86890f855af734bcb5\", \"media_blink_unittests\": \"1f4b06205a172cb6f52d1d4fbc1d56372087a709\", \"media_unittests\": \"24d04ca42d87d3b89bcdc1a36ea62c5679153e00\", \"message_center_unittests\": \"12f6f3d5c902334aaf5733cd8249065c56af927a\", \"midi_unittests\": \"c2125ceeddc6a1b59601323943ff95e07d06f737\", \"mojo_core_unittests\": \"c5cfb66b73950b487afa0d71892ac4753fc1176b\", \"mojo_unittests\": \"9d46a0d7d1237e9ed94fbe1fb53c0b29b99f3267\", \"nacl_loader_unittests\": \"69dea414a17bc3454a2ef16148dbeaf62340e02e\", \"native_theme_unittests\": \"5f2567ddcb2f0373e09850775ecc004aa35469c0\", \"net_unittests\": \"cc64016ec496e9ba8d35c332116a88e03d10b0eb\", \"notification_helper_unittests\": \"85a0478446ceb22ca83f2305b710a06355529fc1\", \"pdf_unittests\": \"b2cfa2bd5917c660e76fc887d013d15a41e190fc\", \"perfetto_unittests\": \"2385592138c70204950e2ab25530397d8eef1821\", \"ppapi_unittests\": \"bf3fe705882d834b1e01c958f20d9f9966a7bc33\", \"printing_unittests\": \"22706cbf0ad7a0d40d0e50f02f3c87b0bee27bec\", \"remoting_unittests\": \"b5678a3a51de9e065257e8be8b81b34aa3774223\", \"sbox_integration_tests\": \"7b48e6ca0293f160a46fa2181f0d60e010d8fd5f\", \"sbox_unittests\": \"cf88ec1304ffddfe41f60e7dc935eef79958af2c\", \"sbox_validation_tests\": \"c92e76ca1f99d2647fb5c83b7dc0c576c4465391\", \"service_manager_unittests\": \"d9d749cfdc3c62d10dffae50d35e48db6749eddb\", \"services_unittests\": \"da0f0dd05bc5771f787d43b89610dbee895f004a\", \"setup_unittests\": \"71d3899fbd5a8332385bac0bd5caae56cfa70bcc\", \"shell_dialogs_unittests\": \"6f11760e10bd9600598aa75df87b5402d392abce\", \"skia_unittests\": \"2f010532fb55639c8d8f481e7249c2a6ebe4d3b5\", \"snapshot_unittests\": \"49de1bf615a8d678a9294cb8d70b5a56bccfcada\", \"sql_unittests\": \"607a49a30a128f6d41df47b21ded5b69f75920c5\", \"storage_unittests\": \"24dfae8aa0f24fbeeecfb8fa2b46ebc7b8e1a10b\", \"sync_integration_tests\": \"f21fe00f431962fabb41302eb43976a73e8dac58\", \"traffic_annotation_auditor_unittests\": \"036cc6b8998f7ce715acb90cf16478157c960185\", \"ui_base_unittests\": \"cb20107554e43ebce1b6f71c67af0530fd053ca9\", \"ui_touch_selection_unittests\": \"ea504152bfe5cc9c661e51fe45031c8fdb27bcc4\", \"unit_tests\": \"ac022fca6cf3b02dfc4e4e617bdbf9ee5e64ce7e\", \"updater_tests\": \"df11906dc264f02678f740952106913ef82e7637\", \"url_unittests\": \"fd114c3b514643b1f5fd0d431b4d1d06e2602468\", \"views_unittests\": \"2737bf1f79c4dc5e7aeb73e1df3ec87d8dd1acbf\", \"viz_unittests\": \"b77be857e12bc8bdb1b2591f8aae6d4cee4f3971\", \"vr_common_unittests\": \"3c65e796038829131c6be41066a9601805d5d8ab\", \"vr_pixeltests\": \"8bf110b11a7a49aa0e9e73b64552a64574b3cb9f\", \"weblayer_browsertests\": \"763ca890f7173ef167acd6048498cec5596b2cc6\", \"weblayer_unittests\": \"cf813eaeec667e6b81c6a2cee5ccfcc275c1250b\", \"wm_unittests\": \"a0425d44409f9ba09791a65cfdf0ee3bf5647282\", \"wtf_unittests\": \"ac145bc76c4d26b4e402d2aa5b427e29f7a6dda6\", \"zlib_unittests\": \"7427a4bf06629232d6369362f0bed70de7787e1e\", \"zucchini_unittests\": \"aaa5601060e2f13bdd08a9f62d426c1c1638f266\"}}, \"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-8-b9eu\"], \"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\": [\"5626-39642e9\"], \"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": "1604931687320250",
"status": "COMPLETED",
"status_changed_ts": "1604935565131737",
"tags": [
"build_address:luci.chromium.ci/win-asan/15554",
"builder:win-asan",
"buildset:commit/git/244f39433705a41a774716738f317ad396a90655",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/244f39433705a41a774716738f317ad396a90655",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029530934424703808",
"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/8864100871663670128/+/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:4fc63390e0a0b710",
"user_agent:luci-scheduler"
],
"updated_ts": "1604935565136632",
"url": "https://ci.chromium.org/b/8864100871663670128",
"utcnow_ts": "1604935565669151"
}
}
[15:26:05.680] Invocation finished in 1h4m44.828706006s with status SUCCEEDED