[21:43:19.019] New invocation is queued and will start shortly
[21:43:20.644] Starting the invocation (attempt 1)
[21:43:20.704] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:43:20.704] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:43:20.704] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9038291033883884768",
"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\":\"18f6d5a44ffdf8ccb08f08a6ce0f1ba3f7e775cb\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@18f6d5a44ffdf8ccb08f08a6ce0f1ba3f7e775cb\",\"title\":\"18f6d5a44ffdf8ccb08f08a6ce0f1ba3f7e775cb\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/18f6d5a44ffdf8ccb08f08a6ce0f1ba3f7e775cb\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"18f6d5a44ffdf8ccb08f08a6ce0f1ba3f7e775cb\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win",
"scheduler_invocation_id:9038291033883884768",
"scheduler_job_id:emscripten-releases/win",
"user_agent:luci-scheduler",
"buildset:commit/git/18f6d5a44ffdf8ccb08f08a6ce0f1ba3f7e775cb",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/18f6d5a44ffdf8ccb08f08a6ce0f1ba3f7e775cb",
"gitiles_ref:refs/heads/master"
]
}
[21:43:21.512] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1596577400874795",
"id": "8872860971259216480",
"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\": \"18f6d5a44ffdf8ccb08f08a6ce0f1ba3f7e775cb\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@18f6d5a44ffdf8ccb08f08a6ce0f1ba3f7e775cb\", \"title\": \"18f6d5a44ffdf8ccb08f08a6ce0f1ba3f7e775cb\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/18f6d5a44ffdf8ccb08f08a6ce0f1ba3f7e775cb\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"18f6d5a44ffdf8ccb08f08a6ce0f1ba3f7e775cb\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1596577401327353",
"tags": [
"builder:win",
"buildset:commit/git/18f6d5a44ffdf8ccb08f08a6ce0f1ba3f7e775cb",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/18f6d5a44ffdf8ccb08f08a6ce0f1ba3f7e775cb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9038291033883884768",
"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/8872860971259216480/+/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": "1596577401327475",
"url": "https://ci.chromium.org/b/8872860971259216480",
"utcnow_ts": "1596577401486898"
}
}
[21:43:21.512] Task URL: https://ci.chromium.org/b/8872860971259216480
[21:43:21.512] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:2:0) after 1m0s
[21:44:21.535] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:2:0)
[21:44:21.535] Timer tick, asking Buildbucket for the build status
[21:44:21.682] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:44:21.682] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:3:0) after 1m0s
[21:45:21.787] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:3:0)
[21:45:21.787] Timer tick, asking Buildbucket for the build status
[21:45:22.174] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:45:22.174] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:4:0) after 1m0s
[21:46:22.215] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:4:0)
[21:46:22.216] Timer tick, asking Buildbucket for the build status
[21:46:22.315] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:46:22.315] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:5:0) after 1m0s
[21:47:22.327] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:5:0)
[21:47:22.327] Timer tick, asking Buildbucket for the build status
[21:47:22.542] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:47:22.542] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:6:0) after 1m0s
[21:48:22.611] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:6:0)
[21:48:22.611] Timer tick, asking Buildbucket for the build status
[21:48:22.712] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:48:22.712] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:7:0) after 1m0s
[21:49:22.790] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:7:0)
[21:49:22.790] Timer tick, asking Buildbucket for the build status
[21:49:23.081] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:49:23.081] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:8:0) after 1m0s
[21:50:23.305] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:8:0)
[21:50:23.305] Timer tick, asking Buildbucket for the build status
[21:50:23.394] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:50:23.394] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:9:0) after 1m0s
[21:51:23.690] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:9:0)
[21:51:23.690] Timer tick, asking Buildbucket for the build status
[21:51:23.783] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:51:23.783] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:10:0) after 1m0s
[21:52:23.824] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:10:0)
[21:52:23.824] Timer tick, asking Buildbucket for the build status
[21:52:24.084] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:52:24.084] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:11:0) after 1m0s
[21:53:24.124] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:11:0)
[21:53:24.124] Timer tick, asking Buildbucket for the build status
[21:53:24.251] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:53:24.251] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:12:0) after 1m0s
[21:54:24.321] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:12:0)
[21:54:24.321] Timer tick, asking Buildbucket for the build status
[21:54:25.441] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:54:25.441] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:13:0) after 1m0s
[21:55:25.464] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:13:0)
[21:55:25.464] Timer tick, asking Buildbucket for the build status
[21:55:25.609] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:55:25.609] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:14:0) after 1m0s
[21:56:25.642] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:14:0)
[21:56:25.642] Timer tick, asking Buildbucket for the build status
[21:56:25.902] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:56:25.902] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:15:0) after 1m0s
[21:57:25.951] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:15:0)
[21:57:25.951] Timer tick, asking Buildbucket for the build status
[21:57:26.048] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:57:26.048] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:16:0) after 1m0s
[21:58:26.072] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:16:0)
[21:58:26.072] Timer tick, asking Buildbucket for the build status
[21:58:26.210] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:58:26.210] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:17:0) after 1m0s
[21:59:26.252] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:17:0)
[21:59:26.252] Timer tick, asking Buildbucket for the build status
[21:59:26.344] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:59:26.345] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:18:0) after 1m0s
[22:00:26.367] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:18:0)
[22:00:26.367] Timer tick, asking Buildbucket for the build status
[22:00:26.611] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:00:26.611] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:19:0) after 1m0s
[22:01:26.642] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:19:0)
[22:01:26.642] Timer tick, asking Buildbucket for the build status
[22:01:27.028] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:01:27.028] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:20:0) after 1m0s
[22:02:27.055] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:20:0)
[22:02:27.055] Timer tick, asking Buildbucket for the build status
[22:02:27.270] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:02:27.270] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:21:0) after 1m0s
[22:03:27.327] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:21:0)
[22:03:27.327] Timer tick, asking Buildbucket for the build status
[22:03:27.790] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:03:27.790] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:22:0) after 1m0s
[22:04:27.809] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:22:0)
[22:04:27.809] Timer tick, asking Buildbucket for the build status
[22:04:28.191] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:04:28.191] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:23:0) after 1m0s
[22:05:28.214] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:23:0)
[22:05:28.214] Timer tick, asking Buildbucket for the build status
[22:05:28.383] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:05:28.383] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:24:0) after 1m0s
[22:06:28.415] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:24:0)
[22:06:28.415] Timer tick, asking Buildbucket for the build status
[22:06:28.679] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:06:28.679] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:25:0) after 1m0s
[22:07:28.699] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:25:0)
[22:07:28.699] Timer tick, asking Buildbucket for the build status
[22:07:28.809] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:07:28.809] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:26:0) after 1m0s
[22:08:28.861] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:26:0)
[22:08:28.861] Timer tick, asking Buildbucket for the build status
[22:08:28.980] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:08:28.981] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:27:0) after 1m0s
[22:09:29.005] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:27:0)
[22:09:29.005] Timer tick, asking Buildbucket for the build status
[22:09:29.091] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:09:29.091] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:28:0) after 1m0s
[22:10:29.189] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:28:0)
[22:10:29.189] Timer tick, asking Buildbucket for the build status
[22:10:29.349] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:10:29.349] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:29:0) after 1m0s
[22:11:29.371] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:29:0)
[22:11:29.371] Timer tick, asking Buildbucket for the build status
[22:11:29.581] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:11:29.581] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:30:0) after 1m0s
[22:12:29.631] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:30:0)
[22:12:29.631] Timer tick, asking Buildbucket for the build status
[22:12:29.718] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:12:29.718] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:31:0) after 1m0s
[22:13:29.810] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:31:0)
[22:13:29.810] Timer tick, asking Buildbucket for the build status
[22:13:29.915] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:13:29.916] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:32:0) after 1m0s
[22:14:30.032] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:32:0)
[22:14:30.032] Timer tick, asking Buildbucket for the build status
[22:14:30.121] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:14:30.121] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:33:0) after 1m0s
[22:15:30.162] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:33:0)
[22:15:30.162] Timer tick, asking Buildbucket for the build status
[22:15:30.355] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:15:30.355] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:34:0) after 1m0s
[22:16:30.395] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:34:0)
[22:16:30.395] Timer tick, asking Buildbucket for the build status
[22:16:30.775] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:16:30.776] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:35:0) after 1m0s
[22:17:30.848] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:35:0)
[22:17:30.848] Timer tick, asking Buildbucket for the build status
[22:17:30.982] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:17:30.982] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:36:0) after 1m0s
[22:18:31.010] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:36:0)
[22:18:31.010] Timer tick, asking Buildbucket for the build status
[22:18:31.141] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:18:31.141] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:37:0) after 1m0s
[22:19:31.162] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:37:0)
[22:19:31.162] Timer tick, asking Buildbucket for the build status
[22:19:31.250] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:19:31.250] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:38:0) after 1m0s
[22:20:31.298] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:38:0)
[22:20:31.298] Timer tick, asking Buildbucket for the build status
[22:20:31.387] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:20:31.387] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:39:0) after 1m0s
[22:21:31.434] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:39:0)
[22:21:31.434] Timer tick, asking Buildbucket for the build status
[22:21:31.576] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:21:31.576] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:40:0) after 1m0s
[22:22:31.659] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:40:0)
[22:22:31.659] Timer tick, asking Buildbucket for the build status
[22:22:31.767] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:22:31.767] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:41:0) after 1m0s
[22:23:31.884] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:41:0)
[22:23:31.884] Timer tick, asking Buildbucket for the build status
[22:23:32.132] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:23:32.133] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:42:0) after 1m0s
[22:24:32.211] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:42:0)
[22:24:32.211] Timer tick, asking Buildbucket for the build status
[22:24:32.397] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:24:32.397] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:43:0) after 1m0s
[22:25:32.435] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:43:0)
[22:25:32.435] Timer tick, asking Buildbucket for the build status
[22:25:32.574] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:25:32.574] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:44:0) after 1m0s
[22:26:32.645] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:44:0)
[22:26:32.645] Timer tick, asking Buildbucket for the build status
[22:26:32.781] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:26:32.781] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:45:0) after 1m0s
[22:27:32.899] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:45:0)
[22:27:32.899] Timer tick, asking Buildbucket for the build status
[22:27:32.993] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:27:32.993] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:46:0) after 1m0s
[22:28:32.988] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:46:0)
[22:28:32.988] Timer tick, asking Buildbucket for the build status
[22:28:33.327] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:28:33.327] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:47:0) after 1m0s
[22:29:33.433] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:47:0)
[22:29:33.433] Timer tick, asking Buildbucket for the build status
[22:29:33.508] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:29:33.508] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:48:0) after 1m0s
[22:30:33.497] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:48:0)
[22:30:33.497] Timer tick, asking Buildbucket for the build status
[22:30:33.579] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:30:33.579] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:49:0) after 1m0s
[22:31:33.678] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:49:0)
[22:31:33.678] Timer tick, asking Buildbucket for the build status
[22:31:33.760] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:31:33.760] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:50:0) after 1m0s
[22:32:33.834] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:50:0)
[22:32:33.834] Timer tick, asking Buildbucket for the build status
[22:32:33.921] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:32:33.921] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:51:0) after 1m0s
[22:33:33.949] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:51:0)
[22:33:33.949] Timer tick, asking Buildbucket for the build status
[22:33:34.277] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:33:34.277] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:52:0) after 1m0s
[22:34:34.298] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:52:0)
[22:34:34.298] Timer tick, asking Buildbucket for the build status
[22:34:34.517] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:34:34.517] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:53:0) after 1m0s
[22:35:34.567] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:53:0)
[22:35:34.567] Timer tick, asking Buildbucket for the build status
[22:35:34.661] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:35:34.661] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:54:0) after 1m0s
[22:36:34.689] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:54:0)
[22:36:34.689] Timer tick, asking Buildbucket for the build status
[22:36:34.781] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:36:34.781] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:55:0) after 1m0s
[22:37:34.855] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:55:0)
[22:37:34.855] Timer tick, asking Buildbucket for the build status
[22:37:34.984] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:37:34.984] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:56:0) after 1m0s
[22:38:35.014] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:56:0)
[22:38:35.014] Timer tick, asking Buildbucket for the build status
[22:38:35.171] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:38:35.171] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:57:0) after 1m0s
[22:39:35.229] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:57:0)
[22:39:35.229] Timer tick, asking Buildbucket for the build status
[22:39:35.552] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:39:35.552] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:58:0) after 1m0s
[22:40:35.673] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:58:0)
[22:40:35.673] Timer tick, asking Buildbucket for the build status
[22:40:36.106] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:40:36.106] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:59:0) after 1m0s
[22:41:36.167] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:59:0)
[22:41:36.167] Timer tick, asking Buildbucket for the build status
[22:41:36.325] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:41:36.325] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:60:0) after 1m0s
[22:42:36.320] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:60:0)
[22:42:36.320] Timer tick, asking Buildbucket for the build status
[22:42:36.437] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:42:36.437] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:61:0) after 1m0s
[22:43:36.490] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:61:0)
[22:43:36.490] Timer tick, asking Buildbucket for the build status
[22:43:36.627] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:43:36.627] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:62:0) after 1m0s
[22:44:36.629] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:62:0)
[22:44:36.629] Timer tick, asking Buildbucket for the build status
[22:44:36.935] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:44:36.935] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:63:0) after 1m0s
[22:45:37.023] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:63:0)
[22:45:37.023] Timer tick, asking Buildbucket for the build status
[22:45:37.207] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:45:37.207] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:64:0) after 1m0s
[22:46:37.291] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:64:0)
[22:46:37.291] Timer tick, asking Buildbucket for the build status
[22:46:37.368] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:46:37.368] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:65:0) after 1m0s
[22:47:37.468] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:65:0)
[22:47:37.469] Timer tick, asking Buildbucket for the build status
[22:47:37.558] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:47:37.558] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:66:0) after 1m0s
[22:48:37.602] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:66:0)
[22:48:37.602] Timer tick, asking Buildbucket for the build status
[22:48:37.906] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:48:37.906] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:67:0) after 1m0s
[22:49:37.930] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:67:0)
[22:49:37.930] Timer tick, asking Buildbucket for the build status
[22:49:38.150] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:49:38.150] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:68:0) after 1m0s
[22:50:38.176] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:68:0)
[22:50:38.176] Timer tick, asking Buildbucket for the build status
[22:50:38.450] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:50:38.450] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:69:0) after 1m0s
[22:51:38.495] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:69:0)
[22:51:38.495] Timer tick, asking Buildbucket for the build status
[22:51:38.634] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:51:38.634] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:70:0) after 1m0s
[22:52:38.668] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:70:0)
[22:52:38.668] Timer tick, asking Buildbucket for the build status
[22:52:38.852] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:52:38.852] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:71:0) after 1m0s
[22:53:38.908] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:71:0)
[22:53:38.908] Timer tick, asking Buildbucket for the build status
[22:53:39.057] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:53:39.057] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:72:0) after 1m0s
[22:54:39.103] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:72:0)
[22:54:39.103] Timer tick, asking Buildbucket for the build status
[22:54:39.283] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:54:39.283] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:73:0) after 1m0s
[22:55:39.433] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:73:0)
[22:55:39.434] Timer tick, asking Buildbucket for the build status
[22:55:39.536] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:55:39.536] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:74:0) after 1m0s
[22:56:39.595] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:74:0)
[22:56:39.595] Timer tick, asking Buildbucket for the build status
[22:56:39.824] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:56:39.824] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:75:0) after 1m0s
[22:57:39.872] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:75:0)
[22:57:39.872] Timer tick, asking Buildbucket for the build status
[22:57:40.132] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:57:40.132] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:76:0) after 1m0s
[22:58:40.225] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:76:0)
[22:58:40.225] Timer tick, asking Buildbucket for the build status
[22:58:40.384] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:58:40.384] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:77:0) after 1m0s
[22:59:40.488] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:77:0)
[22:59:40.488] Timer tick, asking Buildbucket for the build status
[22:59:40.585] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:59:40.586] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:78:0) after 1m0s
[23:00:40.637] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:78:0)
[23:00:40.637] Timer tick, asking Buildbucket for the build status
[23:00:40.729] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:00:40.729] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:79:0) after 1m0s
[23:01:40.787] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:79:0)
[23:01:40.787] Timer tick, asking Buildbucket for the build status
[23:01:41.103] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:01:41.103] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:80:0) after 1m0s
[23:02:41.169] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:80:0)
[23:02:41.169] Timer tick, asking Buildbucket for the build status
[23:02:41.272] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:02:41.272] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:81:0) after 1m0s
[23:03:41.333] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:81:0)
[23:03:41.333] Timer tick, asking Buildbucket for the build status
[23:03:41.524] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:03:41.524] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:82:0) after 1m0s
[23:04:41.529] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:82:0)
[23:04:41.529] Timer tick, asking Buildbucket for the build status
[23:04:41.684] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:04:41.684] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:83:0) after 1m0s
[23:05:41.709] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:83:0)
[23:05:41.709] Timer tick, asking Buildbucket for the build status
[23:05:41.779] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:05:41.779] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:84:0) after 1m0s
[23:06:41.814] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:84:0)
[23:06:41.814] Timer tick, asking Buildbucket for the build status
[23:06:42.019] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:06:42.019] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:85:0) after 1m0s
[23:07:42.087] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:85:0)
[23:07:42.087] Timer tick, asking Buildbucket for the build status
[23:07:42.190] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:07:42.190] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:86:0) after 1m0s
[23:08:42.224] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:86:0)
[23:08:42.224] Timer tick, asking Buildbucket for the build status
[23:08:42.359] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:08:42.359] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:87:0) after 1m0s
[23:09:42.383] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:87:0)
[23:09:42.383] Timer tick, asking Buildbucket for the build status
[23:09:42.558] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:09:42.558] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:88:0) after 1m0s
[23:10:42.619] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:88:0)
[23:10:42.619] Timer tick, asking Buildbucket for the build status
[23:10:42.804] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:10:42.804] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:89:0) after 1m0s
[23:11:42.894] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:89:0)
[23:11:42.894] Timer tick, asking Buildbucket for the build status
[23:11:42.975] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:11:42.975] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:90:0) after 1m0s
[23:12:43.136] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:90:0)
[23:12:43.136] Timer tick, asking Buildbucket for the build status
[23:12:43.379] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:12:43.379] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:91:0) after 1m0s
[23:13:43.434] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:91:0)
[23:13:43.434] Timer tick, asking Buildbucket for the build status
[23:13:43.577] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:13:43.577] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:92:0) after 1m0s
[23:14:43.623] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:92:0)
[23:14:43.623] Timer tick, asking Buildbucket for the build status
[23:14:43.735] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:14:43.735] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:93:0) after 1m0s
[23:15:43.801] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:93:0)
[23:15:43.801] Timer tick, asking Buildbucket for the build status
[23:15:43.877] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:15:43.877] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:94:0) after 1m0s
[23:16:43.894] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:94:0)
[23:16:43.894] Timer tick, asking Buildbucket for the build status
[23:16:44.095] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:16:44.095] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:95:0) after 1m0s
[23:17:44.148] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:95:0)
[23:17:44.148] Timer tick, asking Buildbucket for the build status
[23:17:44.385] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:17:44.387] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:96:0) after 1m0s
[23:18:44.430] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:96:0)
[23:18:44.430] Timer tick, asking Buildbucket for the build status
[23:18:44.543] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:18:44.543] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:97:0) after 1m0s
[23:19:44.582] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:97:0)
[23:19:44.582] Timer tick, asking Buildbucket for the build status
[23:19:44.808] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:19:44.808] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:98:0) after 1m0s
[23:20:44.831] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:98:0)
[23:20:44.831] Timer tick, asking Buildbucket for the build status
[23:20:44.919] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:20:44.919] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:99:0) after 1m0s
[23:21:44.953] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:99:0)
[23:21:44.953] Timer tick, asking Buildbucket for the build status
[23:21:45.059] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:21:45.059] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:100:0) after 1m0s
[23:22:45.117] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:100:0)
[23:22:45.117] Timer tick, asking Buildbucket for the build status
[23:22:45.195] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:22:45.195] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:101:0) after 1m0s
[23:23:45.287] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:101:0)
[23:23:45.287] Timer tick, asking Buildbucket for the build status
[23:23:45.586] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:23:45.586] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:102:0) after 1m0s
[23:24:45.659] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:102:0)
[23:24:45.659] Timer tick, asking Buildbucket for the build status
[23:24:45.766] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:24:45.766] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:103:0) after 1m0s
[23:25:45.822] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:103:0)
[23:25:45.822] Timer tick, asking Buildbucket for the build status
[23:25:46.142] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:25:46.142] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:104:0) after 1m0s
[23:26:46.231] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:104:0)
[23:26:46.231] Timer tick, asking Buildbucket for the build status
[23:26:46.482] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:26:46.482] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:105:0) after 1m0s
[23:27:46.617] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:105:0)
[23:27:46.617] Timer tick, asking Buildbucket for the build status
[23:27:46.702] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:27:46.702] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:106:0) after 1m0s
[23:28:46.791] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:106:0)
[23:28:46.791] Timer tick, asking Buildbucket for the build status
[23:28:46.922] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:28:46.922] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:107:0) after 1m0s
[23:29:47.045] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:107:0)
[23:29:47.045] Timer tick, asking Buildbucket for the build status
[23:29:47.162] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:29:47.162] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:108:0) after 1m0s
[23:30:47.196] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:108:0)
[23:30:47.196] Timer tick, asking Buildbucket for the build status
[23:30:47.417] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:30:47.418] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:109:0) after 1m0s
[23:31:47.471] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:109:0)
[23:31:47.471] Timer tick, asking Buildbucket for the build status
[23:31:47.554] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:31:47.554] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:110:0) after 1m0s
[23:32:47.661] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:110:0)
[23:32:47.661] Timer tick, asking Buildbucket for the build status
[23:32:47.791] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:32:47.791] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:111:0) after 1m0s
[23:33:47.919] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:111:0)
[23:33:47.919] Timer tick, asking Buildbucket for the build status
[23:33:48.219] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:33:48.219] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:112:0) after 1m0s
[23:34:48.283] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:112:0)
[23:34:48.283] Timer tick, asking Buildbucket for the build status
[23:34:48.434] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:34:48.434] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:113:0) after 1m0s
[23:35:48.746] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:113:0)
[23:35:48.746] Timer tick, asking Buildbucket for the build status
[23:35:50.647] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:35:50.647] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:114:0) after 1m0s
[23:36:50.686] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:114:0)
[23:36:50.686] Timer tick, asking Buildbucket for the build status
[23:36:50.797] Build 8872860971259216480: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:36:50.797] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:115:0) after 1m0s
[23:36:55.016] Received PubSub notification, asking Buildbucket for the build status
[23:36:55.096] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:50.989] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:115:0)
[23:37:50.989] Timer tick, asking Buildbucket for the build status
[23:37:51.161] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:51.161] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:117:0) after 1m0s
[23:38:51.243] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:117:0)
[23:38:51.243] Timer tick, asking Buildbucket for the build status
[23:38:51.498] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:51.498] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:118:0) after 1m0s
[23:39:51.777] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:118:0)
[23:39:51.777] Timer tick, asking Buildbucket for the build status
[23:39:52.209] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:52.209] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:119:0) after 1m0s
[23:40:52.432] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:119:0)
[23:40:52.432] Timer tick, asking Buildbucket for the build status
[23:40:52.539] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:52.539] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:120:0) after 1m0s
[23:41:52.630] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:120:0)
[23:41:52.630] Timer tick, asking Buildbucket for the build status
[23:41:52.703] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:52.703] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:121:0) after 1m0s
[23:42:52.894] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:121:0)
[23:42:52.894] Timer tick, asking Buildbucket for the build status
[23:42:53.003] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:53.003] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:122:0) after 1m0s
[23:43:53.111] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:122:0)
[23:43:53.111] Timer tick, asking Buildbucket for the build status
[23:43:53.427] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:53.427] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:123:0) after 1m0s
[23:44:53.643] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:123:0)
[23:44:53.643] Timer tick, asking Buildbucket for the build status
[23:44:53.745] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:53.745] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:124:0) after 1m0s
[23:45:53.876] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:124:0)
[23:45:53.876] Timer tick, asking Buildbucket for the build status
[23:45:54.307] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:54.307] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:125:0) after 1m0s
[23:46:54.383] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:125:0)
[23:46:54.384] Timer tick, asking Buildbucket for the build status
[23:46:54.460] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:54.460] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:126:0) after 1m0s
[23:47:54.504] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:126:0)
[23:47:54.504] Timer tick, asking Buildbucket for the build status
[23:47:54.572] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:54.572] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:127:0) after 1m0s
[23:48:54.701] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:127:0)
[23:48:54.701] Timer tick, asking Buildbucket for the build status
[23:48:55.210] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:55.210] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:128:0) after 1m0s
[23:49:55.274] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:128:0)
[23:49:55.274] Timer tick, asking Buildbucket for the build status
[23:49:55.576] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:55.576] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:129:0) after 1m0s
[23:50:55.636] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:129:0)
[23:50:55.636] Timer tick, asking Buildbucket for the build status
[23:50:55.840] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:55.840] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:130:0) after 1m0s
[23:51:55.937] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:130:0)
[23:51:55.937] Timer tick, asking Buildbucket for the build status
[23:51:56.012] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:56.012] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:131:0) after 1m0s
[23:52:56.102] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:131:0)
[23:52:56.102] Timer tick, asking Buildbucket for the build status
[23:52:56.186] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:56.186] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:132:0) after 1m0s
[23:53:56.286] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:132:0)
[23:53:56.286] Timer tick, asking Buildbucket for the build status
[23:53:56.400] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:56.400] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:133:0) after 1m0s
[23:54:56.557] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:133:0)
[23:54:56.557] Timer tick, asking Buildbucket for the build status
[23:54:56.663] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:56.663] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:134:0) after 1m0s
[23:55:56.697] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:134:0)
[23:55:56.697] Timer tick, asking Buildbucket for the build status
[23:55:57.116] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:57.116] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:135:0) after 1m0s
[23:56:57.186] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:135:0)
[23:56:57.186] Timer tick, asking Buildbucket for the build status
[23:56:57.487] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:57.487] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:136:0) after 1m0s
[23:57:57.591] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:136:0)
[23:57:57.591] Timer tick, asking Buildbucket for the build status
[23:57:57.797] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:57.797] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:137:0) after 1m0s
[23:58:57.927] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:137:0)
[23:58:57.927] Timer tick, asking Buildbucket for the build status
[23:59:00.898] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:00.899] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:138:0) after 1m0s
[00:00:01.939] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:138:0)
[00:00:01.939] Timer tick, asking Buildbucket for the build status
[00:00:02.049] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:02.049] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:139:0) after 1m0s
[00:01:02.513] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:139:0)
[00:01:02.513] Timer tick, asking Buildbucket for the build status
[00:01:02.776] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:02.776] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:140:0) after 1m0s
[00:02:02.813] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:140:0)
[00:02:02.813] Timer tick, asking Buildbucket for the build status
[00:02:02.918] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:02.918] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:141:0) after 1m0s
[00:03:02.942] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:141:0)
[00:03:02.942] Timer tick, asking Buildbucket for the build status
[00:03:03.021] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:03.021] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:142:0) after 1m0s
[00:04:03.068] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:142:0)
[00:04:03.068] Timer tick, asking Buildbucket for the build status
[00:04:04.297] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:04.297] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:143:0) after 1m0s
[00:05:04.404] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:143:0)
[00:05:04.404] Timer tick, asking Buildbucket for the build status
[00:05:05.147] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:05.147] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:144:0) after 1m0s
[00:06:05.263] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:144:0)
[00:06:05.263] Timer tick, asking Buildbucket for the build status
[00:06:05.557] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:05.557] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:145:0) after 1m0s
[00:07:05.689] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:145:0)
[00:07:05.689] Timer tick, asking Buildbucket for the build status
[00:07:05.750] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:05.750] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:146:0) after 1m0s
[00:08:06.078] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:146:0)
[00:08:06.078] Timer tick, asking Buildbucket for the build status
[00:08:06.294] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:06.294] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:147:0) after 1m0s
[00:09:06.422] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:147:0)
[00:09:06.422] Timer tick, asking Buildbucket for the build status
[00:09:06.628] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:06.628] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:148:0) after 1m0s
[00:10:06.872] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:148:0)
[00:10:06.872] Timer tick, asking Buildbucket for the build status
[00:10:07.647] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:07.647] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:149:0) after 1m0s
[00:11:07.742] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:149:0)
[00:11:07.742] Timer tick, asking Buildbucket for the build status
[00:11:07.893] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:07.893] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:150:0) after 1m0s
[00:12:08.786] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:150:0)
[00:12:08.786] Timer tick, asking Buildbucket for the build status
[00:12:09.548] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:09.548] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:151:0) after 1m0s
[00:13:09.678] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:151:0)
[00:13:09.678] Timer tick, asking Buildbucket for the build status
[00:13:09.841] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:09.841] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:152:0) after 1m0s
[00:14:10.015] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:152:0)
[00:14:10.015] Timer tick, asking Buildbucket for the build status
[00:14:10.183] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:10.183] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:153:0) after 1m0s
[00:15:10.349] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:153:0)
[00:15:10.349] Timer tick, asking Buildbucket for the build status
[00:15:10.430] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:10.430] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:154:0) after 1m0s
[00:16:10.472] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:154:0)
[00:16:10.472] Timer tick, asking Buildbucket for the build status
[00:16:10.736] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:10.736] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:155:0) after 1m0s
[00:17:10.799] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:155:0)
[00:17:10.799] Timer tick, asking Buildbucket for the build status
[00:17:10.891] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:10.891] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:156:0) after 1m0s
[00:18:10.959] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:156:0)
[00:18:10.959] Timer tick, asking Buildbucket for the build status
[00:18:11.054] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:11.055] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:157:0) after 1m0s
[00:19:11.058] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:157:0)
[00:19:11.058] Timer tick, asking Buildbucket for the build status
[00:19:11.354] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:11.354] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:158:0) after 1m0s
[00:20:11.410] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:158:0)
[00:20:11.410] Timer tick, asking Buildbucket for the build status
[00:20:11.523] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:11.523] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:159:0) after 1m0s
[00:21:11.581] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:159:0)
[00:21:11.581] Timer tick, asking Buildbucket for the build status
[00:21:11.768] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:11.768] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:160:0) after 1m0s
[00:22:11.801] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:160:0)
[00:22:11.801] Timer tick, asking Buildbucket for the build status
[00:22:11.895] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:11.895] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:161:0) after 1m0s
[00:23:11.900] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:161:0)
[00:23:11.900] Timer tick, asking Buildbucket for the build status
[00:23:11.990] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:11.990] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:162:0) after 1m0s
[00:24:12.137] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:162:0)
[00:24:12.137] Timer tick, asking Buildbucket for the build status
[00:24:12.326] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:12.326] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:163:0) after 1m0s
[00:25:12.335] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:163:0)
[00:25:12.335] Timer tick, asking Buildbucket for the build status
[00:25:12.558] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:12.558] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:164:0) after 1m0s
[00:26:12.606] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:164:0)
[00:26:12.606] Timer tick, asking Buildbucket for the build status
[00:26:12.899] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:12.899] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:165:0) after 1m0s
[00:27:12.952] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:165:0)
[00:27:12.953] Timer tick, asking Buildbucket for the build status
[00:27:13.334] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:13.334] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:166:0) after 1m0s
[00:28:13.368] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:166:0)
[00:28:13.368] Timer tick, asking Buildbucket for the build status
[00:28:13.459] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:13.459] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:167:0) after 1m0s
[00:29:13.526] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:167:0)
[00:29:13.526] Timer tick, asking Buildbucket for the build status
[00:29:13.771] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:13.771] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:168:0) after 1m0s
[00:30:13.820] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:168:0)
[00:30:13.820] Timer tick, asking Buildbucket for the build status
[00:30:13.937] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:13.937] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:169:0) after 1m0s
[00:31:14.069] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:169:0)
[00:31:14.069] Timer tick, asking Buildbucket for the build status
[00:31:14.148] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:14.148] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:170:0) after 1m0s
[00:32:14.230] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:170:0)
[00:32:14.230] Timer tick, asking Buildbucket for the build status
[00:32:14.324] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:14.324] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:171:0) after 1m0s
[00:33:14.396] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:171:0)
[00:33:14.396] Timer tick, asking Buildbucket for the build status
[00:33:14.486] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:14.486] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:172:0) after 1m0s
[00:34:14.803] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:172:0)
[00:34:14.803] Timer tick, asking Buildbucket for the build status
[00:34:14.998] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:14.998] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:173:0) after 1m0s
[00:35:15.108] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:173:0)
[00:35:15.108] Timer tick, asking Buildbucket for the build status
[00:35:15.215] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:15.215] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:174:0) after 1m0s
[00:36:15.311] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:174:0)
[00:36:15.311] Timer tick, asking Buildbucket for the build status
[00:36:16.833] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:16.833] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:175:0) after 1m0s
[00:37:16.916] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:175:0)
[00:37:16.916] Timer tick, asking Buildbucket for the build status
[00:37:17.068] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:17.068] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:176:0) after 1m0s
[00:38:17.162] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:176:0)
[00:38:17.162] Timer tick, asking Buildbucket for the build status
[00:38:17.259] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:17.259] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:177:0) after 1m0s
[00:39:17.356] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:177:0)
[00:39:17.356] Timer tick, asking Buildbucket for the build status
[00:39:17.492] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:17.492] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:178:0) after 1m0s
[00:40:17.523] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:178:0)
[00:40:17.523] Timer tick, asking Buildbucket for the build status
[00:40:17.668] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:17.668] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:179:0) after 1m0s
[00:41:17.735] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:179:0)
[00:41:17.735] Timer tick, asking Buildbucket for the build status
[00:41:18.347] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:18.347] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:180:0) after 1m0s
[00:42:18.442] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:180:0)
[00:42:18.442] Timer tick, asking Buildbucket for the build status
[00:42:18.605] Build 8872860971259216480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:18.605] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9038291033883884768:181:0) after 1m0s
[00:42:46.464] Received PubSub notification, asking Buildbucket for the build status
[00:42:46.820] Build 8872860971259216480: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:42:46.821] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"completed_ts": "1596588165305136",
"created_by": "project:emscripten-releases",
"created_ts": "1596577400874795",
"id": "8872860971259216480",
"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\": \"18f6d5a44ffdf8ccb08f08a6ce0f1ba3f7e775cb\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@18f6d5a44ffdf8ccb08f08a6ce0f1ba3f7e775cb\", \"title\": \"18f6d5a44ffdf8ccb08f08a6ce0f1ba3f7e775cb\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/18f6d5a44ffdf8ccb08f08a6ce0f1ba3f7e775cb\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"18f6d5a44ffdf8ccb08f08a6ce0f1ba3f7e775cb\"}}",
"project": "emscripten-releases",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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\": \"18f6d5a44ffdf8ccb08f08a6ce0f1ba3f7e775cb\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@18f6d5a44ffdf8ccb08f08a6ce0f1ba3f7e775cb\", \"title\": \"18f6d5a44ffdf8ccb08f08a6ce0f1ba3f7e775cb\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/18f6d5a44ffdf8ccb08f08a6ce0f1ba3f7e775cb\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-win10-0-5mj5\", \"branch\": \"refs/heads/master\", \"buildername\": \"win\", \"got_revision\": \"18f6d5a44ffdf8ccb08f08a6ce0f1ba3f7e775cb\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"18f6d5a44ffdf8ccb08f08a6ce0f1ba3f7e775cb\"}, \"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-5mj5\"], \"image\": [\"chrome-win10-1703-20073100-2eb11ddbc6e\"], \"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\": [\"5466-bde9353\"], \"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": "1596584213906449",
"status": "COMPLETED",
"status_changed_ts": "1596588165783976",
"tags": [
"builder:win",
"buildset:commit/git/18f6d5a44ffdf8ccb08f08a6ce0f1ba3f7e775cb",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/18f6d5a44ffdf8ccb08f08a6ce0f1ba3f7e775cb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9038291033883884768",
"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/8872860971259216480/+/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:4dd43f5483110410",
"user_agent:luci-scheduler"
],
"updated_ts": "1596588165798366",
"url": "https://ci.chromium.org/b/8872860971259216480",
"utcnow_ts": "1596588166791841"
}
}
[00:42:46.821] Invocation finished in 2h59m27.832659009s with status SUCCEEDED