[17:44:10.460] New invocation is queued and will start shortly
[17:44:11.800] Starting the invocation (attempt 1)
[17:44:11.836] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:44:11.837] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:44:11.837] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9047909357859837520",
"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\":\"10bbb0d629efb2738da3499dee5ec764eb11dcd3\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@10bbb0d629efb2738da3499dee5ec764eb11dcd3\",\"title\":\"10bbb0d629efb2738da3499dee5ec764eb11dcd3\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/10bbb0d629efb2738da3499dee5ec764eb11dcd3\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"10bbb0d629efb2738da3499dee5ec764eb11dcd3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win",
"scheduler_invocation_id:9047909357859837520",
"scheduler_job_id:emscripten-releases/win",
"user_agent:luci-scheduler",
"buildset:commit/git/10bbb0d629efb2738da3499dee5ec764eb11dcd3",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/10bbb0d629efb2738da3499dee5ec764eb11dcd3",
"gitiles_ref:refs/heads/master"
]
}
[17:44:12.553] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1587404651938244",
"id": "8882479295647423232",
"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\": \"10bbb0d629efb2738da3499dee5ec764eb11dcd3\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@10bbb0d629efb2738da3499dee5ec764eb11dcd3\", \"title\": \"10bbb0d629efb2738da3499dee5ec764eb11dcd3\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/10bbb0d629efb2738da3499dee5ec764eb11dcd3\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"10bbb0d629efb2738da3499dee5ec764eb11dcd3\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1587404652413805",
"tags": [
"builder:win",
"buildset:commit/git/10bbb0d629efb2738da3499dee5ec764eb11dcd3",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/10bbb0d629efb2738da3499dee5ec764eb11dcd3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9047909357859837520",
"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/8882479295647423232/+/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": "1587404652413939",
"url": "https://ci.chromium.org/b/8882479295647423232",
"utcnow_ts": "1587404652542233"
}
}
[17:44:12.553] Task URL: https://ci.chromium.org/b/8882479295647423232
[17:44:12.553] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:2:0) after 1m0s
[17:44:35.171] Received PubSub notification, asking Buildbucket for the build status
[17:44:35.367] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:12.583] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:2:0)
[17:45:12.583] Timer tick, asking Buildbucket for the build status
[17:45:12.671] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:12.671] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:4:0) after 1m0s
[17:46:12.918] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:4:0)
[17:46:12.918] Timer tick, asking Buildbucket for the build status
[17:46:13.605] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:13.605] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:5:0) after 1m0s
[17:47:13.974] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:5:0)
[17:47:13.974] Timer tick, asking Buildbucket for the build status
[17:47:14.161] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:14.161] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:6:0) after 1m0s
[17:48:14.398] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:6:0)
[17:48:14.398] Timer tick, asking Buildbucket for the build status
[17:48:14.573] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:14.573] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:7:0) after 1m0s
[17:49:14.690] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:7:0)
[17:49:14.690] Timer tick, asking Buildbucket for the build status
[17:49:15.284] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:15.284] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:8:0) after 1m0s
[17:50:15.416] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:8:0)
[17:50:15.416] Timer tick, asking Buildbucket for the build status
[17:50:15.620] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:15.620] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:9:0) after 1m0s
[17:51:15.657] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:9:0)
[17:51:15.657] Timer tick, asking Buildbucket for the build status
[17:51:15.943] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:15.943] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:10:0) after 1m0s
[17:52:15.993] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:10:0)
[17:52:15.993] Timer tick, asking Buildbucket for the build status
[17:52:16.200] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:16.200] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:11:0) after 1m0s
[17:53:16.287] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:11:0)
[17:53:16.287] Timer tick, asking Buildbucket for the build status
[17:53:16.457] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:16.457] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:12:0) after 1m0s
[17:54:16.602] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:12:0)
[17:54:16.602] Timer tick, asking Buildbucket for the build status
[17:54:16.739] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:16.739] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:13:0) after 1m0s
[17:55:16.918] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:13:0)
[17:55:16.918] Timer tick, asking Buildbucket for the build status
[17:55:17.036] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:17.036] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:14:0) after 1m0s
[17:56:17.148] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:14:0)
[17:56:17.148] Timer tick, asking Buildbucket for the build status
[17:56:17.670] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:17.670] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:15:0) after 1m0s
[17:57:17.676] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:15:0)
[17:57:17.676] Timer tick, asking Buildbucket for the build status
[17:57:17.942] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:17.942] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:16:0) after 1m0s
[17:58:17.962] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:16:0)
[17:58:17.962] Timer tick, asking Buildbucket for the build status
[17:58:18.105] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:18.105] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:17:0) after 1m0s
[17:59:18.148] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:17:0)
[17:59:18.148] Timer tick, asking Buildbucket for the build status
[17:59:18.736] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:18.736] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:18:0) after 1m0s
[18:00:18.805] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:18:0)
[18:00:18.805] Timer tick, asking Buildbucket for the build status
[18:00:19.135] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:19.135] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:19:0) after 1m0s
[18:01:19.183] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:19:0)
[18:01:19.183] Timer tick, asking Buildbucket for the build status
[18:01:19.511] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:19.511] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:20:0) after 1m0s
[18:02:19.531] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:20:0)
[18:02:19.531] Timer tick, asking Buildbucket for the build status
[18:02:19.735] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:19.735] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:21:0) after 1m0s
[18:03:19.760] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:21:0)
[18:03:19.760] Timer tick, asking Buildbucket for the build status
[18:03:19.942] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:19.942] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:22:0) after 1m0s
[18:04:19.992] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:22:0)
[18:04:19.992] Timer tick, asking Buildbucket for the build status
[18:04:20.250] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:20.250] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:23:0) after 1m0s
[18:05:20.266] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:23:0)
[18:05:20.266] Timer tick, asking Buildbucket for the build status
[18:05:21.232] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:21.232] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:24:0) after 1m0s
[18:06:21.254] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:24:0)
[18:06:21.254] Timer tick, asking Buildbucket for the build status
[18:06:21.421] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:21.421] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:25:0) after 1m0s
[18:07:21.506] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:25:0)
[18:07:21.506] Timer tick, asking Buildbucket for the build status
[18:07:21.595] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:21.595] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:26:0) after 1m0s
[18:08:21.690] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:26:0)
[18:08:21.690] Timer tick, asking Buildbucket for the build status
[18:08:22.441] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:22.441] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:27:0) after 1m0s
[18:09:22.467] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:27:0)
[18:09:22.467] Timer tick, asking Buildbucket for the build status
[18:09:22.627] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:22.627] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:28:0) after 1m0s
[18:10:22.620] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:28:0)
[18:10:22.620] Timer tick, asking Buildbucket for the build status
[18:10:24.514] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:24.514] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:29:0) after 1m0s
[18:11:24.558] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:29:0)
[18:11:24.558] Timer tick, asking Buildbucket for the build status
[18:11:24.880] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:24.880] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:30:0) after 1m0s
[18:12:24.905] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:30:0)
[18:12:24.905] Timer tick, asking Buildbucket for the build status
[18:12:25.259] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:25.259] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:31:0) after 1m0s
[18:13:25.282] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:31:0)
[18:13:25.282] Timer tick, asking Buildbucket for the build status
[18:13:25.472] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:25.472] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:32:0) after 1m0s
[18:14:25.509] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:32:0)
[18:14:25.509] Timer tick, asking Buildbucket for the build status
[18:14:26.178] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:26.178] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:33:0) after 1m0s
[18:15:26.302] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:33:0)
[18:15:26.302] Timer tick, asking Buildbucket for the build status
[18:15:27.791] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:27.791] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:34:0) after 1m0s
[18:16:27.812] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:34:0)
[18:16:27.812] Timer tick, asking Buildbucket for the build status
[18:16:27.870] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:27.870] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:35:0) after 1m0s
[18:17:27.954] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:35:0)
[18:17:27.954] Timer tick, asking Buildbucket for the build status
[18:17:28.203] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:28.203] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:36:0) after 1m0s
[18:18:28.226] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:36:0)
[18:18:28.226] Timer tick, asking Buildbucket for the build status
[18:18:28.427] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:28.428] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:37:0) after 1m0s
[18:19:28.455] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:37:0)
[18:19:28.455] Timer tick, asking Buildbucket for the build status
[18:19:28.655] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:28.655] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:38:0) after 1m0s
[18:20:28.727] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:38:0)
[18:20:28.727] Timer tick, asking Buildbucket for the build status
[18:20:33.401] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:33.401] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:39:0) after 1m0s
[18:21:33.489] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:39:0)
[18:21:33.489] Timer tick, asking Buildbucket for the build status
[18:21:33.769] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:33.769] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:40:0) after 1m0s
[18:22:33.793] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:40:0)
[18:22:33.793] Timer tick, asking Buildbucket for the build status
[18:22:33.940] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:33.940] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:41:0) after 1m0s
[18:23:34.001] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:41:0)
[18:23:34.001] Timer tick, asking Buildbucket for the build status
[18:23:34.357] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:34.357] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:42:0) after 1m0s
[18:24:34.363] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:42:0)
[18:24:34.363] Timer tick, asking Buildbucket for the build status
[18:24:34.508] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:34.508] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:43:0) after 1m0s
[18:25:34.538] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:43:0)
[18:25:34.538] Timer tick, asking Buildbucket for the build status
[18:25:38.435] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:38.435] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:44:0) after 1m0s
[18:26:38.511] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:44:0)
[18:26:38.511] Timer tick, asking Buildbucket for the build status
[18:26:38.681] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:38.681] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:45:0) after 1m0s
[18:27:38.703] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:45:0)
[18:27:38.703] Timer tick, asking Buildbucket for the build status
[18:27:38.923] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:38.923] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:46:0) after 1m0s
[18:28:38.958] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:46:0)
[18:28:38.958] Timer tick, asking Buildbucket for the build status
[18:28:39.240] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:39.240] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:47:0) after 1m0s
[18:29:39.313] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:47:0)
[18:29:39.313] Timer tick, asking Buildbucket for the build status
[18:29:39.630] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:39.630] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:48:0) after 1m0s
[18:30:39.703] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:48:0)
[18:30:39.703] Timer tick, asking Buildbucket for the build status
[18:30:39.868] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:39.868] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:49:0) after 1m0s
[18:31:40.058] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:49:0)
[18:31:40.058] Timer tick, asking Buildbucket for the build status
[18:31:41.045] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:41.045] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:50:0) after 1m0s
[18:32:41.095] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:50:0)
[18:32:41.095] Timer tick, asking Buildbucket for the build status
[18:32:41.376] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:41.376] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:51:0) after 1m0s
[18:33:41.398] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:51:0)
[18:33:41.398] Timer tick, asking Buildbucket for the build status
[18:33:41.637] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:41.637] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:52:0) after 1m0s
[18:34:41.624] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:52:0)
[18:34:41.624] Timer tick, asking Buildbucket for the build status
[18:34:41.834] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:41.834] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:53:0) after 1m0s
[18:35:41.882] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:53:0)
[18:35:41.882] Timer tick, asking Buildbucket for the build status
[18:35:43.416] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:43.416] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:54:0) after 1m0s
[18:36:43.493] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:54:0)
[18:36:43.493] Timer tick, asking Buildbucket for the build status
[18:36:43.922] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:43.922] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:55:0) after 1m0s
[18:37:43.958] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:55:0)
[18:37:43.958] Timer tick, asking Buildbucket for the build status
[18:37:44.118] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:44.118] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:56:0) after 1m0s
[18:38:44.167] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:56:0)
[18:38:44.167] Timer tick, asking Buildbucket for the build status
[18:38:44.780] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:44.780] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:57:0) after 1m0s
[18:39:44.820] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:57:0)
[18:39:44.820] Timer tick, asking Buildbucket for the build status
[18:39:44.922] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:44.922] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:58:0) after 1m0s
[18:40:44.998] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:58:0)
[18:40:44.998] Timer tick, asking Buildbucket for the build status
[18:40:45.398] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:45.398] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:59:0) after 1m0s
[18:41:45.449] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:59:0)
[18:41:45.449] Timer tick, asking Buildbucket for the build status
[18:41:46.891] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:46.891] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:60:0) after 1m0s
[18:42:46.965] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:60:0)
[18:42:46.965] Timer tick, asking Buildbucket for the build status
[18:42:47.069] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:47.069] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:61:0) after 1m0s
[18:43:47.226] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:61:0)
[18:43:47.226] Timer tick, asking Buildbucket for the build status
[18:43:47.345] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:47.345] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:62:0) after 1m0s
[18:44:47.513] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:62:0)
[18:44:47.513] Timer tick, asking Buildbucket for the build status
[18:44:47.659] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:47.659] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:63:0) after 1m0s
[18:45:47.849] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:63:0)
[18:45:47.849] Timer tick, asking Buildbucket for the build status
[18:45:48.355] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:48.355] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:64:0) after 1m0s
[18:46:48.440] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:64:0)
[18:46:48.440] Timer tick, asking Buildbucket for the build status
[18:46:49.111] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:49.111] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:65:0) after 1m0s
[18:47:49.224] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:65:0)
[18:47:49.224] Timer tick, asking Buildbucket for the build status
[18:47:49.362] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:49.362] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:66:0) after 1m0s
[18:48:49.444] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:66:0)
[18:48:49.444] Timer tick, asking Buildbucket for the build status
[18:48:49.629] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:49.629] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:67:0) after 1m0s
[18:49:49.758] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:67:0)
[18:49:49.758] Timer tick, asking Buildbucket for the build status
[18:49:49.948] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:49.948] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:68:0) after 1m0s
[18:50:50.037] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:68:0)
[18:50:50.037] Timer tick, asking Buildbucket for the build status
[18:50:51.388] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:51.388] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:69:0) after 1m0s
[18:51:51.437] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:69:0)
[18:51:51.437] Timer tick, asking Buildbucket for the build status
[18:51:51.822] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:51.822] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:70:0) after 1m0s
[18:52:51.874] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:70:0)
[18:52:51.874] Timer tick, asking Buildbucket for the build status
[18:52:51.977] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:51.977] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:71:0) after 1m0s
[18:53:51.982] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:71:0)
[18:53:51.982] Timer tick, asking Buildbucket for the build status
[18:53:52.235] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:52.235] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:72:0) after 1m0s
[18:54:52.347] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:72:0)
[18:54:52.347] Timer tick, asking Buildbucket for the build status
[18:54:52.619] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:52.619] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:73:0) after 1m0s
[18:55:52.693] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:73:0)
[18:55:52.693] Timer tick, asking Buildbucket for the build status
[18:55:53.175] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:53.175] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:74:0) after 1m0s
[18:56:53.200] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:74:0)
[18:56:53.200] Timer tick, asking Buildbucket for the build status
[18:56:53.748] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:53.748] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:75:0) after 1m0s
[18:57:53.795] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:75:0)
[18:57:53.795] Timer tick, asking Buildbucket for the build status
[18:57:54.147] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:54.147] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:76:0) after 1m0s
[18:58:54.195] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:76:0)
[18:58:54.195] Timer tick, asking Buildbucket for the build status
[18:58:54.394] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:54.394] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:77:0) after 1m0s
[18:59:54.455] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:77:0)
[18:59:54.455] Timer tick, asking Buildbucket for the build status
[18:59:54.888] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:54.888] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:78:0) after 1m0s
[19:00:54.991] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:78:0)
[19:00:54.991] Timer tick, asking Buildbucket for the build status
[19:00:55.198] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:55.198] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:79:0) after 1m0s
[19:01:55.270] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:79:0)
[19:01:55.270] Timer tick, asking Buildbucket for the build status
[19:01:55.488] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:55.488] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:80:0) after 1m0s
[19:02:55.570] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:80:0)
[19:02:55.570] Timer tick, asking Buildbucket for the build status
[19:02:56.368] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:56.368] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:81:0) after 1m0s
[19:03:56.454] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:81:0)
[19:03:56.454] Timer tick, asking Buildbucket for the build status
[19:03:56.662] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:56.662] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:82:0) after 1m0s
[19:04:56.684] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:82:0)
[19:04:56.684] Timer tick, asking Buildbucket for the build status
[19:04:56.852] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:56.852] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:83:0) after 1m0s
[19:05:56.952] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:83:0)
[19:05:56.952] Timer tick, asking Buildbucket for the build status
[19:05:57.124] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:57.125] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:84:0) after 1m0s
[19:06:57.557] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:84:0)
[19:06:57.557] Timer tick, asking Buildbucket for the build status
[19:06:57.789] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:57.789] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:85:0) after 1m0s
[19:07:58.144] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:85:0)
[19:07:58.144] Timer tick, asking Buildbucket for the build status
[19:07:58.264] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:58.264] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:86:0) after 1m0s
[19:08:58.282] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:86:0)
[19:08:58.282] Timer tick, asking Buildbucket for the build status
[19:08:58.768] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:58.768] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:87:0) after 1m0s
[19:09:58.855] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:87:0)
[19:09:58.855] Timer tick, asking Buildbucket for the build status
[19:09:59.067] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:59.067] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:88:0) after 1m0s
[19:10:59.151] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:88:0)
[19:10:59.151] Timer tick, asking Buildbucket for the build status
[19:10:59.276] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:59.276] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:89:0) after 1m0s
[19:11:59.372] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:89:0)
[19:11:59.372] Timer tick, asking Buildbucket for the build status
[19:12:01.229] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:01.229] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:90:0) after 1m0s
[19:13:02.014] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:90:0)
[19:13:02.014] Timer tick, asking Buildbucket for the build status
[19:13:02.179] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:02.179] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:91:0) after 1m0s
[19:14:02.329] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:91:0)
[19:14:02.329] Timer tick, asking Buildbucket for the build status
[19:14:03.345] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:03.345] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:92:0) after 1m0s
[19:15:03.378] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:92:0)
[19:15:03.378] Timer tick, asking Buildbucket for the build status
[19:15:03.609] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:03.609] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:93:0) after 1m0s
[19:16:03.711] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:93:0)
[19:16:03.711] Timer tick, asking Buildbucket for the build status
[19:16:03.795] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:03.795] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:94:0) after 1m0s
[19:17:03.936] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:94:0)
[19:17:03.936] Timer tick, asking Buildbucket for the build status
[19:17:04.173] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:04.173] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:95:0) after 1m0s
[19:18:04.464] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:95:0)
[19:18:04.464] Timer tick, asking Buildbucket for the build status
[19:18:04.902] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:04.902] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:96:0) after 1m0s
[19:19:04.987] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:96:0)
[19:19:04.987] Timer tick, asking Buildbucket for the build status
[19:19:05.169] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:05.169] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:97:0) after 1m0s
[19:20:05.208] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:97:0)
[19:20:05.208] Timer tick, asking Buildbucket for the build status
[19:20:05.800] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:05.800] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:98:0) after 1m0s
[19:21:05.850] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:98:0)
[19:21:05.850] Timer tick, asking Buildbucket for the build status
[19:21:06.210] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:06.210] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:99:0) after 1m0s
[19:22:06.260] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:99:0)
[19:22:06.260] Timer tick, asking Buildbucket for the build status
[19:22:06.431] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:06.431] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:100:0) after 1m0s
[19:23:06.449] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:100:0)
[19:23:06.449] Timer tick, asking Buildbucket for the build status
[19:23:06.602] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:06.602] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:101:0) after 1m0s
[19:24:06.633] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:101:0)
[19:24:06.633] Timer tick, asking Buildbucket for the build status
[19:24:06.774] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:06.774] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:102:0) after 1m0s
[19:25:06.930] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:102:0)
[19:25:06.930] Timer tick, asking Buildbucket for the build status
[19:25:07.037] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:07.037] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:103:0) after 1m0s
[19:26:07.118] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:103:0)
[19:26:07.118] Timer tick, asking Buildbucket for the build status
[19:26:07.605] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:07.605] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:104:0) after 1m0s
[19:27:07.732] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:104:0)
[19:27:07.732] Timer tick, asking Buildbucket for the build status
[19:27:08.049] Build 8882479295647423232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:08.049] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9047909357859837520:105:0) after 1m0s
[19:27:37.008] Received PubSub notification, asking Buildbucket for the build status
[19:27:37.092] Build 8882479295647423232: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:27:37.092] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"completed_ts": "1587410856310384",
"created_by": "project:emscripten-releases",
"created_ts": "1587404651938244",
"id": "8882479295647423232",
"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\": \"10bbb0d629efb2738da3499dee5ec764eb11dcd3\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@10bbb0d629efb2738da3499dee5ec764eb11dcd3\", \"title\": \"10bbb0d629efb2738da3499dee5ec764eb11dcd3\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/10bbb0d629efb2738da3499dee5ec764eb11dcd3\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"10bbb0d629efb2738da3499dee5ec764eb11dcd3\"}}",
"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\": \"10bbb0d629efb2738da3499dee5ec764eb11dcd3\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@10bbb0d629efb2738da3499dee5ec764eb11dcd3\", \"title\": \"10bbb0d629efb2738da3499dee5ec764eb11dcd3\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/10bbb0d629efb2738da3499dee5ec764eb11dcd3\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-win10-0-i54p\", \"branch\": \"refs/heads/master\", \"buildername\": \"win\", \"got_revision\": \"10bbb0d629efb2738da3499dee5ec764eb11dcd3\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"10bbb0d629efb2738da3499dee5ec764eb11dcd3\"}, \"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-i54p\"], \"image\": [\"chrome-win10-1703-20041000-c83e5f50d12\"], \"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\": [\"4997-2128d8d\"], \"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": "1587404674197965",
"status": "COMPLETED",
"status_changed_ts": "1587410856630517",
"tags": [
"builder:win",
"buildset:commit/git/10bbb0d629efb2738da3499dee5ec764eb11dcd3",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/10bbb0d629efb2738da3499dee5ec764eb11dcd3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9047909357859837520",
"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/8882479295647423232/+/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:4bb1828c540afc10",
"user_agent:luci-scheduler"
],
"updated_ts": "1587410856676233",
"url": "https://ci.chromium.org/b/8882479295647423232",
"utcnow_ts": "1587410857076641"
}
}
[19:27:37.092] Invocation finished in 1h43m26.647322703s with status SUCCEEDED