[19:42:40.201] New invocation is queued and will start shortly
[19:42:41.323] Starting the invocation (attempt 1)
[19:42:41.381] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:42:41.381] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:42:41.381] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9030779076122176160",
"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\":\"127b454ea7dc5b8d31cc94cd2a84acd81c411965\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@127b454ea7dc5b8d31cc94cd2a84acd81c411965\",\"title\":\"127b454ea7dc5b8d31cc94cd2a84acd81c411965\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/127b454ea7dc5b8d31cc94cd2a84acd81c411965\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"127b454ea7dc5b8d31cc94cd2a84acd81c411965\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win",
"scheduler_invocation_id:9030779076122176160",
"scheduler_job_id:emscripten-releases/win",
"user_agent:luci-scheduler",
"buildset:commit/git/127b454ea7dc5b8d31cc94cd2a84acd81c411965",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/127b454ea7dc5b8d31cc94cd2a84acd81c411965",
"gitiles_ref:refs/heads/master"
]
}
[19:42:41.816] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1603741361467022",
"id": "8865349014116562576",
"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\": \"127b454ea7dc5b8d31cc94cd2a84acd81c411965\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@127b454ea7dc5b8d31cc94cd2a84acd81c411965\", \"title\": \"127b454ea7dc5b8d31cc94cd2a84acd81c411965\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/127b454ea7dc5b8d31cc94cd2a84acd81c411965\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"127b454ea7dc5b8d31cc94cd2a84acd81c411965\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603741361689066",
"tags": [
"builder:win",
"buildset:commit/git/127b454ea7dc5b8d31cc94cd2a84acd81c411965",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/127b454ea7dc5b8d31cc94cd2a84acd81c411965",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030779076122176160",
"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/8865349014116562576/+/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": "1603741361689181",
"url": "https://ci.chromium.org/b/8865349014116562576",
"utcnow_ts": "1603741361807812"
}
}
[19:42:41.816] Task URL: https://ci.chromium.org/b/8865349014116562576
[19:42:41.816] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:2:0) after 1m0s
[19:43:41.840] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:2:0)
[19:43:41.840] Timer tick, asking Buildbucket for the build status
[19:43:42.005] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:43:42.005] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:3:0) after 1m0s
[19:44:42.068] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:3:0)
[19:44:42.068] Timer tick, asking Buildbucket for the build status
[19:44:42.157] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:44:42.157] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:4:0) after 1m0s
[19:45:42.193] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:4:0)
[19:45:42.193] Timer tick, asking Buildbucket for the build status
[19:45:42.338] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:45:42.338] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:5:0) after 1m0s
[19:46:42.385] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:5:0)
[19:46:42.386] Timer tick, asking Buildbucket for the build status
[19:46:42.527] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:46:42.528] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:6:0) after 1m0s
[19:47:42.552] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:6:0)
[19:47:42.552] Timer tick, asking Buildbucket for the build status
[19:47:42.687] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:47:42.687] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:7:0) after 1m0s
[19:48:42.719] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:7:0)
[19:48:42.719] Timer tick, asking Buildbucket for the build status
[19:48:42.909] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:48:42.909] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:8:0) after 1m0s
[19:49:42.942] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:8:0)
[19:49:42.942] Timer tick, asking Buildbucket for the build status
[19:49:43.216] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:49:43.216] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:9:0) after 1m0s
[19:50:43.258] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:9:0)
[19:50:43.258] Timer tick, asking Buildbucket for the build status
[19:50:43.485] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:50:43.485] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:10:0) after 1m0s
[19:51:43.504] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:10:0)
[19:51:43.504] Timer tick, asking Buildbucket for the build status
[19:51:43.687] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:51:43.687] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:11:0) after 1m0s
[19:52:43.760] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:11:0)
[19:52:43.760] Timer tick, asking Buildbucket for the build status
[19:52:43.975] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:52:43.975] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:12:0) after 1m0s
[19:53:43.995] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:12:0)
[19:53:43.995] Timer tick, asking Buildbucket for the build status
[19:53:44.095] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:53:44.095] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:13:0) after 1m0s
[19:54:44.181] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:13:0)
[19:54:44.181] Timer tick, asking Buildbucket for the build status
[19:54:44.272] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:54:44.272] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:14:0) after 1m0s
[19:55:44.321] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:14:0)
[19:55:44.321] Timer tick, asking Buildbucket for the build status
[19:55:44.401] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:55:44.401] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:15:0) after 1m0s
[19:56:44.426] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:15:0)
[19:56:44.427] Timer tick, asking Buildbucket for the build status
[19:56:44.571] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:56:44.571] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:16:0) after 1m0s
[19:57:44.670] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:16:0)
[19:57:44.670] Timer tick, asking Buildbucket for the build status
[19:57:45.199] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:57:45.199] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:17:0) after 1m0s
[19:58:45.237] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:17:0)
[19:58:45.237] Timer tick, asking Buildbucket for the build status
[19:58:45.387] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:58:45.387] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:18:0) after 1m0s
[19:59:45.435] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:18:0)
[19:59:45.435] Timer tick, asking Buildbucket for the build status
[19:59:45.586] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:59:45.586] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:19:0) after 1m0s
[20:00:45.613] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:19:0)
[20:00:45.613] Timer tick, asking Buildbucket for the build status
[20:00:45.889] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:00:45.889] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:20:0) after 1m0s
[20:01:45.921] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:20:0)
[20:01:45.921] Timer tick, asking Buildbucket for the build status
[20:01:46.084] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:01:46.084] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:21:0) after 1m0s
[20:02:46.233] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:21:0)
[20:02:46.233] Timer tick, asking Buildbucket for the build status
[20:02:47.297] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:02:47.297] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:22:0) after 1m0s
[20:03:47.311] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:22:0)
[20:03:47.311] Timer tick, asking Buildbucket for the build status
[20:03:47.409] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:03:47.409] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:23:0) after 1m0s
[20:04:47.439] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:23:0)
[20:04:47.439] Timer tick, asking Buildbucket for the build status
[20:04:47.537] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:04:47.537] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:24:0) after 1m0s
[20:05:47.562] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:24:0)
[20:05:47.562] Timer tick, asking Buildbucket for the build status
[20:05:47.817] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:05:47.817] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:25:0) after 1m0s
[20:06:47.882] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:25:0)
[20:06:47.882] Timer tick, asking Buildbucket for the build status
[20:06:47.974] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:06:47.974] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:26:0) after 1m0s
[20:07:48.082] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:26:0)
[20:07:48.082] Timer tick, asking Buildbucket for the build status
[20:07:48.212] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:07:48.212] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:27:0) after 1m0s
[20:08:48.248] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:27:0)
[20:08:48.248] Timer tick, asking Buildbucket for the build status
[20:08:48.478] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:08:48.478] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:28:0) after 1m0s
[20:09:48.541] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:28:0)
[20:09:48.541] Timer tick, asking Buildbucket for the build status
[20:09:48.636] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:09:48.636] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:29:0) after 1m0s
[20:10:48.677] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:29:0)
[20:10:48.677] Timer tick, asking Buildbucket for the build status
[20:10:48.769] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:10:48.769] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:30:0) after 1m0s
[20:11:48.877] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:30:0)
[20:11:48.877] Timer tick, asking Buildbucket for the build status
[20:11:49.284] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:11:49.284] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:31:0) after 1m0s
[20:12:49.384] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:31:0)
[20:12:49.384] Timer tick, asking Buildbucket for the build status
[20:12:49.808] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:12:49.808] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:32:0) after 1m0s
[20:13:49.885] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:32:0)
[20:13:49.885] Timer tick, asking Buildbucket for the build status
[20:13:49.973] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:13:49.973] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:33:0) after 1m0s
[20:14:50.054] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:33:0)
[20:14:50.054] Timer tick, asking Buildbucket for the build status
[20:14:50.151] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:14:50.151] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:34:0) after 1m0s
[20:15:50.257] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:34:0)
[20:15:50.257] Timer tick, asking Buildbucket for the build status
[20:15:50.370] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:15:50.370] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:35:0) after 1m0s
[20:16:50.555] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:35:0)
[20:16:50.555] Timer tick, asking Buildbucket for the build status
[20:16:50.648] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:16:50.648] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:36:0) after 1m0s
[20:17:50.708] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:36:0)
[20:17:50.708] Timer tick, asking Buildbucket for the build status
[20:17:50.954] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:17:50.954] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:37:0) after 1m0s
[20:18:51.119] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:37:0)
[20:18:51.119] Timer tick, asking Buildbucket for the build status
[20:18:51.206] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:18:51.206] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:38:0) after 1m0s
[20:19:51.257] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:38:0)
[20:19:51.257] Timer tick, asking Buildbucket for the build status
[20:19:51.334] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:19:51.334] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:39:0) after 1m0s
[20:20:51.405] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:39:0)
[20:20:51.405] Timer tick, asking Buildbucket for the build status
[20:20:51.501] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:20:51.501] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:40:0) after 1m0s
[20:21:51.556] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:40:0)
[20:21:51.556] Timer tick, asking Buildbucket for the build status
[20:21:52.037] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:21:52.037] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:41:0) after 1m0s
[20:22:52.214] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:41:0)
[20:22:52.214] Timer tick, asking Buildbucket for the build status
[20:22:52.344] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:22:52.344] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:42:0) after 1m0s
[20:23:52.408] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:42:0)
[20:23:52.408] Timer tick, asking Buildbucket for the build status
[20:23:52.515] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:23:52.515] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:43:0) after 1m0s
[20:24:52.604] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:43:0)
[20:24:52.604] Timer tick, asking Buildbucket for the build status
[20:24:52.687] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:24:52.687] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:44:0) after 1m0s
[20:25:52.768] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:44:0)
[20:25:52.768] Timer tick, asking Buildbucket for the build status
[20:25:52.953] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:25:52.953] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:45:0) after 1m0s
[20:26:53.006] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:45:0)
[20:26:53.006] Timer tick, asking Buildbucket for the build status
[20:26:53.107] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:26:53.107] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:46:0) after 1m0s
[20:27:53.218] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:46:0)
[20:27:53.218] Timer tick, asking Buildbucket for the build status
[20:27:53.410] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:27:53.410] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:47:0) after 1m0s
[20:28:53.461] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:47:0)
[20:28:53.461] Timer tick, asking Buildbucket for the build status
[20:28:53.553] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:28:53.553] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:48:0) after 1m0s
[20:29:53.603] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:48:0)
[20:29:53.603] Timer tick, asking Buildbucket for the build status
[20:29:53.723] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:29:53.723] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:49:0) after 1m0s
[20:30:53.799] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:49:0)
[20:30:53.799] Timer tick, asking Buildbucket for the build status
[20:30:54.094] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:30:54.094] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:50:0) after 1m0s
[20:31:54.137] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:50:0)
[20:31:54.137] Timer tick, asking Buildbucket for the build status
[20:31:54.515] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:31:54.515] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:51:0) after 1m0s
[20:32:54.671] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:51:0)
[20:32:54.671] Timer tick, asking Buildbucket for the build status
[20:32:54.784] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:32:54.784] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:52:0) after 1m0s
[20:33:54.875] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:52:0)
[20:33:54.875] Timer tick, asking Buildbucket for the build status
[20:33:55.342] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:33:55.342] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:53:0) after 1m0s
[20:34:55.351] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:53:0)
[20:34:55.351] Timer tick, asking Buildbucket for the build status
[20:34:55.604] Build 8865349014116562576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:34:55.604] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:54:0) after 1m0s
[20:35:24.300] Received PubSub notification, asking Buildbucket for the build status
[20:35:24.432] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:55.651] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:54:0)
[20:35:55.651] Timer tick, asking Buildbucket for the build status
[20:35:55.748] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:55.748] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:56:0) after 1m0s
[20:36:55.805] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:56:0)
[20:36:55.805] Timer tick, asking Buildbucket for the build status
[20:36:55.962] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:55.963] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:57:0) after 1m0s
[20:37:55.994] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:57:0)
[20:37:55.994] Timer tick, asking Buildbucket for the build status
[20:37:56.271] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:56.271] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:58:0) after 1m0s
[20:38:56.328] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:58:0)
[20:38:56.328] Timer tick, asking Buildbucket for the build status
[20:38:56.525] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:56.525] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:59:0) after 1m0s
[20:39:56.641] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:59:0)
[20:39:56.641] Timer tick, asking Buildbucket for the build status
[20:39:56.718] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:56.718] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:60:0) after 1m0s
[20:40:56.762] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:60:0)
[20:40:56.762] Timer tick, asking Buildbucket for the build status
[20:40:56.983] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:56.983] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:61:0) after 1m0s
[20:41:57.038] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:61:0)
[20:41:57.038] Timer tick, asking Buildbucket for the build status
[20:41:57.206] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:57.206] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:62:0) after 1m0s
[20:42:57.256] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:62:0)
[20:42:57.256] Timer tick, asking Buildbucket for the build status
[20:42:57.404] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:57.404] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:63:0) after 1m0s
[20:43:57.384] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:63:0)
[20:43:57.384] Timer tick, asking Buildbucket for the build status
[20:43:58.218] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:58.218] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:64:0) after 1m0s
[20:44:58.207] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:64:0)
[20:44:58.207] Timer tick, asking Buildbucket for the build status
[20:44:58.359] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:58.359] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:65:0) after 1m0s
[20:45:58.395] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:65:0)
[20:45:58.395] Timer tick, asking Buildbucket for the build status
[20:45:58.480] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:58.480] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:66:0) after 1m0s
[20:46:58.582] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:66:0)
[20:46:58.582] Timer tick, asking Buildbucket for the build status
[20:46:58.651] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:58.651] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:67:0) after 1m0s
[20:47:58.692] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:67:0)
[20:47:58.692] Timer tick, asking Buildbucket for the build status
[20:47:58.803] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:58.803] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:68:0) after 1m0s
[20:48:58.829] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:68:0)
[20:48:58.829] Timer tick, asking Buildbucket for the build status
[20:48:58.917] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:58.917] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:69:0) after 1m0s
[20:49:58.965] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:69:0)
[20:49:58.965] Timer tick, asking Buildbucket for the build status
[20:49:59.116] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:59.116] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:70:0) after 1m0s
[20:50:59.170] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:70:0)
[20:50:59.170] Timer tick, asking Buildbucket for the build status
[20:50:59.430] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:59.430] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:71:0) after 1m0s
[20:51:59.433] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:71:0)
[20:51:59.433] Timer tick, asking Buildbucket for the build status
[20:51:59.609] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:59.609] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:72:0) after 1m0s
[20:52:59.638] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:72:0)
[20:52:59.638] Timer tick, asking Buildbucket for the build status
[20:52:59.751] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:59.751] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:73:0) after 1m0s
[20:53:59.801] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:73:0)
[20:53:59.801] Timer tick, asking Buildbucket for the build status
[20:54:00.236] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:00.236] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:74:0) after 1m0s
[20:55:00.307] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:74:0)
[20:55:00.307] Timer tick, asking Buildbucket for the build status
[20:55:00.731] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:00.731] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:75:0) after 1m0s
[20:56:01.329] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:75:0)
[20:56:01.329] Timer tick, asking Buildbucket for the build status
[20:56:01.404] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:01.404] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:76:0) after 1m0s
[20:57:01.436] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:76:0)
[20:57:01.436] Timer tick, asking Buildbucket for the build status
[20:57:01.529] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:01.529] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:77:0) after 1m0s
[20:58:01.722] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:77:0)
[20:58:01.722] Timer tick, asking Buildbucket for the build status
[20:58:02.232] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:02.232] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:78:0) after 1m0s
[20:59:02.769] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:78:0)
[20:59:02.769] Timer tick, asking Buildbucket for the build status
[20:59:02.891] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:02.891] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:79:0) after 1m0s
[21:00:02.931] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:79:0)
[21:00:02.931] Timer tick, asking Buildbucket for the build status
[21:00:02.995] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:02.995] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:80:0) after 1m0s
[21:01:03.068] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:80:0)
[21:01:03.068] Timer tick, asking Buildbucket for the build status
[21:01:03.158] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:03.158] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:81:0) after 1m0s
[21:02:03.217] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:81:0)
[21:02:03.217] Timer tick, asking Buildbucket for the build status
[21:02:03.421] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:03.421] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:82:0) after 1m0s
[21:03:03.475] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:82:0)
[21:03:03.475] Timer tick, asking Buildbucket for the build status
[21:03:03.693] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:03.693] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:83:0) after 1m0s
[21:04:03.720] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:83:0)
[21:04:03.720] Timer tick, asking Buildbucket for the build status
[21:04:03.787] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:03.787] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:84:0) after 1m0s
[21:05:03.793] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:84:0)
[21:05:03.793] Timer tick, asking Buildbucket for the build status
[21:05:04.018] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:04.018] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:85:0) after 1m0s
[21:06:04.028] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:85:0)
[21:06:04.028] Timer tick, asking Buildbucket for the build status
[21:06:04.101] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:04.101] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:86:0) after 1m0s
[21:07:04.164] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:86:0)
[21:07:04.164] Timer tick, asking Buildbucket for the build status
[21:07:04.236] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:04.236] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:87:0) after 1m0s
[21:08:04.315] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:87:0)
[21:08:04.315] Timer tick, asking Buildbucket for the build status
[21:08:04.431] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:04.431] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:88:0) after 1m0s
[21:09:04.506] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:88:0)
[21:09:04.506] Timer tick, asking Buildbucket for the build status
[21:09:04.584] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:04.584] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:89:0) after 1m0s
[21:10:04.615] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:89:0)
[21:10:04.615] Timer tick, asking Buildbucket for the build status
[21:10:04.693] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:04.693] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:90:0) after 1m0s
[21:11:04.803] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:90:0)
[21:11:04.803] Timer tick, asking Buildbucket for the build status
[21:11:04.887] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:04.887] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:91:0) after 1m0s
[21:12:04.937] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:91:0)
[21:12:04.938] Timer tick, asking Buildbucket for the build status
[21:12:05.012] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:05.012] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:92:0) after 1m0s
[21:13:05.042] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:92:0)
[21:13:05.042] Timer tick, asking Buildbucket for the build status
[21:13:05.138] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:05.138] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:93:0) after 1m0s
[21:14:05.194] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:93:0)
[21:14:05.194] Timer tick, asking Buildbucket for the build status
[21:14:05.263] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:05.263] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:94:0) after 1m0s
[21:15:05.337] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:94:0)
[21:15:05.337] Timer tick, asking Buildbucket for the build status
[21:15:05.433] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:05.433] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:95:0) after 1m0s
[21:16:05.574] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:95:0)
[21:16:05.574] Timer tick, asking Buildbucket for the build status
[21:16:08.167] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:08.167] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:96:0) after 1m0s
[21:17:08.213] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:96:0)
[21:17:08.213] Timer tick, asking Buildbucket for the build status
[21:17:08.317] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:08.317] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:97:0) after 1m0s
[21:18:08.481] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:97:0)
[21:18:08.481] Timer tick, asking Buildbucket for the build status
[21:18:08.687] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:08.687] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:98:0) after 1m0s
[21:19:08.807] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:98:0)
[21:19:08.807] Timer tick, asking Buildbucket for the build status
[21:19:09.124] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:09.124] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:99:0) after 1m0s
[21:20:09.156] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:99:0)
[21:20:09.156] Timer tick, asking Buildbucket for the build status
[21:20:09.241] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:09.241] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:100:0) after 1m0s
[21:21:09.332] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:100:0)
[21:21:09.332] Timer tick, asking Buildbucket for the build status
[21:21:09.430] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:09.430] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:101:0) after 1m0s
[21:22:09.458] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:101:0)
[21:22:09.458] Timer tick, asking Buildbucket for the build status
[21:22:10.720] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:10.720] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:102:0) after 1m0s
[21:23:10.951] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:102:0)
[21:23:10.951] Timer tick, asking Buildbucket for the build status
[21:23:11.077] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:11.077] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:103:0) after 1m0s
[21:24:11.197] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:103:0)
[21:24:11.197] Timer tick, asking Buildbucket for the build status
[21:24:11.271] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:11.271] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:104:0) after 1m0s
[21:25:11.371] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:104:0)
[21:25:11.371] Timer tick, asking Buildbucket for the build status
[21:25:11.596] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:11.596] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:105:0) after 1m0s
[21:26:11.835] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:105:0)
[21:26:11.835] Timer tick, asking Buildbucket for the build status
[21:26:12.206] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:12.206] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:106:0) after 1m0s
[21:27:12.208] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:106:0)
[21:27:12.208] Timer tick, asking Buildbucket for the build status
[21:27:12.279] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:12.279] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:107:0) after 1m0s
[21:28:12.302] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:107:0)
[21:28:12.302] Timer tick, asking Buildbucket for the build status
[21:28:12.463] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:12.463] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:108:0) after 1m0s
[21:29:12.539] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:108:0)
[21:29:12.539] Timer tick, asking Buildbucket for the build status
[21:29:12.631] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:12.631] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:109:0) after 1m0s
[21:30:12.613] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:109:0)
[21:30:12.613] Timer tick, asking Buildbucket for the build status
[21:30:12.992] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:12.992] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:110:0) after 1m0s
[21:31:12.996] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:110:0)
[21:31:12.996] Timer tick, asking Buildbucket for the build status
[21:31:13.279] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:13.279] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:111:0) after 1m0s
[21:32:13.337] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:111:0)
[21:32:13.337] Timer tick, asking Buildbucket for the build status
[21:32:13.407] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:13.407] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:112:0) after 1m0s
[21:33:13.492] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:112:0)
[21:33:13.492] Timer tick, asking Buildbucket for the build status
[21:33:13.623] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:13.623] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:113:0) after 1m0s
[21:34:13.688] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:113:0)
[21:34:13.688] Timer tick, asking Buildbucket for the build status
[21:34:13.838] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:13.838] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:114:0) after 1m0s
[21:35:13.954] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:114:0)
[21:35:13.954] Timer tick, asking Buildbucket for the build status
[21:35:14.018] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:14.018] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:115:0) after 1m0s
[21:36:14.099] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:115:0)
[21:36:14.099] Timer tick, asking Buildbucket for the build status
[21:36:14.173] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:14.173] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:116:0) after 1m0s
[21:37:14.247] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:116:0)
[21:37:14.247] Timer tick, asking Buildbucket for the build status
[21:37:14.325] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:14.325] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:117:0) after 1m0s
[21:38:14.398] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:117:0)
[21:38:14.398] Timer tick, asking Buildbucket for the build status
[21:38:14.547] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:14.547] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:118:0) after 1m0s
[21:39:14.627] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:118:0)
[21:39:14.627] Timer tick, asking Buildbucket for the build status
[21:39:14.697] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:14.698] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:119:0) after 1m0s
[21:40:14.703] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:119:0)
[21:40:14.703] Timer tick, asking Buildbucket for the build status
[21:40:14.980] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:14.980] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:120:0) after 1m0s
[21:41:15.038] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:120:0)
[21:41:15.038] Timer tick, asking Buildbucket for the build status
[21:41:15.104] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:15.104] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:121:0) after 1m0s
[21:42:15.184] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:121:0)
[21:42:15.184] Timer tick, asking Buildbucket for the build status
[21:42:15.484] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:15.484] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:122:0) after 1m0s
[21:43:15.528] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:122:0)
[21:43:15.528] Timer tick, asking Buildbucket for the build status
[21:43:15.682] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:15.682] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:123:0) after 1m0s
[21:44:15.761] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:123:0)
[21:44:15.761] Timer tick, asking Buildbucket for the build status
[21:44:15.843] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:15.843] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:124:0) after 1m0s
[21:45:15.855] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:124:0)
[21:45:15.855] Timer tick, asking Buildbucket for the build status
[21:45:16.347] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:16.347] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:125:0) after 1m0s
[21:46:16.425] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:125:0)
[21:46:16.426] Timer tick, asking Buildbucket for the build status
[21:46:16.586] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:16.586] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:126:0) after 1m0s
[21:47:16.659] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:126:0)
[21:47:16.659] Timer tick, asking Buildbucket for the build status
[21:47:16.981] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:16.981] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:127:0) after 1m0s
[21:48:17.008] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:127:0)
[21:48:17.008] Timer tick, asking Buildbucket for the build status
[21:48:17.184] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:17.184] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:128:0) after 1m0s
[21:49:17.202] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:128:0)
[21:49:17.202] Timer tick, asking Buildbucket for the build status
[21:49:17.269] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:17.269] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:129:0) after 1m0s
[21:50:17.307] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:129:0)
[21:50:17.307] Timer tick, asking Buildbucket for the build status
[21:50:17.412] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:17.412] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:130:0) after 1m0s
[21:51:17.498] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:130:0)
[21:51:17.498] Timer tick, asking Buildbucket for the build status
[21:51:17.616] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:17.616] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:131:0) after 1m0s
[21:52:17.687] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:131:0)
[21:52:17.687] Timer tick, asking Buildbucket for the build status
[21:52:17.769] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:17.769] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:132:0) after 1m0s
[21:53:17.866] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:132:0)
[21:53:17.866] Timer tick, asking Buildbucket for the build status
[21:53:18.010] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:18.010] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:133:0) after 1m0s
[21:54:18.072] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:133:0)
[21:54:18.072] Timer tick, asking Buildbucket for the build status
[21:54:18.411] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:18.411] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:134:0) after 1m0s
[21:55:18.422] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:134:0)
[21:55:18.422] Timer tick, asking Buildbucket for the build status
[21:55:18.918] Build 8865349014116562576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:18.918] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9030779076122176160:135:0) after 1m0s
[21:55:35.175] Received PubSub notification, asking Buildbucket for the build status
[21:55:35.315] Build 8865349014116562576: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:55:35.315] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"completed_ts": "1603749334247032",
"created_by": "project:emscripten-releases",
"created_ts": "1603741361467022",
"id": "8865349014116562576",
"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\": \"127b454ea7dc5b8d31cc94cd2a84acd81c411965\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@127b454ea7dc5b8d31cc94cd2a84acd81c411965\", \"title\": \"127b454ea7dc5b8d31cc94cd2a84acd81c411965\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/127b454ea7dc5b8d31cc94cd2a84acd81c411965\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"127b454ea7dc5b8d31cc94cd2a84acd81c411965\"}}",
"project": "emscripten-releases",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"127b454ea7dc5b8d31cc94cd2a84acd81c411965\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@127b454ea7dc5b8d31cc94cd2a84acd81c411965\", \"title\": \"127b454ea7dc5b8d31cc94cd2a84acd81c411965\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/127b454ea7dc5b8d31cc94cd2a84acd81c411965\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-win10-0-qcyt\", \"branch\": \"refs/heads/master\", \"buildername\": \"win\", \"got_revision\": \"127b454ea7dc5b8d31cc94cd2a84acd81c411965\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"127b454ea7dc5b8d31cc94cd2a84acd81c411965\"}, \"swarming\": {\"bot_dimensions\": {\"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"host_class\": [\"default\"], \"id\": [\"luci-emscripten-releases-ci-win10-0-qcyt\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"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\": [\"5612-26d29a7\"], \"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": "1603744522985324",
"status": "COMPLETED",
"status_changed_ts": "1603749334793273",
"tags": [
"builder:win",
"buildset:commit/git/127b454ea7dc5b8d31cc94cd2a84acd81c411965",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/127b454ea7dc5b8d31cc94cd2a84acd81c411965",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030779076122176160",
"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/8865349014116562576/+/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:4f7f40b175702510",
"user_agent:luci-scheduler"
],
"updated_ts": "1603749334881471",
"url": "https://ci.chromium.org/b/8865349014116562576",
"utcnow_ts": "1603749335308019"
}
}
[21:55:35.315] Invocation finished in 2h12m55.144247845s with status SUCCEEDED