[01:19:43.473] New invocation is queued and will start shortly
[01:19:45.591] Starting the invocation (attempt 1)
[01:19:45.687] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:19:45.688] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:19:45.688] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9065275314670386240",
"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\":\"2861eca560bbbd96e6c929fe334d155b5b416bcf\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@2861eca560bbbd96e6c929fe334d155b5b416bcf\",\"title\":\"2861eca560bbbd96e6c929fe334d155b5b416bcf\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/2861eca560bbbd96e6c929fe334d155b5b416bcf\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"2861eca560bbbd96e6c929fe334d155b5b416bcf\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win",
"scheduler_invocation_id:9065275314670386240",
"scheduler_job_id:emscripten-releases/win",
"user_agent:luci-scheduler",
"buildset:commit/git/2861eca560bbbd96e6c929fe334d155b5b416bcf",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/2861eca560bbbd96e6c929fe334d155b5b416bcf",
"gitiles_ref:refs/heads/master"
]
}
[01:19:46.818] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1570843185846282",
"id": "8899845251516233808",
"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\": \"2861eca560bbbd96e6c929fe334d155b5b416bcf\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@2861eca560bbbd96e6c929fe334d155b5b416bcf\", \"title\": \"2861eca560bbbd96e6c929fe334d155b5b416bcf\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/2861eca560bbbd96e6c929fe334d155b5b416bcf\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"2861eca560bbbd96e6c929fe334d155b5b416bcf\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1570843186388178",
"tags": [
"builder:win",
"buildset:commit/git/2861eca560bbbd96e6c929fe334d155b5b416bcf",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/2861eca560bbbd96e6c929fe334d155b5b416bcf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9065275314670386240",
"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/8899845251516233808/+/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": "1570843186388303",
"url": "https://ci.chromium.org/b/8899845251516233808",
"utcnow_ts": "1570843186778464"
}
}
[01:19:46.818] Task URL: https://ci.chromium.org/b/8899845251516233808
[01:19:46.818] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:2:0) after 1m0s
[01:20:46.951] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:2:0)
[01:20:46.951] Timer tick, asking Buildbucket for the build status
[01:20:47.171] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:20:47.171] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:3:0) after 1m0s
[01:21:47.263] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:3:0)
[01:21:47.263] Timer tick, asking Buildbucket for the build status
[01:21:47.967] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:21:47.967] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:4:0) after 1m0s
[01:22:48.078] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:4:0)
[01:22:48.078] Timer tick, asking Buildbucket for the build status
[01:22:49.273] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:22:49.273] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:5:0) after 1m0s
[01:23:49.374] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:5:0)
[01:23:49.374] Timer tick, asking Buildbucket for the build status
[01:23:49.687] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:23:49.687] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:6:0) after 1m0s
[01:24:49.801] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:6:0)
[01:24:49.801] Timer tick, asking Buildbucket for the build status
[01:24:50.563] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:24:50.563] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:7:0) after 1m0s
[01:25:50.695] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:7:0)
[01:25:50.695] Timer tick, asking Buildbucket for the build status
[01:25:51.984] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:25:51.984] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:8:0) after 1m0s
[01:26:52.008] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:8:0)
[01:26:52.008] Timer tick, asking Buildbucket for the build status
[01:26:58.844] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:26:58.844] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:9:0) after 1m0s
[01:27:58.866] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:9:0)
[01:27:58.866] Timer tick, asking Buildbucket for the build status
[01:27:59.161] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:27:59.161] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:10:0) after 1m0s
[01:28:59.266] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:10:0)
[01:28:59.266] Timer tick, asking Buildbucket for the build status
[01:28:59.566] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:28:59.566] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:11:0) after 1m0s
[01:29:59.601] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:11:0)
[01:29:59.601] Timer tick, asking Buildbucket for the build status
[01:29:59.781] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:29:59.781] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:12:0) after 1m0s
[01:30:59.894] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:12:0)
[01:30:59.895] Timer tick, asking Buildbucket for the build status
[01:31:00.053] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:31:00.053] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:13:0) after 1m0s
[01:32:00.081] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:13:0)
[01:32:00.081] Timer tick, asking Buildbucket for the build status
[01:32:06.743] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:32:06.743] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:14:0) after 1m0s
[01:33:07.061] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:14:0)
[01:33:07.061] Timer tick, asking Buildbucket for the build status
[01:33:09.495] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:33:09.495] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:15:0) after 1m0s
[01:34:09.561] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:15:0)
[01:34:09.561] Timer tick, asking Buildbucket for the build status
[01:34:09.719] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:34:09.719] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:16:0) after 1m0s
[01:35:09.873] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:16:0)
[01:35:09.873] Timer tick, asking Buildbucket for the build status
[01:35:10.081] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:35:10.081] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:17:0) after 1m0s
[01:36:10.365] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:17:0)
[01:36:10.365] Timer tick, asking Buildbucket for the build status
[01:36:10.928] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:36:10.928] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:18:0) after 1m0s
[01:37:10.975] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:18:0)
[01:37:10.975] Timer tick, asking Buildbucket for the build status
[01:37:11.378] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:37:11.378] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:19:0) after 1m0s
[01:38:11.448] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:19:0)
[01:38:11.448] Timer tick, asking Buildbucket for the build status
[01:38:11.560] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:38:11.560] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:20:0) after 1m0s
[01:39:11.645] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:20:0)
[01:39:11.645] Timer tick, asking Buildbucket for the build status
[01:39:12.681] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:39:12.681] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:21:0) after 1m0s
[01:40:12.771] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:21:0)
[01:40:12.771] Timer tick, asking Buildbucket for the build status
[01:40:12.945] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:40:12.945] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:22:0) after 1m0s
[01:41:13.017] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:22:0)
[01:41:13.017] Timer tick, asking Buildbucket for the build status
[01:41:13.229] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:41:13.229] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:23:0) after 1m0s
[01:42:13.318] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:23:0)
[01:42:13.318] Timer tick, asking Buildbucket for the build status
[01:42:14.107] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:42:14.107] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:24:0) after 1m0s
[01:43:14.159] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:24:0)
[01:43:14.159] Timer tick, asking Buildbucket for the build status
[01:43:18.540] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:43:18.540] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:25:0) after 1m0s
[01:44:18.623] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:25:0)
[01:44:18.623] Timer tick, asking Buildbucket for the build status
[01:44:19.019] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:44:19.019] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:26:0) after 1m0s
[01:45:19.201] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:26:0)
[01:45:19.201] Timer tick, asking Buildbucket for the build status
[01:45:19.362] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:45:19.362] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:27:0) after 1m0s
[01:46:19.545] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:27:0)
[01:46:19.545] Timer tick, asking Buildbucket for the build status
[01:46:19.694] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:46:19.694] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:28:0) after 1m0s
[01:47:19.780] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:28:0)
[01:47:19.780] Timer tick, asking Buildbucket for the build status
[01:47:19.952] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:47:19.952] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:29:0) after 1m0s
[01:48:20.055] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:29:0)
[01:48:20.055] Timer tick, asking Buildbucket for the build status
[01:48:20.387] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:48:20.387] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:30:0) after 1m0s
[01:49:20.442] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:30:0)
[01:49:20.442] Timer tick, asking Buildbucket for the build status
[01:49:21.064] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:49:21.064] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:31:0) after 1m0s
[01:50:21.091] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:31:0)
[01:50:21.091] Timer tick, asking Buildbucket for the build status
[01:50:22.122] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:50:22.122] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:32:0) after 1m0s
[01:51:22.170] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:32:0)
[01:51:22.170] Timer tick, asking Buildbucket for the build status
[01:51:22.395] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:51:22.395] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:33:0) after 1m0s
[01:52:22.410] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:33:0)
[01:52:22.410] Timer tick, asking Buildbucket for the build status
[01:52:22.662] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:52:22.662] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:34:0) after 1m0s
[01:53:22.720] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:34:0)
[01:53:22.720] Timer tick, asking Buildbucket for the build status
[01:53:22.906] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:53:22.906] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:35:0) after 1m0s
[01:54:22.951] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:35:0)
[01:54:22.951] Timer tick, asking Buildbucket for the build status
[01:54:23.418] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:54:23.418] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:36:0) after 1m0s
[01:55:23.475] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:36:0)
[01:55:23.475] Timer tick, asking Buildbucket for the build status
[01:55:23.817] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:55:23.817] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:37:0) after 1m0s
[01:56:23.879] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:37:0)
[01:56:23.879] Timer tick, asking Buildbucket for the build status
[01:56:24.186] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:56:24.186] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:38:0) after 1m0s
[01:57:24.227] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:38:0)
[01:57:24.227] Timer tick, asking Buildbucket for the build status
[01:57:24.620] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:57:24.620] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:39:0) after 1m0s
[01:58:24.649] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:39:0)
[01:58:24.649] Timer tick, asking Buildbucket for the build status
[01:58:24.763] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:58:24.763] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:40:0) after 1m0s
[01:59:24.788] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:40:0)
[01:59:24.788] Timer tick, asking Buildbucket for the build status
[01:59:25.752] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:59:25.752] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:41:0) after 1m0s
[02:00:25.808] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:41:0)
[02:00:25.808] Timer tick, asking Buildbucket for the build status
[02:00:26.298] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:00:26.298] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:42:0) after 1m0s
[02:01:26.324] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:42:0)
[02:01:26.324] Timer tick, asking Buildbucket for the build status
[02:01:26.745] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:01:26.745] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:43:0) after 1m0s
[02:02:26.950] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:43:0)
[02:02:26.950] Timer tick, asking Buildbucket for the build status
[02:02:27.078] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:02:27.078] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:44:0) after 1m0s
[02:03:27.188] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:44:0)
[02:03:27.188] Timer tick, asking Buildbucket for the build status
[02:03:27.302] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:03:27.302] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:45:0) after 1m0s
[02:04:27.387] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:45:0)
[02:04:27.387] Timer tick, asking Buildbucket for the build status
[02:04:27.667] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:04:27.667] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:46:0) after 1m0s
[02:05:27.695] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:46:0)
[02:05:27.695] Timer tick, asking Buildbucket for the build status
[02:05:27.955] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:05:27.955] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:47:0) after 1m0s
[02:06:28.024] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:47:0)
[02:06:28.024] Timer tick, asking Buildbucket for the build status
[02:06:28.185] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:06:28.185] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:48:0) after 1m0s
[02:07:28.194] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:48:0)
[02:07:28.194] Timer tick, asking Buildbucket for the build status
[02:07:28.538] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:07:28.538] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:49:0) after 1m0s
[02:08:28.613] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:49:0)
[02:08:28.613] Timer tick, asking Buildbucket for the build status
[02:08:28.757] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:08:28.757] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:50:0) after 1m0s
[02:09:28.910] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:50:0)
[02:09:28.910] Timer tick, asking Buildbucket for the build status
[02:09:29.162] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:09:29.162] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:51:0) after 1m0s
[02:10:29.221] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:51:0)
[02:10:29.221] Timer tick, asking Buildbucket for the build status
[02:10:29.818] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:10:29.818] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:52:0) after 1m0s
[02:11:29.906] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:52:0)
[02:11:29.906] Timer tick, asking Buildbucket for the build status
[02:11:30.245] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:11:30.245] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:53:0) after 1m0s
[02:12:30.360] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:53:0)
[02:12:30.360] Timer tick, asking Buildbucket for the build status
[02:12:31.449] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:12:31.449] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:54:0) after 1m0s
[02:13:31.481] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:54:0)
[02:13:31.481] Timer tick, asking Buildbucket for the build status
[02:13:31.614] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:13:31.614] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:55:0) after 1m0s
[02:14:31.629] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:55:0)
[02:14:31.629] Timer tick, asking Buildbucket for the build status
[02:14:31.752] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:14:31.752] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:56:0) after 1m0s
[02:15:31.783] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:56:0)
[02:15:31.783] Timer tick, asking Buildbucket for the build status
[02:15:32.256] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:15:32.256] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:57:0) after 1m0s
[02:16:32.371] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:57:0)
[02:16:32.372] Timer tick, asking Buildbucket for the build status
[02:16:32.572] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:16:32.572] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:58:0) after 1m0s
[02:17:32.602] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:58:0)
[02:17:32.602] Timer tick, asking Buildbucket for the build status
[02:17:33.146] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:17:33.146] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:59:0) after 1m0s
[02:18:33.189] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:59:0)
[02:18:33.189] Timer tick, asking Buildbucket for the build status
[02:18:33.309] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:18:33.309] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:60:0) after 1m0s
[02:19:33.392] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:60:0)
[02:19:33.392] Timer tick, asking Buildbucket for the build status
[02:19:34.336] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:19:34.336] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:61:0) after 1m0s
[02:20:34.376] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:61:0)
[02:20:34.376] Timer tick, asking Buildbucket for the build status
[02:20:34.666] Build 8899845251516233808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:20:34.666] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:62:0) after 1m0s
[02:21:26.294] Received PubSub notification, asking Buildbucket for the build status
[02:21:26.403] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:34.698] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:62:0)
[02:21:34.698] Timer tick, asking Buildbucket for the build status
[02:21:35.395] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:35.395] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:64:0) after 1m0s
[02:22:35.451] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:64:0)
[02:22:35.451] Timer tick, asking Buildbucket for the build status
[02:22:35.641] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:35.641] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:65:0) after 1m0s
[02:23:35.660] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:65:0)
[02:23:35.660] Timer tick, asking Buildbucket for the build status
[02:23:35.804] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:35.804] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:66:0) after 1m0s
[02:24:35.938] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:66:0)
[02:24:35.938] Timer tick, asking Buildbucket for the build status
[02:24:36.326] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:36.326] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:67:0) after 1m0s
[02:25:36.402] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:67:0)
[02:25:36.402] Timer tick, asking Buildbucket for the build status
[02:25:36.978] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:36.978] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:68:0) after 1m0s
[02:26:37.043] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:68:0)
[02:26:37.043] Timer tick, asking Buildbucket for the build status
[02:26:37.300] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:37.300] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:69:0) after 1m0s
[02:27:37.352] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:69:0)
[02:27:37.352] Timer tick, asking Buildbucket for the build status
[02:27:37.614] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:37.614] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:70:0) after 1m0s
[02:28:37.617] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:70:0)
[02:28:37.617] Timer tick, asking Buildbucket for the build status
[02:28:37.816] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:37.816] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:71:0) after 1m0s
[02:29:37.844] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:71:0)
[02:29:37.844] Timer tick, asking Buildbucket for the build status
[02:29:38.058] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:38.058] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:72:0) after 1m0s
[02:30:38.140] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:72:0)
[02:30:38.140] Timer tick, asking Buildbucket for the build status
[02:30:38.988] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:38.988] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:73:0) after 1m0s
[02:31:39.046] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:73:0)
[02:31:39.046] Timer tick, asking Buildbucket for the build status
[02:31:39.435] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:39.435] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:74:0) after 1m0s
[02:32:39.491] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:74:0)
[02:32:39.491] Timer tick, asking Buildbucket for the build status
[02:32:39.662] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:39.662] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:75:0) after 1m0s
[02:33:39.757] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:75:0)
[02:33:39.757] Timer tick, asking Buildbucket for the build status
[02:33:39.897] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:39.897] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:76:0) after 1m0s
[02:34:40.027] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:76:0)
[02:34:40.027] Timer tick, asking Buildbucket for the build status
[02:34:40.321] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:40.322] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:77:0) after 1m0s
[02:35:40.473] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:77:0)
[02:35:40.473] Timer tick, asking Buildbucket for the build status
[02:35:40.732] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:40.732] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:78:0) after 1m0s
[02:36:40.759] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:78:0)
[02:36:40.759] Timer tick, asking Buildbucket for the build status
[02:36:41.072] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:41.072] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:79:0) after 1m0s
[02:37:41.140] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:79:0)
[02:37:41.140] Timer tick, asking Buildbucket for the build status
[02:37:41.692] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:41.692] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:80:0) after 1m0s
[02:38:41.767] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:80:0)
[02:38:41.767] Timer tick, asking Buildbucket for the build status
[02:38:42.266] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:42.266] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:81:0) after 1m0s
[02:39:42.354] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:81:0)
[02:39:42.354] Timer tick, asking Buildbucket for the build status
[02:39:42.556] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:42.556] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:82:0) after 1m0s
[02:40:42.662] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:82:0)
[02:40:42.662] Timer tick, asking Buildbucket for the build status
[02:40:42.933] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:42.933] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:83:0) after 1m0s
[02:41:43.103] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:83:0)
[02:41:43.103] Timer tick, asking Buildbucket for the build status
[02:41:43.480] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:43.480] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:84:0) after 1m0s
[02:42:43.503] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:84:0)
[02:42:43.503] Timer tick, asking Buildbucket for the build status
[02:42:43.864] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:43.864] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:85:0) after 1m0s
[02:43:43.919] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:85:0)
[02:43:43.919] Timer tick, asking Buildbucket for the build status
[02:43:44.256] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:44.256] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:86:0) after 1m0s
[02:44:44.244] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:86:0)
[02:44:44.244] Timer tick, asking Buildbucket for the build status
[02:44:44.521] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:44.521] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:87:0) after 1m0s
[02:45:44.556] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:87:0)
[02:45:44.556] Timer tick, asking Buildbucket for the build status
[02:45:44.799] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:44.799] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:88:0) after 1m0s
[02:46:44.896] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:88:0)
[02:46:44.896] Timer tick, asking Buildbucket for the build status
[02:46:45.206] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:45.206] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:89:0) after 1m0s
[02:47:45.298] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:89:0)
[02:47:45.298] Timer tick, asking Buildbucket for the build status
[02:47:45.458] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:45.458] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:90:0) after 1m0s
[02:48:45.458] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:90:0)
[02:48:45.458] Timer tick, asking Buildbucket for the build status
[02:48:46.159] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:46.159] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:91:0) after 1m0s
[02:49:46.223] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:91:0)
[02:49:46.223] Timer tick, asking Buildbucket for the build status
[02:49:46.406] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:46.406] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:92:0) after 1m0s
[02:50:46.449] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:92:0)
[02:50:46.449] Timer tick, asking Buildbucket for the build status
[02:50:47.021] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:47.021] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:93:0) after 1m0s
[02:51:47.067] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:93:0)
[02:51:47.068] Timer tick, asking Buildbucket for the build status
[02:51:47.232] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:47.232] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:94:0) after 1m0s
[02:52:47.374] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:94:0)
[02:52:47.374] Timer tick, asking Buildbucket for the build status
[02:52:47.551] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:47.551] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:95:0) after 1m0s
[02:53:47.649] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:95:0)
[02:53:47.650] Timer tick, asking Buildbucket for the build status
[02:53:48.028] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:48.028] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:96:0) after 1m0s
[02:54:48.176] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:96:0)
[02:54:48.176] Timer tick, asking Buildbucket for the build status
[02:54:48.323] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:48.323] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:97:0) after 1m0s
[02:55:48.546] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:97:0)
[02:55:48.546] Timer tick, asking Buildbucket for the build status
[02:55:48.698] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:48.698] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:98:0) after 1m0s
[02:56:49.175] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:98:0)
[02:56:49.175] Timer tick, asking Buildbucket for the build status
[02:56:49.515] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:49.515] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:99:0) after 1m0s
[02:57:49.802] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:99:0)
[02:57:49.802] Timer tick, asking Buildbucket for the build status
[02:57:50.610] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:50.610] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:100:0) after 1m0s
[02:58:50.946] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:100:0)
[02:58:50.946] Timer tick, asking Buildbucket for the build status
[02:58:51.386] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:51.387] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:101:0) after 1m0s
[02:59:51.464] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:101:0)
[02:59:51.464] Timer tick, asking Buildbucket for the build status
[02:59:51.888] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:51.888] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:102:0) after 1m0s
[03:00:51.912] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:102:0)
[03:00:51.912] Timer tick, asking Buildbucket for the build status
[03:00:53.346] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:53.346] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:103:0) after 1m0s
[03:01:53.455] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:103:0)
[03:01:53.455] Timer tick, asking Buildbucket for the build status
[03:01:53.786] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:53.786] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:104:0) after 1m0s
[03:02:53.835] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:104:0)
[03:02:53.835] Timer tick, asking Buildbucket for the build status
[03:02:54.744] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:54.744] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:105:0) after 1m0s
[03:03:54.849] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:105:0)
[03:03:54.849] Timer tick, asking Buildbucket for the build status
[03:03:55.019] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:55.019] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:106:0) after 1m0s
[03:04:55.100] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:106:0)
[03:04:55.100] Timer tick, asking Buildbucket for the build status
[03:04:55.283] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:55.283] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:107:0) after 1m0s
[03:05:55.360] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:107:0)
[03:05:55.360] Timer tick, asking Buildbucket for the build status
[03:05:55.781] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:55.781] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:108:0) after 1m0s
[03:06:55.844] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:108:0)
[03:06:55.844] Timer tick, asking Buildbucket for the build status
[03:06:56.234] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:56.235] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:109:0) after 1m0s
[03:07:56.332] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:109:0)
[03:07:56.332] Timer tick, asking Buildbucket for the build status
[03:07:57.003] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:57.003] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:110:0) after 1m0s
[03:08:57.122] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:110:0)
[03:08:57.122] Timer tick, asking Buildbucket for the build status
[03:08:57.334] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:57.334] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:111:0) after 1m0s
[03:09:57.337] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:111:0)
[03:09:57.337] Timer tick, asking Buildbucket for the build status
[03:09:57.713] Build 8899845251516233808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:57.713] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9065275314670386240:112:0) after 1m0s
[03:10:49.345] Received PubSub notification, asking Buildbucket for the build status
[03:10:49.541] Build 8899845251516233808: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:10:49.541] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"completed_ts": "1570849848614393",
"created_by": "project:emscripten-releases",
"created_ts": "1570843185846282",
"id": "8899845251516233808",
"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\": \"2861eca560bbbd96e6c929fe334d155b5b416bcf\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@2861eca560bbbd96e6c929fe334d155b5b416bcf\", \"title\": \"2861eca560bbbd96e6c929fe334d155b5b416bcf\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/2861eca560bbbd96e6c929fe334d155b5b416bcf\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"2861eca560bbbd96e6c929fe334d155b5b416bcf\"}}",
"project": "emscripten-releases",
"result": "SUCCESS",
"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\": \"2861eca560bbbd96e6c929fe334d155b5b416bcf\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@2861eca560bbbd96e6c929fe334d155b5b416bcf\", \"title\": \"2861eca560bbbd96e6c929fe334d155b5b416bcf\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/2861eca560bbbd96e6c929fe334d155b5b416bcf\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-win10-0-7kl5\", \"branch\": \"refs/heads/master\", \"buildername\": \"win\", \"got_revision\": \"2861eca560bbbd96e6c929fe334d155b5b416bcf\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"2861eca560bbbd96e6c929fe334d155b5b416bcf\"}, \"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-7kl5\"], \"image\": [\"chrome-win10-1703-19091300-a244b1e46d2\"], \"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\": [\"4501-487d554\"], \"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": "1570846883828318",
"status": "COMPLETED",
"status_changed_ts": "1570849848999784",
"tags": [
"builder:win",
"buildset:commit/git/2861eca560bbbd96e6c929fe334d155b5b416bcf",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/2861eca560bbbd96e6c929fe334d155b5b416bcf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9065275314670386240",
"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/8899845251516233808/+/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:47d65e9d1d7db710",
"user_agent:luci-scheduler"
],
"updated_ts": "1570849849026067",
"url": "https://ci.chromium.org/b/8899845251516233808",
"utcnow_ts": "1570849849520021"
}
}
[03:10:49.541] Invocation finished in 1h51m6.085562328s with status SUCCEEDED