[04:03:18.880] New invocation is queued and will start shortly
[04:03:20.399] Starting the invocation (attempt 1)
[04:03:20.485] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:03:20.485] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:03:20.485] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030022802538987392",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"0526cc47b2634370c304d9daba9142807fc01cec\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9030022802538987392",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/0526cc47b2634370c304d9daba9142807fc01cec",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0526cc47b2634370c304d9daba9142807fc01cec",
"gitiles_ref:refs/heads/master"
]
}
[04:03:21.200] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604462600648618",
"id": "8864592740021392016",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0526cc47b2634370c304d9daba9142807fc01cec\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604462601003888",
"tags": [
"build_address:luci.chromium.ci/win-asan/15447",
"builder:win-asan",
"buildset:commit/git/0526cc47b2634370c304d9daba9142807fc01cec",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0526cc47b2634370c304d9daba9142807fc01cec",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030022802538987392",
"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/8864592740021392016/+/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": "1604462601004026",
"url": "https://ci.chromium.org/b/8864592740021392016",
"utcnow_ts": "1604462601185557"
}
}
[04:03:21.200] Task URL: https://ci.chromium.org/b/8864592740021392016
[04:03:21.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:2:0) after 1m0s
[04:03:25.961] Received PubSub notification, asking Buildbucket for the build status
[04:03:26.120] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:21.255] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:2:0)
[04:04:21.255] Timer tick, asking Buildbucket for the build status
[04:04:21.360] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:21.360] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:4:0) after 1m0s
[04:05:21.397] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:4:0)
[04:05:21.397] Timer tick, asking Buildbucket for the build status
[04:05:21.552] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:21.553] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:5:0) after 1m0s
[04:06:21.575] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:5:0)
[04:06:21.575] Timer tick, asking Buildbucket for the build status
[04:06:21.706] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:21.706] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:6:0) after 1m0s
[04:07:21.825] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:6:0)
[04:07:21.825] Timer tick, asking Buildbucket for the build status
[04:07:22.781] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:22.781] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:7:0) after 1m0s
[04:08:22.825] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:7:0)
[04:08:22.825] Timer tick, asking Buildbucket for the build status
[04:08:23.004] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:23.004] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:8:0) after 1m0s
[04:09:23.133] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:8:0)
[04:09:23.133] Timer tick, asking Buildbucket for the build status
[04:09:23.285] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:23.285] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:9:0) after 1m0s
[04:10:23.324] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:9:0)
[04:10:23.324] Timer tick, asking Buildbucket for the build status
[04:10:23.617] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:23.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:10:0) after 1m0s
[04:11:23.800] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:10:0)
[04:11:23.800] Timer tick, asking Buildbucket for the build status
[04:11:24.108] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:24.109] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:11:0) after 1m0s
[04:12:24.201] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:11:0)
[04:12:24.201] Timer tick, asking Buildbucket for the build status
[04:12:24.370] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:24.370] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:12:0) after 1m0s
[04:13:24.431] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:12:0)
[04:13:24.431] Timer tick, asking Buildbucket for the build status
[04:13:24.553] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:24.553] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:13:0) after 1m0s
[04:14:24.569] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:13:0)
[04:14:24.569] Timer tick, asking Buildbucket for the build status
[04:14:24.669] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:24.669] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:14:0) after 1m0s
[04:15:24.923] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:14:0)
[04:15:24.923] Timer tick, asking Buildbucket for the build status
[04:15:25.073] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:25.073] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:15:0) after 1m0s
[04:16:25.159] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:15:0)
[04:16:25.159] Timer tick, asking Buildbucket for the build status
[04:16:25.232] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:25.232] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:16:0) after 1m0s
[04:17:25.325] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:16:0)
[04:17:25.325] Timer tick, asking Buildbucket for the build status
[04:17:25.957] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:25.957] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:17:0) after 1m0s
[04:18:26.189] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:17:0)
[04:18:26.189] Timer tick, asking Buildbucket for the build status
[04:18:26.399] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:26.399] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:18:0) after 1m0s
[04:19:26.543] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:18:0)
[04:19:26.543] Timer tick, asking Buildbucket for the build status
[04:19:26.742] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:26.742] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:19:0) after 1m0s
[04:20:26.765] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:19:0)
[04:20:26.765] Timer tick, asking Buildbucket for the build status
[04:20:26.893] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:26.893] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:20:0) after 1m0s
[04:21:26.941] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:20:0)
[04:21:26.941] Timer tick, asking Buildbucket for the build status
[04:21:27.067] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:27.067] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:21:0) after 1m0s
[04:22:27.205] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:21:0)
[04:22:27.205] Timer tick, asking Buildbucket for the build status
[04:22:28.184] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:28.184] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:22:0) after 1m0s
[04:23:28.224] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:22:0)
[04:23:28.224] Timer tick, asking Buildbucket for the build status
[04:23:28.316] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:28.316] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:23:0) after 1m0s
[04:24:28.439] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:23:0)
[04:24:28.439] Timer tick, asking Buildbucket for the build status
[04:24:28.627] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:28.628] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:24:0) after 1m0s
[04:25:28.680] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:24:0)
[04:25:28.680] Timer tick, asking Buildbucket for the build status
[04:25:28.793] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:28.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:25:0) after 1m0s
[04:26:28.820] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:25:0)
[04:26:28.820] Timer tick, asking Buildbucket for the build status
[04:26:28.939] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:28.939] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:26:0) after 1m0s
[04:27:28.913] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:26:0)
[04:27:28.913] Timer tick, asking Buildbucket for the build status
[04:27:29.033] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:29.033] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:27:0) after 1m0s
[04:28:29.148] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:27:0)
[04:28:29.148] Timer tick, asking Buildbucket for the build status
[04:28:29.434] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:29.434] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:28:0) after 1m0s
[04:29:29.499] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:28:0)
[04:29:29.499] Timer tick, asking Buildbucket for the build status
[04:29:29.574] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:29.574] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:29:0) after 1m0s
[04:30:29.666] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:29:0)
[04:30:29.666] Timer tick, asking Buildbucket for the build status
[04:30:29.773] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:29.773] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:30:0) after 1m0s
[04:31:29.830] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:30:0)
[04:31:29.830] Timer tick, asking Buildbucket for the build status
[04:31:29.916] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:29.916] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:31:0) after 1m0s
[04:32:30.070] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:31:0)
[04:32:30.070] Timer tick, asking Buildbucket for the build status
[04:32:30.177] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:30.177] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:32:0) after 1m0s
[04:33:30.201] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:32:0)
[04:33:30.201] Timer tick, asking Buildbucket for the build status
[04:33:30.320] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:30.320] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:33:0) after 1m0s
[04:34:30.332] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:33:0)
[04:34:30.332] Timer tick, asking Buildbucket for the build status
[04:34:30.505] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:30.505] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:34:0) after 1m0s
[04:35:30.532] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:34:0)
[04:35:30.532] Timer tick, asking Buildbucket for the build status
[04:35:30.663] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:30.663] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:35:0) after 1m0s
[04:36:30.732] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:35:0)
[04:36:30.732] Timer tick, asking Buildbucket for the build status
[04:36:30.999] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:30.999] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:36:0) after 1m0s
[04:37:31.037] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:36:0)
[04:37:31.037] Timer tick, asking Buildbucket for the build status
[04:37:32.035] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:32.036] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:37:0) after 1m0s
[04:38:32.094] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:37:0)
[04:38:32.094] Timer tick, asking Buildbucket for the build status
[04:38:32.235] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:32.236] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:38:0) after 1m0s
[04:39:32.302] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:38:0)
[04:39:32.302] Timer tick, asking Buildbucket for the build status
[04:39:33.010] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:33.010] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:39:0) after 1m0s
[04:40:33.033] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:39:0)
[04:40:33.033] Timer tick, asking Buildbucket for the build status
[04:40:33.156] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:33.156] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:40:0) after 1m0s
[04:41:33.153] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:40:0)
[04:41:33.153] Timer tick, asking Buildbucket for the build status
[04:41:33.516] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:33.516] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:41:0) after 1m0s
[04:42:33.559] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:41:0)
[04:42:33.559] Timer tick, asking Buildbucket for the build status
[04:42:33.715] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:33.715] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:42:0) after 1m0s
[04:43:33.737] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:42:0)
[04:43:33.737] Timer tick, asking Buildbucket for the build status
[04:43:34.422] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:34.422] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:43:0) after 1m0s
[04:44:34.441] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:43:0)
[04:44:34.441] Timer tick, asking Buildbucket for the build status
[04:44:34.592] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:34.592] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:44:0) after 1m0s
[04:45:34.734] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:44:0)
[04:45:34.734] Timer tick, asking Buildbucket for the build status
[04:45:34.858] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:34.858] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:45:0) after 1m0s
[04:46:34.894] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:45:0)
[04:46:34.894] Timer tick, asking Buildbucket for the build status
[04:46:36.472] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:36.472] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:46:0) after 1m0s
[04:47:36.484] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:46:0)
[04:47:36.484] Timer tick, asking Buildbucket for the build status
[04:47:36.626] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:36.626] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:47:0) after 1m0s
[04:48:36.690] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:47:0)
[04:48:36.690] Timer tick, asking Buildbucket for the build status
[04:48:36.838] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:36.838] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:48:0) after 1m0s
[04:49:36.859] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:48:0)
[04:49:36.859] Timer tick, asking Buildbucket for the build status
[04:49:36.960] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:36.960] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:49:0) after 1m0s
[04:50:37.062] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:49:0)
[04:50:37.062] Timer tick, asking Buildbucket for the build status
[04:50:37.152] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:37.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:50:0) after 1m0s
[04:51:37.269] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:50:0)
[04:51:37.269] Timer tick, asking Buildbucket for the build status
[04:51:37.679] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:37.679] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:51:0) after 1m0s
[04:52:37.782] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:51:0)
[04:52:37.782] Timer tick, asking Buildbucket for the build status
[04:52:37.853] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:37.853] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:52:0) after 1m0s
[04:53:37.910] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:52:0)
[04:53:37.910] Timer tick, asking Buildbucket for the build status
[04:53:38.050] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:38.050] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:53:0) after 1m0s
[04:54:38.174] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:53:0)
[04:54:38.174] Timer tick, asking Buildbucket for the build status
[04:54:38.262] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:38.262] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:54:0) after 1m0s
[04:55:38.321] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:54:0)
[04:55:38.321] Timer tick, asking Buildbucket for the build status
[04:55:38.403] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:38.403] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:55:0) after 1m0s
[04:56:38.529] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:55:0)
[04:56:38.529] Timer tick, asking Buildbucket for the build status
[04:56:38.667] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:38.667] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:56:0) after 1m0s
[04:57:38.758] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:56:0)
[04:57:38.758] Timer tick, asking Buildbucket for the build status
[04:57:38.878] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:38.878] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:57:0) after 1m0s
[04:58:38.933] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:57:0)
[04:58:38.933] Timer tick, asking Buildbucket for the build status
[04:58:39.703] Build 8864592740021392016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:39.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9030022802538987392:58:0) after 1m0s
[04:58:50.231] Received PubSub notification, asking Buildbucket for the build status
[04:58:50.299] Build 8864592740021392016: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:58:50.299] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604465929106702",
"created_by": "project:chromium",
"created_ts": "1604462600648618",
"id": "8864592740021392016",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0526cc47b2634370c304d9daba9142807fc01cec\"}}",
"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\": \"0526cc47b2634370c304d9daba9142807fc01cec\", \"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\": 15447, \"clang_revision\": \"llvmorg-12-init-5627-gf086e85e-3\", \"got_angle_revision\": \"3980b1f815aa10caf5dc94adde9d5a7c31a1797c\", \"got_dawn_revision\": \"43ef0a365b8443226916c090b88b3a0b09d6df96\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"0526cc47b2634370c304d9daba9142807fc01cec\", \"got_revision_cp\": \"refs/heads/master@{#823879}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"31e28d20f8783cda3bb6ec856459ebf3c15d21b7\", \"got_v8_revision\": \"f014ab9299eed4f879b06b06873e7eac3b20b0e5\", \"got_v8_revision_cp\": \"refs/heads/8.8.227@{#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\": \"0526cc47b2634370c304d9daba9142807fc01cec\", \"swarm_hashes_refs/heads/master(at){#823879}_without_patch\": {\"absl_hardening_tests\": \"7a20f029567fb3883762a7b86779071ce686e484\", \"accessibility_unittests\": \"fc6ff1c1e3688905926fd20fbf34091e2cc6b51a\", \"angle_unittests\": \"9908f2ee2d4adb204543fc81fd5e30fd69e932c3\", \"app_shell_unittests\": \"a4dd9b5d1ba86ef02662a1e366d0537f8d04dcb9\", \"aura_unittests\": \"56e74f6012dce3cde7abc358ae8acaaf91b367bd\", \"base_unittests\": \"a93b335b026458801897f2708cf15ecbdf13fee3\", \"base_util_unittests\": \"c43301c59a55465ecadbb10b1a2815c202dcd29d\", \"blink_common_unittests\": \"21ad06604a91600de209637412a0678b7edd9e9f\", \"blink_fuzzer_unittests\": \"0d5519c1135fdf3c819bdfa2fd0013dca5aaa9ed\", \"blink_heap_unittests\": \"fab512c4b1b6e391c50347696b396fbca540404c\", \"blink_platform_unittests\": \"6914598f127a3b0dabfe949cd375aba3a5168444\", \"blink_unittests\": \"0101f6ea400770720f02f78eb1f1ea7200cb5baf\", \"boringssl_crypto_tests\": \"b49d657000f3234fce844cf97fae243ca133da1a\", \"boringssl_ssl_tests\": \"17ce435f55d66d66a1f9bca36840efbb498c3128\", \"browser_switcher_bho_unittests\": \"96eeb35fb11db982fa9db210feb324da80d536f5\", \"browser_tests\": \"9631f39397d9bbdbc9840eb6f9f025206a4d525e\", \"capture_unittests\": \"110f28a238677ba06e47a827e0ffd28219894e85\", \"cast_unittests\": \"d3cb3c9725d67b720e2a821bd591fc931c2ce163\", \"cc_unittests\": \"a8546f2ca4a877f8f338dc02cb5a2fd3b7237c36\", \"chrome_app_unittests\": \"2c5add4f1fbf919d28eb8a1c3c35f3ff14d0c560\", \"chrome_cleaner_unittests\": \"8f18d3764dc7adf503956d19361fa56b54757708\", \"chrome_elf_unittests\": \"49da4e9ede0676e950ba8be98fe0ace1fd264d25\", \"chromedriver_unittests\": \"17ac1c39db1fa068ce1990ba4c39f3585d40b2f8\", \"components_browsertests\": \"f307744b543938f81acafe7ccef1db5db7f564ae\", \"components_unittests\": \"171a160c91fa0274c934040a75ac01d3a05654f2\", \"compositor_unittests\": \"7e362b0a48ec1bec9240f46422b5c246cd8e6cae\", \"content_browsertests\": \"450292c757441e3d8898533c9cda795e85ebd6f4\", \"content_unittests\": \"4300997e4d987818e5f566475f44b390cb0c3459\", \"courgette_unittests\": \"908d6e136b58a2a877c238f44aafb079afb90351\", \"crashpad_tests\": \"6d84e087f475a0af637bfc83807da9acfc789d1c\", \"cronet_tests\": \"95fb844dae05b24697d67d19a0407824251c2c80\", \"cronet_unittests\": \"c3589196d7eb6422cf834d6a4285a24bce6ec450\", \"crypto_unittests\": \"6bee8e9af1b1bd74068a05d946325a585543c16e\", \"delayloads_unittests\": \"f9d923860a3f4fe76c771c603039362b6964f97e\", \"device_unittests\": \"a5f0b7042cfb3f6f7fa47bf1bc43d9c92e341764\", \"display_unittests\": \"9ed4b06be587d180f520ecaa6d29c65d9cae71e3\", \"elevation_service_unittests\": \"9ccf6ad027898424720b951e1011756e01139c87\", \"events_unittests\": \"9952385d3aaf24460beacde9472bec9ed603d05d\", \"extensions_browsertests\": \"0dd6ecc554f94bf3a692a3972a069a2269209e88\", \"extensions_unittests\": \"ab08e791918d7e05b0e8bfca6f1968d0b5648537\", \"filesystem_service_unittests\": \"2e393f1ca1e5abdeb6520eedc5eee67cf427c162\", \"gcm_unit_tests\": \"5acf4f80cba41489c16403e50fb5c12ad329f920\", \"gcp_unittests\": \"87fdf489ea12e91a76bfe60f941abe2bf3d48b13\", \"gfx_unittests\": \"62a35cbb74a3d95f9265fee4eb7a4c65442ee184\", \"gin_unittests\": \"abd2a2fe640f16cba0d1caee931cef89d9ebe616\", \"google_apis_unittests\": \"441bc8c2cd2d07a0c04ec42f82b3b54c18596b87\", \"gpu_unittests\": \"ea07025930c969ec26f27793f79f457c037ac010\", \"gwp_asan_unittests\": \"17e9da5706702e06fd5b8f4704b2b48cc3cfed00\", \"headless_browsertests\": \"a4aa83775aa0982249174a55a965e1718884f468\", \"headless_unittests\": \"4e27ffefb238ff1ff90cb958317eb3ca023bdb4d\", \"install_static_unittests\": \"5553525a01c360c3acbe47ba69827b6e5b3163af\", \"installer_util_unittests\": \"2bfc09afbcffdcdec6292760f8cb4263442435e1\", \"interactive_ui_tests\": \"a6ed7f7f53ea34a3de64e695caf784df892b72aa\", \"ipc_tests\": \"3e329184dc3e77d82ab206792fbee0238a3dd405\", \"jingle_unittests\": \"6db4b4e425e924164fbf3d7760bb0de58f2819de\", \"latency_unittests\": \"3452172c9148932eefb65d9144348e93629b429e\", \"libjingle_xmpp_unittests\": \"9c76447989817a89f8868d41c9e25bdb0fa73f76\", \"liburlpattern_unittests\": \"24325efa6c4b05b67f1a99ede9659da55eb0fe95\", \"media_blink_unittests\": \"addb99daa51af3e6123bfb3508b725ac6e4b5df8\", \"media_unittests\": \"c37ebc942cac1f936941fc802c96f906cecd4c98\", \"message_center_unittests\": \"45d545aae6bf77f9dd5e70c341430e05c792d0d1\", \"midi_unittests\": \"3431d123c50d7ab42c83879651b3ff1561f6a9ed\", \"mojo_core_unittests\": \"2c03871e015272be2c32470c6d3d09fa40f247ef\", \"mojo_unittests\": \"c2c317bd79dea6acaae96290e005bef1e56f9cf2\", \"nacl_loader_unittests\": \"3fbf12948be9e9b94595a64d13e05b629ad92bd2\", \"native_theme_unittests\": \"8f880d349574bf07562594a9beebb50bea9c6d84\", \"net_unittests\": \"def1f96ab63f887db78a59d6364f67addfd5dbf5\", \"notification_helper_unittests\": \"e1053f0809fd3440235c5276859f0a04491d2974\", \"pdf_unittests\": \"621ebedc1b0c3f47428e7de065e84dcbd982944f\", \"perfetto_unittests\": \"68dcbfc337e9d5edce0f8b4df821b67f775f9d49\", \"ppapi_unittests\": \"8f2fdc93ea3a01678954c00941bafaf2023100cf\", \"printing_unittests\": \"fb70ff6afceac332d1b804c8e5f5163522e18308\", \"remoting_unittests\": \"ccee98ef67af56f5a001a8ee2a5adeee12c3586a\", \"sbox_integration_tests\": \"fdaaa55e3e6b573fa9def920867a80cbff9f07f3\", \"sbox_unittests\": \"0a563d8a06a6d5da0babfe9ed7e726f1edd28ba5\", \"sbox_validation_tests\": \"49acd55f008a6915a6c0b0dfe94ca8c70dcfac83\", \"service_manager_unittests\": \"dde58b1dcae6ceef3d97ef877dfab0a407b0eafc\", \"services_unittests\": \"fc23e16da57e3f023d9aa2cc01a0375612af9906\", \"setup_unittests\": \"b2a76eedcc4ff99ab9f7b55c2189b62e55a36a07\", \"shell_dialogs_unittests\": \"6c5bcfbd648a4d6bc30981102aa50c5a4835078a\", \"skia_unittests\": \"9f26c04030101310528901de521a7bf699ceb351\", \"snapshot_unittests\": \"ab5c9cb7dac17ae75fc99f2eede88ffa0c3b2024\", \"sql_unittests\": \"e1d5a1703aab304667897afcaea6fcbf3581676b\", \"storage_unittests\": \"8b1996ae556327b8f63ae3d9e9b96d13350f6543\", \"sync_integration_tests\": \"84d4a345422dff694aef18dbf9dd91c3377877ac\", \"traffic_annotation_auditor_unittests\": \"0138cf70b8407f802d82e520ef71c72d844cb74c\", \"ui_base_unittests\": \"d9a0ea181e1359a6bb7e65042252f76cd0ff3301\", \"ui_touch_selection_unittests\": \"04e4f4d87934ba679231253a34543c142fcd840d\", \"unit_tests\": \"50270eb36bbffb783ea204f6e8f7b9b820a528d8\", \"updater_tests\": \"935c9567620ddb7245a5b243e72cb4add8441b26\", \"url_unittests\": \"6556660773b2ee10d1d3ad4dc2800df749ab868e\", \"views_unittests\": \"dc2e71de62e199829423cdfbe4750c8b5f838243\", \"viz_unittests\": \"5b81facbfb5983aa234af8057d4aefebbb9d10fa\", \"vr_common_unittests\": \"14ca6dc225e3d65997e100842bc208a97a3382a9\", \"vr_pixeltests\": \"b9148db22b5d398fcd3a632bd96034a9ca49f2db\", \"weblayer_browsertests\": \"6535ab310223c2376e10f0214ecc5f775977b919\", \"weblayer_unittests\": \"c2d78605ec6ea8f5b6e3b33cd102f718c1852a2a\", \"wm_unittests\": \"0d1e61390f1fe9c6a3dfe5e9e57bc231fe9539ba\", \"wtf_unittests\": \"7c956bc0e603569861376a952d8dec60f69c4823\", \"zlib_unittests\": \"7408625b6b786e97d67ed47a4694dbe3ff4f7b75\", \"zucchini_unittests\": \"26f1c8e3dede5528000f31b171df03a9448dd6a9\"}}, \"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": "1604462604208778",
"status": "COMPLETED",
"status_changed_ts": "1604465929449186",
"tags": [
"build_address:luci.chromium.ci/win-asan/15447",
"builder:win-asan",
"buildset:commit/git/0526cc47b2634370c304d9daba9142807fc01cec",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0526cc47b2634370c304d9daba9142807fc01cec",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030022802538987392",
"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/8864592740021392016/+/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:4faa3deda31cb210",
"user_agent:luci-scheduler"
],
"updated_ts": "1604465929453748",
"url": "https://ci.chromium.org/b/8864592740021392016",
"utcnow_ts": "1604465930290237"
}
}
[04:58:50.299] Invocation finished in 55m31.43666309s with status SUCCEEDED