[02:15:15.209] New invocation is queued and will start shortly
[02:15:17.456] Starting the invocation (attempt 1)
[02:15:17.533] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:15:17.533] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:15:17.533] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9050776306466173872",
"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\":\"74dda2bf1601250326c9b0257ca1342124a46d4a\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@74dda2bf1601250326c9b0257ca1342124a46d4a\",\"title\":\"74dda2bf1601250326c9b0257ca1342124a46d4a\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/74dda2bf1601250326c9b0257ca1342124a46d4a\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"74dda2bf1601250326c9b0257ca1342124a46d4a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win",
"scheduler_invocation_id:9050776306466173872",
"scheduler_job_id:emscripten-releases/win",
"user_agent:luci-scheduler",
"buildset:commit/git/74dda2bf1601250326c9b0257ca1342124a46d4a",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/74dda2bf1601250326c9b0257ca1342124a46d4a",
"gitiles_ref:refs/heads/master"
]
}
[02:15:18.440] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1584670517709353",
"id": "8885346243180867104",
"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\": \"74dda2bf1601250326c9b0257ca1342124a46d4a\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@74dda2bf1601250326c9b0257ca1342124a46d4a\", \"title\": \"74dda2bf1601250326c9b0257ca1342124a46d4a\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/74dda2bf1601250326c9b0257ca1342124a46d4a\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"74dda2bf1601250326c9b0257ca1342124a46d4a\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1584670518232784",
"tags": [
"builder:win",
"buildset:commit/git/74dda2bf1601250326c9b0257ca1342124a46d4a",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/74dda2bf1601250326c9b0257ca1342124a46d4a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9050776306466173872",
"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/8885346243180867104/+/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": "1584670518232926",
"url": "https://ci.chromium.org/b/8885346243180867104",
"utcnow_ts": "1584670518421185"
}
}
[02:15:18.440] Task URL: https://ci.chromium.org/b/8885346243180867104
[02:15:18.440] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:2:0) after 1m0s
[02:16:18.790] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:2:0)
[02:16:18.790] Timer tick, asking Buildbucket for the build status
[02:16:19.351] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:16:19.351] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:3:0) after 1m0s
[02:17:19.484] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:3:0)
[02:17:19.484] Timer tick, asking Buildbucket for the build status
[02:17:20.141] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:17:20.141] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:4:0) after 1m0s
[02:18:20.191] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:4:0)
[02:18:20.191] Timer tick, asking Buildbucket for the build status
[02:18:20.439] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:18:20.439] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:5:0) after 1m0s
[02:19:20.558] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:5:0)
[02:19:20.558] Timer tick, asking Buildbucket for the build status
[02:19:20.890] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:19:20.890] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:6:0) after 1m0s
[02:20:21.010] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:6:0)
[02:20:21.010] Timer tick, asking Buildbucket for the build status
[02:20:21.187] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:20:21.187] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:7:0) after 1m0s
[02:21:21.206] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:7:0)
[02:21:21.206] Timer tick, asking Buildbucket for the build status
[02:21:21.327] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:21:21.327] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:8:0) after 1m0s
[02:22:21.446] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:8:0)
[02:22:21.446] Timer tick, asking Buildbucket for the build status
[02:22:21.558] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:22:21.558] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:9:0) after 1m0s
[02:23:21.671] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:9:0)
[02:23:21.671] Timer tick, asking Buildbucket for the build status
[02:23:21.937] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:23:21.937] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:10:0) after 1m0s
[02:24:22.052] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:10:0)
[02:24:22.052] Timer tick, asking Buildbucket for the build status
[02:24:22.247] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:24:22.247] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:11:0) after 1m0s
[02:25:22.357] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:11:0)
[02:25:22.357] Timer tick, asking Buildbucket for the build status
[02:25:22.464] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:25:22.464] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:12:0) after 1m0s
[02:26:22.557] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:12:0)
[02:26:22.557] Timer tick, asking Buildbucket for the build status
[02:26:22.847] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:26:22.847] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:13:0) after 1m0s
[02:27:23.059] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:13:0)
[02:27:23.059] Timer tick, asking Buildbucket for the build status
[02:27:23.198] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:27:23.198] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:14:0) after 1m0s
[02:28:23.356] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:14:0)
[02:28:23.356] Timer tick, asking Buildbucket for the build status
[02:28:23.531] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:28:23.531] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:15:0) after 1m0s
[02:29:23.681] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:15:0)
[02:29:23.681] Timer tick, asking Buildbucket for the build status
[02:29:23.897] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:29:23.897] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:16:0) after 1m0s
[02:30:24.027] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:16:0)
[02:30:24.027] Timer tick, asking Buildbucket for the build status
[02:30:24.137] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:30:24.137] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:17:0) after 1m0s
[02:31:24.252] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:17:0)
[02:31:24.252] Timer tick, asking Buildbucket for the build status
[02:31:24.365] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:31:24.365] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:18:0) after 1m0s
[02:32:24.492] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:18:0)
[02:32:24.492] Timer tick, asking Buildbucket for the build status
[02:32:24.702] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:32:24.702] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:19:0) after 1m0s
[02:33:24.777] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:19:0)
[02:33:24.777] Timer tick, asking Buildbucket for the build status
[02:33:24.912] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:33:24.912] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:20:0) after 1m0s
[02:34:25.043] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:20:0)
[02:34:25.043] Timer tick, asking Buildbucket for the build status
[02:34:25.281] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:34:25.281] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:21:0) after 1m0s
[02:35:25.367] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:21:0)
[02:35:25.367] Timer tick, asking Buildbucket for the build status
[02:35:25.875] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:35:25.875] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:22:0) after 1m0s
[02:36:25.885] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:22:0)
[02:36:25.885] Timer tick, asking Buildbucket for the build status
[02:36:26.177] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:36:26.177] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:23:0) after 1m0s
[02:37:26.253] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:23:0)
[02:37:26.253] Timer tick, asking Buildbucket for the build status
[02:37:26.576] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:37:26.576] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:24:0) after 1m0s
[02:38:26.590] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:24:0)
[02:38:26.590] Timer tick, asking Buildbucket for the build status
[02:38:27.015] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:38:27.015] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:25:0) after 1m0s
[02:39:27.065] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:25:0)
[02:39:27.065] Timer tick, asking Buildbucket for the build status
[02:39:27.283] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:39:27.283] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:26:0) after 1m0s
[02:40:27.382] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:26:0)
[02:40:27.382] Timer tick, asking Buildbucket for the build status
[02:40:27.548] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:40:27.548] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:27:0) after 1m0s
[02:41:27.605] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:27:0)
[02:41:27.605] Timer tick, asking Buildbucket for the build status
[02:41:27.810] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:41:27.810] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:28:0) after 1m0s
[02:42:27.843] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:28:0)
[02:42:27.843] Timer tick, asking Buildbucket for the build status
[02:42:29.063] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:42:29.063] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:29:0) after 1m0s
[02:43:29.160] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:29:0)
[02:43:29.160] Timer tick, asking Buildbucket for the build status
[02:43:29.352] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:43:29.352] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:30:0) after 1m0s
[02:44:29.370] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:30:0)
[02:44:29.371] Timer tick, asking Buildbucket for the build status
[02:44:29.707] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:44:29.707] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:31:0) after 1m0s
[02:45:29.810] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:31:0)
[02:45:29.810] Timer tick, asking Buildbucket for the build status
[02:45:30.038] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:45:30.038] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:32:0) after 1m0s
[02:46:30.122] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:32:0)
[02:46:30.122] Timer tick, asking Buildbucket for the build status
[02:46:30.300] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:46:30.300] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:33:0) after 1m0s
[02:47:30.313] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:33:0)
[02:47:30.313] Timer tick, asking Buildbucket for the build status
[02:47:30.767] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:47:30.767] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:34:0) after 1m0s
[02:48:30.814] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:34:0)
[02:48:30.814] Timer tick, asking Buildbucket for the build status
[02:48:30.970] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:48:30.970] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:35:0) after 1m0s
[02:49:31.003] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:35:0)
[02:49:31.003] Timer tick, asking Buildbucket for the build status
[02:49:31.109] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:49:31.109] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:36:0) after 1m0s
[02:50:31.128] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:36:0)
[02:50:31.128] Timer tick, asking Buildbucket for the build status
[02:50:31.303] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:50:31.303] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:37:0) after 1m0s
[02:51:31.345] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:37:0)
[02:51:31.345] Timer tick, asking Buildbucket for the build status
[02:51:31.575] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:51:31.575] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:38:0) after 1m0s
[02:52:31.639] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:38:0)
[02:52:31.639] Timer tick, asking Buildbucket for the build status
[02:52:33.303] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:52:33.303] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:39:0) after 1m0s
[02:53:33.359] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:39:0)
[02:53:33.359] Timer tick, asking Buildbucket for the build status
[02:53:33.686] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:53:33.686] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:40:0) after 1m0s
[02:54:33.748] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:40:0)
[02:54:33.749] Timer tick, asking Buildbucket for the build status
[02:54:33.871] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:54:33.871] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:41:0) after 1m0s
[02:55:33.904] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:41:0)
[02:55:33.904] Timer tick, asking Buildbucket for the build status
[02:55:34.193] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:55:34.193] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:42:0) after 1m0s
[02:56:34.314] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:42:0)
[02:56:34.314] Timer tick, asking Buildbucket for the build status
[02:56:34.436] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:56:34.436] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:43:0) after 1m0s
[02:57:34.454] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:43:0)
[02:57:34.454] Timer tick, asking Buildbucket for the build status
[02:57:34.980] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:57:34.980] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:44:0) after 1m0s
[02:58:34.998] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:44:0)
[02:58:34.998] Timer tick, asking Buildbucket for the build status
[02:58:35.109] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:58:35.110] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:45:0) after 1m0s
[02:59:35.172] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:45:0)
[02:59:35.172] Timer tick, asking Buildbucket for the build status
[02:59:35.304] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:59:35.304] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:46:0) after 1m0s
[03:00:35.307] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:46:0)
[03:00:35.307] Timer tick, asking Buildbucket for the build status
[03:00:35.427] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:00:35.427] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:47:0) after 1m0s
[03:01:35.552] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:47:0)
[03:01:35.552] Timer tick, asking Buildbucket for the build status
[03:01:35.781] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:01:35.781] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:48:0) after 1m0s
[03:02:35.808] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:48:0)
[03:02:35.808] Timer tick, asking Buildbucket for the build status
[03:02:38.345] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:02:38.345] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:49:0) after 1m0s
[03:03:38.451] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:49:0)
[03:03:38.451] Timer tick, asking Buildbucket for the build status
[03:03:46.312] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:03:46.312] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:50:0) after 1m0s
[03:04:46.389] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:50:0)
[03:04:46.389] Timer tick, asking Buildbucket for the build status
[03:04:46.682] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:04:46.682] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:51:0) after 1m0s
[03:05:46.781] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:51:0)
[03:05:46.781] Timer tick, asking Buildbucket for the build status
[03:05:46.910] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:05:46.910] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:52:0) after 1m0s
[03:06:46.938] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:52:0)
[03:06:46.938] Timer tick, asking Buildbucket for the build status
[03:06:47.080] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:06:47.080] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:53:0) after 1m0s
[03:07:47.211] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:53:0)
[03:07:47.211] Timer tick, asking Buildbucket for the build status
[03:07:47.656] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:07:47.656] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:54:0) after 1m0s
[03:08:47.760] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:54:0)
[03:08:47.760] Timer tick, asking Buildbucket for the build status
[03:08:47.912] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:08:47.912] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:55:0) after 1m0s
[03:09:48.037] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:55:0)
[03:09:48.037] Timer tick, asking Buildbucket for the build status
[03:09:48.379] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:09:48.379] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:56:0) after 1m0s
[03:10:48.453] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:56:0)
[03:10:48.453] Timer tick, asking Buildbucket for the build status
[03:10:48.914] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:10:48.914] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:57:0) after 1m0s
[03:11:49.242] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:57:0)
[03:11:49.242] Timer tick, asking Buildbucket for the build status
[03:11:49.565] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:11:49.565] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:58:0) after 1m0s
[03:12:49.604] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:58:0)
[03:12:49.604] Timer tick, asking Buildbucket for the build status
[03:12:49.843] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:12:49.843] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:59:0) after 1m0s
[03:13:49.858] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:59:0)
[03:13:49.858] Timer tick, asking Buildbucket for the build status
[03:13:50.287] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:13:50.287] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:60:0) after 1m0s
[03:14:50.400] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:60:0)
[03:14:50.400] Timer tick, asking Buildbucket for the build status
[03:14:50.559] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:14:50.559] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:61:0) after 1m0s
[03:15:50.618] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:61:0)
[03:15:50.618] Timer tick, asking Buildbucket for the build status
[03:15:50.785] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:15:50.785] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:62:0) after 1m0s
[03:16:50.811] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:62:0)
[03:16:50.811] Timer tick, asking Buildbucket for the build status
[03:16:51.588] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:16:51.588] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:63:0) after 1m0s
[03:17:51.831] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:63:0)
[03:17:51.831] Timer tick, asking Buildbucket for the build status
[03:17:52.129] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:17:52.129] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:64:0) after 1m0s
[03:18:52.192] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:64:0)
[03:18:52.192] Timer tick, asking Buildbucket for the build status
[03:18:52.355] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:18:52.355] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:65:0) after 1m0s
[03:19:52.427] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:65:0)
[03:19:52.427] Timer tick, asking Buildbucket for the build status
[03:19:52.641] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:19:52.641] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:66:0) after 1m0s
[03:20:52.786] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:66:0)
[03:20:52.786] Timer tick, asking Buildbucket for the build status
[03:20:52.909] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:20:52.910] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:67:0) after 1m0s
[03:21:52.996] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:67:0)
[03:21:52.996] Timer tick, asking Buildbucket for the build status
[03:21:53.301] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:21:53.302] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:68:0) after 1m0s
[03:22:53.402] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:68:0)
[03:22:53.402] Timer tick, asking Buildbucket for the build status
[03:22:54.068] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:22:54.068] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:69:0) after 1m0s
[03:23:54.151] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:69:0)
[03:23:54.151] Timer tick, asking Buildbucket for the build status
[03:23:55.207] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:23:55.207] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:70:0) after 1m0s
[03:24:55.342] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:70:0)
[03:24:55.342] Timer tick, asking Buildbucket for the build status
[03:24:55.453] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:24:55.453] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:71:0) after 1m0s
[03:25:55.597] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:71:0)
[03:25:55.597] Timer tick, asking Buildbucket for the build status
[03:25:55.853] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:25:55.853] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:72:0) after 1m0s
[03:26:55.884] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:72:0)
[03:26:55.884] Timer tick, asking Buildbucket for the build status
[03:26:56.213] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:26:56.213] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:73:0) after 1m0s
[03:27:56.297] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:73:0)
[03:27:56.297] Timer tick, asking Buildbucket for the build status
[03:27:56.474] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:27:56.474] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:74:0) after 1m0s
[03:28:56.539] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:74:0)
[03:28:56.539] Timer tick, asking Buildbucket for the build status
[03:28:56.659] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:28:56.659] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:75:0) after 1m0s
[03:29:56.699] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:75:0)
[03:29:56.699] Timer tick, asking Buildbucket for the build status
[03:29:56.846] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:29:56.846] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:76:0) after 1m0s
[03:30:56.908] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:76:0)
[03:30:56.908] Timer tick, asking Buildbucket for the build status
[03:30:57.012] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:30:57.012] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:77:0) after 1m0s
[03:31:57.055] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:77:0)
[03:31:57.055] Timer tick, asking Buildbucket for the build status
[03:31:57.189] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:31:57.189] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:78:0) after 1m0s
[03:32:57.257] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:78:0)
[03:32:57.257] Timer tick, asking Buildbucket for the build status
[03:32:57.414] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:32:57.414] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:79:0) after 1m0s
[03:33:57.568] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:79:0)
[03:33:57.568] Timer tick, asking Buildbucket for the build status
[03:33:57.765] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:33:57.765] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:80:0) after 1m0s
[03:34:57.950] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:80:0)
[03:34:57.950] Timer tick, asking Buildbucket for the build status
[03:34:58.060] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:34:58.060] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:81:0) after 1m0s
[03:35:58.114] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:81:0)
[03:35:58.114] Timer tick, asking Buildbucket for the build status
[03:35:58.233] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:35:58.233] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:82:0) after 1m0s
[03:36:58.239] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:82:0)
[03:36:58.239] Timer tick, asking Buildbucket for the build status
[03:36:58.417] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:36:58.417] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:83:0) after 1m0s
[03:37:58.455] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:83:0)
[03:37:58.455] Timer tick, asking Buildbucket for the build status
[03:37:58.737] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:37:58.737] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:84:0) after 1m0s
[03:38:58.990] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:84:0)
[03:38:58.990] Timer tick, asking Buildbucket for the build status
[03:38:59.391] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:38:59.391] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:85:0) after 1m0s
[03:39:59.457] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:85:0)
[03:39:59.457] Timer tick, asking Buildbucket for the build status
[03:39:59.635] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:39:59.635] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:86:0) after 1m0s
[03:40:59.677] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:86:0)
[03:40:59.677] Timer tick, asking Buildbucket for the build status
[03:40:59.857] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:40:59.857] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:87:0) after 1m0s
[03:42:00.043] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:87:0)
[03:42:00.043] Timer tick, asking Buildbucket for the build status
[03:42:00.525] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:42:00.525] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:88:0) after 1m0s
[03:43:00.596] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:88:0)
[03:43:00.596] Timer tick, asking Buildbucket for the build status
[03:43:00.881] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:43:00.881] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:89:0) after 1m0s
[03:44:00.968] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:89:0)
[03:44:00.968] Timer tick, asking Buildbucket for the build status
[03:44:01.076] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:44:01.076] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:90:0) after 1m0s
[03:45:01.112] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:90:0)
[03:45:01.112] Timer tick, asking Buildbucket for the build status
[03:45:01.286] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:45:01.286] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:91:0) after 1m0s
[03:46:01.356] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:91:0)
[03:46:01.356] Timer tick, asking Buildbucket for the build status
[03:46:01.683] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:46:01.683] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:92:0) after 1m0s
[03:47:01.839] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:92:0)
[03:47:01.839] Timer tick, asking Buildbucket for the build status
[03:47:01.983] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:47:01.983] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:93:0) after 1m0s
[03:48:02.047] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:93:0)
[03:48:02.047] Timer tick, asking Buildbucket for the build status
[03:48:02.357] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:48:02.357] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:94:0) after 1m0s
[03:49:02.445] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:94:0)
[03:49:02.445] Timer tick, asking Buildbucket for the build status
[03:49:02.796] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:49:02.796] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:95:0) after 1m0s
[03:50:02.857] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:95:0)
[03:50:02.857] Timer tick, asking Buildbucket for the build status
[03:50:03.006] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:50:03.006] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:96:0) after 1m0s
[03:51:03.077] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:96:0)
[03:51:03.077] Timer tick, asking Buildbucket for the build status
[03:51:03.239] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:51:03.239] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:97:0) after 1m0s
[03:52:03.306] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:97:0)
[03:52:03.306] Timer tick, asking Buildbucket for the build status
[03:52:03.493] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:52:03.493] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:98:0) after 1m0s
[03:53:03.635] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:98:0)
[03:53:03.635] Timer tick, asking Buildbucket for the build status
[03:53:03.802] Build 8885346243180867104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:53:03.802] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:99:0) after 1m0s
[03:53:29.238] Received PubSub notification, asking Buildbucket for the build status
[03:53:29.399] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:03.918] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:99:0)
[03:54:03.919] Timer tick, asking Buildbucket for the build status
[03:54:04.134] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:04.134] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:101:0) after 1m0s
[03:55:04.190] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:101:0)
[03:55:04.190] Timer tick, asking Buildbucket for the build status
[03:55:04.310] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:04.310] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:102:0) after 1m0s
[03:56:04.446] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:102:0)
[03:56:04.446] Timer tick, asking Buildbucket for the build status
[03:56:04.605] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:04.605] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:103:0) after 1m0s
[03:57:04.669] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:103:0)
[03:57:04.669] Timer tick, asking Buildbucket for the build status
[03:57:04.795] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:04.795] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:104:0) after 1m0s
[03:58:04.829] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:104:0)
[03:58:04.829] Timer tick, asking Buildbucket for the build status
[03:58:05.435] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:05.435] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:105:0) after 1m0s
[03:59:05.505] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:105:0)
[03:59:05.505] Timer tick, asking Buildbucket for the build status
[03:59:05.706] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:05.706] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:106:0) after 1m0s
[04:00:05.745] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:106:0)
[04:00:05.745] Timer tick, asking Buildbucket for the build status
[04:00:05.905] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:05.905] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:107:0) after 1m0s
[04:01:05.904] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:107:0)
[04:01:05.904] Timer tick, asking Buildbucket for the build status
[04:01:06.055] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:06.055] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:108:0) after 1m0s
[04:02:06.145] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:108:0)
[04:02:06.145] Timer tick, asking Buildbucket for the build status
[04:02:06.333] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:06.333] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:109:0) after 1m0s
[04:03:06.386] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:109:0)
[04:03:06.386] Timer tick, asking Buildbucket for the build status
[04:03:06.547] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:06.547] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:110:0) after 1m0s
[04:04:06.598] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:110:0)
[04:04:06.599] Timer tick, asking Buildbucket for the build status
[04:04:06.849] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:06.849] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:111:0) after 1m0s
[04:05:07.095] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:111:0)
[04:05:07.095] Timer tick, asking Buildbucket for the build status
[04:05:07.270] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:07.270] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:112:0) after 1m0s
[04:06:07.431] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:112:0)
[04:06:07.432] Timer tick, asking Buildbucket for the build status
[04:06:07.597] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:07.597] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:113:0) after 1m0s
[04:07:07.938] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:113:0)
[04:07:07.938] Timer tick, asking Buildbucket for the build status
[04:07:08.947] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:08.947] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:114:0) after 1m0s
[04:08:08.941] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:114:0)
[04:08:08.941] Timer tick, asking Buildbucket for the build status
[04:08:09.104] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:09.104] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:115:0) after 1m0s
[04:09:09.159] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:115:0)
[04:09:09.159] Timer tick, asking Buildbucket for the build status
[04:09:09.270] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:09.270] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:116:0) after 1m0s
[04:10:09.504] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:116:0)
[04:10:09.504] Timer tick, asking Buildbucket for the build status
[04:10:09.783] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:09.783] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:117:0) after 1m0s
[04:11:09.948] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:117:0)
[04:11:09.948] Timer tick, asking Buildbucket for the build status
[04:11:10.188] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:10.188] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:118:0) after 1m0s
[04:12:10.362] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:118:0)
[04:12:10.362] Timer tick, asking Buildbucket for the build status
[04:12:10.729] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:10.729] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:119:0) after 1m0s
[04:13:10.896] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:119:0)
[04:13:10.896] Timer tick, asking Buildbucket for the build status
[04:13:11.012] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:11.012] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:120:0) after 1m0s
[04:14:11.042] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:120:0)
[04:14:11.042] Timer tick, asking Buildbucket for the build status
[04:14:11.243] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:11.243] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:121:0) after 1m0s
[04:15:11.310] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:121:0)
[04:15:11.310] Timer tick, asking Buildbucket for the build status
[04:15:11.597] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:11.597] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:122:0) after 1m0s
[04:16:11.655] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:122:0)
[04:16:11.655] Timer tick, asking Buildbucket for the build status
[04:16:11.922] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:11.922] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:123:0) after 1m0s
[04:17:11.990] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:123:0)
[04:17:11.990] Timer tick, asking Buildbucket for the build status
[04:17:12.166] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:12.166] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:124:0) after 1m0s
[04:18:12.336] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:124:0)
[04:18:12.336] Timer tick, asking Buildbucket for the build status
[04:18:12.609] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:12.610] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:125:0) after 1m0s
[04:19:13.447] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:125:0)
[04:19:13.447] Timer tick, asking Buildbucket for the build status
[04:19:13.603] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:13.603] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:126:0) after 1m0s
[04:20:13.698] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:126:0)
[04:20:13.698] Timer tick, asking Buildbucket for the build status
[04:20:13.846] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:13.846] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:127:0) after 1m0s
[04:21:13.905] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:127:0)
[04:21:13.905] Timer tick, asking Buildbucket for the build status
[04:21:14.217] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:14.217] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:128:0) after 1m0s
[04:22:14.251] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:128:0)
[04:22:14.251] Timer tick, asking Buildbucket for the build status
[04:22:15.202] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:15.202] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:129:0) after 1m0s
[04:23:15.255] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:129:0)
[04:23:15.255] Timer tick, asking Buildbucket for the build status
[04:23:15.510] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:15.510] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:130:0) after 1m0s
[04:24:15.582] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:130:0)
[04:24:15.582] Timer tick, asking Buildbucket for the build status
[04:24:15.898] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:15.898] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:131:0) after 1m0s
[04:25:15.943] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:131:0)
[04:25:15.943] Timer tick, asking Buildbucket for the build status
[04:25:16.049] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:16.049] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:132:0) after 1m0s
[04:26:16.242] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:132:0)
[04:26:16.242] Timer tick, asking Buildbucket for the build status
[04:26:16.620] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:16.620] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:133:0) after 1m0s
[04:27:16.677] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:133:0)
[04:27:16.677] Timer tick, asking Buildbucket for the build status
[04:27:17.088] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:17.088] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:134:0) after 1m0s
[04:28:17.164] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:134:0)
[04:28:17.164] Timer tick, asking Buildbucket for the build status
[04:28:17.350] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:17.350] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:135:0) after 1m0s
[04:29:17.406] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:135:0)
[04:29:17.406] Timer tick, asking Buildbucket for the build status
[04:29:17.563] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:17.563] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:136:0) after 1m0s
[04:30:17.730] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:136:0)
[04:30:17.730] Timer tick, asking Buildbucket for the build status
[04:30:17.949] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:17.949] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:137:0) after 1m0s
[04:31:18.151] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:137:0)
[04:31:18.151] Timer tick, asking Buildbucket for the build status
[04:31:18.346] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:18.346] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:138:0) after 1m0s
[04:32:18.364] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:138:0)
[04:32:18.364] Timer tick, asking Buildbucket for the build status
[04:32:19.133] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:19.133] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:139:0) after 1m0s
[04:33:19.296] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:139:0)
[04:33:19.296] Timer tick, asking Buildbucket for the build status
[04:33:19.657] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:19.657] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:140:0) after 1m0s
[04:34:19.671] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:140:0)
[04:34:19.671] Timer tick, asking Buildbucket for the build status
[04:34:19.841] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:19.841] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:141:0) after 1m0s
[04:35:19.866] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:141:0)
[04:35:19.866] Timer tick, asking Buildbucket for the build status
[04:35:20.039] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:20.039] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:142:0) after 1m0s
[04:36:20.096] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:142:0)
[04:36:20.096] Timer tick, asking Buildbucket for the build status
[04:36:20.282] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:20.282] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:143:0) after 1m0s
[04:37:20.400] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:143:0)
[04:37:20.400] Timer tick, asking Buildbucket for the build status
[04:37:21.616] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:21.616] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:144:0) after 1m0s
[04:38:21.749] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:144:0)
[04:38:21.749] Timer tick, asking Buildbucket for the build status
[04:38:22.430] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:22.430] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:145:0) after 1m0s
[04:39:22.527] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:145:0)
[04:39:22.527] Timer tick, asking Buildbucket for the build status
[04:39:22.725] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:22.725] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:146:0) after 1m0s
[04:40:22.724] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:146:0)
[04:40:22.724] Timer tick, asking Buildbucket for the build status
[04:40:22.850] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:22.850] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:147:0) after 1m0s
[04:41:22.892] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:147:0)
[04:41:22.892] Timer tick, asking Buildbucket for the build status
[04:41:23.044] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:23.044] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:148:0) after 1m0s
[04:42:23.124] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:148:0)
[04:42:23.124] Timer tick, asking Buildbucket for the build status
[04:42:24.670] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:24.670] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:149:0) after 1m0s
[04:43:24.745] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:149:0)
[04:43:24.745] Timer tick, asking Buildbucket for the build status
[04:43:24.997] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:24.997] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:150:0) after 1m0s
[04:44:25.038] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:150:0)
[04:44:25.038] Timer tick, asking Buildbucket for the build status
[04:44:25.261] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:25.261] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:151:0) after 1m0s
[04:45:25.356] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:151:0)
[04:45:25.356] Timer tick, asking Buildbucket for the build status
[04:45:25.661] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:25.661] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:152:0) after 1m0s
[04:46:25.645] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:152:0)
[04:46:25.645] Timer tick, asking Buildbucket for the build status
[04:46:26.005] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:26.005] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:153:0) after 1m0s
[04:47:26.068] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:153:0)
[04:47:26.068] Timer tick, asking Buildbucket for the build status
[04:47:26.956] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:26.956] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:154:0) after 1m0s
[04:48:27.000] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:154:0)
[04:48:27.000] Timer tick, asking Buildbucket for the build status
[04:48:27.168] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:27.168] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:155:0) after 1m0s
[04:49:27.239] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:155:0)
[04:49:27.239] Timer tick, asking Buildbucket for the build status
[04:49:27.528] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:27.528] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:156:0) after 1m0s
[04:50:27.557] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:156:0)
[04:50:27.557] Timer tick, asking Buildbucket for the build status
[04:50:27.665] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:27.665] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:157:0) after 1m0s
[04:51:27.734] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:157:0)
[04:51:27.734] Timer tick, asking Buildbucket for the build status
[04:51:28.354] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:28.354] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:158:0) after 1m0s
[04:52:28.434] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:158:0)
[04:52:28.434] Timer tick, asking Buildbucket for the build status
[04:52:30.759] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:30.759] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:159:0) after 1m0s
[04:53:30.895] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:159:0)
[04:53:30.895] Timer tick, asking Buildbucket for the build status
[04:53:31.039] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:31.039] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:160:0) after 1m0s
[04:54:31.062] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:160:0)
[04:54:31.062] Timer tick, asking Buildbucket for the build status
[04:54:31.380] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:31.380] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:161:0) after 1m0s
[04:55:31.436] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:161:0)
[04:55:31.436] Timer tick, asking Buildbucket for the build status
[04:55:31.621] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:31.621] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:162:0) after 1m0s
[04:56:31.651] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:162:0)
[04:56:31.651] Timer tick, asking Buildbucket for the build status
[04:56:32.011] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:32.011] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:163:0) after 1m0s
[04:57:32.042] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:163:0)
[04:57:32.042] Timer tick, asking Buildbucket for the build status
[04:57:32.277] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:32.277] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:164:0) after 1m0s
[04:58:32.317] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:164:0)
[04:58:32.317] Timer tick, asking Buildbucket for the build status
[04:58:32.424] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:32.424] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:165:0) after 1m0s
[04:59:32.509] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:165:0)
[04:59:32.509] Timer tick, asking Buildbucket for the build status
[04:59:32.650] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:32.650] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:166:0) after 1m0s
[05:00:32.674] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:166:0)
[05:00:32.674] Timer tick, asking Buildbucket for the build status
[05:00:33.305] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:33.305] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:167:0) after 1m0s
[05:01:33.348] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:167:0)
[05:01:33.348] Timer tick, asking Buildbucket for the build status
[05:01:33.486] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:33.486] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:168:0) after 1m0s
[05:02:33.494] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:168:0)
[05:02:33.494] Timer tick, asking Buildbucket for the build status
[05:02:34.443] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:34.443] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:169:0) after 1m0s
[05:03:34.472] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:169:0)
[05:03:34.472] Timer tick, asking Buildbucket for the build status
[05:03:34.710] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:34.710] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:170:0) after 1m0s
[05:04:34.785] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:170:0)
[05:04:34.785] Timer tick, asking Buildbucket for the build status
[05:04:35.303] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:35.303] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:171:0) after 1m0s
[05:05:35.342] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:171:0)
[05:05:35.342] Timer tick, asking Buildbucket for the build status
[05:05:35.454] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:35.455] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:172:0) after 1m0s
[05:06:35.491] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:172:0)
[05:06:35.491] Timer tick, asking Buildbucket for the build status
[05:06:35.612] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:35.612] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:173:0) after 1m0s
[05:07:35.652] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:173:0)
[05:07:35.652] Timer tick, asking Buildbucket for the build status
[05:07:35.959] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:35.959] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:174:0) after 1m0s
[05:08:35.993] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:174:0)
[05:08:35.993] Timer tick, asking Buildbucket for the build status
[05:08:36.394] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:36.394] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:175:0) after 1m0s
[05:09:36.420] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:175:0)
[05:09:36.420] Timer tick, asking Buildbucket for the build status
[05:09:36.612] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:36.612] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:176:0) after 1m0s
[05:10:36.638] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:176:0)
[05:10:36.638] Timer tick, asking Buildbucket for the build status
[05:10:36.981] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:36.981] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:177:0) after 1m0s
[05:11:37.013] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:177:0)
[05:11:37.013] Timer tick, asking Buildbucket for the build status
[05:11:37.345] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:37.345] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:178:0) after 1m0s
[05:12:37.415] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:178:0)
[05:12:37.415] Timer tick, asking Buildbucket for the build status
[05:12:38.423] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:38.423] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:179:0) after 1m0s
[05:13:38.474] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:179:0)
[05:13:38.474] Timer tick, asking Buildbucket for the build status
[05:13:38.620] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:38.620] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:180:0) after 1m0s
[05:14:38.645] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:180:0)
[05:14:38.645] Timer tick, asking Buildbucket for the build status
[05:14:38.831] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:38.831] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:181:0) after 1m0s
[05:15:38.890] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:181:0)
[05:15:38.890] Timer tick, asking Buildbucket for the build status
[05:15:39.012] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:39.012] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:182:0) after 1m0s
[05:16:39.062] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:182:0)
[05:16:39.062] Timer tick, asking Buildbucket for the build status
[05:16:39.772] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:39.772] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:183:0) after 1m0s
[05:17:39.804] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:183:0)
[05:17:39.804] Timer tick, asking Buildbucket for the build status
[05:17:43.387] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:43.387] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:184:0) after 1m0s
[05:18:43.455] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:184:0)
[05:18:43.455] Timer tick, asking Buildbucket for the build status
[05:18:43.586] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:43.586] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:185:0) after 1m0s
[05:19:43.617] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:185:0)
[05:19:43.617] Timer tick, asking Buildbucket for the build status
[05:19:43.832] Build 8885346243180867104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:43.832] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050776306466173872:186:0) after 1m0s
[05:20:25.889] Received PubSub notification, asking Buildbucket for the build status
[05:20:25.971] Build 8885346243180867104: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:20:25.971] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"completed_ts": "1584681625103907",
"created_by": "project:emscripten-releases",
"created_ts": "1584670517709353",
"id": "8885346243180867104",
"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\": \"74dda2bf1601250326c9b0257ca1342124a46d4a\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@74dda2bf1601250326c9b0257ca1342124a46d4a\", \"title\": \"74dda2bf1601250326c9b0257ca1342124a46d4a\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/74dda2bf1601250326c9b0257ca1342124a46d4a\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"74dda2bf1601250326c9b0257ca1342124a46d4a\"}}",
"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\": \"74dda2bf1601250326c9b0257ca1342124a46d4a\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@74dda2bf1601250326c9b0257ca1342124a46d4a\", \"title\": \"74dda2bf1601250326c9b0257ca1342124a46d4a\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/74dda2bf1601250326c9b0257ca1342124a46d4a\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-win10-0-nl3q\", \"branch\": \"refs/heads/master\", \"buildername\": \"win\", \"got_revision\": \"74dda2bf1601250326c9b0257ca1342124a46d4a\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"74dda2bf1601250326c9b0257ca1342124a46d4a\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_0175bca77590805533ed6e20351c9bfa7effd036e42d11a5b619a6ce75a8e486_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"host_class\": [\"default\"], \"id\": [\"luci-emscripten-releases-ci-win10-0-nl3q\"], \"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\": [\"4874-3598771\"], \"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": "1584676408302555",
"status": "COMPLETED",
"status_changed_ts": "1584681625464087",
"tags": [
"builder:win",
"buildset:commit/git/74dda2bf1601250326c9b0257ca1342124a46d4a",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/74dda2bf1601250326c9b0257ca1342124a46d4a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9050776306466173872",
"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/8885346243180867104/+/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:4b0e8ad44f45fc10",
"user_agent:luci-scheduler"
],
"updated_ts": "1584681625477039",
"url": "https://ci.chromium.org/b/8885346243180867104",
"utcnow_ts": "1584681625963740"
}
}
[05:20:25.971] Invocation finished in 3h5m10.778915076s with status SUCCEEDED