[19:58:37.067] New invocation is queued and will start shortly
[19:58:38.182] Starting the invocation (attempt 1)
[19:58:38.261] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:58:38.261] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:58:38.261] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9064117756397985360",
"parameters_json": "{\"builder_name\":\"win\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"a0f51b4acfdcbc3101c8b30f1f096b23eaec852a\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@a0f51b4acfdcbc3101c8b30f1f096b23eaec852a\",\"title\":\"a0f51b4acfdcbc3101c8b30f1f096b23eaec852a\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/a0f51b4acfdcbc3101c8b30f1f096b23eaec852a\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"a0f51b4acfdcbc3101c8b30f1f096b23eaec852a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win",
"scheduler_invocation_id:9064117756397985360",
"scheduler_job_id:emscripten-releases/win",
"user_agent:luci-scheduler",
"buildset:commit/git/a0f51b4acfdcbc3101c8b30f1f096b23eaec852a",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/a0f51b4acfdcbc3101c8b30f1f096b23eaec852a",
"gitiles_ref:refs/heads/master"
]
}
[19:58:39.648] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1571947118454282",
"id": "8898687694278423280",
"parameters_json": "{\"builder_name\": \"win\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"a0f51b4acfdcbc3101c8b30f1f096b23eaec852a\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@a0f51b4acfdcbc3101c8b30f1f096b23eaec852a\", \"title\": \"a0f51b4acfdcbc3101c8b30f1f096b23eaec852a\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/a0f51b4acfdcbc3101c8b30f1f096b23eaec852a\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"a0f51b4acfdcbc3101c8b30f1f096b23eaec852a\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1571947119244199",
"tags": [
"builder:win",
"buildset:commit/git/a0f51b4acfdcbc3101c8b30f1f096b23eaec852a",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/a0f51b4acfdcbc3101c8b30f1f096b23eaec852a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9064117756397985360",
"scheduler_job_id:emscripten-releases/win",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/emscripten-releases/buildbucket/cr-buildbucket.appspot.com/8898687694278423280/+/annotations",
"swarming_tag:luci_project:emscripten-releases",
"swarming_tag:recipe_name:emscripten_releases",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1571947119244320",
"url": "https://ci.chromium.org/b/8898687694278423280",
"utcnow_ts": "1571947119636606"
}
}
[19:58:39.648] Task URL: https://ci.chromium.org/b/8898687694278423280
[19:58:39.648] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:2:0) after 1m0s
[19:59:39.708] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:2:0)
[19:59:39.708] Timer tick, asking Buildbucket for the build status
[19:59:39.953] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:59:39.953] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:3:0) after 1m0s
[20:01:56.533] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:3:0)
[20:01:56.533] Timer tick, asking Buildbucket for the build status
[20:01:56.713] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:01:56.713] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:4:0) after 1m0s
[20:02:57.322] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:4:0)
[20:02:57.322] Timer tick, asking Buildbucket for the build status
[20:02:57.599] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:02:57.599] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:5:0) after 1m0s
[20:04:39.928] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:5:0)
[20:04:39.929] Timer tick, asking Buildbucket for the build status
[20:04:40.564] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:04:40.564] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:6:0) after 1m0s
[20:05:40.651] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:6:0)
[20:05:40.651] Timer tick, asking Buildbucket for the build status
[20:05:42.457] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:05:42.457] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:7:0) after 1m0s
[20:06:42.501] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:7:0)
[20:06:42.501] Timer tick, asking Buildbucket for the build status
[20:06:43.210] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:06:43.210] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:8:0) after 1m0s
[20:07:43.324] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:8:0)
[20:07:43.324] Timer tick, asking Buildbucket for the build status
[20:07:43.659] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:07:43.659] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:9:0) after 1m0s
[20:08:43.724] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:9:0)
[20:08:43.724] Timer tick, asking Buildbucket for the build status
[20:08:43.800] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:08:43.800] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:10:0) after 1m0s
[20:09:46.561] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:10:0)
[20:09:46.561] Timer tick, asking Buildbucket for the build status
[20:09:46.735] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:09:46.735] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:11:0) after 1m0s
[20:10:47.375] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:11:0)
[20:10:47.375] Timer tick, asking Buildbucket for the build status
[20:10:47.895] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:10:47.895] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:12:0) after 1m0s
[20:11:48.632] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:12:0)
[20:11:48.633] Timer tick, asking Buildbucket for the build status
[20:11:49.114] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:11:49.114] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:13:0) after 1m0s
[20:12:49.959] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:13:0)
[20:12:49.959] Timer tick, asking Buildbucket for the build status
[20:12:50.604] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:12:50.604] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:14:0) after 1m0s
[20:13:51.498] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:14:0)
[20:13:51.498] Timer tick, asking Buildbucket for the build status
[20:13:51.745] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:13:51.745] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:15:0) after 1m0s
[20:14:51.885] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:15:0)
[20:14:51.885] Timer tick, asking Buildbucket for the build status
[20:14:52.297] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:14:52.297] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:16:0) after 1m0s
[20:15:52.348] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:16:0)
[20:15:52.348] Timer tick, asking Buildbucket for the build status
[20:15:52.561] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:15:52.561] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:17:0) after 1m0s
[20:16:52.579] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:17:0)
[20:16:52.579] Timer tick, asking Buildbucket for the build status
[20:16:53.180] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:16:53.180] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:18:0) after 1m0s
[20:17:53.303] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:18:0)
[20:17:53.303] Timer tick, asking Buildbucket for the build status
[20:17:53.942] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:17:53.942] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:19:0) after 1m0s
[20:18:54.098] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:19:0)
[20:18:54.098] Timer tick, asking Buildbucket for the build status
[20:18:54.608] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:18:54.608] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:20:0) after 1m0s
[20:19:54.717] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:20:0)
[20:19:54.717] Timer tick, asking Buildbucket for the build status
[20:19:55.203] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:19:55.203] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:21:0) after 1m0s
[20:20:55.218] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:21:0)
[20:20:55.218] Timer tick, asking Buildbucket for the build status
[20:20:55.503] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:20:55.503] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:22:0) after 1m0s
[20:21:55.506] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:22:0)
[20:21:55.506] Timer tick, asking Buildbucket for the build status
[20:21:55.763] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:21:55.763] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:23:0) after 1m0s
[20:22:55.873] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:23:0)
[20:22:55.873] Timer tick, asking Buildbucket for the build status
[20:22:56.457] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:22:56.457] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:24:0) after 1m0s
[20:23:56.580] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:24:0)
[20:23:56.580] Timer tick, asking Buildbucket for the build status
[20:23:57.075] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:23:57.075] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:25:0) after 1m0s
[20:24:57.157] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:25:0)
[20:24:57.157] Timer tick, asking Buildbucket for the build status
[20:24:57.294] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:24:57.294] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:26:0) after 1m0s
[20:25:57.394] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:26:0)
[20:25:57.394] Timer tick, asking Buildbucket for the build status
[20:25:58.557] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:25:58.557] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:27:0) after 1m0s
[20:26:58.714] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:27:0)
[20:26:58.714] Timer tick, asking Buildbucket for the build status
[20:26:58.834] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:26:58.834] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:28:0) after 1m0s
[20:27:58.867] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:28:0)
[20:27:58.867] Timer tick, asking Buildbucket for the build status
[20:27:59.268] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:27:59.268] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:29:0) after 1m0s
[20:28:59.288] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:29:0)
[20:28:59.288] Timer tick, asking Buildbucket for the build status
[20:28:59.556] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:28:59.556] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:30:0) after 1m0s
[20:29:59.579] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:30:0)
[20:29:59.579] Timer tick, asking Buildbucket for the build status
[20:30:00.295] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:30:00.295] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:31:0) after 1m0s
[20:31:00.346] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:31:0)
[20:31:00.346] Timer tick, asking Buildbucket for the build status
[20:31:00.441] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:31:00.441] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:32:0) after 1m0s
[20:32:00.621] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:32:0)
[20:32:00.621] Timer tick, asking Buildbucket for the build status
[20:32:00.895] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:32:00.895] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:33:0) after 1m0s
[20:33:00.941] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:33:0)
[20:33:00.941] Timer tick, asking Buildbucket for the build status
[20:33:01.349] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:33:01.349] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:34:0) after 1m0s
[20:34:01.435] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:34:0)
[20:34:01.435] Timer tick, asking Buildbucket for the build status
[20:34:02.102] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:34:02.102] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:35:0) after 1m0s
[20:35:02.364] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:35:0)
[20:35:02.364] Timer tick, asking Buildbucket for the build status
[20:35:03.165] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:35:03.165] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:36:0) after 1m0s
[20:36:03.203] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:36:0)
[20:36:03.203] Timer tick, asking Buildbucket for the build status
[20:36:04.619] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:36:04.619] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:37:0) after 1m0s
[20:37:04.860] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:37:0)
[20:37:04.860] Timer tick, asking Buildbucket for the build status
[20:37:05.097] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:37:05.097] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:38:0) after 1m0s
[20:38:05.159] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:38:0)
[20:38:05.159] Timer tick, asking Buildbucket for the build status
[20:38:06.164] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:38:06.164] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:39:0) after 1m0s
[20:39:06.197] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:39:0)
[20:39:06.197] Timer tick, asking Buildbucket for the build status
[20:39:06.658] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:39:06.658] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:40:0) after 1m0s
[20:40:06.660] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:40:0)
[20:40:06.660] Timer tick, asking Buildbucket for the build status
[20:40:06.863] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:40:06.863] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:41:0) after 1m0s
[20:41:06.876] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:41:0)
[20:41:06.876] Timer tick, asking Buildbucket for the build status
[20:41:07.053] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:41:07.053] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:42:0) after 1m0s
[20:42:07.210] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:42:0)
[20:42:07.210] Timer tick, asking Buildbucket for the build status
[20:42:08.108] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:42:08.108] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:43:0) after 1m0s
[20:43:08.272] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:43:0)
[20:43:08.272] Timer tick, asking Buildbucket for the build status
[20:43:08.786] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:43:08.786] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:44:0) after 1m0s
[20:44:09.004] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:44:0)
[20:44:09.004] Timer tick, asking Buildbucket for the build status
[20:44:09.107] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:44:09.107] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:45:0) after 1m0s
[20:45:09.199] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:45:0)
[20:45:09.199] Timer tick, asking Buildbucket for the build status
[20:45:10.551] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:45:10.551] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:46:0) after 1m0s
[20:46:10.762] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:46:0)
[20:46:10.762] Timer tick, asking Buildbucket for the build status
[20:46:12.051] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:46:12.051] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:47:0) after 1m0s
[20:47:12.126] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:47:0)
[20:47:12.126] Timer tick, asking Buildbucket for the build status
[20:47:12.447] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:47:12.447] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:48:0) after 1m0s
[20:48:12.536] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:48:0)
[20:48:12.536] Timer tick, asking Buildbucket for the build status
[20:48:12.693] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:48:12.693] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:49:0) after 1m0s
[20:49:12.810] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:49:0)
[20:49:12.810] Timer tick, asking Buildbucket for the build status
[20:49:12.907] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:49:12.907] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:50:0) after 1m0s
[20:50:13.004] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:50:0)
[20:50:13.004] Timer tick, asking Buildbucket for the build status
[20:50:13.335] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:50:13.335] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:51:0) after 1m0s
[20:51:13.380] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:51:0)
[20:51:13.380] Timer tick, asking Buildbucket for the build status
[20:51:13.880] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:51:13.880] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:52:0) after 1m0s
[20:52:13.974] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:52:0)
[20:52:13.974] Timer tick, asking Buildbucket for the build status
[20:52:14.096] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:52:14.096] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:53:0) after 1m0s
[20:53:14.308] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:53:0)
[20:53:14.308] Timer tick, asking Buildbucket for the build status
[20:53:14.462] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:53:14.462] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:54:0) after 1m0s
[20:54:14.589] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:54:0)
[20:54:14.589] Timer tick, asking Buildbucket for the build status
[20:54:14.745] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:54:14.745] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:55:0) after 1m0s
[20:55:14.889] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:55:0)
[20:55:14.889] Timer tick, asking Buildbucket for the build status
[20:55:15.046] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:55:15.046] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:56:0) after 1m0s
[20:56:15.161] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:56:0)
[20:56:15.161] Timer tick, asking Buildbucket for the build status
[20:56:16.272] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:56:16.272] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:57:0) after 1m0s
[20:57:16.340] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:57:0)
[20:57:16.340] Timer tick, asking Buildbucket for the build status
[20:57:16.597] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:57:16.597] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:58:0) after 1m0s
[20:58:16.759] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:58:0)
[20:58:16.759] Timer tick, asking Buildbucket for the build status
[20:58:16.949] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:58:16.949] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:59:0) after 1m0s
[20:59:17.091] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:59:0)
[20:59:17.091] Timer tick, asking Buildbucket for the build status
[20:59:17.288] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:59:17.288] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:60:0) after 1m0s
[21:00:17.320] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:60:0)
[21:00:17.320] Timer tick, asking Buildbucket for the build status
[21:00:17.536] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:00:17.536] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:61:0) after 1m0s
[21:01:17.579] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:61:0)
[21:01:17.579] Timer tick, asking Buildbucket for the build status
[21:01:17.829] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:01:17.829] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:62:0) after 1m0s
[21:02:17.926] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:62:0)
[21:02:17.926] Timer tick, asking Buildbucket for the build status
[21:02:18.409] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:02:18.409] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:63:0) after 1m0s
[21:03:18.513] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:63:0)
[21:03:18.513] Timer tick, asking Buildbucket for the build status
[21:03:18.792] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:03:18.792] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:64:0) after 1m0s
[21:04:18.849] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:64:0)
[21:04:18.849] Timer tick, asking Buildbucket for the build status
[21:04:19.169] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:04:19.169] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:65:0) after 1m0s
[21:05:19.192] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:65:0)
[21:05:19.192] Timer tick, asking Buildbucket for the build status
[21:05:20.471] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:05:20.471] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:66:0) after 1m0s
[21:06:20.543] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:66:0)
[21:06:20.543] Timer tick, asking Buildbucket for the build status
[21:06:21.311] Build 8898687694278423280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:06:21.311] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:67:0) after 1m0s
[21:07:12.948] Received PubSub notification, asking Buildbucket for the build status
[21:07:13.155] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:21.373] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:67:0)
[21:07:21.373] Timer tick, asking Buildbucket for the build status
[21:07:21.559] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:21.559] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:69:0) after 1m0s
[21:08:21.585] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:69:0)
[21:08:21.585] Timer tick, asking Buildbucket for the build status
[21:08:22.111] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:22.111] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:70:0) after 1m0s
[21:09:22.197] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:70:0)
[21:09:22.197] Timer tick, asking Buildbucket for the build status
[21:09:22.759] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:22.759] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:71:0) after 1m0s
[21:10:22.936] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:71:0)
[21:10:22.936] Timer tick, asking Buildbucket for the build status
[21:10:24.210] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:24.210] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:72:0) after 1m0s
[21:11:24.258] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:72:0)
[21:11:24.258] Timer tick, asking Buildbucket for the build status
[21:11:24.420] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:24.420] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:73:0) after 1m0s
[21:12:24.527] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:73:0)
[21:12:24.528] Timer tick, asking Buildbucket for the build status
[21:12:24.785] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:24.785] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:74:0) after 1m0s
[21:13:24.811] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:74:0)
[21:13:24.811] Timer tick, asking Buildbucket for the build status
[21:13:25.269] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:25.269] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:75:0) after 1m0s
[21:14:25.375] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:75:0)
[21:14:25.375] Timer tick, asking Buildbucket for the build status
[21:14:25.786] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:25.786] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:76:0) after 1m0s
[21:15:25.862] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:76:0)
[21:15:25.862] Timer tick, asking Buildbucket for the build status
[21:15:26.691] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:26.691] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:77:0) after 1m0s
[21:16:26.768] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:77:0)
[21:16:26.768] Timer tick, asking Buildbucket for the build status
[21:16:26.935] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:26.935] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:78:0) after 1m0s
[21:17:27.028] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:78:0)
[21:17:27.028] Timer tick, asking Buildbucket for the build status
[21:17:29.904] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:29.904] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:79:0) after 1m0s
[21:18:29.952] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:79:0)
[21:18:29.952] Timer tick, asking Buildbucket for the build status
[21:18:30.047] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:30.047] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:80:0) after 1m0s
[21:19:30.131] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:80:0)
[21:19:30.131] Timer tick, asking Buildbucket for the build status
[21:19:30.642] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:30.642] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:81:0) after 1m0s
[21:20:30.704] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:81:0)
[21:20:30.704] Timer tick, asking Buildbucket for the build status
[21:20:30.865] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:30.865] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:82:0) after 1m0s
[21:21:31.089] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:82:0)
[21:21:31.089] Timer tick, asking Buildbucket for the build status
[21:21:31.256] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:31.256] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:83:0) after 1m0s
[21:22:31.729] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:83:0)
[21:22:31.729] Timer tick, asking Buildbucket for the build status
[21:22:32.146] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:32.146] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:84:0) after 1m0s
[21:23:32.204] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:84:0)
[21:23:32.204] Timer tick, asking Buildbucket for the build status
[21:23:32.367] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:32.367] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:85:0) after 1m0s
[21:24:32.449] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:85:0)
[21:24:32.449] Timer tick, asking Buildbucket for the build status
[21:24:32.673] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:32.673] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:86:0) after 1m0s
[21:25:32.700] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:86:0)
[21:25:32.700] Timer tick, asking Buildbucket for the build status
[21:25:32.810] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:32.810] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:87:0) after 1m0s
[21:26:32.832] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:87:0)
[21:26:32.832] Timer tick, asking Buildbucket for the build status
[21:26:33.580] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:33.580] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:88:0) after 1m0s
[21:27:33.626] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:88:0)
[21:27:33.626] Timer tick, asking Buildbucket for the build status
[21:27:36.523] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:36.523] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:89:0) after 1m0s
[21:28:36.624] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:89:0)
[21:28:36.624] Timer tick, asking Buildbucket for the build status
[21:28:37.793] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:37.793] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:90:0) after 1m0s
[21:29:37.849] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:90:0)
[21:29:37.849] Timer tick, asking Buildbucket for the build status
[21:29:37.924] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:37.924] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:91:0) after 1m0s
[21:30:38.007] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:91:0)
[21:30:38.008] Timer tick, asking Buildbucket for the build status
[21:30:38.182] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:38.182] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:92:0) after 1m0s
[21:31:38.249] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:92:0)
[21:31:38.249] Timer tick, asking Buildbucket for the build status
[21:31:38.618] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:38.618] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:93:0) after 1m0s
[21:32:38.755] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:93:0)
[21:32:38.755] Timer tick, asking Buildbucket for the build status
[21:32:38.945] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:38.945] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:94:0) after 1m0s
[21:33:39.010] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:94:0)
[21:33:39.010] Timer tick, asking Buildbucket for the build status
[21:33:39.144] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:39.144] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:95:0) after 1m0s
[21:34:39.198] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:95:0)
[21:34:39.198] Timer tick, asking Buildbucket for the build status
[21:34:39.623] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:39.623] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:96:0) after 1m0s
[21:35:39.661] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:96:0)
[21:35:39.661] Timer tick, asking Buildbucket for the build status
[21:35:40.079] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:40.079] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:97:0) after 1m0s
[21:36:40.158] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:97:0)
[21:36:40.158] Timer tick, asking Buildbucket for the build status
[21:36:41.780] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:41.780] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:98:0) after 1m0s
[21:37:41.838] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:98:0)
[21:37:41.838] Timer tick, asking Buildbucket for the build status
[21:37:42.499] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:42.499] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:99:0) after 1m0s
[21:38:42.545] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:99:0)
[21:38:42.545] Timer tick, asking Buildbucket for the build status
[21:38:43.029] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:43.029] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:100:0) after 1m0s
[21:39:43.114] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:100:0)
[21:39:43.114] Timer tick, asking Buildbucket for the build status
[21:39:43.205] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:43.205] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:101:0) after 1m0s
[21:40:43.271] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:101:0)
[21:40:43.271] Timer tick, asking Buildbucket for the build status
[21:40:43.611] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:43.611] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:102:0) after 1m0s
[21:41:43.643] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:102:0)
[21:41:43.643] Timer tick, asking Buildbucket for the build status
[21:41:43.995] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:43.995] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:103:0) after 1m0s
[21:42:44.058] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:103:0)
[21:42:44.058] Timer tick, asking Buildbucket for the build status
[21:42:44.454] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:44.454] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:104:0) after 1m0s
[21:43:44.500] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:104:0)
[21:43:44.500] Timer tick, asking Buildbucket for the build status
[21:43:44.566] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:44.566] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:105:0) after 1m0s
[21:44:44.601] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:105:0)
[21:44:44.601] Timer tick, asking Buildbucket for the build status
[21:44:44.767] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:44.767] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:106:0) after 1m0s
[21:45:44.895] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:106:0)
[21:45:44.895] Timer tick, asking Buildbucket for the build status
[21:45:45.241] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:45.241] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:107:0) after 1m0s
[21:46:45.340] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:107:0)
[21:46:45.340] Timer tick, asking Buildbucket for the build status
[21:46:46.140] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:46.140] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:108:0) after 1m0s
[21:47:46.347] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:108:0)
[21:47:46.347] Timer tick, asking Buildbucket for the build status
[21:47:46.602] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:46.602] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:109:0) after 1m0s
[21:48:46.779] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:109:0)
[21:48:46.779] Timer tick, asking Buildbucket for the build status
[21:48:48.378] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:48.378] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:110:0) after 1m0s
[21:49:48.447] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:110:0)
[21:49:48.447] Timer tick, asking Buildbucket for the build status
[21:49:49.069] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:49.069] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:111:0) after 1m0s
[21:50:49.340] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:111:0)
[21:50:49.340] Timer tick, asking Buildbucket for the build status
[21:50:49.421] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:49.421] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:112:0) after 1m0s
[21:51:49.490] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:112:0)
[21:51:49.490] Timer tick, asking Buildbucket for the build status
[21:51:50.792] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:50.792] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:113:0) after 1m0s
[21:52:50.852] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:113:0)
[21:52:50.852] Timer tick, asking Buildbucket for the build status
[21:52:51.385] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:51.385] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:114:0) after 1m0s
[21:53:51.429] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:114:0)
[21:53:51.429] Timer tick, asking Buildbucket for the build status
[21:53:52.108] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:52.108] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:115:0) after 1m0s
[21:54:52.143] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:115:0)
[21:54:52.143] Timer tick, asking Buildbucket for the build status
[21:54:52.750] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:52.750] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:116:0) after 1m0s
[21:55:52.810] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:116:0)
[21:55:52.810] Timer tick, asking Buildbucket for the build status
[21:55:53.143] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:53.143] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:117:0) after 1m0s
[21:56:53.184] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:117:0)
[21:56:53.184] Timer tick, asking Buildbucket for the build status
[21:56:53.644] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:53.644] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:118:0) after 1m0s
[21:57:53.653] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:118:0)
[21:57:53.653] Timer tick, asking Buildbucket for the build status
[21:57:53.822] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:53.822] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:119:0) after 1m0s
[21:58:53.849] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:119:0)
[21:58:53.849] Timer tick, asking Buildbucket for the build status
[21:58:54.147] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:54.147] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:120:0) after 1m0s
[21:59:54.267] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:120:0)
[21:59:54.267] Timer tick, asking Buildbucket for the build status
[21:59:54.476] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:54.476] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:121:0) after 1m0s
[22:00:54.506] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:121:0)
[22:00:54.506] Timer tick, asking Buildbucket for the build status
[22:00:54.703] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:54.703] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:122:0) after 1m0s
[22:01:54.753] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:122:0)
[22:01:54.753] Timer tick, asking Buildbucket for the build status
[22:01:55.202] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:55.202] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:123:0) after 1m0s
[22:02:55.294] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:123:0)
[22:02:55.294] Timer tick, asking Buildbucket for the build status
[22:02:55.553] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:55.553] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:124:0) after 1m0s
[22:03:55.667] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:124:0)
[22:03:55.667] Timer tick, asking Buildbucket for the build status
[22:03:56.587] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:56.587] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:125:0) after 1m0s
[22:04:56.659] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:125:0)
[22:04:56.659] Timer tick, asking Buildbucket for the build status
[22:04:56.737] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:56.737] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:126:0) after 1m0s
[22:05:56.851] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:126:0)
[22:05:56.851] Timer tick, asking Buildbucket for the build status
[22:05:57.064] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:57.064] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:127:0) after 1m0s
[22:06:57.100] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:127:0)
[22:06:57.100] Timer tick, asking Buildbucket for the build status
[22:06:57.225] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:57.225] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:128:0) after 1m0s
[22:07:57.242] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:128:0)
[22:07:57.242] Timer tick, asking Buildbucket for the build status
[22:07:57.835] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:57.835] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:129:0) after 1m0s
[22:08:57.883] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:129:0)
[22:08:57.883] Timer tick, asking Buildbucket for the build status
[22:08:58.676] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:58.676] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:130:0) after 1m0s
[22:09:58.698] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:130:0)
[22:09:58.698] Timer tick, asking Buildbucket for the build status
[22:09:58.941] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:58.941] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:131:0) after 1m0s
[22:10:58.996] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:131:0)
[22:10:58.996] Timer tick, asking Buildbucket for the build status
[22:10:59.439] Build 8898687694278423280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:59.439] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9064117756397985360:132:0) after 1m0s
[22:11:31.672] Received PubSub notification, asking Buildbucket for the build status
[22:11:32.206] Build 8898687694278423280: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:11:32.206] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"completed_ts": "1571955090517648",
"created_by": "project:emscripten-releases",
"created_ts": "1571947118454282",
"id": "8898687694278423280",
"parameters_json": "{\"builder_name\": \"win\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"a0f51b4acfdcbc3101c8b30f1f096b23eaec852a\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@a0f51b4acfdcbc3101c8b30f1f096b23eaec852a\", \"title\": \"a0f51b4acfdcbc3101c8b30f1f096b23eaec852a\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/a0f51b4acfdcbc3101c8b30f1f096b23eaec852a\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"a0f51b4acfdcbc3101c8b30f1f096b23eaec852a\"}}",
"project": "emscripten-releases",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$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}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"a0f51b4acfdcbc3101c8b30f1f096b23eaec852a\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@a0f51b4acfdcbc3101c8b30f1f096b23eaec852a\", \"title\": \"a0f51b4acfdcbc3101c8b30f1f096b23eaec852a\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/a0f51b4acfdcbc3101c8b30f1f096b23eaec852a\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-win10-0-g478\", \"branch\": \"refs/heads/master\", \"buildername\": \"win\", \"got_revision\": \"a0f51b4acfdcbc3101c8b30f1f096b23eaec852a\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"a0f51b4acfdcbc3101c8b30f1f096b23eaec852a\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"git\", \"goma_v2\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"host_class\": [\"default\"], \"id\": [\"luci-emscripten-releases-ci-win10-0-g478\"], \"image\": [\"chrome-win10-1703-19102200-47150345821\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.emscripten-releases.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"4549-8dc3ae7\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1571951231021609",
"status": "COMPLETED",
"status_changed_ts": "1571955091073606",
"tags": [
"builder:win",
"buildset:commit/git/a0f51b4acfdcbc3101c8b30f1f096b23eaec852a",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/a0f51b4acfdcbc3101c8b30f1f096b23eaec852a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9064117756397985360",
"scheduler_job_id:emscripten-releases/win",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/emscripten-releases/buildbucket/cr-buildbucket.appspot.com/8898687694278423280/+/annotations",
"swarming_tag:luci_project:emscripten-releases",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:emscripten_releases",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:48182be88e32a410",
"user_agent:luci-scheduler"
],
"updated_ts": "1571955091083191",
"url": "https://ci.chromium.org/b/8898687694278423280",
"utcnow_ts": "1571955092189467"
}
}
[22:11:32.206] Invocation finished in 2h12m55.156918068s with status SUCCEEDED