[14:32:31.490] New invocation is queued and will start shortly
[14:32:32.880] Starting the invocation (attempt 1)
[14:32:32.931] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:32:32.931] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:32:32.932] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9050367533496856096",
"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\":\"a6aec66d8d022da0cea5c1860a6bbbc0bf8f6c63\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@a6aec66d8d022da0cea5c1860a6bbbc0bf8f6c63\",\"title\":\"a6aec66d8d022da0cea5c1860a6bbbc0bf8f6c63\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/a6aec66d8d022da0cea5c1860a6bbbc0bf8f6c63\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"a6aec66d8d022da0cea5c1860a6bbbc0bf8f6c63\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win",
"scheduler_invocation_id:9050367533496856096",
"scheduler_job_id:emscripten-releases/win",
"user_agent:luci-scheduler",
"buildset:commit/git/a6aec66d8d022da0cea5c1860a6bbbc0bf8f6c63",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/a6aec66d8d022da0cea5c1860a6bbbc0bf8f6c63",
"gitiles_ref:refs/heads/master"
]
}
[14:32:33.781] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1585060353139065",
"id": "8884937471105028528",
"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\": \"a6aec66d8d022da0cea5c1860a6bbbc0bf8f6c63\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@a6aec66d8d022da0cea5c1860a6bbbc0bf8f6c63\", \"title\": \"a6aec66d8d022da0cea5c1860a6bbbc0bf8f6c63\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/a6aec66d8d022da0cea5c1860a6bbbc0bf8f6c63\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"a6aec66d8d022da0cea5c1860a6bbbc0bf8f6c63\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1585060353431597",
"tags": [
"builder:win",
"buildset:commit/git/a6aec66d8d022da0cea5c1860a6bbbc0bf8f6c63",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/a6aec66d8d022da0cea5c1860a6bbbc0bf8f6c63",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9050367533496856096",
"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/8884937471105028528/+/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": "1585060353431718",
"url": "https://ci.chromium.org/b/8884937471105028528",
"utcnow_ts": "1585060353774654"
}
}
[14:32:33.781] Task URL: https://ci.chromium.org/b/8884937471105028528
[14:32:33.781] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:2:0) after 1m0s
[14:33:12.546] Received PubSub notification, asking Buildbucket for the build status
[14:33:12.635] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:33.911] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:2:0)
[14:33:33.911] Timer tick, asking Buildbucket for the build status
[14:33:33.986] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:33.986] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:4:0) after 1m0s
[14:34:34.025] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:4:0)
[14:34:34.025] Timer tick, asking Buildbucket for the build status
[14:34:34.381] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:34.381] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:5:0) after 1m0s
[14:35:34.403] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:5:0)
[14:35:34.403] Timer tick, asking Buildbucket for the build status
[14:35:34.511] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:34.511] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:6:0) after 1m0s
[14:36:34.530] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:6:0)
[14:36:34.530] Timer tick, asking Buildbucket for the build status
[14:36:34.662] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:34.662] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:7:0) after 1m0s
[14:37:34.654] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:7:0)
[14:37:34.654] Timer tick, asking Buildbucket for the build status
[14:37:34.940] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:34.940] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:8:0) after 1m0s
[14:38:35.007] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:8:0)
[14:38:35.007] Timer tick, asking Buildbucket for the build status
[14:38:35.298] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:35.298] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:9:0) after 1m0s
[14:39:35.321] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:9:0)
[14:39:35.321] Timer tick, asking Buildbucket for the build status
[14:39:35.499] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:35.499] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:10:0) after 1m0s
[14:40:35.547] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:10:0)
[14:40:35.547] Timer tick, asking Buildbucket for the build status
[14:40:35.679] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:35.679] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:11:0) after 1m0s
[14:41:35.728] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:11:0)
[14:41:35.728] Timer tick, asking Buildbucket for the build status
[14:41:35.829] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:35.829] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:12:0) after 1m0s
[14:42:35.860] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:12:0)
[14:42:35.860] Timer tick, asking Buildbucket for the build status
[14:42:35.987] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:35.988] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:13:0) after 1m0s
[14:43:36.038] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:13:0)
[14:43:36.038] Timer tick, asking Buildbucket for the build status
[14:43:36.544] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:36.544] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:14:0) after 1m0s
[14:44:36.582] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:14:0)
[14:44:36.582] Timer tick, asking Buildbucket for the build status
[14:44:36.667] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:36.667] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:15:0) after 1m0s
[14:45:36.714] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:15:0)
[14:45:36.714] Timer tick, asking Buildbucket for the build status
[14:45:36.765] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:36.765] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:16:0) after 1m0s
[14:46:36.742] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:16:0)
[14:46:36.742] Timer tick, asking Buildbucket for the build status
[14:46:36.878] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:36.879] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:17:0) after 1m0s
[14:47:36.949] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:17:0)
[14:47:36.949] Timer tick, asking Buildbucket for the build status
[14:47:37.171] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:37.171] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:18:0) after 1m0s
[14:48:37.197] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:18:0)
[14:48:37.197] Timer tick, asking Buildbucket for the build status
[14:48:37.594] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:37.594] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:19:0) after 1m0s
[14:49:37.606] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:19:0)
[14:49:37.606] Timer tick, asking Buildbucket for the build status
[14:49:37.751] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:37.751] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:20:0) after 1m0s
[14:50:37.779] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:20:0)
[14:50:37.779] Timer tick, asking Buildbucket for the build status
[14:50:37.933] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:37.933] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:21:0) after 1m0s
[14:51:37.948] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:21:0)
[14:51:37.948] Timer tick, asking Buildbucket for the build status
[14:51:38.231] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:38.231] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:22:0) after 1m0s
[14:52:38.323] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:22:0)
[14:52:38.323] Timer tick, asking Buildbucket for the build status
[14:52:38.704] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:38.705] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:23:0) after 1m0s
[14:53:38.758] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:23:0)
[14:53:38.758] Timer tick, asking Buildbucket for the build status
[14:53:38.908] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:38.908] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:24:0) after 1m0s
[14:54:38.965] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:24:0)
[14:54:38.965] Timer tick, asking Buildbucket for the build status
[14:54:39.431] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:39.431] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:25:0) after 1m0s
[14:55:39.405] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:25:0)
[14:55:39.405] Timer tick, asking Buildbucket for the build status
[14:55:39.714] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:39.714] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:26:0) after 1m0s
[14:56:39.709] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:26:0)
[14:56:39.709] Timer tick, asking Buildbucket for the build status
[14:56:39.870] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:39.870] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:27:0) after 1m0s
[14:57:39.883] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:27:0)
[14:57:39.883] Timer tick, asking Buildbucket for the build status
[14:57:39.991] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:39.991] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:28:0) after 1m0s
[14:58:39.985] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:28:0)
[14:58:39.985] Timer tick, asking Buildbucket for the build status
[14:58:40.134] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:40.134] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:29:0) after 1m0s
[14:59:40.191] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:29:0)
[14:59:40.191] Timer tick, asking Buildbucket for the build status
[14:59:40.350] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:40.350] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:30:0) after 1m0s
[15:00:40.366] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:30:0)
[15:00:40.366] Timer tick, asking Buildbucket for the build status
[15:00:40.760] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:40.760] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:31:0) after 1m0s
[15:01:40.741] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:31:0)
[15:01:40.741] Timer tick, asking Buildbucket for the build status
[15:01:40.960] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:40.960] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:32:0) after 1m0s
[15:02:41.035] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:32:0)
[15:02:41.035] Timer tick, asking Buildbucket for the build status
[15:02:41.728] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:41.728] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:33:0) after 1m0s
[15:03:41.749] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:33:0)
[15:03:41.749] Timer tick, asking Buildbucket for the build status
[15:03:41.901] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:41.902] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:34:0) after 1m0s
[15:04:42.004] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:34:0)
[15:04:42.004] Timer tick, asking Buildbucket for the build status
[15:04:43.091] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:43.091] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:35:0) after 1m0s
[15:05:43.143] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:35:0)
[15:05:43.143] Timer tick, asking Buildbucket for the build status
[15:05:43.234] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:43.234] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:36:0) after 1m0s
[15:06:43.275] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:36:0)
[15:06:43.275] Timer tick, asking Buildbucket for the build status
[15:06:43.339] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:43.339] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:37:0) after 1m0s
[15:07:43.373] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:37:0)
[15:07:43.373] Timer tick, asking Buildbucket for the build status
[15:07:43.627] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:43.627] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:38:0) after 1m0s
[15:08:43.630] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:38:0)
[15:08:43.630] Timer tick, asking Buildbucket for the build status
[15:08:44.030] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:44.030] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:39:0) after 1m0s
[15:09:44.090] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:39:0)
[15:09:44.090] Timer tick, asking Buildbucket for the build status
[15:09:44.370] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:44.370] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:40:0) after 1m0s
[15:10:44.390] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:40:0)
[15:10:44.390] Timer tick, asking Buildbucket for the build status
[15:10:44.500] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:44.500] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:41:0) after 1m0s
[15:11:44.520] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:41:0)
[15:11:44.520] Timer tick, asking Buildbucket for the build status
[15:11:44.587] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:44.587] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:42:0) after 1m0s
[15:12:44.592] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:42:0)
[15:12:44.592] Timer tick, asking Buildbucket for the build status
[15:12:44.715] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:44.715] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:43:0) after 1m0s
[15:13:44.736] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:43:0)
[15:13:44.736] Timer tick, asking Buildbucket for the build status
[15:13:44.860] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:44.860] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:44:0) after 1m0s
[15:14:44.849] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:44:0)
[15:14:44.849] Timer tick, asking Buildbucket for the build status
[15:14:45.904] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:45.904] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:45:0) after 1m0s
[15:15:46.075] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:45:0)
[15:15:46.075] Timer tick, asking Buildbucket for the build status
[15:15:46.208] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:46.208] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:46:0) after 1m0s
[15:16:46.277] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:46:0)
[15:16:46.277] Timer tick, asking Buildbucket for the build status
[15:16:46.426] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:46.427] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:47:0) after 1m0s
[15:17:46.501] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:47:0)
[15:17:46.501] Timer tick, asking Buildbucket for the build status
[15:17:46.793] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:46.793] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:48:0) after 1m0s
[15:18:46.858] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:48:0)
[15:18:46.858] Timer tick, asking Buildbucket for the build status
[15:18:47.062] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:47.062] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:49:0) after 1m0s
[15:19:47.152] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:49:0)
[15:19:47.152] Timer tick, asking Buildbucket for the build status
[15:19:47.714] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:47.714] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:50:0) after 1m0s
[15:20:47.998] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:50:0)
[15:20:47.998] Timer tick, asking Buildbucket for the build status
[15:20:48.380] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:48.380] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:51:0) after 1m0s
[15:21:48.405] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:51:0)
[15:21:48.405] Timer tick, asking Buildbucket for the build status
[15:21:48.587] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:48.587] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:52:0) after 1m0s
[15:22:48.643] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:52:0)
[15:22:48.643] Timer tick, asking Buildbucket for the build status
[15:22:48.790] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:48.790] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:53:0) after 1m0s
[15:23:48.872] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:53:0)
[15:23:48.872] Timer tick, asking Buildbucket for the build status
[15:23:48.987] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:48.987] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:54:0) after 1m0s
[15:24:49.025] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:54:0)
[15:24:49.025] Timer tick, asking Buildbucket for the build status
[15:24:49.356] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:49.356] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:55:0) after 1m0s
[15:25:49.434] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:55:0)
[15:25:49.434] Timer tick, asking Buildbucket for the build status
[15:25:49.635] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:49.635] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:56:0) after 1m0s
[15:26:49.652] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:56:0)
[15:26:49.652] Timer tick, asking Buildbucket for the build status
[15:26:49.833] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:49.833] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:57:0) after 1m0s
[15:27:49.893] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:57:0)
[15:27:49.893] Timer tick, asking Buildbucket for the build status
[15:27:49.987] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:49.987] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:58:0) after 1m0s
[15:28:50.005] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:58:0)
[15:28:50.005] Timer tick, asking Buildbucket for the build status
[15:28:50.143] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:50.143] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:59:0) after 1m0s
[15:29:50.170] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:59:0)
[15:29:50.170] Timer tick, asking Buildbucket for the build status
[15:29:50.734] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:50.734] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:60:0) after 1m0s
[15:30:50.797] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:60:0)
[15:30:50.797] Timer tick, asking Buildbucket for the build status
[15:30:50.898] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:50.898] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:61:0) after 1m0s
[15:31:51.016] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:61:0)
[15:31:51.016] Timer tick, asking Buildbucket for the build status
[15:31:51.160] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:51.160] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:62:0) after 1m0s
[15:32:51.236] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:62:0)
[15:32:51.236] Timer tick, asking Buildbucket for the build status
[15:32:51.455] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:51.455] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:63:0) after 1m0s
[15:33:51.511] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:63:0)
[15:33:51.511] Timer tick, asking Buildbucket for the build status
[15:33:51.629] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:51.629] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:64:0) after 1m0s
[15:34:51.642] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:64:0)
[15:34:51.642] Timer tick, asking Buildbucket for the build status
[15:34:51.782] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:51.782] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:65:0) after 1m0s
[15:35:51.887] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:65:0)
[15:35:51.887] Timer tick, asking Buildbucket for the build status
[15:35:52.047] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:52.047] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:66:0) after 1m0s
[15:36:52.080] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:66:0)
[15:36:52.080] Timer tick, asking Buildbucket for the build status
[15:36:52.191] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:52.192] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:67:0) after 1m0s
[15:37:52.249] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:67:0)
[15:37:52.250] Timer tick, asking Buildbucket for the build status
[15:37:52.373] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:52.373] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:68:0) after 1m0s
[15:38:52.497] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:68:0)
[15:38:52.497] Timer tick, asking Buildbucket for the build status
[15:38:52.603] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:52.603] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:69:0) after 1m0s
[15:39:52.697] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:69:0)
[15:39:52.697] Timer tick, asking Buildbucket for the build status
[15:39:53.792] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:53.792] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:70:0) after 1m0s
[15:40:53.813] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:70:0)
[15:40:53.813] Timer tick, asking Buildbucket for the build status
[15:40:53.993] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:53.993] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:71:0) after 1m0s
[15:41:54.014] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:71:0)
[15:41:54.014] Timer tick, asking Buildbucket for the build status
[15:41:54.110] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:54.110] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:72:0) after 1m0s
[15:42:54.141] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:72:0)
[15:42:54.141] Timer tick, asking Buildbucket for the build status
[15:42:54.230] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:54.230] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:73:0) after 1m0s
[15:43:54.307] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:73:0)
[15:43:54.307] Timer tick, asking Buildbucket for the build status
[15:43:54.590] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:54.590] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:74:0) after 1m0s
[15:44:54.715] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:74:0)
[15:44:54.715] Timer tick, asking Buildbucket for the build status
[15:44:54.796] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:54.796] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:75:0) after 1m0s
[15:45:54.820] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:75:0)
[15:45:54.820] Timer tick, asking Buildbucket for the build status
[15:45:54.998] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:54.999] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:76:0) after 1m0s
[15:46:55.056] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:76:0)
[15:46:55.056] Timer tick, asking Buildbucket for the build status
[15:46:55.437] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:55.437] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:77:0) after 1m0s
[15:47:55.509] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:77:0)
[15:47:55.509] Timer tick, asking Buildbucket for the build status
[15:47:55.617] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:55.617] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:78:0) after 1m0s
[15:48:55.638] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:78:0)
[15:48:55.638] Timer tick, asking Buildbucket for the build status
[15:48:55.747] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:55.747] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:79:0) after 1m0s
[15:49:55.859] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:79:0)
[15:49:55.859] Timer tick, asking Buildbucket for the build status
[15:49:55.916] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:55.916] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:80:0) after 1m0s
[15:50:56.015] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:80:0)
[15:50:56.015] Timer tick, asking Buildbucket for the build status
[15:50:56.169] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:56.169] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:81:0) after 1m0s
[15:51:56.165] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:81:0)
[15:51:56.165] Timer tick, asking Buildbucket for the build status
[15:51:56.275] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:56.275] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:82:0) after 1m0s
[15:52:56.315] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:82:0)
[15:52:56.315] Timer tick, asking Buildbucket for the build status
[15:52:56.410] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:56.410] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:83:0) after 1m0s
[15:53:56.443] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:83:0)
[15:53:56.443] Timer tick, asking Buildbucket for the build status
[15:53:56.557] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:56.557] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:84:0) after 1m0s
[15:54:56.565] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:84:0)
[15:54:56.565] Timer tick, asking Buildbucket for the build status
[15:54:56.641] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:56.641] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:85:0) after 1m0s
[15:55:56.670] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:85:0)
[15:55:56.670] Timer tick, asking Buildbucket for the build status
[15:55:56.882] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:56.882] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:86:0) after 1m0s
[15:56:56.975] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:86:0)
[15:56:56.975] Timer tick, asking Buildbucket for the build status
[15:56:57.266] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:57.266] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:87:0) after 1m0s
[15:57:57.287] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:87:0)
[15:57:57.287] Timer tick, asking Buildbucket for the build status
[15:57:57.540] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:57.541] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:88:0) after 1m0s
[15:58:57.588] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:88:0)
[15:58:57.588] Timer tick, asking Buildbucket for the build status
[15:58:59.460] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:59.460] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:89:0) after 1m0s
[15:59:59.541] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:89:0)
[15:59:59.541] Timer tick, asking Buildbucket for the build status
[15:59:59.649] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:59.649] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:90:0) after 1m0s
[16:00:59.757] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:90:0)
[16:00:59.757] Timer tick, asking Buildbucket for the build status
[16:00:59.902] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:59.902] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:91:0) after 1m0s
[16:02:00.021] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:91:0)
[16:02:00.021] Timer tick, asking Buildbucket for the build status
[16:02:00.293] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:00.293] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:92:0) after 1m0s
[16:03:00.383] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:92:0)
[16:03:00.383] Timer tick, asking Buildbucket for the build status
[16:03:00.744] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:00.744] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:93:0) after 1m0s
[16:04:00.873] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:93:0)
[16:04:00.873] Timer tick, asking Buildbucket for the build status
[16:04:01.012] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:01.012] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:94:0) after 1m0s
[16:05:01.089] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:94:0)
[16:05:01.089] Timer tick, asking Buildbucket for the build status
[16:05:01.560] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:01.560] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:95:0) after 1m0s
[16:06:01.564] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:95:0)
[16:06:01.564] Timer tick, asking Buildbucket for the build status
[16:06:01.782] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:01.782] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:96:0) after 1m0s
[16:07:02.079] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:96:0)
[16:07:02.079] Timer tick, asking Buildbucket for the build status
[16:07:02.394] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:02.394] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:97:0) after 1m0s
[16:08:02.521] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:97:0)
[16:08:02.521] Timer tick, asking Buildbucket for the build status
[16:08:02.651] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:02.651] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:98:0) after 1m0s
[16:09:02.816] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:98:0)
[16:09:02.816] Timer tick, asking Buildbucket for the build status
[16:09:02.965] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:02.965] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:99:0) after 1m0s
[16:10:03.131] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:99:0)
[16:10:03.131] Timer tick, asking Buildbucket for the build status
[16:10:03.427] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:03.427] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:100:0) after 1m0s
[16:11:03.424] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:100:0)
[16:11:03.424] Timer tick, asking Buildbucket for the build status
[16:11:03.529] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:03.529] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:101:0) after 1m0s
[16:12:03.690] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:101:0)
[16:12:03.690] Timer tick, asking Buildbucket for the build status
[16:12:03.848] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:03.848] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:102:0) after 1m0s
[16:13:03.885] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:102:0)
[16:13:03.885] Timer tick, asking Buildbucket for the build status
[16:13:04.046] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:04.046] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:103:0) after 1m0s
[16:14:04.067] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:103:0)
[16:14:04.067] Timer tick, asking Buildbucket for the build status
[16:14:04.379] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:04.379] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:104:0) after 1m0s
[16:15:04.483] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:104:0)
[16:15:04.483] Timer tick, asking Buildbucket for the build status
[16:15:04.678] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:04.678] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:105:0) after 1m0s
[16:16:04.752] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:105:0)
[16:16:04.752] Timer tick, asking Buildbucket for the build status
[16:16:05.308] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:05.308] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:106:0) after 1m0s
[16:17:05.389] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:106:0)
[16:17:05.389] Timer tick, asking Buildbucket for the build status
[16:17:05.544] Build 8884937471105028528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:05.544] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9050367533496856096:107:0) after 1m0s
[16:17:19.569] Received PubSub notification, asking Buildbucket for the build status
[16:17:19.681] Build 8884937471105028528: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:17:19.681] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"completed_ts": "1585066639028019",
"created_by": "project:emscripten-releases",
"created_ts": "1585060353139065",
"id": "8884937471105028528",
"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\": \"a6aec66d8d022da0cea5c1860a6bbbc0bf8f6c63\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@a6aec66d8d022da0cea5c1860a6bbbc0bf8f6c63\", \"title\": \"a6aec66d8d022da0cea5c1860a6bbbc0bf8f6c63\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/a6aec66d8d022da0cea5c1860a6bbbc0bf8f6c63\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"a6aec66d8d022da0cea5c1860a6bbbc0bf8f6c63\"}}",
"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\": \"a6aec66d8d022da0cea5c1860a6bbbc0bf8f6c63\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@a6aec66d8d022da0cea5c1860a6bbbc0bf8f6c63\", \"title\": \"a6aec66d8d022da0cea5c1860a6bbbc0bf8f6c63\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/a6aec66d8d022da0cea5c1860a6bbbc0bf8f6c63\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-win10-0-9e2g\", \"branch\": \"refs/heads/master\", \"buildername\": \"win\", \"got_revision\": \"a6aec66d8d022da0cea5c1860a6bbbc0bf8f6c63\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"a6aec66d8d022da0cea5c1860a6bbbc0bf8f6c63\"}, \"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-9e2g\"], \"image\": [\"chrome-win10-1703-19112100-3085293b610\"], \"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\": [\"4895-ce889b2\"], \"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": "1585060391764563",
"status": "COMPLETED",
"status_changed_ts": "1585066639348281",
"tags": [
"builder:win",
"buildset:commit/git/a6aec66d8d022da0cea5c1860a6bbbc0bf8f6c63",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/a6aec66d8d022da0cea5c1860a6bbbc0bf8f6c63",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9050367533496856096",
"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/8884937471105028528/+/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:4b25c7667f3e4c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1585066639372269",
"url": "https://ci.chromium.org/b/8884937471105028528",
"utcnow_ts": "1585066639673269"
}
}
[16:17:19.681] Invocation finished in 1h44m48.206395112s with status SUCCEEDED