[23:29:45.218] New invocation is queued and will start shortly
[23:29:46.549] Starting the invocation (attempt 1)
[23:29:46.579] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:29:46.579] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:29:46.579] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9024875986430007168",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"49e83833ef3cdeaad422805c0045e9a5cccb376b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9024875986430007168",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/49e83833ef3cdeaad422805c0045e9a5cccb376b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/49e83833ef3cdeaad422805c0045e9a5cccb376b",
"gitiles_ref:refs/heads/master"
]
}
[23:29:47.598] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1609370986692488",
"id": "8859445924217179824",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"49e83833ef3cdeaad422805c0045e9a5cccb376b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1609370987480936",
"tags": [
"build_address:luci.chromium.ci/win-asan/16562",
"builder:win-asan",
"buildset:commit/git/49e83833ef3cdeaad422805c0045e9a5cccb376b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/49e83833ef3cdeaad422805c0045e9a5cccb376b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024875986430007168",
"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/8859445924217179824/+/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": "1609370987481368",
"url": "https://ci.chromium.org/b/8859445924217179824",
"utcnow_ts": "1609370987588544"
}
}
[23:29:47.598] Task URL: https://ci.chromium.org/b/8859445924217179824
[23:29:47.598] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:2:0) after 1m0s
[23:29:51.466] Received PubSub notification, asking Buildbucket for the build status
[23:29:51.524] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:47.695] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:2:0)
[23:30:47.695] Timer tick, asking Buildbucket for the build status
[23:30:48.036] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:48.036] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:4:0) after 1m0s
[23:31:48.165] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:4:0)
[23:31:48.165] Timer tick, asking Buildbucket for the build status
[23:31:48.442] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:48.442] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:5:0) after 1m0s
[23:32:48.525] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:5:0)
[23:32:48.525] Timer tick, asking Buildbucket for the build status
[23:32:48.635] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:48.635] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:6:0) after 1m0s
[23:33:48.688] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:6:0)
[23:33:48.688] Timer tick, asking Buildbucket for the build status
[23:33:48.861] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:48.861] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:7:0) after 1m0s
[23:34:48.908] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:7:0)
[23:34:48.908] Timer tick, asking Buildbucket for the build status
[23:34:49.105] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:49.105] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:8:0) after 1m0s
[23:35:49.290] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:8:0)
[23:35:49.290] Timer tick, asking Buildbucket for the build status
[23:35:49.370] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:49.370] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:9:0) after 1m0s
[23:36:49.425] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:9:0)
[23:36:49.425] Timer tick, asking Buildbucket for the build status
[23:36:49.484] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:49.484] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:10:0) after 1m0s
[23:37:49.549] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:10:0)
[23:37:49.549] Timer tick, asking Buildbucket for the build status
[23:37:49.703] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:49.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:11:0) after 1m0s
[23:38:49.842] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:11:0)
[23:38:49.842] Timer tick, asking Buildbucket for the build status
[23:38:49.950] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:49.950] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:12:0) after 1m0s
[23:39:50.003] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:12:0)
[23:39:50.003] Timer tick, asking Buildbucket for the build status
[23:39:50.303] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:50.303] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:13:0) after 1m0s
[23:40:50.329] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:13:0)
[23:40:50.329] Timer tick, asking Buildbucket for the build status
[23:40:50.393] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:50.393] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:14:0) after 1m0s
[23:41:50.556] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:14:0)
[23:41:50.556] Timer tick, asking Buildbucket for the build status
[23:41:50.674] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:50.674] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:15:0) after 1m0s
[23:42:50.802] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:15:0)
[23:42:50.802] Timer tick, asking Buildbucket for the build status
[23:42:50.906] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:50.907] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:16:0) after 1m0s
[23:43:51.058] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:16:0)
[23:43:51.058] Timer tick, asking Buildbucket for the build status
[23:43:51.185] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:51.185] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:17:0) after 1m0s
[23:44:51.233] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:17:0)
[23:44:51.233] Timer tick, asking Buildbucket for the build status
[23:44:51.459] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:51.459] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:18:0) after 1m0s
[23:45:51.595] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:18:0)
[23:45:51.595] Timer tick, asking Buildbucket for the build status
[23:45:51.722] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:51.722] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:19:0) after 1m0s
[23:46:51.751] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:19:0)
[23:46:51.751] Timer tick, asking Buildbucket for the build status
[23:46:51.943] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:51.943] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:20:0) after 1m0s
[23:47:52.023] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:20:0)
[23:47:52.023] Timer tick, asking Buildbucket for the build status
[23:47:52.498] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:52.498] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:21:0) after 1m0s
[23:48:52.657] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:21:0)
[23:48:52.657] Timer tick, asking Buildbucket for the build status
[23:48:52.899] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:52.899] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:22:0) after 1m0s
[23:49:52.943] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:22:0)
[23:49:52.943] Timer tick, asking Buildbucket for the build status
[23:49:53.052] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:53.052] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:23:0) after 1m0s
[23:50:53.231] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:23:0)
[23:50:53.231] Timer tick, asking Buildbucket for the build status
[23:50:53.324] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:53.325] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:24:0) after 1m0s
[23:51:53.591] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:24:0)
[23:51:53.591] Timer tick, asking Buildbucket for the build status
[23:51:54.143] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:54.143] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:25:0) after 1m0s
[23:52:54.332] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:25:0)
[23:52:54.332] Timer tick, asking Buildbucket for the build status
[23:52:54.406] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:54.406] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:26:0) after 1m0s
[23:53:54.624] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:26:0)
[23:53:54.624] Timer tick, asking Buildbucket for the build status
[23:53:54.683] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:54.683] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:27:0) after 1m0s
[23:54:54.782] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:27:0)
[23:54:54.782] Timer tick, asking Buildbucket for the build status
[23:54:54.870] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:54.870] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:28:0) after 1m0s
[23:55:55.042] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:28:0)
[23:55:55.042] Timer tick, asking Buildbucket for the build status
[23:55:55.285] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:55.285] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:29:0) after 1m0s
[23:56:55.516] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:29:0)
[23:56:55.516] Timer tick, asking Buildbucket for the build status
[23:56:55.575] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:55.575] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:30:0) after 1m0s
[23:57:55.725] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:30:0)
[23:57:55.725] Timer tick, asking Buildbucket for the build status
[23:57:55.839] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:55.839] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:31:0) after 1m0s
[23:58:56.217] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:31:0)
[23:58:56.217] Timer tick, asking Buildbucket for the build status
[23:58:56.291] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:56.291] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:32:0) after 1m0s
[23:59:56.563] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:32:0)
[23:59:56.563] Timer tick, asking Buildbucket for the build status
[23:59:56.694] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:56.694] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:33:0) after 1m0s
[00:00:56.768] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:33:0)
[00:00:56.768] Timer tick, asking Buildbucket for the build status
[00:00:56.846] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:56.846] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:34:0) after 1m0s
[00:01:56.918] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:34:0)
[00:01:56.918] Timer tick, asking Buildbucket for the build status
[00:01:57.003] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:57.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:35:0) after 1m0s
[00:02:57.034] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:35:0)
[00:02:57.035] Timer tick, asking Buildbucket for the build status
[00:02:57.201] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:57.201] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:36:0) after 1m0s
[00:03:57.210] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:36:0)
[00:03:57.210] Timer tick, asking Buildbucket for the build status
[00:03:57.318] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:57.318] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:37:0) after 1m0s
[00:04:57.331] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:37:0)
[00:04:57.331] Timer tick, asking Buildbucket for the build status
[00:04:57.442] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:57.442] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:38:0) after 1m0s
[00:05:57.460] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:38:0)
[00:05:57.460] Timer tick, asking Buildbucket for the build status
[00:05:57.558] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:57.558] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:39:0) after 1m0s
[00:06:57.594] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:39:0)
[00:06:57.594] Timer tick, asking Buildbucket for the build status
[00:06:58.005] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:58.005] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:40:0) after 1m0s
[00:07:58.006] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:40:0)
[00:07:58.006] Timer tick, asking Buildbucket for the build status
[00:07:58.135] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:58.135] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:41:0) after 1m0s
[00:08:58.605] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:41:0)
[00:08:58.605] Timer tick, asking Buildbucket for the build status
[00:08:58.661] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:58.661] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:42:0) after 1m0s
[00:09:58.790] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:42:0)
[00:09:58.790] Timer tick, asking Buildbucket for the build status
[00:09:58.941] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:58.941] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:43:0) after 1m0s
[00:10:59.277] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:43:0)
[00:10:59.277] Timer tick, asking Buildbucket for the build status
[00:10:59.381] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:59.381] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:44:0) after 1m0s
[00:11:59.692] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:44:0)
[00:11:59.692] Timer tick, asking Buildbucket for the build status
[00:11:59.811] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:59.811] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:45:0) after 1m0s
[00:12:59.900] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:45:0)
[00:12:59.900] Timer tick, asking Buildbucket for the build status
[00:13:00.143] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:00.143] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:46:0) after 1m0s
[00:14:00.245] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:46:0)
[00:14:00.245] Timer tick, asking Buildbucket for the build status
[00:14:00.367] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:00.367] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:47:0) after 1m0s
[00:15:00.434] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:47:0)
[00:15:00.434] Timer tick, asking Buildbucket for the build status
[00:15:00.588] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:00.588] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:48:0) after 1m0s
[00:16:00.769] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:48:0)
[00:16:00.769] Timer tick, asking Buildbucket for the build status
[00:16:00.852] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:00.852] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:49:0) after 1m0s
[00:17:01.281] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:49:0)
[00:17:01.281] Timer tick, asking Buildbucket for the build status
[00:17:01.349] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:01.349] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:50:0) after 1m0s
[00:18:01.646] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:50:0)
[00:18:01.646] Timer tick, asking Buildbucket for the build status
[00:18:01.730] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:01.730] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:51:0) after 1m0s
[00:19:01.874] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:51:0)
[00:19:01.874] Timer tick, asking Buildbucket for the build status
[00:19:02.021] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:02.021] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:52:0) after 1m0s
[00:20:02.376] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:52:0)
[00:20:02.376] Timer tick, asking Buildbucket for the build status
[00:20:02.518] Build 8859445924217179824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:02.518] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024875986430007168:53:0) after 1m0s
[00:21:00.884] Received PubSub notification, asking Buildbucket for the build status
[00:21:01.187] Build 8859445924217179824: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:21:01.187] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1609374058739118",
"created_by": "project:chromium",
"created_ts": "1609370986692488",
"id": "8859445924217179824",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"49e83833ef3cdeaad422805c0045e9a5cccb376b\"}}",
"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\": \"49e83833ef3cdeaad422805c0045e9a5cccb376b\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-win10-us-central1-b-32-1-2sgf\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16562, \"clang_revision\": \"llvmorg-12-init-12923-g6ee22ca6-1\", \"got_angle_revision\": \"938399865e720c2e37616cdad64109ef331bb035\", \"got_dawn_revision\": \"86980018b3f2786aeb5ded1220ec94bc927fa6b2\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"49e83833ef3cdeaad422805c0045e9a5cccb376b\", \"got_revision_cp\": \"refs/heads/master@{#839815}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"ff29e249d3179766a40c9486183559fe3e5c1456\", \"got_v8_revision\": \"ef6c61213b14d3cf31e97bbd314e1dda24794a0d\", \"got_v8_revision_cp\": \"refs/heads/8.9.199@{#1}\", \"got_webrtc_revision\": \"f86cf4c2de2fb6fa37a2637b4613c37c9b75f48a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32890}\", \"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\": \"49e83833ef3cdeaad422805c0045e9a5cccb376b\", \"swarm_hashes_refs/heads/master(at){#839815}_without_patch\": {\"absl_hardening_tests\": \"3ca82dbaabba65bac2cba0d03cfaec3dc2c31202\", \"accessibility_unittests\": \"6a4a035aa6c0bd7cded342ea67c4eedd5b376c9d\", \"angle_unittests\": \"39633b6a117ed071d66aed213cb361fc84fbd497\", \"app_shell_unittests\": \"62a02f1a00e0252cbd2aad32c5bbd87f405fa1f7\", \"aura_unittests\": \"de80d334411c28063f3c0272bfa7d74b3705d3a4\", \"base_unittests\": \"937d73d48e1882e8fabb28cbe73badd20fdc45c6\", \"base_util_unittests\": \"1cdc7016aa67f7db15faf4afc6cd35c76f2d87e3\", \"blink_common_unittests\": \"7c2303cea2fd50dd2c32d790f4989ac1a9a26e4d\", \"blink_fuzzer_unittests\": \"2c7a80a70c98ed9c8e2660b273995bab28d4299e\", \"blink_heap_unittests\": \"96be0639c97d1312c853a37932de34d98a0d3ea0\", \"blink_platform_unittests\": \"ba098b5be5dbffc7ca1a8bb2b62c1e0bb11d639d\", \"blink_unittests\": \"8933bf91dd7ae4c8fce6fe56c7866b6fd88b38b4\", \"boringssl_crypto_tests\": \"7a30a92e8c1600f750e0f0c953f76839ce17c5b6\", \"boringssl_ssl_tests\": \"f39aa66eba77f3141a5a1aae04323814c055ba8f\", \"browser_switcher_bho_unittests\": \"65e5528c655665a92c69e44475d7b8df5be95ccd\", \"browser_tests\": \"99540785a6550b5a8750219080211875eb91a493\", \"capture_unittests\": \"6d95eb0e31db20fb785bbd62c785882165bfd3b1\", \"cast_unittests\": \"10d0b8f343d482a0785e1b07f800a8637a1879aa\", \"cc_unittests\": \"af71532e4054a0a2c32d349cc7f21e313abb0edb\", \"chrome_app_unittests\": \"a9e4e4c9b41e31b0df59742b6cc79fd31ce99f71\", \"chrome_cleaner_unittests\": \"810364de716f49e37f39a532ea2d5b06cecf4c82\", \"chrome_elf_unittests\": \"b769cd84d43d6ee2f58d91eca209d858e7a81414\", \"chromedriver_unittests\": \"9e93d71763571bdb89ba433cad380857c254b852\", \"components_browsertests\": \"48d95cfc7970b362af17dc78850248a10512cc70\", \"components_unittests\": \"9a3b900e86bea2d60be9958f0aafd415e2a4d3a9\", \"compositor_unittests\": \"c6ab2d653c7707ca14188f44878270739e5f3f52\", \"content_browsertests\": \"4b49bebd63cf21db54ec6cc6d4a7804a5d7882fc\", \"content_unittests\": \"1ae45aeee9f18f81a8d9dd8dfec0dac1dd12e176\", \"courgette_unittests\": \"1b51ca14e8a1ce0a89e692766794f1d2b7e11dd5\", \"crashpad_tests\": \"bd8dbd1ed9c418781e470d952c975ebbaa95bcef\", \"cronet_tests\": \"7e10d3d1da3d212c774ebfe29d78f1ba93e3da15\", \"cronet_unittests\": \"2281d4abb4dc5aee20492423fb3b7df3a9fbd6e2\", \"crypto_unittests\": \"bfd899cacdc1ba9e35e38a0844284d3dac46f755\", \"delayloads_unittests\": \"9451f2b12d3aaf86a90514fd711142ebe410f438\", \"device_unittests\": \"8a921c06877ad8b29589d055e0130393a0a16785\", \"display_unittests\": \"a1f9c4160045f8fbdf07bf388358d0dd3cb46a67\", \"elevation_service_unittests\": \"58467108d2d2f5cb2b23794510f85be98265eb38\", \"events_unittests\": \"8e250cfeadb0ad1ebc881bbc6ba4a1c58f4fe854\", \"extensions_browsertests\": \"c60eb758ce7a09cfff0922195b8872c26b13bbdc\", \"extensions_unittests\": \"a728e2c4d601894f70407a58f533a99dbe44d346\", \"filesystem_service_unittests\": \"04193e33bf434a5c9b864fb3f270b516db11427f\", \"gcm_unit_tests\": \"91c063b0cb72ff3e4cecfb2295d0d97015115b9b\", \"gcp_unittests\": \"249e0f430c32dea541b72ef9b1e1981fc5452a28\", \"gfx_unittests\": \"8e60d7638a025acf1682d2cf12b64f7e6b839f6a\", \"gin_unittests\": \"c6b4ea0a8d86759baa22b2e50afe45dfb3352260\", \"google_apis_unittests\": \"1ce3fd01739c0f6846e41b91941693eff127738e\", \"gpu_unittests\": \"4e455ec8d5c16c1d5d08f0f83ec7ce229902ea18\", \"gwp_asan_unittests\": \"0bf41fb37aa03105eb69a6661850bdb84796ad61\", \"headless_browsertests\": \"72624de9a24be8b6b1f27bbb79d890a1e7c286a5\", \"headless_unittests\": \"55d29a6a04e5a4d53da704eb4e9f28aa6b73be7b\", \"install_static_unittests\": \"37c9c1e050cebe0124eb8b80d122d3622e5903f3\", \"installer_util_unittests\": \"bcd10dd5a1261fdd607d69c261b9d839c101b894\", \"interactive_ui_tests\": \"aff5e45aec6b070aff3e48ead18db74006fb5bbb\", \"ipc_tests\": \"703e7aad2a1d1d7069bc9a981c770575e887ac5b\", \"jingle_unittests\": \"e25fb4169b0b5841195eb5e1a525389cd7766215\", \"latency_unittests\": \"64cb76fe7bf1cfec9678e5b87bfbaaacbf55dbd7\", \"libjingle_xmpp_unittests\": \"5df25f941cdf39d69d6028544d4588653fe61515\", \"liburlpattern_unittests\": \"9ef69c8d10127418c5d86c59cc4bfb0079114634\", \"media_blink_unittests\": \"c501019246aa9834cc893c73ee444c870ffba978\", \"media_unittests\": \"ebaf5e0238bc4cef2bad63226b6f8b5e035a75df\", \"message_center_unittests\": \"5149f01c73255777b002f2019630ceed25619854\", \"midi_unittests\": \"1f23186c5023e9318867a5b2c305a85cf10f6a29\", \"mojo_core_unittests\": \"2cdceb1d9035231fa21918ec38a12b347605a8e9\", \"mojo_unittests\": \"589b20f3c5ac0b508caee72621dee0dda4c4375f\", \"nacl_loader_unittests\": \"dd087349bd5b60fa659898b44d52c6762031b76f\", \"native_theme_unittests\": \"5ea80d28d3f88a824abe3d4caba804b4a3e6ce60\", \"net_unittests\": \"b09c94ee504e556cb8203267d20b3ee85dad0fd6\", \"notification_helper_unittests\": \"8c2ce2bf28f49c3f79a716893dd26b4e39faeb34\", \"pdf_unittests\": \"923d26a0d2c50147577c6bb3cb10f84b8b95c2b4\", \"perfetto_unittests\": \"0cdda5fb1714d9c963bb7b03b4fc73cf3a2e0123\", \"ppapi_unittests\": \"ac020c69bcef8039baf8e8d7e2fe1c934e8e3cc7\", \"printing_unittests\": \"9eb661078b60d418165579e82c62956a77137abb\", \"remoting_unittests\": \"ea5ab3421d3d14fbccb97fef24a085e082e395f6\", \"sbox_integration_tests\": \"b4cc33443f0ef416f54fdbf72215bf8f2c2511c8\", \"sbox_unittests\": \"2327f7e72bc2dcd8cde8f208da45308d13dd803c\", \"sbox_validation_tests\": \"2d9bf615dc9df4dc6916bb58abc3a06c0e0e34a3\", \"service_manager_unittests\": \"5c7cc8cb11b1b239b7c32040ec874d40fdc9a6fe\", \"services_unittests\": \"837da1d4f3cf570e5632efd319a5b0442142dd4e\", \"setup_unittests\": \"733ef137bbcbe1f24065a6ae00ef64c7ab672cea\", \"shell_dialogs_unittests\": \"26b301bab3238d3a51ca3365f3975d79d0d41778\", \"skia_unittests\": \"de32844b805f803e6c1f7457584601bb4680dfee\", \"snapshot_unittests\": \"bb846e369dfa6765d414fbbad455c67128a81541\", \"sql_unittests\": \"02cfd58ed75e20ef8385687ef0bce4d021d77a31\", \"storage_unittests\": \"059deb644149c038828ee6d41f675a23e60dbda5\", \"sync_integration_tests\": \"d3413a98b5519c48838c1ace483cc48926d2e016\", \"traffic_annotation_auditor_unittests\": \"711db2a359dc2a4b1f6f071ac7cc815bf112ccf4\", \"ui_base_unittests\": \"01f49e253a02091ab5ff23bfa76c7162783ee6aa\", \"ui_touch_selection_unittests\": \"142659ff90b2bd45e15e93764c318da18be4a5b6\", \"unit_tests\": \"40430909992350a55988904e17a948b1b3dd6961\", \"updater_tests\": \"bb73667caa2e97ae7245a0fe107167140c890609\", \"url_unittests\": \"b9f9501c1ddbc70b8e8de58943143fe0cd47f116\", \"views_unittests\": \"6cd296dfcfc2431c90d49486ad0ef60577ed1cc4\", \"viz_unittests\": \"08fa5788931fa21e24899a7b05eab65f3bcbfef4\", \"vr_common_unittests\": \"d4e896c9433ca9b778c3cdc16ef50e1bcd67940a\", \"vr_pixeltests\": \"264e1d08b1fff4ff0c7355c8ae5774868c54d7e1\", \"weblayer_browsertests\": \"182dc5326ee915634a7b0d8fae2705ba9dadb7df\", \"weblayer_unittests\": \"304929e7c2d7f7e904d4ceaf231b318530e7c5b1\", \"wm_unittests\": \"cb50a50ed459dca8706b97d5b93c7dc2d5b1668e\", \"wtf_unittests\": \"41bbde7cadf473dc2cfd1f647b070b8391bfa1c5\", \"zlib_unittests\": \"8d05b34c1745fd5be9008b0cc3048b4964142e04\", \"zucchini_unittests\": \"d3575d6467120e8f35e7adcf9a6b99d1da2fbc0b\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-us-central1-b-32-1-2sgf\"], \"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\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1609370989438241",
"status": "COMPLETED",
"status_changed_ts": "1609374059319755",
"tags": [
"build_address:luci.chromium.ci/win-asan/16562",
"builder:win-asan",
"buildset:commit/git/49e83833ef3cdeaad422805c0045e9a5cccb376b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/49e83833ef3cdeaad422805c0045e9a5cccb376b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024875986430007168",
"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/8859445924217179824/+/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:50cecdf4e0a0f010",
"user_agent:luci-scheduler"
],
"updated_ts": "1609374059401040",
"url": "https://ci.chromium.org/b/8859445924217179824",
"utcnow_ts": "1609374061135150"
}
}
[00:21:01.187] Invocation finished in 51m15.988757882s with status SUCCEEDED