[05:44:31.057] New invocation is queued and will start shortly
[05:44:32.454] Starting the invocation (attempt 1)
[05:44:32.487] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:44:32.488] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:44:32.488] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9026483153712159536",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b3dc1b1a8c6096ae9e31efd10acf052178d63872\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9026483153712159536",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/b3dc1b1a8c6096ae9e31efd10acf052178d63872",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b3dc1b1a8c6096ae9e31efd10acf052178d63872",
"gitiles_ref:refs/heads/master"
]
}
[05:44:33.708] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1607838272619026",
"id": "8861053091408284064",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b3dc1b1a8c6096ae9e31efd10acf052178d63872\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1607838273424813",
"tags": [
"build_address:luci.chromium.ci/win-asan/16192",
"builder:win-asan",
"buildset:commit/git/b3dc1b1a8c6096ae9e31efd10acf052178d63872",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b3dc1b1a8c6096ae9e31efd10acf052178d63872",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026483153712159536",
"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/8861053091408284064/+/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": "1607838273424973",
"url": "https://ci.chromium.org/b/8861053091408284064",
"utcnow_ts": "1607838273694749"
}
}
[05:44:33.708] Task URL: https://ci.chromium.org/b/8861053091408284064
[05:44:33.708] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:2:0) after 1m0s
[05:45:37.776] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:2:0)
[05:45:37.777] Timer tick, asking Buildbucket for the build status
[05:45:37.959] Build 8861053091408284064: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:45:37.959] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:3:0) after 1m0s
[05:46:37.975] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:3:0)
[05:46:37.975] Timer tick, asking Buildbucket for the build status
[05:46:38.048] Build 8861053091408284064: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:46:38.048] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:4:0) after 1m0s
[05:47:38.065] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:4:0)
[05:47:38.065] Timer tick, asking Buildbucket for the build status
[05:47:38.159] Build 8861053091408284064: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:47:38.159] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:5:0) after 1m0s
[05:48:38.176] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:5:0)
[05:48:38.176] Timer tick, asking Buildbucket for the build status
[05:48:38.244] Build 8861053091408284064: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:48:38.244] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:6:0) after 1m0s
[05:49:08.084] Received PubSub notification, asking Buildbucket for the build status
[05:49:08.194] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:38.237] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:6:0)
[05:49:38.237] Timer tick, asking Buildbucket for the build status
[05:49:38.527] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:38.527] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:8:0) after 1m0s
[05:50:38.586] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:8:0)
[05:50:38.586] Timer tick, asking Buildbucket for the build status
[05:50:38.737] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:38.737] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:9:0) after 1m0s
[05:51:38.757] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:9:0)
[05:51:38.757] Timer tick, asking Buildbucket for the build status
[05:51:38.826] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:38.826] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:10:0) after 1m0s
[05:52:38.806] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:10:0)
[05:52:38.806] Timer tick, asking Buildbucket for the build status
[05:52:38.872] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:38.872] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:11:0) after 1m0s
[05:53:38.875] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:11:0)
[05:53:38.875] Timer tick, asking Buildbucket for the build status
[05:53:39.138] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:39.138] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:12:0) after 1m0s
[05:54:39.223] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:12:0)
[05:54:39.223] Timer tick, asking Buildbucket for the build status
[05:54:39.558] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:39.558] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:13:0) after 1m0s
[05:55:39.744] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:13:0)
[05:55:39.744] Timer tick, asking Buildbucket for the build status
[05:55:39.876] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:39.876] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:14:0) after 1m0s
[05:56:39.989] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:14:0)
[05:56:39.989] Timer tick, asking Buildbucket for the build status
[05:56:40.221] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:40.221] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:15:0) after 1m0s
[05:57:40.333] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:15:0)
[05:57:40.333] Timer tick, asking Buildbucket for the build status
[05:57:40.619] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:40.619] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:16:0) after 1m0s
[05:58:40.809] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:16:0)
[05:58:40.809] Timer tick, asking Buildbucket for the build status
[05:58:40.875] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:40.875] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:17:0) after 1m0s
[05:59:41.043] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:17:0)
[05:59:41.043] Timer tick, asking Buildbucket for the build status
[05:59:41.112] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:41.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:18:0) after 1m0s
[06:00:41.246] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:18:0)
[06:00:41.246] Timer tick, asking Buildbucket for the build status
[06:00:41.602] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:41.602] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:19:0) after 1m0s
[06:01:46.215] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:19:0)
[06:01:46.215] Timer tick, asking Buildbucket for the build status
[06:01:46.301] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:46.301] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:20:0) after 1m0s
[06:02:46.374] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:20:0)
[06:02:46.374] Timer tick, asking Buildbucket for the build status
[06:02:46.522] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:46.522] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:21:0) after 1m0s
[06:03:46.535] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:21:0)
[06:03:46.535] Timer tick, asking Buildbucket for the build status
[06:03:46.606] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:46.606] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:22:0) after 1m0s
[06:04:46.646] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:22:0)
[06:04:46.646] Timer tick, asking Buildbucket for the build status
[06:04:47.132] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:47.132] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:23:0) after 1m0s
[06:05:47.163] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:23:0)
[06:05:47.163] Timer tick, asking Buildbucket for the build status
[06:05:47.393] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:47.393] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:24:0) after 1m0s
[06:06:47.539] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:24:0)
[06:06:47.539] Timer tick, asking Buildbucket for the build status
[06:06:47.615] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:47.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:25:0) after 1m0s
[06:07:47.677] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:25:0)
[06:07:47.677] Timer tick, asking Buildbucket for the build status
[06:07:47.747] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:47.747] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:26:0) after 1m0s
[06:08:47.855] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:26:0)
[06:08:47.855] Timer tick, asking Buildbucket for the build status
[06:08:47.923] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:47.923] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:27:0) after 1m0s
[06:09:48.113] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:27:0)
[06:09:48.113] Timer tick, asking Buildbucket for the build status
[06:09:48.207] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:48.207] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:28:0) after 1m0s
[06:10:48.268] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:28:0)
[06:10:48.268] Timer tick, asking Buildbucket for the build status
[06:10:48.334] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:48.334] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:29:0) after 1m0s
[06:11:48.367] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:29:0)
[06:11:48.367] Timer tick, asking Buildbucket for the build status
[06:11:48.425] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:48.425] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:30:0) after 1m0s
[06:12:48.395] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:30:0)
[06:12:48.395] Timer tick, asking Buildbucket for the build status
[06:12:48.452] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:48.452] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:31:0) after 1m0s
[06:13:48.422] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:31:0)
[06:13:48.422] Timer tick, asking Buildbucket for the build status
[06:13:48.528] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:48.528] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:32:0) after 1m0s
[06:14:48.547] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:32:0)
[06:14:48.547] Timer tick, asking Buildbucket for the build status
[06:14:48.639] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:48.639] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:33:0) after 1m0s
[06:15:48.776] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:33:0)
[06:15:48.776] Timer tick, asking Buildbucket for the build status
[06:15:48.836] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:48.836] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:34:0) after 1m0s
[06:16:48.934] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:34:0)
[06:16:48.934] Timer tick, asking Buildbucket for the build status
[06:16:48.992] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:48.992] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:35:0) after 1m0s
[06:17:49.015] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:35:0)
[06:17:49.015] Timer tick, asking Buildbucket for the build status
[06:17:49.080] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:49.080] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:36:0) after 1m0s
[06:18:49.132] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:36:0)
[06:18:49.132] Timer tick, asking Buildbucket for the build status
[06:18:49.185] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:49.185] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:37:0) after 1m0s
[06:19:49.156] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:37:0)
[06:19:49.156] Timer tick, asking Buildbucket for the build status
[06:19:49.264] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:49.264] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:38:0) after 1m0s
[06:20:49.298] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:38:0)
[06:20:49.298] Timer tick, asking Buildbucket for the build status
[06:20:49.367] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:49.367] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:39:0) after 1m0s
[06:21:49.460] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:39:0)
[06:21:49.460] Timer tick, asking Buildbucket for the build status
[06:21:49.523] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:49.523] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:40:0) after 1m0s
[06:22:49.509] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:40:0)
[06:22:49.509] Timer tick, asking Buildbucket for the build status
[06:22:49.610] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:49.610] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:41:0) after 1m0s
[06:23:49.724] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:41:0)
[06:23:49.724] Timer tick, asking Buildbucket for the build status
[06:23:49.788] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:49.788] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:42:0) after 1m0s
[06:24:49.789] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:42:0)
[06:24:49.789] Timer tick, asking Buildbucket for the build status
[06:24:49.886] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:49.886] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:43:0) after 1m0s
[06:25:50.131] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:43:0)
[06:25:50.131] Timer tick, asking Buildbucket for the build status
[06:25:50.237] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:50.237] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:44:0) after 1m0s
[06:26:50.404] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:44:0)
[06:26:50.404] Timer tick, asking Buildbucket for the build status
[06:26:50.496] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:50.496] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:45:0) after 1m0s
[06:27:50.604] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:45:0)
[06:27:50.604] Timer tick, asking Buildbucket for the build status
[06:27:50.698] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:50.698] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:46:0) after 1m0s
[06:28:50.791] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:46:0)
[06:28:50.791] Timer tick, asking Buildbucket for the build status
[06:28:50.852] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:50.852] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:47:0) after 1m0s
[06:29:50.872] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:47:0)
[06:29:50.872] Timer tick, asking Buildbucket for the build status
[06:29:50.981] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:50.981] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:48:0) after 1m0s
[06:30:51.142] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:48:0)
[06:30:51.142] Timer tick, asking Buildbucket for the build status
[06:30:51.854] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:51.854] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:49:0) after 1m0s
[06:31:52.030] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:49:0)
[06:31:52.030] Timer tick, asking Buildbucket for the build status
[06:31:52.212] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:52.212] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:50:0) after 1m0s
[06:32:52.329] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:50:0)
[06:32:52.329] Timer tick, asking Buildbucket for the build status
[06:32:52.404] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:52.404] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:51:0) after 1m0s
[06:33:54.626] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:51:0)
[06:33:54.626] Timer tick, asking Buildbucket for the build status
[06:33:54.731] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:54.731] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:52:0) after 1m0s
[06:34:54.709] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:52:0)
[06:34:54.709] Timer tick, asking Buildbucket for the build status
[06:34:54.945] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:54.945] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:53:0) after 1m0s
[06:35:55.294] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:53:0)
[06:35:55.294] Timer tick, asking Buildbucket for the build status
[06:35:55.352] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:55.352] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:54:0) after 1m0s
[06:36:55.489] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:54:0)
[06:36:55.489] Timer tick, asking Buildbucket for the build status
[06:36:55.545] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:55.545] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:55:0) after 1m0s
[06:37:55.679] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:55:0)
[06:37:55.679] Timer tick, asking Buildbucket for the build status
[06:37:55.741] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:55.741] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:56:0) after 1m0s
[06:38:55.970] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:56:0)
[06:38:55.970] Timer tick, asking Buildbucket for the build status
[06:38:56.037] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:56.037] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:57:0) after 1m0s
[06:39:56.072] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:57:0)
[06:39:56.072] Timer tick, asking Buildbucket for the build status
[06:39:56.173] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:56.173] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:58:0) after 1m0s
[06:40:56.322] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:58:0)
[06:40:56.322] Timer tick, asking Buildbucket for the build status
[06:40:56.558] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:56.558] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:59:0) after 1m0s
[06:41:56.734] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:59:0)
[06:41:56.734] Timer tick, asking Buildbucket for the build status
[06:41:56.789] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:56.789] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:60:0) after 1m0s
[06:42:56.951] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:60:0)
[06:42:56.951] Timer tick, asking Buildbucket for the build status
[06:42:57.022] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:57.022] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:61:0) after 1m0s
[06:43:57.161] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:61:0)
[06:43:57.161] Timer tick, asking Buildbucket for the build status
[06:43:57.733] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:57.733] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:62:0) after 1m0s
[06:44:57.875] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:62:0)
[06:44:57.875] Timer tick, asking Buildbucket for the build status
[06:44:57.963] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:57.963] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:63:0) after 1m0s
[06:45:58.015] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:63:0)
[06:45:58.015] Timer tick, asking Buildbucket for the build status
[06:45:58.821] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:58.821] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:64:0) after 1m0s
[06:46:58.903] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:64:0)
[06:46:58.903] Timer tick, asking Buildbucket for the build status
[06:46:58.964] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:58.964] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:65:0) after 1m0s
[06:47:58.983] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:65:0)
[06:47:58.983] Timer tick, asking Buildbucket for the build status
[06:47:59.132] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:59.132] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:66:0) after 1m0s
[06:48:59.152] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:66:0)
[06:48:59.152] Timer tick, asking Buildbucket for the build status
[06:48:59.221] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:59.221] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:67:0) after 1m0s
[06:49:59.248] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:67:0)
[06:49:59.248] Timer tick, asking Buildbucket for the build status
[06:49:59.374] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:59.374] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:68:0) after 1m0s
[06:50:59.414] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:68:0)
[06:50:59.414] Timer tick, asking Buildbucket for the build status
[06:50:59.468] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:59.468] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:69:0) after 1m0s
[06:51:59.498] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:69:0)
[06:51:59.498] Timer tick, asking Buildbucket for the build status
[06:51:59.560] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:59.560] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:70:0) after 1m0s
[06:52:59.605] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:70:0)
[06:52:59.605] Timer tick, asking Buildbucket for the build status
[06:52:59.992] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:59.992] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:71:0) after 1m0s
[06:54:00.039] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:71:0)
[06:54:00.039] Timer tick, asking Buildbucket for the build status
[06:54:00.241] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:00.241] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:72:0) after 1m0s
[06:55:00.317] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:72:0)
[06:55:00.317] Timer tick, asking Buildbucket for the build status
[06:55:00.422] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:00.422] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:73:0) after 1m0s
[06:56:00.457] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:73:0)
[06:56:00.457] Timer tick, asking Buildbucket for the build status
[06:56:00.522] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:00.522] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:74:0) after 1m0s
[06:57:00.544] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:74:0)
[06:57:00.544] Timer tick, asking Buildbucket for the build status
[06:57:00.601] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:00.601] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:75:0) after 1m0s
[06:58:00.620] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:75:0)
[06:58:00.620] Timer tick, asking Buildbucket for the build status
[06:58:00.798] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:00.798] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:76:0) after 1m0s
[06:59:00.837] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:76:0)
[06:59:00.837] Timer tick, asking Buildbucket for the build status
[06:59:00.893] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:00.893] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:77:0) after 1m0s
[07:00:00.911] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:77:0)
[07:00:00.911] Timer tick, asking Buildbucket for the build status
[07:00:01.043] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:01.043] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:78:0) after 1m0s
[07:01:01.203] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:78:0)
[07:01:01.203] Timer tick, asking Buildbucket for the build status
[07:01:01.297] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:01.297] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:79:0) after 1m0s
[07:02:01.329] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:79:0)
[07:02:01.329] Timer tick, asking Buildbucket for the build status
[07:02:01.430] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:01.430] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:80:0) after 1m0s
[07:03:01.516] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:80:0)
[07:03:01.516] Timer tick, asking Buildbucket for the build status
[07:03:01.611] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:01.611] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:81:0) after 1m0s
[07:04:01.634] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:81:0)
[07:04:01.634] Timer tick, asking Buildbucket for the build status
[07:04:01.732] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:01.732] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:82:0) after 1m0s
[07:05:01.743] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:82:0)
[07:05:01.743] Timer tick, asking Buildbucket for the build status
[07:05:01.848] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:01.848] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:83:0) after 1m0s
[07:06:01.924] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:83:0)
[07:06:01.924] Timer tick, asking Buildbucket for the build status
[07:06:02.133] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:02.133] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:84:0) after 1m0s
[07:07:02.153] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:84:0)
[07:07:02.153] Timer tick, asking Buildbucket for the build status
[07:07:02.283] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:02.283] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:85:0) after 1m0s
[07:08:02.310] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:85:0)
[07:08:02.310] Timer tick, asking Buildbucket for the build status
[07:08:02.431] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:02.431] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:86:0) after 1m0s
[07:09:02.428] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:86:0)
[07:09:02.428] Timer tick, asking Buildbucket for the build status
[07:09:02.559] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:02.560] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:87:0) after 1m0s
[07:10:02.556] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:87:0)
[07:10:02.556] Timer tick, asking Buildbucket for the build status
[07:10:02.691] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:02.691] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:88:0) after 1m0s
[07:11:02.803] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:88:0)
[07:11:02.803] Timer tick, asking Buildbucket for the build status
[07:11:02.920] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:02.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:89:0) after 1m0s
[07:12:03.051] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:89:0)
[07:12:03.051] Timer tick, asking Buildbucket for the build status
[07:12:03.413] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:03.413] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:90:0) after 1m0s
[07:13:03.570] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:90:0)
[07:13:03.570] Timer tick, asking Buildbucket for the build status
[07:13:03.701] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:03.701] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:91:0) after 1m0s
[07:14:03.843] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:91:0)
[07:14:03.843] Timer tick, asking Buildbucket for the build status
[07:14:04.136] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:04.136] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:92:0) after 1m0s
[07:15:04.116] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:92:0)
[07:15:04.116] Timer tick, asking Buildbucket for the build status
[07:15:04.743] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:04.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:93:0) after 1m0s
[07:16:04.963] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:93:0)
[07:16:04.963] Timer tick, asking Buildbucket for the build status
[07:16:05.064] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:05.064] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:94:0) after 1m0s
[07:17:05.134] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:94:0)
[07:17:05.134] Timer tick, asking Buildbucket for the build status
[07:17:05.543] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:05.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:95:0) after 1m0s
[07:18:05.574] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:95:0)
[07:18:05.574] Timer tick, asking Buildbucket for the build status
[07:18:05.932] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:05.932] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:96:0) after 1m0s
[07:19:05.921] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:96:0)
[07:19:05.921] Timer tick, asking Buildbucket for the build status
[07:19:06.023] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:06.023] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:97:0) after 1m0s
[07:20:06.045] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:97:0)
[07:20:06.045] Timer tick, asking Buildbucket for the build status
[07:20:06.179] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:06.179] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:98:0) after 1m0s
[07:21:06.251] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:98:0)
[07:21:06.251] Timer tick, asking Buildbucket for the build status
[07:21:06.526] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:06.526] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:99:0) after 1m0s
[07:22:07.004] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:99:0)
[07:22:07.004] Timer tick, asking Buildbucket for the build status
[07:22:07.085] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:07.085] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:100:0) after 1m0s
[07:23:07.299] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:100:0)
[07:23:07.299] Timer tick, asking Buildbucket for the build status
[07:23:07.381] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:07.381] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:101:0) after 1m0s
[07:24:07.410] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:101:0)
[07:24:07.410] Timer tick, asking Buildbucket for the build status
[07:24:07.522] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:07.522] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:102:0) after 1m0s
[07:25:07.558] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:102:0)
[07:25:07.558] Timer tick, asking Buildbucket for the build status
[07:25:07.741] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:07.741] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:103:0) after 1m0s
[07:26:07.743] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:103:0)
[07:26:07.743] Timer tick, asking Buildbucket for the build status
[07:26:08.024] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:08.024] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:104:0) after 1m0s
[07:27:08.059] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:104:0)
[07:27:08.059] Timer tick, asking Buildbucket for the build status
[07:27:08.142] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:08.142] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:105:0) after 1m0s
[07:28:08.208] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:105:0)
[07:28:08.208] Timer tick, asking Buildbucket for the build status
[07:28:08.347] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:08.347] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:106:0) after 1m0s
[07:29:08.398] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:106:0)
[07:29:08.398] Timer tick, asking Buildbucket for the build status
[07:29:08.480] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:08.480] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:107:0) after 1m0s
[07:30:08.531] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:107:0)
[07:30:08.532] Timer tick, asking Buildbucket for the build status
[07:30:08.649] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:08.649] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:108:0) after 1m0s
[07:31:08.693] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:108:0)
[07:31:08.693] Timer tick, asking Buildbucket for the build status
[07:31:08.813] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:08.813] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:109:0) after 1m0s
[07:32:08.866] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:109:0)
[07:32:08.866] Timer tick, asking Buildbucket for the build status
[07:32:08.996] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:08.996] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:110:0) after 1m0s
[07:33:09.007] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:110:0)
[07:33:09.007] Timer tick, asking Buildbucket for the build status
[07:33:09.088] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:09.088] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:111:0) after 1m0s
[07:34:09.133] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:111:0)
[07:34:09.133] Timer tick, asking Buildbucket for the build status
[07:34:09.258] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:09.258] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:112:0) after 1m0s
[07:35:09.328] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:112:0)
[07:35:09.328] Timer tick, asking Buildbucket for the build status
[07:35:09.439] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:09.439] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:113:0) after 1m0s
[07:36:09.448] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:113:0)
[07:36:09.448] Timer tick, asking Buildbucket for the build status
[07:36:09.554] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:09.554] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:114:0) after 1m0s
[07:37:09.680] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:114:0)
[07:37:09.680] Timer tick, asking Buildbucket for the build status
[07:37:09.833] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:09.833] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:115:0) after 1m0s
[07:38:09.866] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:115:0)
[07:38:09.866] Timer tick, asking Buildbucket for the build status
[07:38:09.994] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:09.994] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:116:0) after 1m0s
[07:39:10.019] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:116:0)
[07:39:10.019] Timer tick, asking Buildbucket for the build status
[07:39:10.084] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:10.084] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:117:0) after 1m0s
[07:40:10.078] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:117:0)
[07:40:10.078] Timer tick, asking Buildbucket for the build status
[07:40:10.183] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:10.183] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:118:0) after 1m0s
[07:41:10.208] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:118:0)
[07:41:10.208] Timer tick, asking Buildbucket for the build status
[07:41:10.299] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:10.299] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:119:0) after 1m0s
[07:42:10.322] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:119:0)
[07:42:10.322] Timer tick, asking Buildbucket for the build status
[07:42:10.446] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:10.446] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:120:0) after 1m0s
[07:43:10.483] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:120:0)
[07:43:10.483] Timer tick, asking Buildbucket for the build status
[07:43:10.557] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:10.557] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:121:0) after 1m0s
[07:44:10.636] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:121:0)
[07:44:10.636] Timer tick, asking Buildbucket for the build status
[07:44:10.703] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:10.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:122:0) after 1m0s
[07:45:10.704] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:122:0)
[07:45:10.704] Timer tick, asking Buildbucket for the build status
[07:45:10.805] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:10.805] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:123:0) after 1m0s
[07:46:10.902] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:123:0)
[07:46:10.902] Timer tick, asking Buildbucket for the build status
[07:46:11.114] Build 8861053091408284064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:11.114] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026483153712159536:124:0) after 1m0s
[07:46:54.307] Received PubSub notification, asking Buildbucket for the build status
[07:46:54.377] Build 8861053091408284064: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:46:54.377] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1607845613283711",
"created_by": "project:chromium",
"created_ts": "1607838272619026",
"id": "8861053091408284064",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b3dc1b1a8c6096ae9e31efd10acf052178d63872\"}}",
"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\": \"b3dc1b1a8c6096ae9e31efd10acf052178d63872\", \"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-e1ol\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16192, \"clang_revision\": \"llvmorg-12-init-12923-g6ee22ca6-1\", \"got_angle_revision\": \"4fb29e83e02c5152ebc60733eb5351ea98c7097d\", \"got_dawn_revision\": \"fb6c21547e6c5bc2053c15169769397e6584c9d2\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"b3dc1b1a8c6096ae9e31efd10acf052178d63872\", \"got_revision_cp\": \"refs/heads/master@{#836465}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"c16dc7107fd329b815c700b002d1ba40372b16dc\", \"got_v8_revision\": \"e7e9e702c110a535bb2daa6cd60db7b7d62d8665\", \"got_v8_revision_cp\": \"refs/heads/8.9.143@{#1}\", \"got_webrtc_revision\": \"d7808f1c464a07c8f1e2f97ec7ee92fda998d590\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32804}\", \"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\": \"b3dc1b1a8c6096ae9e31efd10acf052178d63872\", \"swarm_hashes_refs/heads/master(at){#836465}_without_patch\": {\"absl_hardening_tests\": \"5080ae065846359a22385effb24aabf4039468fe\", \"accessibility_unittests\": \"638ebce2109271563d4cdf598466e2bb49ef314f\", \"angle_unittests\": \"6b0f5c0f3d306caf9ecdded96c66c835a56fb24b\", \"app_shell_unittests\": \"214efdfa0907c4c7037fb53414e6d210a2708226\", \"aura_unittests\": \"2aa7ac0f1bbd07c15f4aeef0aa9a6d88a2fc8b60\", \"base_unittests\": \"6fc17d7d38362fa4e5fd6310416ad3efceb226e0\", \"base_util_unittests\": \"6e2c10c5527443443c81920340face08da725661\", \"blink_common_unittests\": \"a5f783f1c5a4b21a105785919c1a0e4f463a626d\", \"blink_fuzzer_unittests\": \"5acbe83fae321d7daf4d4d895e2e7172131196e3\", \"blink_heap_unittests\": \"0edd0aa787176618782aea4cd9e9fd9c3365ed83\", \"blink_platform_unittests\": \"69df6a4772fdb1026be3a1cebd26b765f34e52ec\", \"blink_unittests\": \"879efa33b5c5d9afaf43eb07ff69c2a5c8ec60ed\", \"boringssl_crypto_tests\": \"f5b30c865c2a8aee262bb7941f2eec472c3011a4\", \"boringssl_ssl_tests\": \"67344d2de04294a61d405b87f675047b426e64da\", \"browser_switcher_bho_unittests\": \"ae61f3ac9abdfa72ad65137f7507868e6f221d38\", \"browser_tests\": \"d74c2de89c6261a40d8ef6802faba1684058dec2\", \"capture_unittests\": \"d0166e337280f2ca3181b77538cf532a2332be32\", \"cast_unittests\": \"2e3f42b76b2f458cc5154e4ecfe9652ad7a7b953\", \"cc_unittests\": \"891866c91e2c0209435d0a48293cee6c98fd152e\", \"chrome_app_unittests\": \"a31ff0595d65301a16c89902092eb045a358b59f\", \"chrome_cleaner_unittests\": \"6e96f99a45d6d8f86587c421612f40037f8bfd8b\", \"chrome_elf_unittests\": \"f9adb7dc58e4b7bc642c812b6662b82110263bf9\", \"chromedriver_unittests\": \"8e29ceb2cea62de7a1fa5516a41771a7d1d48f7d\", \"components_browsertests\": \"5540859a318131eb118cdd3759dda6967236f7db\", \"components_unittests\": \"04d00b6046b3d5da3e225381b09305234f317418\", \"compositor_unittests\": \"82337556579371c1dd606d185bd296c7027e93d0\", \"content_browsertests\": \"1bc2d41a68ba0caa24177ed6c51a4c90c45102a5\", \"content_unittests\": \"8e4a6133d36e9b3cb25abd522673b425f6c71eca\", \"courgette_unittests\": \"79ae2b873177061932a79a0e0c4814c618cf9d12\", \"crashpad_tests\": \"edba5c7cb0d1becae84ffd59ef129d7fc462ad65\", \"cronet_tests\": \"eaaeaf5a10d417b2b273122136663d0096e4c49a\", \"cronet_unittests\": \"d01400586d20f5cab2c8d5a7c81fdff8e371ef07\", \"crypto_unittests\": \"2a5b17a9a9cfefeb69882874faa13c7715991655\", \"delayloads_unittests\": \"dce30e650ea218d0497b8a178eacf5e79e061022\", \"device_unittests\": \"f1482dc611973ce8376d3a2256353ff939915816\", \"display_unittests\": \"5fd82684d8aeadc878e82772b77b24e4c9156e33\", \"elevation_service_unittests\": \"cf32f390bbd28f9eb7925cf9966c00f9f7577ebe\", \"events_unittests\": \"b4008930b67e7cfa398a4acb3c2ea32f922b544e\", \"extensions_browsertests\": \"28edea92debdabec96f2659537b41aceb74cd125\", \"extensions_unittests\": \"60b1a904298e75fee62aa57ccd0da694b8c85c3b\", \"filesystem_service_unittests\": \"3faf561d28ee547f1cf9fa053b2135f1e33fd4bc\", \"gcm_unit_tests\": \"613c7a970f2eff900e5b18be10dca042e75771e6\", \"gcp_unittests\": \"751d08a4bf5947c555bee0ccf79e5cd90d7247ef\", \"gfx_unittests\": \"27536ca10376903e56f0961c7277b6e7470a9995\", \"gin_unittests\": \"5d386ce26bc3d66d5391688e424b09f88b415377\", \"google_apis_unittests\": \"14ae91fcdb00f18362403a590c3523b2d1d86b8d\", \"gpu_unittests\": \"7f5e728fb4042a61a0aa832a055721489a5d7e82\", \"gwp_asan_unittests\": \"cf71fbeddb1b6aaaacbcd06de581dc0b93b2d0eb\", \"headless_browsertests\": \"20e393395d11247659af0889be55ba4ef60fc31b\", \"headless_unittests\": \"f0d86c7e54601f933636eecced86f8c46b1c315e\", \"install_static_unittests\": \"83ff3ca9db599f55875712f30f12d436dac2a5e5\", \"installer_util_unittests\": \"969eb09524237b4d74456c89dd905249bbf8ec74\", \"interactive_ui_tests\": \"a970d7de128af4740b0cbc6bd19a6e3187fa5ae1\", \"ipc_tests\": \"1d5761c8d149b70d4f40114211f3bf90a42d68fb\", \"jingle_unittests\": \"a0e599e7b68dcf21ad82923bcffb4a3937ccbe22\", \"latency_unittests\": \"71ae37ce177d0d5f5594f0ba95f6623a53c6cf2c\", \"libjingle_xmpp_unittests\": \"dff217b9ba1f69e901ffb2bc30d36977abd6ffb3\", \"liburlpattern_unittests\": \"e81d0d8c028c122f9d43070c05cda32ec167b099\", \"media_blink_unittests\": \"55c9505d5a4b3a716fefab8769ffefe117adae49\", \"media_unittests\": \"360b0c0a4cacd7443211088df9e48ad5bc23d745\", \"message_center_unittests\": \"45e311ccd4c51d52a730f210b74c8748249cd950\", \"midi_unittests\": \"60bcb9970f645a2cf32253c6247b9cb4ed9bc3ce\", \"mojo_core_unittests\": \"394cf2a036beab6ede8244883c8436b6609a0f35\", \"mojo_unittests\": \"29c340745aeec6397886ec1595afc4b0be60124b\", \"nacl_loader_unittests\": \"ad05b6ff2c23db7a862902dc997a108a7d32cfe2\", \"native_theme_unittests\": \"25d64f3e338aa0149cca813fef867327e9a5d864\", \"net_unittests\": \"16b249d6fb02e2a2683bfa99e1200469c2a17dd9\", \"notification_helper_unittests\": \"789cb89d72561cc46e7547800fd4c20ee42a81e1\", \"pdf_unittests\": \"4e21e07717fec2e287d1e09b3a2d1292e4f842cd\", \"perfetto_unittests\": \"96cb9f3a43a9d5f89c5ee82fba4fbceb5f781495\", \"ppapi_unittests\": \"b1c723d565b573c3118d8d91946ef3575f364feb\", \"printing_unittests\": \"c83fe7c22c7517034f06cf09c7a2e6b2a3d5897d\", \"remoting_unittests\": \"130c05dea1e0f8ad98842e8a40cc4df6fb7189c7\", \"sbox_integration_tests\": \"513a7eaa9697e8a80c3f1c206307ba929745f665\", \"sbox_unittests\": \"848958202cbb2f2447cda4332ffed4e2a63684ef\", \"sbox_validation_tests\": \"706d05d1d1d6f12237ce205afb5dc06be3a6dc5f\", \"service_manager_unittests\": \"ff75879480b31199a78e342f4ca26a0c622b9579\", \"services_unittests\": \"f539177e4174103e571fdeb3ba7e4f5d6754ed0e\", \"setup_unittests\": \"d60440ae1c402bbabe6c7845f2ae67bcad70c47c\", \"shell_dialogs_unittests\": \"c25a7c464deb3f04ed29da01f4bdea5c053ad039\", \"skia_unittests\": \"93bcb700ee44c470a8cc2f921608c07b35db018f\", \"snapshot_unittests\": \"975ea7675a165144c764455ca64ed04fa91470c6\", \"sql_unittests\": \"661e8a0be394e6ba8bbc49e63dd5cb98b760f4b9\", \"storage_unittests\": \"d589d3877ea470bdcd23428d27a7821af701894c\", \"sync_integration_tests\": \"fdecb0f86466879f56f06c375a3cd3b1edce6169\", \"traffic_annotation_auditor_unittests\": \"a0f80eacd761cf484320126791015ec38319a9fa\", \"ui_base_unittests\": \"ef544c60ddd22895310d5ba8fda96e3c77ce69a6\", \"ui_touch_selection_unittests\": \"e058f612f99276948fe95f80e1d53844c918781c\", \"unit_tests\": \"b781dbffafd591f5ff992999e5b86d09c59ea34e\", \"updater_tests\": \"02fc992baebf32df1129b19be702dd46b53764e9\", \"url_unittests\": \"b793d002d82a9af1c868bc5874a0af725b4b1742\", \"views_unittests\": \"6957c38e74b68dcfbec62bbd37906720f4f1cf8d\", \"viz_unittests\": \"61f08ff6414ebdf9a0a3d2384b8ef4ce3deac50e\", \"vr_common_unittests\": \"1223cc3825ab70468ba598bae2946e6348f113cb\", \"vr_pixeltests\": \"65462f2002152773958db65ba4134766884b354a\", \"weblayer_browsertests\": \"475842fe29d2e8117ab0b80a57cb3b98918728e7\", \"weblayer_unittests\": \"e7bab0c676e3b970565dbc592b84eb71191f63f0\", \"wm_unittests\": \"4b313fc7b5970b1907a12e64a56f53c0ba591202\", \"wtf_unittests\": \"ee12ecfef4fbf760c8585a3a2f94c2d83a8fd5d2\", \"zlib_unittests\": \"99cccb560471e8ebfe032706a0e2fb27e4c25ea2\", \"zucchini_unittests\": \"39502f0d9f1b8dca46f542527f7344c7df89c499\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_05f97ad14167df9074a6905c05cccbc862b4a7ff68b1655c21ecf0b33d70df67_v2\"], \"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-e1ol\"], \"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-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1607838546937415",
"status": "COMPLETED",
"status_changed_ts": "1607845613741100",
"tags": [
"build_address:luci.chromium.ci/win-asan/16192",
"builder:win-asan",
"buildset:commit/git/b3dc1b1a8c6096ae9e31efd10acf052178d63872",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b3dc1b1a8c6096ae9e31efd10acf052178d63872",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026483153712159536",
"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/8861053091408284064/+/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:507372c8fd8e7f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1607845613744924",
"url": "https://ci.chromium.org/b/8861053091408284064",
"utcnow_ts": "1607845614369548"
}
}
[07:46:54.377] Invocation finished in 2h2m23.337360321s with status SUCCEEDED