[00:52:53.082] New invocation is queued and will start shortly
[00:52:55.336] Starting the invocation (attempt 1)
[00:52:55.426] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:52:55.427] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:52:55.427] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9061834318567268592",
"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\":\"ec3fb71a7c4c0ca7bdc4974f352eb71c497083a3\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@ec3fb71a7c4c0ca7bdc4974f352eb71c497083a3\",\"title\":\"ec3fb71a7c4c0ca7bdc4974f352eb71c497083a3\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/ec3fb71a7c4c0ca7bdc4974f352eb71c497083a3\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"ec3fb71a7c4c0ca7bdc4974f352eb71c497083a3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win",
"scheduler_invocation_id:9061834318567268592",
"scheduler_job_id:emscripten-releases/win",
"user_agent:luci-scheduler",
"buildset:commit/git/ec3fb71a7c4c0ca7bdc4974f352eb71c497083a3",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/ec3fb71a7c4c0ca7bdc4974f352eb71c497083a3",
"gitiles_ref:refs/heads/master"
]
}
[00:52:56.823] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1574124775643516",
"id": "8896404255213355840",
"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\": \"ec3fb71a7c4c0ca7bdc4974f352eb71c497083a3\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@ec3fb71a7c4c0ca7bdc4974f352eb71c497083a3\", \"title\": \"ec3fb71a7c4c0ca7bdc4974f352eb71c497083a3\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/ec3fb71a7c4c0ca7bdc4974f352eb71c497083a3\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"ec3fb71a7c4c0ca7bdc4974f352eb71c497083a3\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1574124776034070",
"tags": [
"builder:win",
"buildset:commit/git/ec3fb71a7c4c0ca7bdc4974f352eb71c497083a3",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/ec3fb71a7c4c0ca7bdc4974f352eb71c497083a3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9061834318567268592",
"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/8896404255213355840/+/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": "1574124776034170",
"url": "https://ci.chromium.org/b/8896404255213355840",
"utcnow_ts": "1574124776802846"
}
}
[00:52:56.823] Task URL: https://ci.chromium.org/b/8896404255213355840
[00:52:56.823] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:2:0) after 1m0s
[00:53:56.908] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:2:0)
[00:53:56.908] Timer tick, asking Buildbucket for the build status
[00:53:57.177] Build 8896404255213355840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:53:57.177] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:3:0) after 1m0s
[00:54:14.109] Received PubSub notification, asking Buildbucket for the build status
[00:54:14.261] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:57.239] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:3:0)
[00:54:57.239] Timer tick, asking Buildbucket for the build status
[00:54:57.403] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:57.403] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:5:0) after 1m0s
[00:55:57.854] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:5:0)
[00:55:57.854] Timer tick, asking Buildbucket for the build status
[00:55:57.988] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:57.988] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:6:0) after 1m0s
[00:56:58.078] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:6:0)
[00:56:58.078] Timer tick, asking Buildbucket for the build status
[00:56:58.545] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:58.545] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:7:0) after 1m0s
[00:57:58.731] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:7:0)
[00:57:58.731] Timer tick, asking Buildbucket for the build status
[00:57:59.006] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:59.006] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:8:0) after 1m0s
[00:58:59.042] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:8:0)
[00:58:59.042] Timer tick, asking Buildbucket for the build status
[00:58:59.271] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:59.271] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:9:0) after 1m0s
[00:59:59.376] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:9:0)
[00:59:59.376] Timer tick, asking Buildbucket for the build status
[00:59:59.517] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:59.517] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:10:0) after 1m0s
[01:00:59.574] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:10:0)
[01:00:59.574] Timer tick, asking Buildbucket for the build status
[01:00:59.947] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:59.948] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:11:0) after 1m0s
[01:02:00.014] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:11:0)
[01:02:00.014] Timer tick, asking Buildbucket for the build status
[01:02:00.219] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:00.219] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:12:0) after 1m0s
[01:03:00.260] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:12:0)
[01:03:00.260] Timer tick, asking Buildbucket for the build status
[01:03:00.548] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:00.548] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:13:0) after 1m0s
[01:04:00.572] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:13:0)
[01:04:00.572] Timer tick, asking Buildbucket for the build status
[01:04:01.579] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:01.579] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:14:0) after 1m0s
[01:05:01.601] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:14:0)
[01:05:01.601] Timer tick, asking Buildbucket for the build status
[01:05:02.190] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:02.190] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:15:0) after 1m0s
[01:06:02.201] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:15:0)
[01:06:02.201] Timer tick, asking Buildbucket for the build status
[01:06:02.443] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:02.443] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:16:0) after 1m0s
[01:07:02.463] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:16:0)
[01:07:02.464] Timer tick, asking Buildbucket for the build status
[01:07:02.580] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:02.580] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:17:0) after 1m0s
[01:08:02.698] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:17:0)
[01:08:02.698] Timer tick, asking Buildbucket for the build status
[01:08:03.378] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:03.378] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:18:0) after 1m0s
[01:09:03.614] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:18:0)
[01:09:03.614] Timer tick, asking Buildbucket for the build status
[01:09:03.927] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:03.927] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:19:0) after 1m0s
[01:10:04.005] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:19:0)
[01:10:04.005] Timer tick, asking Buildbucket for the build status
[01:10:06.841] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:06.841] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:20:0) after 1m0s
[01:11:06.853] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:20:0)
[01:11:06.853] Timer tick, asking Buildbucket for the build status
[01:11:07.440] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:07.440] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:21:0) after 1m0s
[01:12:07.497] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:21:0)
[01:12:07.497] Timer tick, asking Buildbucket for the build status
[01:12:07.708] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:07.708] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:22:0) after 1m0s
[01:13:07.752] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:22:0)
[01:13:07.752] Timer tick, asking Buildbucket for the build status
[01:13:07.998] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:07.998] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:23:0) after 1m0s
[01:14:08.134] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:23:0)
[01:14:08.134] Timer tick, asking Buildbucket for the build status
[01:14:08.257] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:08.257] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:24:0) after 1m0s
[01:15:08.277] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:24:0)
[01:15:08.277] Timer tick, asking Buildbucket for the build status
[01:15:08.729] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:08.729] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:25:0) after 1m0s
[01:16:08.862] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:25:0)
[01:16:08.862] Timer tick, asking Buildbucket for the build status
[01:16:09.223] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:09.223] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:26:0) after 1m0s
[01:17:09.266] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:26:0)
[01:17:09.266] Timer tick, asking Buildbucket for the build status
[01:17:09.373] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:09.373] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:27:0) after 1m0s
[01:18:09.491] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:27:0)
[01:18:09.491] Timer tick, asking Buildbucket for the build status
[01:18:09.831] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:09.831] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:28:0) after 1m0s
[01:19:09.928] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:28:0)
[01:19:09.928] Timer tick, asking Buildbucket for the build status
[01:19:10.235] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:10.235] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:29:0) after 1m0s
[01:20:10.367] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:29:0)
[01:20:10.367] Timer tick, asking Buildbucket for the build status
[01:20:10.481] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:10.481] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:30:0) after 1m0s
[01:21:10.583] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:30:0)
[01:21:10.583] Timer tick, asking Buildbucket for the build status
[01:21:12.679] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:12.679] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:31:0) after 1m0s
[01:22:12.779] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:31:0)
[01:22:12.779] Timer tick, asking Buildbucket for the build status
[01:22:12.916] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:12.916] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:32:0) after 1m0s
[01:23:12.996] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:32:0)
[01:23:12.996] Timer tick, asking Buildbucket for the build status
[01:23:13.128] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:13.128] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:33:0) after 1m0s
[01:24:13.490] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:33:0)
[01:24:13.490] Timer tick, asking Buildbucket for the build status
[01:24:13.683] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:13.683] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:34:0) after 1m0s
[01:25:13.737] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:34:0)
[01:25:13.737] Timer tick, asking Buildbucket for the build status
[01:25:14.117] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:14.117] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:35:0) after 1m0s
[01:26:14.171] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:35:0)
[01:26:14.171] Timer tick, asking Buildbucket for the build status
[01:26:14.302] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:14.302] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:36:0) after 1m0s
[01:27:14.335] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:36:0)
[01:27:14.335] Timer tick, asking Buildbucket for the build status
[01:27:14.545] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:14.546] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:37:0) after 1m0s
[01:28:14.551] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:37:0)
[01:28:14.551] Timer tick, asking Buildbucket for the build status
[01:28:15.577] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:15.577] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:38:0) after 1m0s
[01:29:15.635] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:38:0)
[01:29:15.635] Timer tick, asking Buildbucket for the build status
[01:29:16.095] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:16.095] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:39:0) after 1m0s
[01:30:16.133] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:39:0)
[01:30:16.133] Timer tick, asking Buildbucket for the build status
[01:30:18.579] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:18.579] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:40:0) after 1m0s
[01:31:18.722] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:40:0)
[01:31:18.722] Timer tick, asking Buildbucket for the build status
[01:31:19.099] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:19.099] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:41:0) after 1m0s
[01:32:19.131] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:41:0)
[01:32:19.131] Timer tick, asking Buildbucket for the build status
[01:32:19.293] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:19.293] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:42:0) after 1m0s
[01:33:19.478] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:42:0)
[01:33:19.478] Timer tick, asking Buildbucket for the build status
[01:33:19.577] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:19.578] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:43:0) after 1m0s
[01:34:19.762] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:43:0)
[01:34:19.762] Timer tick, asking Buildbucket for the build status
[01:34:20.209] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:20.209] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:44:0) after 1m0s
[01:35:20.267] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:44:0)
[01:35:20.267] Timer tick, asking Buildbucket for the build status
[01:35:20.557] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:20.557] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:45:0) after 1m0s
[01:36:20.633] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:45:0)
[01:36:20.633] Timer tick, asking Buildbucket for the build status
[01:36:20.766] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:20.766] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:46:0) after 1m0s
[01:37:20.822] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:46:0)
[01:37:20.822] Timer tick, asking Buildbucket for the build status
[01:37:21.474] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:21.474] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:47:0) after 1m0s
[01:38:21.506] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:47:0)
[01:38:21.506] Timer tick, asking Buildbucket for the build status
[01:38:21.803] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:21.803] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:48:0) after 1m0s
[01:39:21.834] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:48:0)
[01:39:21.834] Timer tick, asking Buildbucket for the build status
[01:39:21.914] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:21.914] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:49:0) after 1m0s
[01:40:21.987] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:49:0)
[01:40:21.987] Timer tick, asking Buildbucket for the build status
[01:40:22.103] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:22.103] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:50:0) after 1m0s
[01:41:22.420] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:50:0)
[01:41:22.420] Timer tick, asking Buildbucket for the build status
[01:41:23.318] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:23.318] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:51:0) after 1m0s
[01:42:23.397] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:51:0)
[01:42:23.397] Timer tick, asking Buildbucket for the build status
[01:42:23.545] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:23.545] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:52:0) after 1m0s
[01:43:23.934] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:52:0)
[01:43:23.934] Timer tick, asking Buildbucket for the build status
[01:43:24.349] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:24.349] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:53:0) after 1m0s
[01:44:24.436] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:53:0)
[01:44:24.436] Timer tick, asking Buildbucket for the build status
[01:44:24.549] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:24.549] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:54:0) after 1m0s
[01:45:24.584] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:54:0)
[01:45:24.584] Timer tick, asking Buildbucket for the build status
[01:45:25.064] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:25.064] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:55:0) after 1m0s
[01:46:25.254] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:55:0)
[01:46:25.254] Timer tick, asking Buildbucket for the build status
[01:46:25.523] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:25.523] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:56:0) after 1m0s
[01:47:25.535] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:56:0)
[01:47:25.535] Timer tick, asking Buildbucket for the build status
[01:47:25.668] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:25.668] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:57:0) after 1m0s
[01:48:25.847] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:57:0)
[01:48:25.847] Timer tick, asking Buildbucket for the build status
[01:48:25.939] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:25.939] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:58:0) after 1m0s
[01:49:25.954] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:58:0)
[01:49:25.954] Timer tick, asking Buildbucket for the build status
[01:49:26.124] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:26.124] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:59:0) after 1m0s
[01:50:26.171] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:59:0)
[01:50:26.171] Timer tick, asking Buildbucket for the build status
[01:50:26.327] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:26.327] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:60:0) after 1m0s
[01:51:26.592] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:60:0)
[01:51:26.592] Timer tick, asking Buildbucket for the build status
[01:51:26.963] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:26.963] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:61:0) after 1m0s
[01:52:27.063] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:61:0)
[01:52:27.063] Timer tick, asking Buildbucket for the build status
[01:52:27.199] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:27.199] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:62:0) after 1m0s
[01:53:27.255] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:62:0)
[01:53:27.255] Timer tick, asking Buildbucket for the build status
[01:53:27.400] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:27.400] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:63:0) after 1m0s
[01:54:27.396] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:63:0)
[01:54:27.396] Timer tick, asking Buildbucket for the build status
[01:54:27.675] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:27.675] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:64:0) after 1m0s
[01:55:27.726] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:64:0)
[01:55:27.726] Timer tick, asking Buildbucket for the build status
[01:55:28.122] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:28.122] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:65:0) after 1m0s
[01:56:28.154] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:65:0)
[01:56:28.154] Timer tick, asking Buildbucket for the build status
[01:56:28.814] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:28.814] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:66:0) after 1m0s
[01:57:28.831] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:66:0)
[01:57:28.831] Timer tick, asking Buildbucket for the build status
[01:57:29.117] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:29.117] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:67:0) after 1m0s
[01:58:29.148] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:67:0)
[01:58:29.148] Timer tick, asking Buildbucket for the build status
[01:58:29.337] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:29.337] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:68:0) after 1m0s
[01:59:29.352] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:68:0)
[01:59:29.352] Timer tick, asking Buildbucket for the build status
[01:59:29.653] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:29.653] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:69:0) after 1m0s
[02:00:29.829] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:69:0)
[02:00:29.829] Timer tick, asking Buildbucket for the build status
[02:00:30.003] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:30.003] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:70:0) after 1m0s
[02:01:30.145] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:70:0)
[02:01:30.145] Timer tick, asking Buildbucket for the build status
[02:01:30.393] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:30.393] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:71:0) after 1m0s
[02:02:30.416] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:71:0)
[02:02:30.416] Timer tick, asking Buildbucket for the build status
[02:02:30.728] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:30.728] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:72:0) after 1m0s
[02:03:30.855] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:72:0)
[02:03:30.855] Timer tick, asking Buildbucket for the build status
[02:03:31.336] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:31.336] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:73:0) after 1m0s
[02:04:31.445] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:73:0)
[02:04:31.445] Timer tick, asking Buildbucket for the build status
[02:04:31.573] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:31.573] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:74:0) after 1m0s
[02:05:31.634] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:74:0)
[02:05:31.634] Timer tick, asking Buildbucket for the build status
[02:05:32.250] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:32.250] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:75:0) after 1m0s
[02:06:32.354] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:75:0)
[02:06:32.354] Timer tick, asking Buildbucket for the build status
[02:06:32.462] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:32.462] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:76:0) after 1m0s
[02:07:32.498] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:76:0)
[02:07:32.498] Timer tick, asking Buildbucket for the build status
[02:07:32.697] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:32.697] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:77:0) after 1m0s
[02:08:32.829] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:77:0)
[02:08:32.829] Timer tick, asking Buildbucket for the build status
[02:08:33.066] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:33.066] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:78:0) after 1m0s
[02:09:33.222] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:78:0)
[02:09:33.222] Timer tick, asking Buildbucket for the build status
[02:09:33.286] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:33.286] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:79:0) after 1m0s
[02:10:33.288] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:79:0)
[02:10:33.288] Timer tick, asking Buildbucket for the build status
[02:10:33.392] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:33.392] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:80:0) after 1m0s
[02:11:33.415] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:80:0)
[02:11:33.415] Timer tick, asking Buildbucket for the build status
[02:11:34.061] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:34.061] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:81:0) after 1m0s
[02:12:34.129] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:81:0)
[02:12:34.129] Timer tick, asking Buildbucket for the build status
[02:12:34.305] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:34.305] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:82:0) after 1m0s
[02:13:34.335] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:82:0)
[02:13:34.335] Timer tick, asking Buildbucket for the build status
[02:13:34.436] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:34.436] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:83:0) after 1m0s
[02:14:34.485] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:83:0)
[02:14:34.485] Timer tick, asking Buildbucket for the build status
[02:14:34.744] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:34.744] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:84:0) after 1m0s
[02:15:34.795] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:84:0)
[02:15:34.795] Timer tick, asking Buildbucket for the build status
[02:15:35.004] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:35.004] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:85:0) after 1m0s
[02:16:35.031] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:85:0)
[02:16:35.031] Timer tick, asking Buildbucket for the build status
[02:16:35.166] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:35.166] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:86:0) after 1m0s
[02:17:35.234] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:86:0)
[02:17:35.234] Timer tick, asking Buildbucket for the build status
[02:17:35.344] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:35.344] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:87:0) after 1m0s
[02:18:35.417] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:87:0)
[02:18:35.417] Timer tick, asking Buildbucket for the build status
[02:18:35.512] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:35.512] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:88:0) after 1m0s
[02:19:35.537] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:88:0)
[02:19:35.537] Timer tick, asking Buildbucket for the build status
[02:19:35.638] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:35.638] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:89:0) after 1m0s
[02:20:35.776] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:89:0)
[02:20:35.776] Timer tick, asking Buildbucket for the build status
[02:20:35.963] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:35.963] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:90:0) after 1m0s
[02:21:35.951] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:90:0)
[02:21:35.951] Timer tick, asking Buildbucket for the build status
[02:21:36.078] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:36.078] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:91:0) after 1m0s
[02:22:36.179] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:91:0)
[02:22:36.179] Timer tick, asking Buildbucket for the build status
[02:22:36.370] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:36.370] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:92:0) after 1m0s
[02:23:36.425] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:92:0)
[02:23:36.425] Timer tick, asking Buildbucket for the build status
[02:23:36.584] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:36.584] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:93:0) after 1m0s
[02:24:36.740] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:93:0)
[02:24:36.740] Timer tick, asking Buildbucket for the build status
[02:24:36.959] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:36.959] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:94:0) after 1m0s
[02:25:37.037] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:94:0)
[02:25:37.037] Timer tick, asking Buildbucket for the build status
[02:25:37.307] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:37.307] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:95:0) after 1m0s
[02:26:37.345] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:95:0)
[02:26:37.345] Timer tick, asking Buildbucket for the build status
[02:26:37.544] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:37.544] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:96:0) after 1m0s
[02:27:37.766] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:96:0)
[02:27:37.766] Timer tick, asking Buildbucket for the build status
[02:27:37.911] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:37.911] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:97:0) after 1m0s
[02:28:38.143] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:97:0)
[02:28:38.143] Timer tick, asking Buildbucket for the build status
[02:28:38.212] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:38.212] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:98:0) after 1m0s
[02:29:38.408] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:98:0)
[02:29:38.408] Timer tick, asking Buildbucket for the build status
[02:29:38.552] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:38.552] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:99:0) after 1m0s
[02:30:38.715] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:99:0)
[02:30:38.715] Timer tick, asking Buildbucket for the build status
[02:30:39.065] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:39.065] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:100:0) after 1m0s
[02:31:39.245] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:100:0)
[02:31:39.245] Timer tick, asking Buildbucket for the build status
[02:31:39.513] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:39.513] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:101:0) after 1m0s
[02:32:39.716] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:101:0)
[02:32:39.716] Timer tick, asking Buildbucket for the build status
[02:32:39.956] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:39.956] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:102:0) after 1m0s
[02:33:40.067] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:102:0)
[02:33:40.067] Timer tick, asking Buildbucket for the build status
[02:33:40.269] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:40.269] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:103:0) after 1m0s
[02:34:40.483] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:103:0)
[02:34:40.483] Timer tick, asking Buildbucket for the build status
[02:34:40.623] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:40.623] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:104:0) after 1m0s
[02:35:40.705] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:104:0)
[02:35:40.705] Timer tick, asking Buildbucket for the build status
[02:35:40.872] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:40.873] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:105:0) after 1m0s
[02:36:40.971] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:105:0)
[02:36:40.971] Timer tick, asking Buildbucket for the build status
[02:36:41.305] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:41.305] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:106:0) after 1m0s
[02:37:41.298] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:106:0)
[02:37:41.298] Timer tick, asking Buildbucket for the build status
[02:37:41.626] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:41.626] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:107:0) after 1m0s
[02:38:41.653] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:107:0)
[02:38:41.653] Timer tick, asking Buildbucket for the build status
[02:38:43.033] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:43.033] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:108:0) after 1m0s
[02:39:43.093] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:108:0)
[02:39:43.093] Timer tick, asking Buildbucket for the build status
[02:39:43.257] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:43.257] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:109:0) after 1m0s
[02:40:43.288] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:109:0)
[02:40:43.288] Timer tick, asking Buildbucket for the build status
[02:40:43.449] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:43.449] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:110:0) after 1m0s
[02:41:43.490] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:110:0)
[02:41:43.490] Timer tick, asking Buildbucket for the build status
[02:41:43.639] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:43.639] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:111:0) after 1m0s
[02:42:43.679] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:111:0)
[02:42:43.679] Timer tick, asking Buildbucket for the build status
[02:42:43.872] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:43.872] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:112:0) after 1m0s
[02:43:43.865] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:112:0)
[02:43:43.865] Timer tick, asking Buildbucket for the build status
[02:43:44.095] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:44.095] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:113:0) after 1m0s
[02:44:44.158] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:113:0)
[02:44:44.158] Timer tick, asking Buildbucket for the build status
[02:44:44.413] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:44.413] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:114:0) after 1m0s
[02:45:44.416] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:114:0)
[02:45:44.416] Timer tick, asking Buildbucket for the build status
[02:45:44.535] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:44.535] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:115:0) after 1m0s
[02:46:44.729] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:115:0)
[02:46:44.729] Timer tick, asking Buildbucket for the build status
[02:46:44.857] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:44.857] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:116:0) after 1m0s
[02:47:44.985] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:116:0)
[02:47:44.985] Timer tick, asking Buildbucket for the build status
[02:47:45.246] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:45.246] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:117:0) after 1m0s
[02:48:45.343] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:117:0)
[02:48:45.343] Timer tick, asking Buildbucket for the build status
[02:48:45.543] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:45.543] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:118:0) after 1m0s
[02:49:45.604] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:118:0)
[02:49:45.604] Timer tick, asking Buildbucket for the build status
[02:49:45.826] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:45.827] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:119:0) after 1m0s
[02:50:45.906] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:119:0)
[02:50:45.906] Timer tick, asking Buildbucket for the build status
[02:50:46.076] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:46.077] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:120:0) after 1m0s
[02:51:46.307] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:120:0)
[02:51:46.307] Timer tick, asking Buildbucket for the build status
[02:51:46.554] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:46.554] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:121:0) after 1m0s
[02:52:46.775] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:121:0)
[02:52:46.775] Timer tick, asking Buildbucket for the build status
[02:52:46.903] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:46.903] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:122:0) after 1m0s
[02:53:46.961] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:122:0)
[02:53:46.961] Timer tick, asking Buildbucket for the build status
[02:53:47.213] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:47.213] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:123:0) after 1m0s
[02:54:47.297] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:123:0)
[02:54:47.297] Timer tick, asking Buildbucket for the build status
[02:54:47.710] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:47.710] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:124:0) after 1m0s
[02:55:47.826] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:124:0)
[02:55:47.826] Timer tick, asking Buildbucket for the build status
[02:55:47.994] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:47.994] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:125:0) after 1m0s
[02:56:48.031] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:125:0)
[02:56:48.031] Timer tick, asking Buildbucket for the build status
[02:56:48.215] Build 8896404255213355840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:48.215] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9061834318567268592:126:0) after 1m0s
[02:57:33.975] Received PubSub notification, asking Buildbucket for the build status
[02:57:34.079] Build 8896404255213355840: status "COMPLETED", result "CANCELED", failure_reason "", cancelation_reason "TIMEOUT"
[02:57:34.080] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"cancelation_reason": "TIMEOUT",
"completed_ts": "1574132252756666",
"created_by": "project:emscripten-releases",
"created_ts": "1574124775643516",
"id": "8896404255213355840",
"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\": \"ec3fb71a7c4c0ca7bdc4974f352eb71c497083a3\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@ec3fb71a7c4c0ca7bdc4974f352eb71c497083a3\", \"title\": \"ec3fb71a7c4c0ca7bdc4974f352eb71c497083a3\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/ec3fb71a7c4c0ca7bdc4974f352eb71c497083a3\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"ec3fb71a7c4c0ca7bdc4974f352eb71c497083a3\"}}",
"project": "emscripten-releases",
"result": "CANCELED",
"result_details_json": "{\"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"ec3fb71a7c4c0ca7bdc4974f352eb71c497083a3\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@ec3fb71a7c4c0ca7bdc4974f352eb71c497083a3\", \"title\": \"ec3fb71a7c4c0ca7bdc4974f352eb71c497083a3\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/ec3fb71a7c4c0ca7bdc4974f352eb71c497083a3\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-win10-0-8lr3\", \"branch\": \"refs/heads/master\", \"buildername\": \"win\", \"got_revision\": \"ec3fb71a7c4c0ca7bdc4974f352eb71c497083a3\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"ec3fb71a7c4c0ca7bdc4974f352eb71c497083a3\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_0175bca77590805533ed6e20351c9bfa7effd036e42d11a5b619a6ce75a8e486_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"host_class\": [\"default\"], \"id\": [\"luci-emscripten-releases-ci-win10-0-8lr3\"], \"image\": [\"chrome-win10-1703-19102400-d35fedf5a0d\"], \"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\": [\"4638-f6b223c\"], \"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": "1574124852378000",
"status": "COMPLETED",
"status_changed_ts": "1574132253296288",
"tags": [
"builder:win",
"buildset:commit/git/ec3fb71a7c4c0ca7bdc4974f352eb71c497083a3",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/ec3fb71a7c4c0ca7bdc4974f352eb71c497083a3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9061834318567268592",
"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/8896404255213355840/+/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:4899f7a2d4c72510",
"user_agent:luci-scheduler"
],
"updated_ts": "1574132253306982",
"url": "https://ci.chromium.org/b/8896404255213355840",
"utcnow_ts": "1574132254062768"
}
}
[02:57:34.080] Invocation finished in 2h4m41.018299419s with status FAILED