[23:09:20.617] New invocation is queued and will start shortly
[23:09:22.047] Starting the invocation (attempt 1)
[23:09:22.129] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:09:22.130] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:09:22.130] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9060210087408893328",
"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\":\"43e51b9c68ef5bd9fcc42f4e30066daaab5df4e7\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@43e51b9c68ef5bd9fcc42f4e30066daaab5df4e7\",\"title\":\"43e51b9c68ef5bd9fcc42f4e30066daaab5df4e7\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/43e51b9c68ef5bd9fcc42f4e30066daaab5df4e7\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"43e51b9c68ef5bd9fcc42f4e30066daaab5df4e7\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win",
"scheduler_invocation_id:9060210087408893328",
"scheduler_job_id:emscripten-releases/win",
"user_agent:luci-scheduler",
"buildset:commit/git/43e51b9c68ef5bd9fcc42f4e30066daaab5df4e7",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/43e51b9c68ef5bd9fcc42f4e30066daaab5df4e7",
"gitiles_ref:refs/heads/master"
]
}
[23:09:23.713] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1575673762291750",
"id": "8894780024990511168",
"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\": \"43e51b9c68ef5bd9fcc42f4e30066daaab5df4e7\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@43e51b9c68ef5bd9fcc42f4e30066daaab5df4e7\", \"title\": \"43e51b9c68ef5bd9fcc42f4e30066daaab5df4e7\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/43e51b9c68ef5bd9fcc42f4e30066daaab5df4e7\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"43e51b9c68ef5bd9fcc42f4e30066daaab5df4e7\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1575673763194642",
"tags": [
"builder:win",
"buildset:commit/git/43e51b9c68ef5bd9fcc42f4e30066daaab5df4e7",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/43e51b9c68ef5bd9fcc42f4e30066daaab5df4e7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9060210087408893328",
"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/8894780024990511168/+/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": "1575673763194899",
"url": "https://ci.chromium.org/b/8894780024990511168",
"utcnow_ts": "1575673763696399"
}
}
[23:09:23.713] Task URL: https://ci.chromium.org/b/8894780024990511168
[23:09:23.713] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:2:0) after 1m0s
[23:10:23.733] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:2:0)
[23:10:23.733] Timer tick, asking Buildbucket for the build status
[23:10:23.831] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:10:23.832] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:3:0) after 1m0s
[23:11:24.049] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:3:0)
[23:11:24.049] Timer tick, asking Buildbucket for the build status
[23:11:24.239] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:11:24.239] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:4:0) after 1m0s
[23:12:24.294] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:4:0)
[23:12:24.295] Timer tick, asking Buildbucket for the build status
[23:12:24.432] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:12:24.433] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:5:0) after 1m0s
[23:13:24.507] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:5:0)
[23:13:24.507] Timer tick, asking Buildbucket for the build status
[23:13:24.631] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:13:24.631] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:6:0) after 1m0s
[23:14:24.655] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:6:0)
[23:14:24.655] Timer tick, asking Buildbucket for the build status
[23:14:24.932] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:14:24.932] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:7:0) after 1m0s
[23:15:24.975] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:7:0)
[23:15:24.975] Timer tick, asking Buildbucket for the build status
[23:15:25.140] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:15:25.140] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:8:0) after 1m0s
[23:16:25.199] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:8:0)
[23:16:25.199] Timer tick, asking Buildbucket for the build status
[23:16:25.651] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:16:25.651] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:9:0) after 1m0s
[23:17:25.636] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:9:0)
[23:17:25.636] Timer tick, asking Buildbucket for the build status
[23:17:25.769] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:17:25.769] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:10:0) after 1m0s
[23:18:25.949] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:10:0)
[23:18:25.949] Timer tick, asking Buildbucket for the build status
[23:18:26.129] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:18:26.129] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:11:0) after 1m0s
[23:19:26.185] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:11:0)
[23:19:26.185] Timer tick, asking Buildbucket for the build status
[23:19:26.390] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:19:26.390] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:12:0) after 1m0s
[23:20:26.475] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:12:0)
[23:20:26.475] Timer tick, asking Buildbucket for the build status
[23:20:26.658] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:20:26.658] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:13:0) after 1m0s
[23:21:26.784] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:13:0)
[23:21:26.784] Timer tick, asking Buildbucket for the build status
[23:21:27.343] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:21:27.343] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:14:0) after 1m0s
[23:22:27.418] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:14:0)
[23:22:27.418] Timer tick, asking Buildbucket for the build status
[23:22:27.567] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:22:27.567] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:15:0) after 1m0s
[23:23:27.619] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:15:0)
[23:23:27.619] Timer tick, asking Buildbucket for the build status
[23:23:27.731] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:23:27.731] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:16:0) after 1m0s
[23:24:27.830] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:16:0)
[23:24:27.830] Timer tick, asking Buildbucket for the build status
[23:24:27.984] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:24:27.984] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:17:0) after 1m0s
[23:25:28.052] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:17:0)
[23:25:28.052] Timer tick, asking Buildbucket for the build status
[23:25:28.176] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:25:28.176] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:18:0) after 1m0s
[23:26:28.266] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:18:0)
[23:26:28.266] Timer tick, asking Buildbucket for the build status
[23:26:28.427] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:26:28.427] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:19:0) after 1m0s
[23:27:28.437] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:19:0)
[23:27:28.437] Timer tick, asking Buildbucket for the build status
[23:27:29.002] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:27:29.002] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:20:0) after 1m0s
[23:28:29.315] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:20:0)
[23:28:29.315] Timer tick, asking Buildbucket for the build status
[23:28:29.649] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:28:29.649] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:21:0) after 1m0s
[23:29:29.890] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:21:0)
[23:29:29.890] Timer tick, asking Buildbucket for the build status
[23:29:30.312] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:29:30.312] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:22:0) after 1m0s
[23:30:30.453] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:22:0)
[23:30:30.453] Timer tick, asking Buildbucket for the build status
[23:30:30.711] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:30:30.711] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:23:0) after 1m0s
[23:31:30.756] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:23:0)
[23:31:30.756] Timer tick, asking Buildbucket for the build status
[23:31:31.281] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:31:31.281] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:24:0) after 1m0s
[23:32:31.420] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:24:0)
[23:32:31.420] Timer tick, asking Buildbucket for the build status
[23:32:32.031] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:32:32.031] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:25:0) after 1m0s
[23:33:32.125] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:25:0)
[23:33:32.125] Timer tick, asking Buildbucket for the build status
[23:33:32.895] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:33:32.895] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:26:0) after 1m0s
[23:34:33.050] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:26:0)
[23:34:33.050] Timer tick, asking Buildbucket for the build status
[23:34:33.313] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:34:33.313] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:27:0) after 1m0s
[23:35:33.445] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:27:0)
[23:35:33.445] Timer tick, asking Buildbucket for the build status
[23:35:33.656] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:35:33.656] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:28:0) after 1m0s
[23:36:33.770] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:28:0)
[23:36:33.770] Timer tick, asking Buildbucket for the build status
[23:36:33.959] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:36:33.959] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:29:0) after 1m0s
[23:37:34.102] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:29:0)
[23:37:34.103] Timer tick, asking Buildbucket for the build status
[23:37:35.761] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:37:35.761] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:30:0) after 1m0s
[23:38:36.034] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:30:0)
[23:38:36.034] Timer tick, asking Buildbucket for the build status
[23:38:38.856] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:38:38.856] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:31:0) after 1m0s
[23:39:38.977] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:31:0)
[23:39:38.977] Timer tick, asking Buildbucket for the build status
[23:39:39.624] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:39:39.624] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:32:0) after 1m0s
[23:40:39.862] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:32:0)
[23:40:39.862] Timer tick, asking Buildbucket for the build status
[23:40:40.265] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:40:40.265] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:33:0) after 1m0s
[23:41:40.455] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:33:0)
[23:41:40.455] Timer tick, asking Buildbucket for the build status
[23:41:41.704] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:41:41.704] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:34:0) after 1m0s
[23:42:41.783] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:34:0)
[23:42:41.783] Timer tick, asking Buildbucket for the build status
[23:42:43.174] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:42:43.174] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:35:0) after 1m0s
[23:43:43.251] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:35:0)
[23:43:43.251] Timer tick, asking Buildbucket for the build status
[23:43:43.491] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:43:43.491] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:36:0) after 1m0s
[23:44:43.933] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:36:0)
[23:44:43.933] Timer tick, asking Buildbucket for the build status
[23:44:45.774] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:44:45.774] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:37:0) after 1m0s
[23:45:45.962] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:37:0)
[23:45:45.962] Timer tick, asking Buildbucket for the build status
[23:45:47.037] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:45:47.037] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:38:0) after 1m0s
[23:46:47.098] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:38:0)
[23:46:47.098] Timer tick, asking Buildbucket for the build status
[23:46:47.588] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:46:47.588] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:39:0) after 1m0s
[23:47:47.592] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:39:0)
[23:47:47.592] Timer tick, asking Buildbucket for the build status
[23:47:47.867] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:47:47.867] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:40:0) after 1m0s
[23:48:47.912] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:40:0)
[23:48:47.912] Timer tick, asking Buildbucket for the build status
[23:48:48.381] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:48:48.381] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:41:0) after 1m0s
[23:49:48.366] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:41:0)
[23:49:48.366] Timer tick, asking Buildbucket for the build status
[23:49:49.017] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:49:49.017] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:42:0) after 1m0s
[23:50:49.043] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:42:0)
[23:50:49.043] Timer tick, asking Buildbucket for the build status
[23:50:49.256] Build 8894780024990511168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:50:49.257] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:43:0) after 1m0s
[23:50:54.007] Received PubSub notification, asking Buildbucket for the build status
[23:50:54.342] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:49.349] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:43:0)
[23:51:49.349] Timer tick, asking Buildbucket for the build status
[23:51:49.803] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:49.803] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:45:0) after 1m0s
[23:52:49.793] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:45:0)
[23:52:49.793] Timer tick, asking Buildbucket for the build status
[23:52:50.304] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:50.304] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:46:0) after 1m0s
[23:53:50.374] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:46:0)
[23:53:50.375] Timer tick, asking Buildbucket for the build status
[23:53:53.012] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:53.012] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:47:0) after 1m0s
[23:54:53.039] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:47:0)
[23:54:53.039] Timer tick, asking Buildbucket for the build status
[23:54:54.156] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:54.156] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:48:0) after 1m0s
[23:55:54.204] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:48:0)
[23:55:54.204] Timer tick, asking Buildbucket for the build status
[23:55:56.729] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:56.729] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:49:0) after 1m0s
[23:56:56.815] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:49:0)
[23:56:56.815] Timer tick, asking Buildbucket for the build status
[23:56:57.593] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:57.593] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:50:0) after 1m0s
[23:57:57.641] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:50:0)
[23:57:57.641] Timer tick, asking Buildbucket for the build status
[23:57:58.086] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:58.086] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:51:0) after 1m0s
[23:58:58.182] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:51:0)
[23:58:58.182] Timer tick, asking Buildbucket for the build status
[23:58:58.285] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:58.285] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:52:0) after 1m0s
[23:59:58.458] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:52:0)
[23:59:58.458] Timer tick, asking Buildbucket for the build status
[23:59:58.790] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:58.790] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:53:0) after 1m0s
[00:00:59.024] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:53:0)
[00:00:59.024] Timer tick, asking Buildbucket for the build status
[00:01:00.853] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:00.853] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:54:0) after 1m0s
[00:02:00.910] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:54:0)
[00:02:00.910] Timer tick, asking Buildbucket for the build status
[00:02:02.003] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:02.003] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:55:0) after 1m0s
[00:03:02.109] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:55:0)
[00:03:02.109] Timer tick, asking Buildbucket for the build status
[00:03:02.298] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:02.298] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:56:0) after 1m0s
[00:04:02.331] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:56:0)
[00:04:02.331] Timer tick, asking Buildbucket for the build status
[00:04:02.905] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:02.905] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:57:0) after 1m0s
[00:05:03.044] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:57:0)
[00:05:03.044] Timer tick, asking Buildbucket for the build status
[00:05:03.384] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:03.384] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:58:0) after 1m0s
[00:06:03.406] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:58:0)
[00:06:03.406] Timer tick, asking Buildbucket for the build status
[00:06:03.590] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:03.590] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:59:0) after 1m0s
[00:07:03.760] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:59:0)
[00:07:03.760] Timer tick, asking Buildbucket for the build status
[00:07:05.227] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:05.227] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:60:0) after 1m0s
[00:08:05.516] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:60:0)
[00:08:05.516] Timer tick, asking Buildbucket for the build status
[00:08:06.491] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:06.491] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:61:0) after 1m0s
[00:09:06.621] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:61:0)
[00:09:06.621] Timer tick, asking Buildbucket for the build status
[00:09:06.930] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:06.930] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:62:0) after 1m0s
[00:10:07.030] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:62:0)
[00:10:07.030] Timer tick, asking Buildbucket for the build status
[00:10:07.387] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:07.387] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:63:0) after 1m0s
[00:11:07.421] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:63:0)
[00:11:07.421] Timer tick, asking Buildbucket for the build status
[00:11:07.627] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:07.627] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:64:0) after 1m0s
[00:12:07.692] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:64:0)
[00:12:07.692] Timer tick, asking Buildbucket for the build status
[00:12:08.603] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:08.603] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:65:0) after 1m0s
[00:13:08.649] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:65:0)
[00:13:08.649] Timer tick, asking Buildbucket for the build status
[00:13:09.701] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:09.701] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:66:0) after 1m0s
[00:14:10.212] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:66:0)
[00:14:10.212] Timer tick, asking Buildbucket for the build status
[00:14:11.454] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:11.454] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:67:0) after 1m0s
[00:15:11.632] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:67:0)
[00:15:11.632] Timer tick, asking Buildbucket for the build status
[00:15:11.971] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:11.971] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:68:0) after 1m0s
[00:16:12.336] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:68:0)
[00:16:12.336] Timer tick, asking Buildbucket for the build status
[00:16:12.589] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:12.589] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:69:0) after 1m0s
[00:17:12.616] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:69:0)
[00:17:12.616] Timer tick, asking Buildbucket for the build status
[00:17:13.036] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:13.036] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:70:0) after 1m0s
[00:18:13.064] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:70:0)
[00:18:13.064] Timer tick, asking Buildbucket for the build status
[00:18:13.558] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:13.558] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:71:0) after 1m0s
[00:19:14.166] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:71:0)
[00:19:14.166] Timer tick, asking Buildbucket for the build status
[00:19:15.848] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:15.848] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:72:0) after 1m0s
[00:20:15.985] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:72:0)
[00:20:15.985] Timer tick, asking Buildbucket for the build status
[00:20:16.315] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:16.315] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:73:0) after 1m0s
[00:21:16.663] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:73:0)
[00:21:16.663] Timer tick, asking Buildbucket for the build status
[00:21:17.242] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:17.242] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:74:0) after 1m0s
[00:22:17.393] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:74:0)
[00:22:17.393] Timer tick, asking Buildbucket for the build status
[00:22:20.892] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:20.892] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:75:0) after 1m0s
[00:23:20.919] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:75:0)
[00:23:20.919] Timer tick, asking Buildbucket for the build status
[00:23:21.146] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:21.146] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:76:0) after 1m0s
[00:24:21.210] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:76:0)
[00:24:21.210] Timer tick, asking Buildbucket for the build status
[00:24:21.706] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:21.707] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:77:0) after 1m0s
[00:25:21.824] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:77:0)
[00:25:21.824] Timer tick, asking Buildbucket for the build status
[00:25:22.310] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:22.310] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:78:0) after 1m0s
[00:26:22.353] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:78:0)
[00:26:22.353] Timer tick, asking Buildbucket for the build status
[00:26:23.675] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:23.675] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:79:0) after 1m0s
[00:27:23.734] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:79:0)
[00:27:23.734] Timer tick, asking Buildbucket for the build status
[00:27:24.105] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:24.105] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:80:0) after 1m0s
[00:28:24.240] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:80:0)
[00:28:24.240] Timer tick, asking Buildbucket for the build status
[00:28:24.414] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:24.415] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:81:0) after 1m0s
[00:29:24.442] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:81:0)
[00:29:24.442] Timer tick, asking Buildbucket for the build status
[00:29:25.009] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:25.009] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:82:0) after 1m0s
[00:30:25.109] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:82:0)
[00:30:25.109] Timer tick, asking Buildbucket for the build status
[00:30:26.053] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:26.053] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:83:0) after 1m0s
[00:31:26.151] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:83:0)
[00:31:26.151] Timer tick, asking Buildbucket for the build status
[00:31:26.273] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:26.273] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:84:0) after 1m0s
[00:32:26.297] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:84:0)
[00:32:26.297] Timer tick, asking Buildbucket for the build status
[00:32:26.738] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:26.738] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:85:0) after 1m0s
[00:33:26.773] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:85:0)
[00:33:26.773] Timer tick, asking Buildbucket for the build status
[00:33:27.103] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:27.103] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:86:0) after 1m0s
[00:34:27.152] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:86:0)
[00:34:27.152] Timer tick, asking Buildbucket for the build status
[00:34:27.470] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:27.470] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:87:0) after 1m0s
[00:35:27.620] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:87:0)
[00:35:27.620] Timer tick, asking Buildbucket for the build status
[00:35:28.455] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:28.455] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:88:0) after 1m0s
[00:36:28.620] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:88:0)
[00:36:28.620] Timer tick, asking Buildbucket for the build status
[00:36:28.861] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:28.861] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:89:0) after 1m0s
[00:37:28.960] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:89:0)
[00:37:28.960] Timer tick, asking Buildbucket for the build status
[00:37:30.473] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:30.473] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:90:0) after 1m0s
[00:38:30.573] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:90:0)
[00:38:30.573] Timer tick, asking Buildbucket for the build status
[00:38:30.811] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:30.811] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:91:0) after 1m0s
[00:39:30.799] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:91:0)
[00:39:30.799] Timer tick, asking Buildbucket for the build status
[00:39:30.963] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:30.963] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:92:0) after 1m0s
[00:40:31.038] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:92:0)
[00:40:31.038] Timer tick, asking Buildbucket for the build status
[00:40:32.199] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:32.199] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:93:0) after 1m0s
[00:41:32.290] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:93:0)
[00:41:32.290] Timer tick, asking Buildbucket for the build status
[00:41:33.425] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:33.425] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:94:0) after 1m0s
[00:42:33.437] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:94:0)
[00:42:33.437] Timer tick, asking Buildbucket for the build status
[00:42:34.738] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:34.738] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:95:0) after 1m0s
[00:43:34.935] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:95:0)
[00:43:34.935] Timer tick, asking Buildbucket for the build status
[00:43:36.014] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:36.014] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:96:0) after 1m0s
[00:44:36.185] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:96:0)
[00:44:36.185] Timer tick, asking Buildbucket for the build status
[00:44:36.420] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:36.420] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:97:0) after 1m0s
[00:45:36.574] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:97:0)
[00:45:36.574] Timer tick, asking Buildbucket for the build status
[00:45:36.794] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:36.794] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:98:0) after 1m0s
[00:46:36.775] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:98:0)
[00:46:36.775] Timer tick, asking Buildbucket for the build status
[00:46:36.960] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:36.960] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:99:0) after 1m0s
[00:47:37.043] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:99:0)
[00:47:37.043] Timer tick, asking Buildbucket for the build status
[00:47:39.956] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:39.956] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:100:0) after 1m0s
[00:48:40.341] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:100:0)
[00:48:40.341] Timer tick, asking Buildbucket for the build status
[00:48:41.128] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:41.128] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:101:0) after 1m0s
[00:49:41.244] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:101:0)
[00:49:41.244] Timer tick, asking Buildbucket for the build status
[00:49:41.396] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:41.396] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:102:0) after 1m0s
[00:50:41.687] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:102:0)
[00:50:41.687] Timer tick, asking Buildbucket for the build status
[00:50:41.803] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:41.803] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:103:0) after 1m0s
[00:51:42.235] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:103:0)
[00:51:42.235] Timer tick, asking Buildbucket for the build status
[00:51:42.387] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:42.387] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:104:0) after 1m0s
[00:52:42.549] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:104:0)
[00:52:42.549] Timer tick, asking Buildbucket for the build status
[00:52:43.552] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:43.552] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:105:0) after 1m0s
[00:53:43.640] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:105:0)
[00:53:43.640] Timer tick, asking Buildbucket for the build status
[00:53:43.924] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:43.924] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:106:0) after 1m0s
[00:54:44.282] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:106:0)
[00:54:44.282] Timer tick, asking Buildbucket for the build status
[00:54:44.449] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:44.449] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:107:0) after 1m0s
[00:55:44.572] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:107:0)
[00:55:44.572] Timer tick, asking Buildbucket for the build status
[00:55:44.720] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:44.720] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:108:0) after 1m0s
[00:56:44.983] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:108:0)
[00:56:44.983] Timer tick, asking Buildbucket for the build status
[00:56:45.118] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:45.118] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:109:0) after 1m0s
[00:57:45.323] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:109:0)
[00:57:45.323] Timer tick, asking Buildbucket for the build status
[00:57:45.641] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:45.641] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:110:0) after 1m0s
[00:58:45.719] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:110:0)
[00:58:45.719] Timer tick, asking Buildbucket for the build status
[00:58:46.042] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:46.042] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:111:0) after 1m0s
[00:59:46.072] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:111:0)
[00:59:46.072] Timer tick, asking Buildbucket for the build status
[00:59:46.440] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:46.440] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:112:0) after 1m0s
[01:00:46.478] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:112:0)
[01:00:46.478] Timer tick, asking Buildbucket for the build status
[01:00:47.214] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:47.214] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:113:0) after 1m0s
[01:01:47.340] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:113:0)
[01:01:47.340] Timer tick, asking Buildbucket for the build status
[01:01:47.679] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:47.679] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:114:0) after 1m0s
[01:02:47.703] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:114:0)
[01:02:47.703] Timer tick, asking Buildbucket for the build status
[01:02:47.884] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:47.885] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:115:0) after 1m0s
[01:03:47.940] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:115:0)
[01:03:47.940] Timer tick, asking Buildbucket for the build status
[01:03:48.074] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:48.074] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:116:0) after 1m0s
[01:04:48.136] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:116:0)
[01:04:48.136] Timer tick, asking Buildbucket for the build status
[01:04:48.719] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:48.719] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:117:0) after 1m0s
[01:05:48.759] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:117:0)
[01:05:48.759] Timer tick, asking Buildbucket for the build status
[01:05:49.433] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:49.433] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:118:0) after 1m0s
[01:06:49.470] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:118:0)
[01:06:49.470] Timer tick, asking Buildbucket for the build status
[01:06:49.758] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:49.758] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:119:0) after 1m0s
[01:07:49.788] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:119:0)
[01:07:49.788] Timer tick, asking Buildbucket for the build status
[01:07:49.947] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:49.947] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:120:0) after 1m0s
[01:08:50.008] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:120:0)
[01:08:50.008] Timer tick, asking Buildbucket for the build status
[01:08:50.303] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:50.303] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:121:0) after 1m0s
[01:09:50.436] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:121:0)
[01:09:50.436] Timer tick, asking Buildbucket for the build status
[01:09:50.569] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:50.569] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:122:0) after 1m0s
[01:10:50.630] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:122:0)
[01:10:50.630] Timer tick, asking Buildbucket for the build status
[01:10:50.865] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:50.865] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:123:0) after 1m0s
[01:11:50.909] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:123:0)
[01:11:50.909] Timer tick, asking Buildbucket for the build status
[01:11:51.268] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:51.268] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:124:0) after 1m0s
[01:12:51.326] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:124:0)
[01:12:51.326] Timer tick, asking Buildbucket for the build status
[01:12:51.556] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:51.556] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:125:0) after 1m0s
[01:13:51.571] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:125:0)
[01:13:51.571] Timer tick, asking Buildbucket for the build status
[01:13:51.818] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:51.818] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:126:0) after 1m0s
[01:14:51.848] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:126:0)
[01:14:51.848] Timer tick, asking Buildbucket for the build status
[01:14:52.275] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:52.275] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:127:0) after 1m0s
[01:15:52.413] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:127:0)
[01:15:52.413] Timer tick, asking Buildbucket for the build status
[01:15:52.685] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:52.685] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:128:0) after 1m0s
[01:16:52.747] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:128:0)
[01:16:52.747] Timer tick, asking Buildbucket for the build status
[01:16:52.943] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:52.943] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:129:0) after 1m0s
[01:17:52.989] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:129:0)
[01:17:52.989] Timer tick, asking Buildbucket for the build status
[01:17:54.022] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:54.022] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:130:0) after 1m0s
[01:18:54.202] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:130:0)
[01:18:54.202] Timer tick, asking Buildbucket for the build status
[01:18:54.491] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:54.491] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:131:0) after 1m0s
[01:19:54.515] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:131:0)
[01:19:54.515] Timer tick, asking Buildbucket for the build status
[01:19:54.620] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:54.620] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:132:0) after 1m0s
[01:20:54.708] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:132:0)
[01:20:54.708] Timer tick, asking Buildbucket for the build status
[01:20:54.964] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:54.964] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:133:0) after 1m0s
[01:21:55.044] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:133:0)
[01:21:55.044] Timer tick, asking Buildbucket for the build status
[01:21:55.330] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:55.330] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:134:0) after 1m0s
[01:22:55.568] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:134:0)
[01:22:55.568] Timer tick, asking Buildbucket for the build status
[01:22:57.235] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:57.235] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:135:0) after 1m0s
[01:23:57.919] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:135:0)
[01:23:57.919] Timer tick, asking Buildbucket for the build status
[01:23:58.263] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:58.263] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:136:0) after 1m0s
[01:24:58.882] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:136:0)
[01:24:58.882] Timer tick, asking Buildbucket for the build status
[01:24:59.463] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:59.463] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:137:0) after 1m0s
[01:25:59.710] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:137:0)
[01:25:59.710] Timer tick, asking Buildbucket for the build status
[01:25:59.947] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:59.947] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:138:0) after 1m0s
[01:27:00.424] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:138:0)
[01:27:00.424] Timer tick, asking Buildbucket for the build status
[01:27:00.675] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:00.675] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:139:0) after 1m0s
[01:28:00.664] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:139:0)
[01:28:00.664] Timer tick, asking Buildbucket for the build status
[01:28:00.938] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:00.938] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:140:0) after 1m0s
[01:29:01.156] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:140:0)
[01:29:01.156] Timer tick, asking Buildbucket for the build status
[01:29:01.562] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:01.562] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:141:0) after 1m0s
[01:30:01.640] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:141:0)
[01:30:01.640] Timer tick, asking Buildbucket for the build status
[01:30:01.813] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:01.813] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:142:0) after 1m0s
[01:31:01.954] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:142:0)
[01:31:01.954] Timer tick, asking Buildbucket for the build status
[01:31:02.200] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:02.200] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:143:0) after 1m0s
[01:32:02.295] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:143:0)
[01:32:02.295] Timer tick, asking Buildbucket for the build status
[01:32:02.472] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:02.472] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:144:0) after 1m0s
[01:33:02.603] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:144:0)
[01:33:02.603] Timer tick, asking Buildbucket for the build status
[01:33:03.012] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:03.012] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:145:0) after 1m0s
[01:34:03.338] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:145:0)
[01:34:03.338] Timer tick, asking Buildbucket for the build status
[01:34:03.573] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:03.573] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:146:0) after 1m0s
[01:35:03.916] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:146:0)
[01:35:03.916] Timer tick, asking Buildbucket for the build status
[01:35:04.059] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:04.059] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:147:0) after 1m0s
[01:36:04.189] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:147:0)
[01:36:04.189] Timer tick, asking Buildbucket for the build status
[01:36:04.376] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:04.376] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:148:0) after 1m0s
[01:37:05.021] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:148:0)
[01:37:05.021] Timer tick, asking Buildbucket for the build status
[01:37:05.220] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:05.220] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:149:0) after 1m0s
[01:38:05.310] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:149:0)
[01:38:05.310] Timer tick, asking Buildbucket for the build status
[01:38:05.488] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:05.488] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:150:0) after 1m0s
[01:39:05.591] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:150:0)
[01:39:05.591] Timer tick, asking Buildbucket for the build status
[01:39:05.744] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:05.744] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:151:0) after 1m0s
[01:40:06.098] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:151:0)
[01:40:06.098] Timer tick, asking Buildbucket for the build status
[01:40:06.329] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:06.329] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:152:0) after 1m0s
[01:41:06.449] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:152:0)
[01:41:06.449] Timer tick, asking Buildbucket for the build status
[01:41:06.610] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:06.610] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:153:0) after 1m0s
[01:42:06.719] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:153:0)
[01:42:06.719] Timer tick, asking Buildbucket for the build status
[01:42:06.901] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:06.901] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:154:0) after 1m0s
[01:43:06.991] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:154:0)
[01:43:06.991] Timer tick, asking Buildbucket for the build status
[01:43:07.168] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:07.168] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:155:0) after 1m0s
[01:44:07.392] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:155:0)
[01:44:07.392] Timer tick, asking Buildbucket for the build status
[01:44:07.595] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:07.595] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:156:0) after 1m0s
[01:45:08.212] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:156:0)
[01:45:08.212] Timer tick, asking Buildbucket for the build status
[01:45:08.432] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:08.432] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:157:0) after 1m0s
[01:46:08.611] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:157:0)
[01:46:08.611] Timer tick, asking Buildbucket for the build status
[01:46:08.742] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:08.742] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:158:0) after 1m0s
[01:47:08.900] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:158:0)
[01:47:08.900] Timer tick, asking Buildbucket for the build status
[01:47:09.690] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:09.690] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:159:0) after 1m0s
[01:48:09.968] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:159:0)
[01:48:09.968] Timer tick, asking Buildbucket for the build status
[01:48:10.106] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:10.106] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:160:0) after 1m0s
[01:49:10.402] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:160:0)
[01:49:10.402] Timer tick, asking Buildbucket for the build status
[01:49:10.576] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:10.576] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:161:0) after 1m0s
[01:50:10.611] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:161:0)
[01:50:10.611] Timer tick, asking Buildbucket for the build status
[01:50:10.913] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:10.913] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:162:0) after 1m0s
[01:51:11.065] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:162:0)
[01:51:11.065] Timer tick, asking Buildbucket for the build status
[01:51:11.361] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:11.361] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:163:0) after 1m0s
[01:52:11.415] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:163:0)
[01:52:11.415] Timer tick, asking Buildbucket for the build status
[01:52:11.679] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:11.679] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:164:0) after 1m0s
[01:53:11.785] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:164:0)
[01:53:11.785] Timer tick, asking Buildbucket for the build status
[01:53:11.978] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:11.978] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:165:0) after 1m0s
[01:54:12.075] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:165:0)
[01:54:12.075] Timer tick, asking Buildbucket for the build status
[01:54:12.449] Build 8894780024990511168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:12.449] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9060210087408893328:166:0) after 1m0s
[01:54:39.556] Received PubSub notification, asking Buildbucket for the build status
[01:54:39.894] Build 8894780024990511168: status "COMPLETED", result "CANCELED", failure_reason "", cancelation_reason "TIMEOUT"
[01:54:39.894] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"cancelation_reason": "TIMEOUT",
"completed_ts": "1575683678321011",
"created_by": "project:emscripten-releases",
"created_ts": "1575673762291750",
"id": "8894780024990511168",
"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\": \"43e51b9c68ef5bd9fcc42f4e30066daaab5df4e7\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@43e51b9c68ef5bd9fcc42f4e30066daaab5df4e7\", \"title\": \"43e51b9c68ef5bd9fcc42f4e30066daaab5df4e7\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/43e51b9c68ef5bd9fcc42f4e30066daaab5df4e7\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"43e51b9c68ef5bd9fcc42f4e30066daaab5df4e7\"}}",
"project": "emscripten-releases",
"result": "CANCELED",
"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\": \"43e51b9c68ef5bd9fcc42f4e30066daaab5df4e7\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@43e51b9c68ef5bd9fcc42f4e30066daaab5df4e7\", \"title\": \"43e51b9c68ef5bd9fcc42f4e30066daaab5df4e7\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/43e51b9c68ef5bd9fcc42f4e30066daaab5df4e7\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-win10-0-a4y8\", \"branch\": \"refs/heads/master\", \"buildername\": \"win\", \"got_revision\": \"43e51b9c68ef5bd9fcc42f4e30066daaab5df4e7\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"43e51b9c68ef5bd9fcc42f4e30066daaab5df4e7\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_0175bca77590805533ed6e20351c9bfa7effd036e42d11a5b619a6ce75a8e486_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"host_class\": [\"default\"], \"id\": [\"luci-emscripten-releases-ci-win10-0-a4y8\"], \"image\": [\"chrome-win10-1703-19112100-3085293b610\"], \"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\": [\"4702-f6d98f9\"], \"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": "1575676253080002",
"status": "COMPLETED",
"status_changed_ts": "1575683678747550",
"tags": [
"builder:win",
"buildset:commit/git/43e51b9c68ef5bd9fcc42f4e30066daaab5df4e7",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/43e51b9c68ef5bd9fcc42f4e30066daaab5df4e7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9060210087408893328",
"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/8894780024990511168/+/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:48f64b24dc0e7510",
"user_agent:luci-scheduler"
],
"updated_ts": "1575683678758541",
"url": "https://ci.chromium.org/b/8894780024990511168",
"utcnow_ts": "1575683679879009"
}
}
[01:54:39.894] Invocation finished in 2h45m19.292563807s with status FAILED