[17:51:10.368] New invocation is queued and will start shortly
[17:51:11.495] Starting the invocation (attempt 1)
[17:51:11.617] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:51:11.617] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:51:11.618] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9078621289180061904",
"parameters_json": "{\"builder_name\":\"win\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"db90d8ef18b877c133265b14eb62b597e54fdb94\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win",
"scheduler_invocation_id:9078621289180061904",
"scheduler_job_id:emscripten-releases/win",
"user_agent:luci-scheduler",
"buildset:commit/git/db90d8ef18b877c133265b14eb62b597e54fdb94",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/db90d8ef18b877c133265b14eb62b597e54fdb94",
"gitiles_ref:refs/heads/master"
]
}
[17:51:12.619] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "AUTO",
"created_by": "project:emscripten-releases",
"created_ts": "1558115471716183",
"id": "8913191227088177200",
"parameters_json": "{\"builder_name\": \"win\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"db90d8ef18b877c133265b14eb62b597e54fdb94\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1558115472073033",
"tags": [
"builder:win",
"buildset:commit/git/db90d8ef18b877c133265b14eb62b597e54fdb94",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/db90d8ef18b877c133265b14eb62b597e54fdb94",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9078621289180061904",
"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/8913191227088177200/+/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": "1558115472073118",
"url": "https://ci.chromium.org/b/8913191227088177200",
"utcnow_ts": "1558115472612904"
}
}
[17:51:12.620] Task URL: https://ci.chromium.org/b/8913191227088177200
[17:51:12.620] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:2:0) after 1m0s
[17:51:17.167] Received PubSub notification, asking Buildbucket for the build status
[17:51:17.305] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:12.647] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:2:0)
[17:52:12.647] Timer tick, asking Buildbucket for the build status
[17:52:12.714] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:12.714] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:4:0) after 1m0s
[17:53:12.762] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:4:0)
[17:53:12.762] Timer tick, asking Buildbucket for the build status
[17:53:12.876] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:12.876] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:5:0) after 1m0s
[17:54:12.901] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:5:0)
[17:54:12.901] Timer tick, asking Buildbucket for the build status
[17:54:12.961] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:12.961] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:6:0) after 1m0s
[17:55:12.985] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:6:0)
[17:55:12.985] Timer tick, asking Buildbucket for the build status
[17:55:13.093] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:13.093] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:7:0) after 1m0s
[17:56:13.114] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:7:0)
[17:56:13.114] Timer tick, asking Buildbucket for the build status
[17:56:13.174] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:13.174] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:8:0) after 1m0s
[17:57:13.205] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:8:0)
[17:57:13.205] Timer tick, asking Buildbucket for the build status
[17:57:13.249] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:13.249] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:9:0) after 1m0s
[17:58:13.376] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:9:0)
[17:58:13.376] Timer tick, asking Buildbucket for the build status
[17:58:13.506] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:13.506] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:10:0) after 1m0s
[17:59:13.493] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:10:0)
[17:59:13.493] Timer tick, asking Buildbucket for the build status
[17:59:13.535] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:13.535] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:11:0) after 1m0s
[18:00:13.577] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:11:0)
[18:00:13.577] Timer tick, asking Buildbucket for the build status
[18:00:13.787] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:13.787] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:12:0) after 1m0s
[18:01:13.846] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:12:0)
[18:01:13.846] Timer tick, asking Buildbucket for the build status
[18:01:14.695] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:14.695] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:13:0) after 1m0s
[18:02:14.723] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:13:0)
[18:02:14.723] Timer tick, asking Buildbucket for the build status
[18:02:15.189] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:15.189] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:14:0) after 1m0s
[18:03:15.277] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:14:0)
[18:03:15.277] Timer tick, asking Buildbucket for the build status
[18:03:15.363] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:15.363] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:15:0) after 1m0s
[18:04:15.384] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:15:0)
[18:04:15.384] Timer tick, asking Buildbucket for the build status
[18:04:15.645] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:15.645] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:16:0) after 1m0s
[18:05:15.714] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:16:0)
[18:05:15.714] Timer tick, asking Buildbucket for the build status
[18:05:15.854] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:15.854] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:17:0) after 1m0s
[18:06:15.881] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:17:0)
[18:06:15.881] Timer tick, asking Buildbucket for the build status
[18:06:16.354] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:16.354] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:18:0) after 1m0s
[18:07:16.407] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:18:0)
[18:07:16.407] Timer tick, asking Buildbucket for the build status
[18:07:16.462] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:16.462] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:19:0) after 1m0s
[18:08:16.493] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:19:0)
[18:08:16.493] Timer tick, asking Buildbucket for the build status
[18:08:16.611] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:16.612] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:20:0) after 1m0s
[18:09:16.644] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:20:0)
[18:09:16.644] Timer tick, asking Buildbucket for the build status
[18:09:16.784] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:16.784] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:21:0) after 1m0s
[18:10:16.819] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:21:0)
[18:10:16.819] Timer tick, asking Buildbucket for the build status
[18:10:16.887] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:16.887] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:22:0) after 1m0s
[18:11:16.952] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:22:0)
[18:11:16.952] Timer tick, asking Buildbucket for the build status
[18:11:17.061] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:17.062] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:23:0) after 1m0s
[18:12:17.107] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:23:0)
[18:12:17.107] Timer tick, asking Buildbucket for the build status
[18:12:17.196] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:17.196] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:24:0) after 1m0s
[18:13:17.219] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:24:0)
[18:13:17.219] Timer tick, asking Buildbucket for the build status
[18:13:17.431] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:17.431] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:25:0) after 1m0s
[18:14:17.439] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:25:0)
[18:14:17.439] Timer tick, asking Buildbucket for the build status
[18:14:17.762] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:17.762] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:26:0) after 1m0s
[18:15:17.861] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:26:0)
[18:15:17.861] Timer tick, asking Buildbucket for the build status
[18:15:18.238] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:18.238] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:27:0) after 1m0s
[18:16:18.259] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:27:0)
[18:16:18.259] Timer tick, asking Buildbucket for the build status
[18:16:18.393] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:18.393] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:28:0) after 1m0s
[18:17:18.427] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:28:0)
[18:17:18.427] Timer tick, asking Buildbucket for the build status
[18:17:18.480] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:18.480] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:29:0) after 1m0s
[18:18:18.521] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:29:0)
[18:18:18.521] Timer tick, asking Buildbucket for the build status
[18:18:19.055] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:19.056] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:30:0) after 1m0s
[18:19:19.058] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:30:0)
[18:19:19.058] Timer tick, asking Buildbucket for the build status
[18:19:19.187] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:19.187] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:31:0) after 1m0s
[18:20:19.213] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:31:0)
[18:20:19.213] Timer tick, asking Buildbucket for the build status
[18:20:20.056] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:20.056] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:32:0) after 1m0s
[18:21:20.165] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:32:0)
[18:21:20.165] Timer tick, asking Buildbucket for the build status
[18:21:20.558] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:20.558] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:33:0) after 1m0s
[18:22:20.593] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:33:0)
[18:22:20.593] Timer tick, asking Buildbucket for the build status
[18:22:20.719] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:20.719] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:34:0) after 1m0s
[18:23:20.741] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:34:0)
[18:23:20.741] Timer tick, asking Buildbucket for the build status
[18:23:20.792] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:20.792] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:35:0) after 1m0s
[18:24:20.826] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:35:0)
[18:24:20.826] Timer tick, asking Buildbucket for the build status
[18:24:20.907] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:20.907] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:36:0) after 1m0s
[18:25:20.927] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:36:0)
[18:25:20.927] Timer tick, asking Buildbucket for the build status
[18:25:21.011] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:21.011] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:37:0) after 1m0s
[18:26:21.028] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:37:0)
[18:26:21.028] Timer tick, asking Buildbucket for the build status
[18:26:21.209] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:21.209] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:38:0) after 1m0s
[18:27:21.213] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:38:0)
[18:27:21.213] Timer tick, asking Buildbucket for the build status
[18:27:21.345] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:21.345] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:39:0) after 1m0s
[18:28:21.355] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:39:0)
[18:28:21.355] Timer tick, asking Buildbucket for the build status
[18:28:21.415] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:21.415] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:40:0) after 1m0s
[18:29:21.468] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:40:0)
[18:29:21.468] Timer tick, asking Buildbucket for the build status
[18:29:21.505] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:21.505] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:41:0) after 1m0s
[18:30:21.536] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:41:0)
[18:30:21.536] Timer tick, asking Buildbucket for the build status
[18:30:21.641] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:21.641] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:42:0) after 1m0s
[18:31:21.631] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:42:0)
[18:31:21.631] Timer tick, asking Buildbucket for the build status
[18:31:21.746] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:21.746] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:43:0) after 1m0s
[18:32:21.734] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:43:0)
[18:32:21.734] Timer tick, asking Buildbucket for the build status
[18:32:21.852] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:21.852] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:44:0) after 1m0s
[18:33:21.924] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:44:0)
[18:33:21.924] Timer tick, asking Buildbucket for the build status
[18:33:22.071] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:22.071] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:45:0) after 1m0s
[18:34:22.128] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:45:0)
[18:34:22.128] Timer tick, asking Buildbucket for the build status
[18:34:22.203] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:22.203] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:46:0) after 1m0s
[18:35:22.236] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:46:0)
[18:35:22.236] Timer tick, asking Buildbucket for the build status
[18:35:22.504] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:22.504] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:47:0) after 1m0s
[18:36:22.531] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:47:0)
[18:36:22.531] Timer tick, asking Buildbucket for the build status
[18:36:22.961] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:22.961] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:48:0) after 1m0s
[18:37:22.993] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:48:0)
[18:37:22.993] Timer tick, asking Buildbucket for the build status
[18:37:23.424] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:23.424] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:49:0) after 1m0s
[18:38:23.399] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:49:0)
[18:38:23.399] Timer tick, asking Buildbucket for the build status
[18:38:23.469] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:23.469] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:50:0) after 1m0s
[18:39:23.485] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:50:0)
[18:39:23.485] Timer tick, asking Buildbucket for the build status
[18:39:23.651] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:23.651] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:51:0) after 1m0s
[18:40:23.682] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:51:0)
[18:40:23.682] Timer tick, asking Buildbucket for the build status
[18:40:23.737] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:23.737] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:52:0) after 1m0s
[18:41:23.762] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:52:0)
[18:41:23.762] Timer tick, asking Buildbucket for the build status
[18:41:23.865] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:23.865] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:53:0) after 1m0s
[18:42:23.869] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:53:0)
[18:42:23.869] Timer tick, asking Buildbucket for the build status
[18:42:24.012] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:24.012] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:54:0) after 1m0s
[18:43:24.044] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:54:0)
[18:43:24.044] Timer tick, asking Buildbucket for the build status
[18:43:24.089] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:24.089] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:55:0) after 1m0s
[18:44:24.149] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:55:0)
[18:44:24.149] Timer tick, asking Buildbucket for the build status
[18:44:24.320] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:24.320] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:56:0) after 1m0s
[18:45:24.323] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:56:0)
[18:45:24.323] Timer tick, asking Buildbucket for the build status
[18:45:24.518] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:24.518] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:57:0) after 1m0s
[18:46:24.584] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:57:0)
[18:46:24.584] Timer tick, asking Buildbucket for the build status
[18:46:25.227] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:25.227] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:58:0) after 1m0s
[18:47:25.256] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:58:0)
[18:47:25.256] Timer tick, asking Buildbucket for the build status
[18:47:25.502] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:25.502] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:59:0) after 1m0s
[18:48:25.584] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:59:0)
[18:48:25.584] Timer tick, asking Buildbucket for the build status
[18:48:25.683] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:25.683] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:60:0) after 1m0s
[18:49:25.729] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:60:0)
[18:49:25.729] Timer tick, asking Buildbucket for the build status
[18:49:26.290] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:26.290] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:61:0) after 1m0s
[18:50:26.294] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:61:0)
[18:50:26.294] Timer tick, asking Buildbucket for the build status
[18:50:26.370] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:26.370] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:62:0) after 1m0s
[18:51:26.384] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:62:0)
[18:51:26.384] Timer tick, asking Buildbucket for the build status
[18:51:26.467] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:26.467] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:63:0) after 1m0s
[18:52:26.489] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:63:0)
[18:52:26.489] Timer tick, asking Buildbucket for the build status
[18:52:26.715] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:26.715] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:64:0) after 1m0s
[18:53:26.769] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:64:0)
[18:53:26.769] Timer tick, asking Buildbucket for the build status
[18:53:26.901] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:26.901] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:65:0) after 1m0s
[18:54:26.977] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:65:0)
[18:54:26.977] Timer tick, asking Buildbucket for the build status
[18:54:27.218] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:27.218] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:66:0) after 1m0s
[18:55:27.243] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:66:0)
[18:55:27.243] Timer tick, asking Buildbucket for the build status
[18:55:27.344] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:27.344] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:67:0) after 1m0s
[18:56:27.378] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:67:0)
[18:56:27.378] Timer tick, asking Buildbucket for the build status
[18:56:27.454] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:27.454] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:68:0) after 1m0s
[18:57:27.475] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:68:0)
[18:57:27.475] Timer tick, asking Buildbucket for the build status
[18:57:27.587] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:27.587] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:69:0) after 1m0s
[18:58:27.716] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:69:0)
[18:58:27.716] Timer tick, asking Buildbucket for the build status
[18:58:27.768] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:27.768] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:70:0) after 1m0s
[18:59:27.800] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:70:0)
[18:59:27.800] Timer tick, asking Buildbucket for the build status
[18:59:27.883] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:27.883] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:71:0) after 1m0s
[19:00:27.893] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:71:0)
[19:00:27.893] Timer tick, asking Buildbucket for the build status
[19:00:28.068] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:28.068] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:72:0) after 1m0s
[19:01:28.185] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:72:0)
[19:01:28.185] Timer tick, asking Buildbucket for the build status
[19:01:28.248] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:28.248] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:73:0) after 1m0s
[19:02:28.277] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:73:0)
[19:02:28.277] Timer tick, asking Buildbucket for the build status
[19:02:28.322] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:28.322] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:74:0) after 1m0s
[19:03:28.354] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:74:0)
[19:03:28.354] Timer tick, asking Buildbucket for the build status
[19:03:28.393] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:28.393] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:75:0) after 1m0s
[19:04:28.423] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:75:0)
[19:04:28.423] Timer tick, asking Buildbucket for the build status
[19:04:28.522] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:28.522] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:76:0) after 1m0s
[19:05:28.555] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:76:0)
[19:05:28.555] Timer tick, asking Buildbucket for the build status
[19:05:28.604] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:28.604] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:77:0) after 1m0s
[19:06:28.636] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:77:0)
[19:06:28.636] Timer tick, asking Buildbucket for the build status
[19:06:28.729] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:28.729] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:78:0) after 1m0s
[19:07:28.792] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:78:0)
[19:07:28.792] Timer tick, asking Buildbucket for the build status
[19:07:28.883] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:28.883] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:79:0) after 1m0s
[19:08:28.934] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:79:0)
[19:08:28.934] Timer tick, asking Buildbucket for the build status
[19:08:29.007] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:29.007] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:80:0) after 1m0s
[19:09:29.042] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:80:0)
[19:09:29.042] Timer tick, asking Buildbucket for the build status
[19:09:29.171] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:29.171] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:81:0) after 1m0s
[19:10:29.167] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:81:0)
[19:10:29.167] Timer tick, asking Buildbucket for the build status
[19:10:29.299] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:29.299] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:82:0) after 1m0s
[19:11:29.333] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:82:0)
[19:11:29.333] Timer tick, asking Buildbucket for the build status
[19:11:29.764] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:29.764] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:83:0) after 1m0s
[19:12:29.767] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:83:0)
[19:12:29.767] Timer tick, asking Buildbucket for the build status
[19:12:29.826] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:29.826] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:84:0) after 1m0s
[19:13:29.830] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:84:0)
[19:13:29.830] Timer tick, asking Buildbucket for the build status
[19:13:30.100] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:30.100] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:85:0) after 1m0s
[19:14:30.125] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:85:0)
[19:14:30.125] Timer tick, asking Buildbucket for the build status
[19:14:30.248] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:30.248] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:86:0) after 1m0s
[19:15:30.266] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:86:0)
[19:15:30.266] Timer tick, asking Buildbucket for the build status
[19:15:30.320] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:30.320] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:87:0) after 1m0s
[19:16:30.421] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:87:0)
[19:16:30.421] Timer tick, asking Buildbucket for the build status
[19:16:30.506] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:30.506] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:88:0) after 1m0s
[19:17:30.514] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:88:0)
[19:17:30.514] Timer tick, asking Buildbucket for the build status
[19:17:30.935] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:30.935] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:89:0) after 1m0s
[19:18:30.958] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:89:0)
[19:18:30.958] Timer tick, asking Buildbucket for the build status
[19:18:31.179] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:31.179] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:90:0) after 1m0s
[19:19:31.203] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:90:0)
[19:19:31.203] Timer tick, asking Buildbucket for the build status
[19:19:32.061] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:32.061] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:91:0) after 1m0s
[19:20:32.068] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:91:0)
[19:20:32.068] Timer tick, asking Buildbucket for the build status
[19:20:32.498] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:32.498] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:92:0) after 1m0s
[19:21:32.514] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:92:0)
[19:21:32.514] Timer tick, asking Buildbucket for the build status
[19:21:32.728] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:32.728] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:93:0) after 1m0s
[19:22:32.797] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:93:0)
[19:22:32.797] Timer tick, asking Buildbucket for the build status
[19:22:32.890] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:32.890] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:94:0) after 1m0s
[19:23:32.887] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:94:0)
[19:23:32.887] Timer tick, asking Buildbucket for the build status
[19:23:32.938] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:32.938] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:95:0) after 1m0s
[19:24:33.009] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:95:0)
[19:24:33.009] Timer tick, asking Buildbucket for the build status
[19:24:33.082] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:33.082] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:96:0) after 1m0s
[19:25:33.115] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:96:0)
[19:25:33.115] Timer tick, asking Buildbucket for the build status
[19:25:33.184] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:33.184] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:97:0) after 1m0s
[19:26:33.214] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:97:0)
[19:26:33.214] Timer tick, asking Buildbucket for the build status
[19:26:33.371] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:33.371] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:98:0) after 1m0s
[19:27:33.410] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:98:0)
[19:27:33.410] Timer tick, asking Buildbucket for the build status
[19:27:33.503] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:33.503] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:99:0) after 1m0s
[19:28:33.542] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:99:0)
[19:28:33.542] Timer tick, asking Buildbucket for the build status
[19:28:33.616] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:33.616] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:100:0) after 1m0s
[19:29:33.628] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:100:0)
[19:29:33.628] Timer tick, asking Buildbucket for the build status
[19:29:33.788] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:33.788] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:101:0) after 1m0s
[19:30:33.838] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:101:0)
[19:30:33.839] Timer tick, asking Buildbucket for the build status
[19:30:34.357] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:34.357] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:102:0) after 1m0s
[19:31:34.463] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:102:0)
[19:31:34.463] Timer tick, asking Buildbucket for the build status
[19:31:34.594] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:34.594] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:103:0) after 1m0s
[19:32:34.599] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:103:0)
[19:32:34.599] Timer tick, asking Buildbucket for the build status
[19:32:34.771] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:34.771] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:104:0) after 1m0s
[19:33:34.814] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:104:0)
[19:33:34.814] Timer tick, asking Buildbucket for the build status
[19:33:35.068] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:35.068] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:105:0) after 1m0s
[19:34:35.151] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:105:0)
[19:34:35.151] Timer tick, asking Buildbucket for the build status
[19:34:35.209] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:35.209] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:106:0) after 1m0s
[19:35:35.251] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:106:0)
[19:35:35.251] Timer tick, asking Buildbucket for the build status
[19:35:35.463] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:35.463] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:107:0) after 1m0s
[19:36:35.467] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:107:0)
[19:36:35.467] Timer tick, asking Buildbucket for the build status
[19:36:35.551] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:35.551] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:108:0) after 1m0s
[19:37:35.587] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:108:0)
[19:37:35.587] Timer tick, asking Buildbucket for the build status
[19:37:35.915] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:35.915] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:109:0) after 1m0s
[19:38:36.450] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:109:0)
[19:38:36.450] Timer tick, asking Buildbucket for the build status
[19:38:36.585] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:36.585] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:110:0) after 1m0s
[19:39:36.612] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:110:0)
[19:39:36.612] Timer tick, asking Buildbucket for the build status
[19:39:36.669] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:36.669] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:111:0) after 1m0s
[19:40:36.705] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:111:0)
[19:40:36.705] Timer tick, asking Buildbucket for the build status
[19:40:36.790] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:36.790] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:112:0) after 1m0s
[19:41:36.822] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:112:0)
[19:41:36.822] Timer tick, asking Buildbucket for the build status
[19:41:36.898] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:36.898] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:113:0) after 1m0s
[19:42:36.917] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:113:0)
[19:42:36.917] Timer tick, asking Buildbucket for the build status
[19:42:37.080] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:37.080] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:114:0) after 1m0s
[19:43:37.078] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:114:0)
[19:43:37.078] Timer tick, asking Buildbucket for the build status
[19:43:37.133] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:37.133] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:115:0) after 1m0s
[19:44:37.182] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:115:0)
[19:44:37.182] Timer tick, asking Buildbucket for the build status
[19:44:37.294] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:37.294] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:116:0) after 1m0s
[19:45:37.394] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:116:0)
[19:45:37.394] Timer tick, asking Buildbucket for the build status
[19:45:37.431] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:37.431] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:117:0) after 1m0s
[19:46:37.448] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:117:0)
[19:46:37.448] Timer tick, asking Buildbucket for the build status
[19:46:37.717] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:37.717] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:118:0) after 1m0s
[19:47:37.753] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:118:0)
[19:47:37.753] Timer tick, asking Buildbucket for the build status
[19:47:37.879] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:37.879] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:119:0) after 1m0s
[19:48:37.864] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:119:0)
[19:48:37.864] Timer tick, asking Buildbucket for the build status
[19:48:37.985] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:37.985] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:120:0) after 1m0s
[19:49:38.007] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:120:0)
[19:49:38.007] Timer tick, asking Buildbucket for the build status
[19:49:38.077] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:38.077] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:121:0) after 1m0s
[19:50:38.123] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:121:0)
[19:50:38.123] Timer tick, asking Buildbucket for the build status
[19:50:38.294] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:38.294] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:122:0) after 1m0s
[19:51:38.304] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:122:0)
[19:51:38.304] Timer tick, asking Buildbucket for the build status
[19:51:38.390] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:38.390] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:123:0) after 1m0s
[19:52:38.460] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:123:0)
[19:52:38.460] Timer tick, asking Buildbucket for the build status
[19:52:38.583] Build 8913191227088177200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:38.583] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9078621289180061904:124:0) after 1m0s
[19:53:04.516] Received PubSub notification, asking Buildbucket for the build status
[19:53:04.581] Build 8913191227088177200: status "COMPLETED", result "CANCELED", failure_reason "", cancelation_reason "TIMEOUT"
[19:53:04.581] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "AUTO",
"cancelation_reason": "TIMEOUT",
"completed_ts": "1558122782273116",
"created_by": "project:emscripten-releases",
"created_ts": "1558115471716183",
"id": "8913191227088177200",
"parameters_json": "{\"builder_name\": \"win\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"db90d8ef18b877c133265b14eb62b597e54fdb94\"}}",
"project": "emscripten-releases",
"result": "CANCELED",
"result_details_json": "{\"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-emscripten-releases-ci-win10-0-pzq7\", \"branch\": \"refs/heads/master\", \"buildername\": \"win\", \"got_revision\": \"db90d8ef18b877c133265b14eb62b597e54fdb94\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"db90d8ef18b877c133265b14eb62b597e54fdb94\"}, \"swarming\": {\"bot_dimensions\": {\"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"host_class\": [\"default\"], \"id\": [\"luci-emscripten-releases-ci-win10-0-pzq7\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"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\": [\"4301-0053cb9\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1558115474665763",
"status": "COMPLETED",
"status_changed_ts": "1558122784169353",
"tags": [
"builder:win",
"buildset:commit/git/db90d8ef18b877c133265b14eb62b597e54fdb94",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/db90d8ef18b877c133265b14eb62b597e54fdb94",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9078621289180061904",
"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/8913191227088177200/+/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:44dfbcddead76c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1558122784194462",
"url": "https://ci.chromium.org/b/8913191227088177200",
"utcnow_ts": "1558122784571299"
}
}
[19:53:04.581] Invocation finished in 2h1m54.243428193s with status FAILED