[10:45:28.713] New invocation is queued and will start shortly
[10:45:29.844] Starting the invocation (attempt 1)
[10:45:29.877] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:45:29.878] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:45:29.878] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021753176632263216",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e8c8a7fd22c3392c8fc83ec48ec2f1cab3a4e207\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9021753176632263216",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/e8c8a7fd22c3392c8fc83ec48ec2f1cab3a4e207",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e8c8a7fd22c3392c8fc83ec48ec2f1cab3a4e207",
"gitiles_ref:refs/heads/master"
]
}
[10:45:30.682] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612349129967442",
"id": "8856323114654277680",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e8c8a7fd22c3392c8fc83ec48ec2f1cab3a4e207\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612349130473599",
"tags": [
"build_address:luci.chromium.ci/win-asan/17146",
"builder:win-asan",
"buildset:commit/git/e8c8a7fd22c3392c8fc83ec48ec2f1cab3a4e207",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e8c8a7fd22c3392c8fc83ec48ec2f1cab3a4e207",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021753176632263216",
"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/8856323114654277680/+/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": "1612349130473780",
"url": "https://ci.chromium.org/b/8856323114654277680",
"utcnow_ts": "1612349130672006"
}
}
[10:45:30.682] Task URL: https://ci.chromium.org/b/8856323114654277680
[10:45:30.682] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:2:0) after 1m0s
[10:45:32.569] Received PubSub notification, asking Buildbucket for the build status
[10:45:32.677] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:30.720] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:2:0)
[10:46:30.720] Timer tick, asking Buildbucket for the build status
[10:46:30.922] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:30.922] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:4:0) after 1m0s
[10:47:30.939] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:4:0)
[10:47:30.939] Timer tick, asking Buildbucket for the build status
[10:47:31.046] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:31.047] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:5:0) after 1m0s
[10:48:31.223] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:5:0)
[10:48:31.223] Timer tick, asking Buildbucket for the build status
[10:48:31.338] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:31.338] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:6:0) after 1m0s
[10:49:31.462] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:6:0)
[10:49:31.462] Timer tick, asking Buildbucket for the build status
[10:49:31.628] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:31.628] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:7:0) after 1m0s
[10:50:31.731] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:7:0)
[10:50:31.731] Timer tick, asking Buildbucket for the build status
[10:50:32.023] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:32.023] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:8:0) after 1m0s
[10:51:32.127] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:8:0)
[10:51:32.127] Timer tick, asking Buildbucket for the build status
[10:51:32.670] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:32.670] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:9:0) after 1m0s
[10:52:32.774] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:9:0)
[10:52:32.774] Timer tick, asking Buildbucket for the build status
[10:52:32.852] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:32.852] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:10:0) after 1m0s
[10:53:32.911] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:10:0)
[10:53:32.911] Timer tick, asking Buildbucket for the build status
[10:53:32.984] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:32.984] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:11:0) after 1m0s
[10:54:34.134] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:11:0)
[10:54:34.134] Timer tick, asking Buildbucket for the build status
[10:54:34.185] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:34.185] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:12:0) after 1m0s
[10:55:34.385] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:12:0)
[10:55:34.385] Timer tick, asking Buildbucket for the build status
[10:55:34.480] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:34.480] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:13:0) after 1m0s
[10:56:34.758] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:13:0)
[10:56:34.759] Timer tick, asking Buildbucket for the build status
[10:56:34.879] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:34.879] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:14:0) after 1m0s
[10:57:36.392] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:14:0)
[10:57:36.392] Timer tick, asking Buildbucket for the build status
[10:57:36.627] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:36.627] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:15:0) after 1m0s
[10:58:36.883] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:15:0)
[10:58:36.883] Timer tick, asking Buildbucket for the build status
[10:58:36.944] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:36.944] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:16:0) after 1m0s
[10:59:37.339] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:16:0)
[10:59:37.339] Timer tick, asking Buildbucket for the build status
[10:59:37.398] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:37.398] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:17:0) after 1m0s
[11:00:37.529] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:17:0)
[11:00:37.529] Timer tick, asking Buildbucket for the build status
[11:00:37.833] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:37.833] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:18:0) after 1m0s
[11:01:38.001] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:18:0)
[11:01:38.001] Timer tick, asking Buildbucket for the build status
[11:01:38.307] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:38.307] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:19:0) after 1m0s
[11:02:38.441] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:19:0)
[11:02:38.441] Timer tick, asking Buildbucket for the build status
[11:02:38.526] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:38.526] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:20:0) after 1m0s
[11:03:38.603] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:20:0)
[11:03:38.603] Timer tick, asking Buildbucket for the build status
[11:03:38.668] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:38.668] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:21:0) after 1m0s
[11:04:39.031] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:21:0)
[11:04:39.031] Timer tick, asking Buildbucket for the build status
[11:04:39.157] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:39.157] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:22:0) after 1m0s
[11:05:39.398] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:22:0)
[11:05:39.398] Timer tick, asking Buildbucket for the build status
[11:05:39.587] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:39.587] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:23:0) after 1m0s
[11:06:39.743] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:23:0)
[11:06:39.743] Timer tick, asking Buildbucket for the build status
[11:06:39.848] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:39.848] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:24:0) after 1m0s
[11:07:39.979] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:24:0)
[11:07:39.979] Timer tick, asking Buildbucket for the build status
[11:07:40.183] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:40.183] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:25:0) after 1m0s
[11:08:40.387] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:25:0)
[11:08:40.387] Timer tick, asking Buildbucket for the build status
[11:08:40.508] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:40.508] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:26:0) after 1m0s
[11:09:40.579] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:26:0)
[11:09:40.579] Timer tick, asking Buildbucket for the build status
[11:09:41.345] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:41.345] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:27:0) after 1m0s
[11:10:41.466] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:27:0)
[11:10:41.466] Timer tick, asking Buildbucket for the build status
[11:10:41.617] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:41.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:28:0) after 1m0s
[11:11:41.659] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:28:0)
[11:11:41.659] Timer tick, asking Buildbucket for the build status
[11:11:41.866] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:41.866] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:29:0) after 1m0s
[11:12:41.891] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:29:0)
[11:12:41.891] Timer tick, asking Buildbucket for the build status
[11:12:43.794] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:43.794] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:30:0) after 1m0s
[11:13:43.924] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:30:0)
[11:13:43.924] Timer tick, asking Buildbucket for the build status
[11:13:44.465] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:44.465] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:31:0) after 1m0s
[11:14:44.639] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:31:0)
[11:14:44.639] Timer tick, asking Buildbucket for the build status
[11:14:48.110] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:48.110] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:32:0) after 1m0s
[11:15:48.163] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:32:0)
[11:15:48.163] Timer tick, asking Buildbucket for the build status
[11:15:51.150] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:51.150] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:33:0) after 1m0s
[11:16:51.204] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:33:0)
[11:16:51.204] Timer tick, asking Buildbucket for the build status
[11:16:54.814] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:54.814] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:34:0) after 1m0s
[11:17:54.811] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:34:0)
[11:17:54.811] Timer tick, asking Buildbucket for the build status
[11:17:56.527] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:56.527] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:35:0) after 1m0s
[11:18:56.505] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:35:0)
[11:18:56.505] Timer tick, asking Buildbucket for the build status
[11:18:56.988] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:56.988] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:36:0) after 1m0s
[11:19:57.052] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:36:0)
[11:19:57.052] Timer tick, asking Buildbucket for the build status
[11:19:57.182] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:57.182] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:37:0) after 1m0s
[11:20:57.319] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:37:0)
[11:20:57.319] Timer tick, asking Buildbucket for the build status
[11:20:58.409] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:58.409] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:38:0) after 1m0s
[11:21:58.743] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:38:0)
[11:21:58.743] Timer tick, asking Buildbucket for the build status
[11:22:02.166] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:02.166] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:39:0) after 1m0s
[11:23:02.875] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:39:0)
[11:23:02.875] Timer tick, asking Buildbucket for the build status
[11:23:03.124] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:03.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:40:0) after 1m0s
[11:24:03.236] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:40:0)
[11:24:03.236] Timer tick, asking Buildbucket for the build status
[11:24:05.245] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:05.245] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:41:0) after 1m0s
[11:25:05.305] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:41:0)
[11:25:05.305] Timer tick, asking Buildbucket for the build status
[11:25:05.747] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:05.747] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:42:0) after 1m0s
[11:26:05.843] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:42:0)
[11:26:05.843] Timer tick, asking Buildbucket for the build status
[11:26:09.279] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:09.279] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:43:0) after 1m0s
[11:27:09.431] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:43:0)
[11:27:09.431] Timer tick, asking Buildbucket for the build status
[11:27:10.988] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:10.988] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:44:0) after 1m0s
[11:28:11.087] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:44:0)
[11:28:11.087] Timer tick, asking Buildbucket for the build status
[11:28:13.961] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:13.961] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:45:0) after 1m0s
[11:29:14.055] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:45:0)
[11:29:14.055] Timer tick, asking Buildbucket for the build status
[11:29:17.473] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:17.473] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:46:0) after 1m0s
[11:30:17.669] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:46:0)
[11:30:17.669] Timer tick, asking Buildbucket for the build status
[11:30:19.689] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:19.689] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:47:0) after 1m0s
[11:31:20.095] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:47:0)
[11:31:20.095] Timer tick, asking Buildbucket for the build status
[11:31:21.255] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:21.255] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:48:0) after 1m0s
[11:32:21.336] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:48:0)
[11:32:21.336] Timer tick, asking Buildbucket for the build status
[11:32:21.450] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:21.450] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:49:0) after 1m0s
[11:33:21.668] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:49:0)
[11:33:21.668] Timer tick, asking Buildbucket for the build status
[11:33:23.520] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:23.520] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:50:0) after 1m0s
[11:34:23.610] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:50:0)
[11:34:23.611] Timer tick, asking Buildbucket for the build status
[11:34:40.452] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:40.452] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:51:0) after 1m0s
[11:35:40.610] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:51:0)
[11:35:40.610] Timer tick, asking Buildbucket for the build status
[11:35:41.431] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:41.431] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:52:0) after 1m0s
[11:36:41.422] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:52:0)
[11:36:41.422] Timer tick, asking Buildbucket for the build status
[11:36:42.999] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:42.999] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:53:0) after 1m0s
[11:37:43.054] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:53:0)
[11:37:43.054] Timer tick, asking Buildbucket for the build status
[11:37:43.293] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:43.293] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:54:0) after 1m0s
[11:38:43.489] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:54:0)
[11:38:43.489] Timer tick, asking Buildbucket for the build status
[11:38:45.514] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:45.514] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:55:0) after 1m0s
[11:39:45.516] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:55:0)
[11:39:45.516] Timer tick, asking Buildbucket for the build status
[11:39:47.437] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:47.437] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:56:0) after 1m0s
[11:40:47.530] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:56:0)
[11:40:47.530] Timer tick, asking Buildbucket for the build status
[11:40:48.096] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:48.096] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:57:0) after 1m0s
[11:41:48.127] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:57:0)
[11:41:48.127] Timer tick, asking Buildbucket for the build status
[11:41:48.808] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:48.808] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:58:0) after 1m0s
[11:42:48.918] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:58:0)
[11:42:48.918] Timer tick, asking Buildbucket for the build status
[11:42:49.491] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:49.491] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:59:0) after 1m0s
[11:43:49.535] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:59:0)
[11:43:49.535] Timer tick, asking Buildbucket for the build status
[11:43:52.367] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:52.367] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:60:0) after 1m0s
[11:44:52.485] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:60:0)
[11:44:52.485] Timer tick, asking Buildbucket for the build status
[11:44:52.963] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:52.963] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:61:0) after 1m0s
[11:45:53.276] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:61:0)
[11:45:53.276] Timer tick, asking Buildbucket for the build status
[11:45:55.858] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:55.858] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:62:0) after 1m0s
[11:46:55.883] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:62:0)
[11:46:55.883] Timer tick, asking Buildbucket for the build status
[11:46:56.827] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:56.827] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:63:0) after 1m0s
[11:47:56.897] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:63:0)
[11:47:56.897] Timer tick, asking Buildbucket for the build status
[11:47:57.231] Build 8856323114654277680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:57.231] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021753176632263216:64:0) after 1m0s
[11:48:17.115] Received PubSub notification, asking Buildbucket for the build status
[11:48:17.482] Build 8856323114654277680: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:48:17.482] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612352889772744",
"created_by": "project:chromium",
"created_ts": "1612349129967442",
"id": "8856323114654277680",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e8c8a7fd22c3392c8fc83ec48ec2f1cab3a4e207\"}}",
"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\": \"e8c8a7fd22c3392c8fc83ec48ec2f1cab3a4e207\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-win10-32-0-be5b\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17146, \"clang_revision\": \"llvmorg-12-init-17251-g6de48655-1\", \"got_angle_revision\": \"6cc845bb0a603587ac36b900558d483e05f02f8c\", \"got_dawn_revision\": \"fd5fd05db039710c797ee8bac5e6d999173e5fc3\", \"got_nacl_revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\", \"got_revision\": \"e8c8a7fd22c3392c8fc83ec48ec2f1cab3a4e207\", \"got_revision_cp\": \"refs/heads/master@{#850049}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"51045556acd0fe0a1b687ef00725a57f0f19a91b\", \"got_v8_revision\": \"53720ace941d84ac17ae67a94166a363dcf0cacf\", \"got_v8_revision_cp\": \"refs/heads/9.0.123@{#1}\", \"got_webrtc_revision\": \"e7c79fd3d66e0f6c54c027f880a8b1682ebae58a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33124}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.win:win-asan\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e8c8a7fd22c3392c8fc83ec48ec2f1cab3a4e207\", \"swarm_hashes_refs/heads/master(at){#850049}_without_patch\": {\"absl_hardening_tests\": \"ef0f0cae7e28001006a2443cec323a7d24a8a4e8\", \"accessibility_unittests\": \"a9f79fa6dd190cf0933045b96a230a61ec609a0c\", \"angle_unittests\": \"4c7bad0c9a39526c8ccf232a770032962fb6d98f\", \"app_shell_unittests\": \"e955cea4bc72b6f40d188991067b2ec6b8fe33c1\", \"aura_unittests\": \"bf847377f48d8cf66ec9ef6b0160ab9a9855413a\", \"base_unittests\": \"c74c7615a7cea8ad9300504b740d8a9c9e953672\", \"base_util_unittests\": \"d9c740eaf7e7c6048b3a0bf5a289f266fb26845d\", \"blink_common_unittests\": \"006aad14e61bb45bcc7576de25947d05d3687b5c\", \"blink_fuzzer_unittests\": \"be89417a03a892f4405d2183132d2a357686fdc8\", \"blink_heap_unittests\": \"a6b0a79b785f8881013fa8587d6fdb131dc4e91e\", \"blink_platform_unittests\": \"5f2e1e78d63269aa73609c7c63ee21f839ce91a0\", \"blink_unittests\": \"384ae52309309959ce6d8afd15a8f4ca0c7f80fb\", \"boringssl_crypto_tests\": \"cb4ab8d3aa503d1cf9849357cd9ba463daddb12c\", \"boringssl_ssl_tests\": \"bf53ed4d3dd905a6eec6811075e10c11b2c4bd0a\", \"browser_switcher_bho_unittests\": \"895382379f79d1b8bb4a82c67d1b006ed4cb183b\", \"browser_tests\": \"3e79d62e284c0e0c32e48ccb723a05dd7997308b\", \"capture_unittests\": \"2ea6f9f4297da8fba93f9cd3d03599cd3a1e1d86\", \"cast_unittests\": \"4f12df7ec6e8210171209048db965babbeae5d6c\", \"cc_unittests\": \"56cb0455e66f79e9a0f9ace2fc38fce402332bad\", \"chrome_app_unittests\": \"9c73a2b546f1c60fe110391651bb2d8a90843f65\", \"chrome_cleaner_unittests\": \"fa172a3af9ff0be6dd96ad7f4e06ef10efaa2165\", \"chrome_elf_unittests\": \"bdab05630d15c24bc0531692b531bd124ad327e0\", \"chromedriver_unittests\": \"2674741ee2f9c931b20db349579caae11db328fe\", \"components_browsertests\": \"b25508eea4944d79ed0ffda7b83006f63ee64786\", \"components_unittests\": \"ab8b86fe6ed7e52fe91fd683fd018efacd44647f\", \"compositor_unittests\": \"83a3893788ab71da5b0cf35f70e77377877d4bc7\", \"content_browsertests\": \"2fdf96de63a50aa8caa8b5806d8d315d83031620\", \"content_unittests\": \"2d39829a3e5abf19b7809f02c1deea804f539e9f\", \"courgette_unittests\": \"06c99485e43463543152fc4491f30df936287b94\", \"crashpad_tests\": \"4c4a59fa5c52a6675a238ae6209f535b123acfc8\", \"cronet_tests\": \"45d342ec29f7424b4f03ef91f9ac3906e4b0bc28\", \"cronet_unittests\": \"275b4c913aa4471a0e0ceab3ad6c75739bf03320\", \"crypto_unittests\": \"e5fc234e041d0cb32f779233b2c3e67e2f083c12\", \"delayloads_unittests\": \"ee8fdca16b9c3f288235a1943225927d357ba430\", \"device_unittests\": \"d3e3fecd49dd6d80dbc397458e8ed9ccdf67aef1\", \"display_unittests\": \"09d64d8e230d0b2b9e0c173c321a341312a0ffec\", \"elevation_service_unittests\": \"5488e85d8feb46c4214b03b1b150aee344bf57e9\", \"events_unittests\": \"885764a7354bade18e7bea9becd214371dc63b16\", \"extensions_browsertests\": \"8ed6a12eb6c5dbb3175c2d5f7cffa42cd3ec518a\", \"extensions_unittests\": \"ae720ff7e28ff7c08020874069834ef5fc8d87a4\", \"filesystem_service_unittests\": \"ed7031f729fffd3567046db54a3362f414c7283b\", \"gcm_unit_tests\": \"4466c524108a4419112543bc2e20b57e6db21934\", \"gcp_unittests\": \"251b59c3658a9307e74e68bd7b786edbbedd6a7e\", \"gfx_unittests\": \"ede3c6679659c6dbfb8086bf0031e87652501f0b\", \"gin_unittests\": \"38e77e059184d89dfaa20982d4fb55d8cea3bc83\", \"google_apis_unittests\": \"946cdc0f9e598a3cc3c4d4697b080b48b49a2662\", \"gpu_unittests\": \"f76411f3608bed3f970f32748336f7af2332d960\", \"gwp_asan_unittests\": \"2b6651f2b5ea6163ef11e13d88fe428b0cbc29ee\", \"headless_browsertests\": \"1d0b0acb7cf2fdc66efa664b391b84d0f4ea17ba\", \"headless_unittests\": \"39432673acdc0216df723a7685a4a8186d727bc7\", \"install_static_unittests\": \"6fb847eaf6ccc6c46183ba64fc38624fe20e059c\", \"installer_util_unittests\": \"13e9d2a706b267104cee24fa8469b786d5f32367\", \"interactive_ui_tests\": \"8ce96411108ffe13e90cb447d1f74306d04864a2\", \"ipc_tests\": \"e583722c5faa944461304e7cd2ff9c66bba4f0b2\", \"jingle_unittests\": \"9db98cdc4bb581387a2cb0282f63c4cfdc3c5c9c\", \"latency_unittests\": \"68f25751f9691946b5e13ee935aa3c091edf58aa\", \"libjingle_xmpp_unittests\": \"90b8be5ee803631065db1ca1c9d16289ecf1a945\", \"liburlpattern_unittests\": \"4096642b1adba5dac7408bbf5a351d5b34fb255c\", \"media_blink_unittests\": \"116854d99e8d54f9ebce209a16b05fc0ad773560\", \"media_unittests\": \"0b91682d150ecb93d947b2880d68a071419dd589\", \"message_center_unittests\": \"c4df1bb8dfe3d28e23b5fcbbabe15edf707f86f1\", \"midi_unittests\": \"ab37c98b0fdd5a4c6e350f767eed919798b891bd\", \"mojo_core_unittests\": \"d6f5fddefab74ef862c799a5fe287f873c0371da\", \"mojo_unittests\": \"122fc925db51db314d83566cbe9f8ca10297eb7a\", \"nacl_loader_unittests\": \"2ebfb285c87a19b22dd2700465b76ffb739948d4\", \"native_theme_unittests\": \"bc3ff9d1d93c8bf3a1e227cf62284e8dcc559517\", \"net_unittests\": \"1e68d1e3a0979eb6360d97b9f0d7103b8ed0dcb2\", \"notification_helper_unittests\": \"f704866dd4d05395aafaf1342950e7ad7b1e8660\", \"pdf_unittests\": \"7610db6c4b19cd15833b6eeb71b27c95ab3bbcb1\", \"perfetto_unittests\": \"964e9ec93e61bc86c4b2b62fff0b0712e188bec7\", \"ppapi_unittests\": \"279ad68cce90b1645503d2ed5702b022bbd2b3b4\", \"printing_unittests\": \"f421fa1ceb5f20d1e6ee07d34b913db4795a8a1b\", \"remoting_unittests\": \"c597ceff20f9afdc31495b7d0fc64006f5db481c\", \"sbox_integration_tests\": \"8375df4cb3fbda329af263122143e9a807b50409\", \"sbox_unittests\": \"cef2d797f9e90ad27e522621bf68a22c2fb7db3b\", \"sbox_validation_tests\": \"f4587c8b5479278cfa3d0944391b5080c5ad3ea3\", \"service_manager_unittests\": \"173c68e49c131668772c34d453b05efd58821a7e\", \"services_unittests\": \"9b698fb3f1a8a15febc6ec77110f6303b2fc5f45\", \"setup_unittests\": \"97a93cbf30481681de3979aa934d8c9d67d25f31\", \"shell_dialogs_unittests\": \"df6430536557791bb2813992358b7ffb26ac8659\", \"skia_unittests\": \"48e09d1cfaf203b0d7c02468b560deea2ebd31e0\", \"snapshot_unittests\": \"ddc52b9f16a508e79b4d1a1704d7fa9bdd7b5cd6\", \"sql_unittests\": \"9e1e10669dda097c5f6f126ad2a98998bd3b627c\", \"storage_unittests\": \"b8ea123ca82436ae54e9015d87dc878f3c3b6604\", \"sync_integration_tests\": \"8f5fab9b19ac1125b9109e44c8e792cef7a551d2\", \"traffic_annotation_auditor_unittests\": \"001d4bedd253c0b5630b8916a79cbdd6f6f89f98\", \"ui_base_unittests\": \"8101953d378158cd95dd5ed0855330e8bc9bd57e\", \"ui_touch_selection_unittests\": \"4e7f5ea1f1753c6bab3150ac3226b5cf59e58802\", \"unit_tests\": \"0b99f79718d551853284251745e44d820152e602\", \"updater_tests\": \"42c166e20566bd67823fa6ee7a52057ec2a2f28f\", \"url_unittests\": \"662f2ee333d2a1da15423b9652d930471a519b11\", \"views_unittests\": \"40a90d2a13c355809fc627110a6641a06714882b\", \"viz_unittests\": \"9afdb04f4d1416c58c40c6026f7686c2b3a34b4f\", \"vr_common_unittests\": \"4913723633a8aa445b449a0ac7dbe5ae36760680\", \"vr_pixeltests\": \"59f0508c1b19869be0cf53b0b686fe00996299f4\", \"weblayer_browsertests\": \"80e5a4136380e0ea8449e1ebd5a03046066d824c\", \"weblayer_unittests\": \"4614e6f5aae6b2c88d8ae57cde180c52adf44981\", \"wm_unittests\": \"9be1b335132df695ffffa863a09a4b970027ae20\", \"wtf_unittests\": \"46b17623a58c4d654ece618ffaa52dc4a21c9181\", \"zlib_unittests\": \"9029971070ef5d8a2b031544a1208b8a3c525f65\", \"zucchini_unittests\": \"603e16d24f2aa87cb99e7c2e5c7f08a04de8d130\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_ba2591630e3c492a7f8bed019e3d41c3ae1f8879793a1bf71c3be1367a2696d6_v2\", \"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-0-be5b\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5676-c76598c\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612349131682776",
"status": "COMPLETED",
"status_changed_ts": "1612352894579684",
"tags": [
"build_address:luci.chromium.ci/win-asan/17146",
"builder:win-asan",
"buildset:commit/git/e8c8a7fd22c3392c8fc83ec48ec2f1cab3a4e207",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e8c8a7fd22c3392c8fc83ec48ec2f1cab3a4e207",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021753176632263216",
"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/8856323114654277680/+/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:518050d0713f4e10",
"user_agent:luci-scheduler"
],
"updated_ts": "1612352894639845",
"url": "https://ci.chromium.org/b/8856323114654277680",
"utcnow_ts": "1612352897471932"
}
}
[11:48:17.482] Invocation finished in 1h2m48.785356064s with status SUCCEEDED