[18:54:55.187] New invocation is queued and will start shortly
[18:54:56.524] Starting the invocation (attempt 1)
[18:54:56.565] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:54:56.565] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:54:56.566] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9018098504998367488",
"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\":\"1313db304381836cafea95f490bffee7ef165769\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@1313db304381836cafea95f490bffee7ef165769\",\"title\":\"1313db304381836cafea95f490bffee7ef165769\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/1313db304381836cafea95f490bffee7ef165769\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"1313db304381836cafea95f490bffee7ef165769\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win",
"scheduler_invocation_id:9018098504998367488",
"scheduler_job_id:emscripten-releases/win",
"user_agent:luci-scheduler",
"buildset:commit/git/1313db304381836cafea95f490bffee7ef165769",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/1313db304381836cafea95f490bffee7ef165769",
"gitiles_ref:refs/heads/master"
]
}
[18:54:58.144] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1615834497463518",
"id": "8852668441946200976",
"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\": \"1313db304381836cafea95f490bffee7ef165769\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@1313db304381836cafea95f490bffee7ef165769\", \"title\": \"1313db304381836cafea95f490bffee7ef165769\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/1313db304381836cafea95f490bffee7ef165769\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"1313db304381836cafea95f490bffee7ef165769\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615834497901202",
"tags": [
"builder:win",
"buildset:commit/git/1313db304381836cafea95f490bffee7ef165769",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/1313db304381836cafea95f490bffee7ef165769",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018098504998367488",
"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/8852668441946200976/+/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": "1615834497901377",
"url": "https://ci.chromium.org/b/8852668441946200976",
"utcnow_ts": "1615834498129647"
}
}
[18:54:58.144] Task URL: https://ci.chromium.org/b/8852668441946200976
[18:54:58.144] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:2:0) after 1m0s
[18:55:58.161] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:2:0)
[18:55:58.161] Timer tick, asking Buildbucket for the build status
[18:55:58.232] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:55:58.232] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:3:0) after 1m0s
[18:56:58.312] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:3:0)
[18:56:58.312] Timer tick, asking Buildbucket for the build status
[18:56:58.428] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:56:58.428] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:4:0) after 1m0s
[18:57:58.443] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:4:0)
[18:57:58.469] Build status: SCHEDULED
[18:57:58.469] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:5:0) after 8m42s
[19:06:40.564] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:5:0)
[19:06:40.564] Timer tick, asking Buildbucket for the build status
[19:06:42.661] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:06:42.661] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:6:0) after 1m0s
[19:07:42.657] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:6:0)
[19:07:42.657] Timer tick, asking Buildbucket for the build status
[19:07:42.819] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:07:42.819] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:7:0) after 1m0s
[19:08:42.843] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:7:0)
[19:08:42.869] Build status: SCHEDULED
[19:08:42.869] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:8:0) after 6m47s
[19:15:29.837] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:8:0)
[19:15:29.837] Timer tick, asking Buildbucket for the build status
[19:15:30.127] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:15:30.127] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:9:0) after 1m0s
[19:16:30.131] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:9:0)
[19:16:30.131] Timer tick, asking Buildbucket for the build status
[19:16:32.540] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:16:32.540] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:10:0) after 1m0s
[19:17:32.560] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:10:0)
[19:17:32.560] Timer tick, asking Buildbucket for the build status
[19:17:32.644] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:17:32.644] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:11:0) after 1m0s
[19:18:32.725] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:11:0)
[19:18:32.725] Timer tick, asking Buildbucket for the build status
[19:18:32.816] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:18:32.816] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:12:0) after 1m0s
[19:19:32.840] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:12:0)
[19:19:32.840] Timer tick, asking Buildbucket for the build status
[19:19:32.933] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:19:32.933] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:13:0) after 1m0s
[19:20:33.099] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:13:0)
[19:20:33.099] Timer tick, asking Buildbucket for the build status
[19:20:33.322] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:20:33.322] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:14:0) after 1m0s
[19:21:33.408] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:14:0)
[19:21:33.408] Timer tick, asking Buildbucket for the build status
[19:21:35.798] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:21:35.798] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:15:0) after 1m0s
[19:22:35.810] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:15:0)
[19:22:35.810] Timer tick, asking Buildbucket for the build status
[19:22:35.882] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:22:35.882] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:16:0) after 1m0s
[19:23:35.920] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:16:0)
[19:23:35.920] Timer tick, asking Buildbucket for the build status
[19:23:35.990] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:23:35.990] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:17:0) after 1m0s
[19:24:35.993] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:17:0)
[19:24:35.993] Timer tick, asking Buildbucket for the build status
[19:24:36.150] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:24:36.150] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:18:0) after 1m0s
[19:25:36.171] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:18:0)
[19:25:36.171] Timer tick, asking Buildbucket for the build status
[19:25:36.267] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:25:36.267] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:19:0) after 1m0s
[19:26:36.309] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:19:0)
[19:26:36.309] Timer tick, asking Buildbucket for the build status
[19:26:36.418] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:26:36.418] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:20:0) after 1m0s
[19:27:36.473] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:20:0)
[19:27:36.473] Timer tick, asking Buildbucket for the build status
[19:27:36.544] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:27:36.544] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:21:0) after 1m0s
[19:28:36.582] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:21:0)
[19:28:36.582] Timer tick, asking Buildbucket for the build status
[19:28:36.742] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:28:36.742] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:22:0) after 1m0s
[19:29:36.768] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:22:0)
[19:29:36.768] Timer tick, asking Buildbucket for the build status
[19:29:36.852] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:29:36.852] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:23:0) after 1m0s
[19:30:36.904] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:23:0)
[19:30:36.904] Timer tick, asking Buildbucket for the build status
[19:30:37.071] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:30:37.071] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:24:0) after 1m0s
[19:31:37.095] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:24:0)
[19:31:37.095] Timer tick, asking Buildbucket for the build status
[19:31:37.240] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:31:37.240] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:25:0) after 1m0s
[19:32:37.221] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:25:0)
[19:32:37.221] Timer tick, asking Buildbucket for the build status
[19:32:37.285] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:32:37.285] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:26:0) after 1m0s
[19:33:37.265] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:26:0)
[19:33:37.265] Timer tick, asking Buildbucket for the build status
[19:33:37.356] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:33:37.356] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:27:0) after 1m0s
[19:34:37.397] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:27:0)
[19:34:37.397] Timer tick, asking Buildbucket for the build status
[19:34:37.494] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:34:37.494] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:28:0) after 1m0s
[19:35:37.500] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:28:0)
[19:35:37.500] Timer tick, asking Buildbucket for the build status
[19:35:37.785] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:35:37.785] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:29:0) after 1m0s
[19:36:37.822] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:29:0)
[19:36:37.822] Timer tick, asking Buildbucket for the build status
[19:36:37.929] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:36:37.929] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:30:0) after 1m0s
[19:37:37.978] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:30:0)
[19:37:37.978] Timer tick, asking Buildbucket for the build status
[19:37:38.073] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:37:38.073] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:31:0) after 1m0s
[19:38:38.119] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:31:0)
[19:38:38.119] Timer tick, asking Buildbucket for the build status
[19:38:38.202] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:38:38.202] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:32:0) after 1m0s
[19:39:38.214] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:32:0)
[19:39:38.214] Timer tick, asking Buildbucket for the build status
[19:39:38.292] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:39:38.292] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:33:0) after 1m0s
[19:40:38.277] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:33:0)
[19:40:38.277] Timer tick, asking Buildbucket for the build status
[19:40:38.432] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:40:38.432] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:34:0) after 1m0s
[19:41:38.458] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:34:0)
[19:41:38.458] Timer tick, asking Buildbucket for the build status
[19:41:38.553] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:41:38.553] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:35:0) after 1m0s
[19:42:38.654] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:35:0)
[19:42:38.654] Timer tick, asking Buildbucket for the build status
[19:42:39.117] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:42:39.117] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:36:0) after 1m0s
[19:43:39.274] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:36:0)
[19:43:39.274] Timer tick, asking Buildbucket for the build status
[19:43:39.355] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:43:39.355] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:37:0) after 1m0s
[19:44:39.400] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:37:0)
[19:44:39.400] Timer tick, asking Buildbucket for the build status
[19:44:39.476] Build 8852668441946200976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:44:39.476] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:38:0) after 1m0s
[19:45:00.682] Received PubSub notification, asking Buildbucket for the build status
[19:45:00.821] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:39.540] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:38:0)
[19:45:39.540] Timer tick, asking Buildbucket for the build status
[19:45:39.667] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:39.667] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:40:0) after 1m0s
[19:46:39.734] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:40:0)
[19:46:39.734] Timer tick, asking Buildbucket for the build status
[19:46:40.252] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:40.252] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:41:0) after 1m0s
[19:47:40.411] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:41:0)
[19:47:40.411] Timer tick, asking Buildbucket for the build status
[19:47:40.933] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:40.933] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:42:0) after 1m0s
[19:48:40.977] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:42:0)
[19:48:40.977] Timer tick, asking Buildbucket for the build status
[19:48:41.067] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:41.067] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:43:0) after 1m0s
[19:49:41.102] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:43:0)
[19:49:41.102] Timer tick, asking Buildbucket for the build status
[19:49:41.187] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:41.187] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:44:0) after 1m0s
[19:50:41.248] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:44:0)
[19:50:41.248] Timer tick, asking Buildbucket for the build status
[19:50:41.362] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:41.362] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:45:0) after 1m0s
[19:51:41.451] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:45:0)
[19:51:41.451] Timer tick, asking Buildbucket for the build status
[19:51:41.521] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:41.521] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:46:0) after 1m0s
[19:52:41.544] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:46:0)
[19:52:41.544] Timer tick, asking Buildbucket for the build status
[19:52:41.608] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:41.608] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:47:0) after 1m0s
[19:53:41.583] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:47:0)
[19:53:41.583] Timer tick, asking Buildbucket for the build status
[19:53:41.736] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:41.736] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:48:0) after 1m0s
[19:54:41.780] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:48:0)
[19:54:41.780] Timer tick, asking Buildbucket for the build status
[19:54:41.962] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:41.962] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:49:0) after 1m0s
[19:55:42.366] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:49:0)
[19:55:42.366] Timer tick, asking Buildbucket for the build status
[19:55:42.787] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:42.787] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:50:0) after 1m0s
[19:56:43.335] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:50:0)
[19:56:43.335] Timer tick, asking Buildbucket for the build status
[19:56:43.443] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:43.443] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:51:0) after 1m0s
[19:57:43.535] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:51:0)
[19:57:43.535] Timer tick, asking Buildbucket for the build status
[19:57:44.144] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:44.144] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:52:0) after 1m0s
[19:58:44.224] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:52:0)
[19:58:44.224] Timer tick, asking Buildbucket for the build status
[19:58:44.803] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:44.803] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:53:0) after 1m0s
[19:59:44.876] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:53:0)
[19:59:44.876] Timer tick, asking Buildbucket for the build status
[19:59:44.982] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:44.982] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:54:0) after 1m0s
[20:00:45.032] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:54:0)
[20:00:45.032] Timer tick, asking Buildbucket for the build status
[20:00:45.146] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:45.147] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:55:0) after 1m0s
[20:01:45.198] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:55:0)
[20:01:45.198] Timer tick, asking Buildbucket for the build status
[20:01:45.355] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:45.355] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:56:0) after 1m0s
[20:02:45.395] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:56:0)
[20:02:45.395] Timer tick, asking Buildbucket for the build status
[20:02:45.535] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:45.535] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:57:0) after 1m0s
[20:03:45.526] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:57:0)
[20:03:45.526] Timer tick, asking Buildbucket for the build status
[20:03:45.602] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:45.602] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:58:0) after 1m0s
[20:04:45.621] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:58:0)
[20:04:45.621] Timer tick, asking Buildbucket for the build status
[20:04:45.753] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:45.753] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:59:0) after 1m0s
[20:05:45.754] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:59:0)
[20:05:45.754] Timer tick, asking Buildbucket for the build status
[20:05:47.308] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:47.308] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:60:0) after 1m0s
[20:06:47.825] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:60:0)
[20:06:47.825] Timer tick, asking Buildbucket for the build status
[20:06:47.903] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:47.903] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:61:0) after 1m0s
[20:07:47.902] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:61:0)
[20:07:47.902] Timer tick, asking Buildbucket for the build status
[20:07:47.965] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:47.965] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:62:0) after 1m0s
[20:08:47.964] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:62:0)
[20:08:47.964] Timer tick, asking Buildbucket for the build status
[20:08:50.509] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:50.509] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:63:0) after 1m0s
[20:09:50.716] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:63:0)
[20:09:50.716] Timer tick, asking Buildbucket for the build status
[20:09:50.839] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:50.839] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:64:0) after 1m0s
[20:10:50.875] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:64:0)
[20:10:50.875] Timer tick, asking Buildbucket for the build status
[20:10:50.995] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:50.995] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:65:0) after 1m0s
[20:11:51.027] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:65:0)
[20:11:51.027] Timer tick, asking Buildbucket for the build status
[20:11:51.145] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:51.145] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:66:0) after 1m0s
[20:12:51.191] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:66:0)
[20:12:51.191] Timer tick, asking Buildbucket for the build status
[20:12:51.283] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:51.283] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:67:0) after 1m0s
[20:13:51.350] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:67:0)
[20:13:51.350] Timer tick, asking Buildbucket for the build status
[20:13:51.405] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:51.405] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:68:0) after 1m0s
[20:14:51.469] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:68:0)
[20:14:51.469] Timer tick, asking Buildbucket for the build status
[20:14:51.787] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:51.787] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:69:0) after 1m0s
[20:15:51.937] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:69:0)
[20:15:51.937] Timer tick, asking Buildbucket for the build status
[20:15:52.165] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:52.165] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:70:0) after 1m0s
[20:16:52.231] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:70:0)
[20:16:52.231] Timer tick, asking Buildbucket for the build status
[20:16:52.358] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:52.358] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:71:0) after 1m0s
[20:17:52.402] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:71:0)
[20:17:52.402] Timer tick, asking Buildbucket for the build status
[20:17:52.471] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:52.471] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:72:0) after 1m0s
[20:18:52.494] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:72:0)
[20:18:52.494] Timer tick, asking Buildbucket for the build status
[20:18:52.571] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:52.571] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:73:0) after 1m0s
[20:19:52.668] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:73:0)
[20:19:52.668] Timer tick, asking Buildbucket for the build status
[20:19:52.772] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:52.772] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:74:0) after 1m0s
[20:20:52.849] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:74:0)
[20:20:52.849] Timer tick, asking Buildbucket for the build status
[20:20:52.984] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:52.984] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:75:0) after 1m0s
[20:21:53.052] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:75:0)
[20:21:53.052] Timer tick, asking Buildbucket for the build status
[20:21:53.120] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:53.120] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:76:0) after 1m0s
[20:22:53.662] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:76:0)
[20:22:53.662] Timer tick, asking Buildbucket for the build status
[20:22:55.908] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:55.908] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:77:0) after 1m0s
[20:23:56.945] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:77:0)
[20:23:56.945] Timer tick, asking Buildbucket for the build status
[20:23:57.061] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:57.061] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:78:0) after 1m0s
[20:24:57.085] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:78:0)
[20:24:57.085] Timer tick, asking Buildbucket for the build status
[20:24:57.220] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:57.220] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:79:0) after 1m0s
[20:25:57.471] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:79:0)
[20:25:57.471] Timer tick, asking Buildbucket for the build status
[20:25:57.699] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:57.699] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:80:0) after 1m0s
[20:26:57.714] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:80:0)
[20:26:57.714] Timer tick, asking Buildbucket for the build status
[20:26:57.806] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:57.806] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:81:0) after 1m0s
[20:27:57.830] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:81:0)
[20:27:57.830] Timer tick, asking Buildbucket for the build status
[20:27:57.953] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:57.953] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:82:0) after 1m0s
[20:28:57.962] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:82:0)
[20:28:57.962] Timer tick, asking Buildbucket for the build status
[20:28:58.258] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:58.258] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:83:0) after 1m0s
[20:29:58.306] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:83:0)
[20:29:58.306] Timer tick, asking Buildbucket for the build status
[20:29:58.378] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:58.378] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:84:0) after 1m0s
[20:30:58.439] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:84:0)
[20:30:58.440] Timer tick, asking Buildbucket for the build status
[20:30:59.176] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:59.176] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:85:0) after 1m0s
[20:31:59.185] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:85:0)
[20:31:59.185] Timer tick, asking Buildbucket for the build status
[20:32:00.207] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:00.207] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:86:0) after 1m0s
[20:33:00.355] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:86:0)
[20:33:00.355] Timer tick, asking Buildbucket for the build status
[20:33:00.464] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:00.464] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:87:0) after 1m0s
[20:34:00.573] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:87:0)
[20:34:00.573] Timer tick, asking Buildbucket for the build status
[20:34:00.690] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:00.690] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:88:0) after 1m0s
[20:35:00.825] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:88:0)
[20:35:00.825] Timer tick, asking Buildbucket for the build status
[20:35:01.066] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:01.066] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:89:0) after 1m0s
[20:36:01.282] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:89:0)
[20:36:01.282] Timer tick, asking Buildbucket for the build status
[20:36:01.372] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:01.372] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:90:0) after 1m0s
[20:37:01.481] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:90:0)
[20:37:01.481] Timer tick, asking Buildbucket for the build status
[20:37:01.569] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:01.569] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:91:0) after 1m0s
[20:38:01.716] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:91:0)
[20:38:01.716] Timer tick, asking Buildbucket for the build status
[20:38:01.788] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:01.788] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:92:0) after 1m0s
[20:39:02.668] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:92:0)
[20:39:02.668] Timer tick, asking Buildbucket for the build status
[20:39:02.744] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:02.744] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:93:0) after 1m0s
[20:40:02.986] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:93:0)
[20:40:02.986] Timer tick, asking Buildbucket for the build status
[20:40:03.572] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:03.572] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:94:0) after 1m0s
[20:41:03.595] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:94:0)
[20:41:03.595] Timer tick, asking Buildbucket for the build status
[20:41:03.810] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:03.810] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:95:0) after 1m0s
[20:42:03.854] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:95:0)
[20:42:03.854] Timer tick, asking Buildbucket for the build status
[20:42:04.571] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:04.571] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:96:0) after 1m0s
[20:43:04.622] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:96:0)
[20:43:04.622] Timer tick, asking Buildbucket for the build status
[20:43:04.701] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:04.701] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:97:0) after 1m0s
[20:44:04.694] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:97:0)
[20:44:04.694] Timer tick, asking Buildbucket for the build status
[20:44:04.759] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:04.759] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:98:0) after 1m0s
[20:45:04.807] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:98:0)
[20:45:04.807] Timer tick, asking Buildbucket for the build status
[20:45:04.982] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:04.982] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:99:0) after 1m0s
[20:46:05.004] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:99:0)
[20:46:05.004] Timer tick, asking Buildbucket for the build status
[20:46:05.076] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:05.076] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:100:0) after 1m0s
[20:47:05.117] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:100:0)
[20:47:05.117] Timer tick, asking Buildbucket for the build status
[20:47:05.193] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:05.193] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:101:0) after 1m0s
[20:48:05.268] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:101:0)
[20:48:05.268] Timer tick, asking Buildbucket for the build status
[20:48:05.355] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:05.355] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:102:0) after 1m0s
[20:49:05.621] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:102:0)
[20:49:05.621] Timer tick, asking Buildbucket for the build status
[20:49:05.758] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:05.758] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:103:0) after 1m0s
[20:50:06.119] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:103:0)
[20:50:06.119] Timer tick, asking Buildbucket for the build status
[20:50:06.202] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:06.202] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:104:0) after 1m0s
[20:51:06.353] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:104:0)
[20:51:06.353] Timer tick, asking Buildbucket for the build status
[20:51:06.449] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:06.449] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:105:0) after 1m0s
[20:52:06.960] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:105:0)
[20:52:06.960] Timer tick, asking Buildbucket for the build status
[20:52:07.073] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:07.073] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:106:0) after 1m0s
[20:53:07.113] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:106:0)
[20:53:07.113] Timer tick, asking Buildbucket for the build status
[20:53:07.516] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:07.516] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:107:0) after 1m0s
[20:54:07.525] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:107:0)
[20:54:07.525] Timer tick, asking Buildbucket for the build status
[20:54:07.677] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:07.678] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:108:0) after 1m0s
[20:55:07.714] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:108:0)
[20:55:07.714] Timer tick, asking Buildbucket for the build status
[20:55:07.807] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:07.807] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:109:0) after 1m0s
[20:56:07.827] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:109:0)
[20:56:07.827] Timer tick, asking Buildbucket for the build status
[20:56:08.370] Build 8852668441946200976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:08.370] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9018098504998367488:110:0) after 1m0s
[20:56:33.005] Received PubSub notification, asking Buildbucket for the build status
[20:56:33.095] Build 8852668441946200976: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[20:56:33.095] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"completed_ts": "1615841792664361",
"created_by": "project:emscripten-releases",
"created_ts": "1615834497463518",
"failure_reason": "BUILD_FAILURE",
"id": "8852668441946200976",
"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\": \"1313db304381836cafea95f490bffee7ef165769\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@1313db304381836cafea95f490bffee7ef165769\", \"title\": \"1313db304381836cafea95f490bffee7ef165769\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/1313db304381836cafea95f490bffee7ef165769\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"1313db304381836cafea95f490bffee7ef165769\"}}",
"project": "emscripten-releases",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 out of 2 aggregated steps failed: Step('Emscripten testsuite (upstream, other)') (retcode: 2)\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$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\": \"1313db304381836cafea95f490bffee7ef165769\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@1313db304381836cafea95f490bffee7ef165769\", \"title\": \"1313db304381836cafea95f490bffee7ef165769\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/1313db304381836cafea95f490bffee7ef165769\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-win10-0-e5n8\", \"branch\": \"refs/heads/master\", \"buildername\": \"win\", \"got_revision\": \"1313db304381836cafea95f490bffee7ef165769\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"1313db304381836cafea95f490bffee7ef165769\"}, \"swarming\": {\"bot_dimensions\": {\"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-e5n8\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"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\": [\"5754-8c4f760\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}, \"ui\": {\"info\": \"1 out of 2 aggregated steps failed: Step('Emscripten testsuite (upstream, other)') (retcode: 2)\"}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615837500226751",
"status": "COMPLETED",
"status_changed_ts": "1615837500484047",
"tags": [
"builder:win",
"buildset:commit/git/1313db304381836cafea95f490bffee7ef165769",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/1313db304381836cafea95f490bffee7ef165769",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018098504998367488",
"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/8852668441946200976/+/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:52500f4ea9de0310",
"user_agent:luci-scheduler"
],
"updated_ts": "1615841792664737",
"url": "https://ci.chromium.org/b/8852668441946200976",
"utcnow_ts": "1615841793089388"
}
}
[20:56:33.095] Invocation finished in 2h1m37.926090278s with status FAILED