[01:43:36.411] New invocation is queued and will start shortly
[01:43:37.520] Starting the invocation (attempt 1)
[01:43:37.570] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:43:37.570] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:43:37.570] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9024052192410184128",
"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\":\"f36e69f27261fd0fa9e3d3decbcce1ba271fd25b\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@f36e69f27261fd0fa9e3d3decbcce1ba271fd25b\",\"title\":\"f36e69f27261fd0fa9e3d3decbcce1ba271fd25b\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/f36e69f27261fd0fa9e3d3decbcce1ba271fd25b\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"f36e69f27261fd0fa9e3d3decbcce1ba271fd25b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win",
"scheduler_invocation_id:9024052192410184128",
"scheduler_job_id:emscripten-releases/win",
"user_agent:luci-scheduler",
"buildset:commit/git/f36e69f27261fd0fa9e3d3decbcce1ba271fd25b",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/f36e69f27261fd0fa9e3d3decbcce1ba271fd25b",
"gitiles_ref:refs/heads/master"
]
}
[01:43:38.109] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1610156617708203",
"id": "8858622130388925536",
"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\": \"f36e69f27261fd0fa9e3d3decbcce1ba271fd25b\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@f36e69f27261fd0fa9e3d3decbcce1ba271fd25b\", \"title\": \"f36e69f27261fd0fa9e3d3decbcce1ba271fd25b\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/f36e69f27261fd0fa9e3d3decbcce1ba271fd25b\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"f36e69f27261fd0fa9e3d3decbcce1ba271fd25b\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610156617976535",
"tags": [
"builder:win",
"buildset:commit/git/f36e69f27261fd0fa9e3d3decbcce1ba271fd25b",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/f36e69f27261fd0fa9e3d3decbcce1ba271fd25b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024052192410184128",
"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/8858622130388925536/+/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": "1610156617976644",
"url": "https://ci.chromium.org/b/8858622130388925536",
"utcnow_ts": "1610156618096901"
}
}
[01:43:38.109] Task URL: https://ci.chromium.org/b/8858622130388925536
[01:43:38.109] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:2:0) after 1m0s
[01:44:38.134] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:2:0)
[01:44:38.134] Timer tick, asking Buildbucket for the build status
[01:44:38.253] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:44:38.253] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:3:0) after 1m0s
[01:45:38.278] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:3:0)
[01:45:38.278] Timer tick, asking Buildbucket for the build status
[01:45:38.377] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:45:38.377] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:4:0) after 1m0s
[01:46:38.402] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:4:0)
[01:46:38.402] Timer tick, asking Buildbucket for the build status
[01:46:38.698] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:46:38.698] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:5:0) after 1m0s
[01:47:38.758] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:5:0)
[01:47:38.758] Timer tick, asking Buildbucket for the build status
[01:47:38.851] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:47:38.851] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:6:0) after 1m0s
[01:48:38.907] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:6:0)
[01:48:38.907] Timer tick, asking Buildbucket for the build status
[01:48:39.021] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:48:39.021] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:7:0) after 1m0s
[01:49:39.084] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:7:0)
[01:49:39.084] Timer tick, asking Buildbucket for the build status
[01:49:39.183] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:49:39.183] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:8:0) after 1m0s
[01:50:39.205] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:8:0)
[01:50:39.205] Timer tick, asking Buildbucket for the build status
[01:50:39.275] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:50:39.275] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:9:0) after 1m0s
[01:51:39.252] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:9:0)
[01:51:39.252] Timer tick, asking Buildbucket for the build status
[01:51:39.327] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:51:39.327] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:10:0) after 1m0s
[01:52:39.414] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:10:0)
[01:52:39.414] Timer tick, asking Buildbucket for the build status
[01:52:39.483] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:52:39.483] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:11:0) after 1m0s
[01:53:39.568] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:11:0)
[01:53:39.568] Timer tick, asking Buildbucket for the build status
[01:53:39.648] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:53:39.648] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:12:0) after 1m0s
[01:54:39.724] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:12:0)
[01:54:39.724] Timer tick, asking Buildbucket for the build status
[01:54:39.821] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:54:39.821] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:13:0) after 1m0s
[01:55:39.836] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:13:0)
[01:55:39.836] Timer tick, asking Buildbucket for the build status
[01:55:39.903] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:55:39.903] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:14:0) after 1m0s
[01:56:39.885] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:14:0)
[01:56:39.885] Timer tick, asking Buildbucket for the build status
[01:56:39.968] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:56:39.968] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:15:0) after 1m0s
[01:57:39.995] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:15:0)
[01:57:39.995] Timer tick, asking Buildbucket for the build status
[01:57:40.100] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:57:40.100] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:16:0) after 1m0s
[01:58:40.146] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:16:0)
[01:58:40.146] Timer tick, asking Buildbucket for the build status
[01:58:40.250] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:58:40.250] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:17:0) after 1m0s
[01:59:40.311] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:17:0)
[01:59:40.311] Timer tick, asking Buildbucket for the build status
[01:59:40.391] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:59:40.391] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:18:0) after 1m0s
[02:00:40.400] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:18:0)
[02:00:40.400] Timer tick, asking Buildbucket for the build status
[02:00:40.471] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:00:40.471] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:19:0) after 1m0s
[02:01:40.516] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:19:0)
[02:01:40.516] Timer tick, asking Buildbucket for the build status
[02:01:43.192] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:01:43.192] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:20:0) after 1m0s
[02:02:43.188] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:20:0)
[02:02:43.188] Timer tick, asking Buildbucket for the build status
[02:02:43.394] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:02:43.394] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:21:0) after 1m0s
[02:03:43.478] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:21:0)
[02:03:43.478] Timer tick, asking Buildbucket for the build status
[02:03:43.674] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:03:43.674] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:22:0) after 1m0s
[02:04:43.747] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:22:0)
[02:04:43.747] Timer tick, asking Buildbucket for the build status
[02:04:43.826] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:04:43.826] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:23:0) after 1m0s
[02:05:43.864] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:23:0)
[02:05:43.864] Timer tick, asking Buildbucket for the build status
[02:05:44.009] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:05:44.009] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:24:0) after 1m0s
[02:06:44.011] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:24:0)
[02:06:44.011] Timer tick, asking Buildbucket for the build status
[02:06:44.104] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:06:44.104] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:25:0) after 1m0s
[02:07:44.156] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:25:0)
[02:07:44.156] Timer tick, asking Buildbucket for the build status
[02:07:44.250] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:07:44.250] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:26:0) after 1m0s
[02:08:44.418] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:26:0)
[02:08:44.419] Timer tick, asking Buildbucket for the build status
[02:08:44.528] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:08:44.528] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:27:0) after 1m0s
[02:09:44.530] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:27:0)
[02:09:44.530] Timer tick, asking Buildbucket for the build status
[02:09:52.613] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:09:52.613] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:28:0) after 1m0s
[02:10:52.595] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:28:0)
[02:10:52.596] Timer tick, asking Buildbucket for the build status
[02:10:52.753] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:10:52.753] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:29:0) after 1m0s
[02:11:52.815] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:29:0)
[02:11:52.815] Timer tick, asking Buildbucket for the build status
[02:11:52.927] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:11:52.927] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:30:0) after 1m0s
[02:12:52.933] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:30:0)
[02:12:52.933] Timer tick, asking Buildbucket for the build status
[02:12:56.219] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:12:56.219] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:31:0) after 1m0s
[02:13:56.255] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:31:0)
[02:13:56.255] Timer tick, asking Buildbucket for the build status
[02:13:56.566] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:13:56.566] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:32:0) after 1m0s
[02:14:56.615] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:32:0)
[02:14:56.615] Timer tick, asking Buildbucket for the build status
[02:14:56.697] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:14:56.697] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:33:0) after 1m0s
[02:15:56.738] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:33:0)
[02:15:56.738] Timer tick, asking Buildbucket for the build status
[02:15:56.821] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:15:56.821] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:34:0) after 1m0s
[02:16:56.895] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:34:0)
[02:16:56.895] Timer tick, asking Buildbucket for the build status
[02:16:56.975] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:16:56.975] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:35:0) after 1m0s
[02:17:57.133] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:35:0)
[02:17:57.133] Timer tick, asking Buildbucket for the build status
[02:17:57.267] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:17:57.267] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:36:0) after 1m0s
[02:18:57.257] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:36:0)
[02:18:57.257] Timer tick, asking Buildbucket for the build status
[02:18:57.373] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:18:57.373] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:37:0) after 1m0s
[02:19:57.680] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:37:0)
[02:19:57.680] Timer tick, asking Buildbucket for the build status
[02:19:58.073] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:19:58.073] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:38:0) after 1m0s
[02:20:58.229] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:38:0)
[02:20:58.229] Timer tick, asking Buildbucket for the build status
[02:20:58.317] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:20:58.317] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:39:0) after 1m0s
[02:21:58.707] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:39:0)
[02:21:58.707] Timer tick, asking Buildbucket for the build status
[02:21:58.795] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:21:58.795] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:40:0) after 1m0s
[02:22:58.824] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:40:0)
[02:22:58.824] Timer tick, asking Buildbucket for the build status
[02:22:58.906] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:22:58.906] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:41:0) after 1m0s
[02:23:58.954] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:41:0)
[02:23:58.954] Timer tick, asking Buildbucket for the build status
[02:23:59.068] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:23:59.068] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:42:0) after 1m0s
[02:24:59.095] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:42:0)
[02:24:59.095] Timer tick, asking Buildbucket for the build status
[02:24:59.233] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:24:59.233] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:43:0) after 1m0s
[02:25:59.294] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:43:0)
[02:25:59.294] Timer tick, asking Buildbucket for the build status
[02:25:59.364] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:25:59.364] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:44:0) after 1m0s
[02:26:59.354] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:44:0)
[02:26:59.354] Timer tick, asking Buildbucket for the build status
[02:26:59.425] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:26:59.425] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:45:0) after 1m0s
[02:27:59.497] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:45:0)
[02:27:59.497] Timer tick, asking Buildbucket for the build status
[02:27:59.813] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:27:59.813] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:46:0) after 1m0s
[02:28:59.975] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:46:0)
[02:28:59.975] Timer tick, asking Buildbucket for the build status
[02:29:00.277] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:29:00.277] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:47:0) after 1m0s
[02:30:00.368] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:47:0)
[02:30:00.368] Timer tick, asking Buildbucket for the build status
[02:30:00.583] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:30:00.583] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:48:0) after 1m0s
[02:31:01.129] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:48:0)
[02:31:01.129] Timer tick, asking Buildbucket for the build status
[02:31:01.468] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:31:01.468] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:49:0) after 1m0s
[02:32:01.666] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:49:0)
[02:32:01.666] Timer tick, asking Buildbucket for the build status
[02:32:02.245] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:32:02.245] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:50:0) after 1m0s
[02:33:02.287] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:50:0)
[02:33:02.287] Timer tick, asking Buildbucket for the build status
[02:33:02.381] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:33:02.381] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:51:0) after 1m0s
[02:34:02.408] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:51:0)
[02:34:02.408] Timer tick, asking Buildbucket for the build status
[02:34:02.691] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:34:02.691] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:52:0) after 1m0s
[02:35:02.761] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:52:0)
[02:35:02.761] Timer tick, asking Buildbucket for the build status
[02:35:03.118] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:35:03.118] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:53:0) after 1m0s
[02:36:03.133] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:53:0)
[02:36:03.133] Timer tick, asking Buildbucket for the build status
[02:36:03.213] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:36:03.213] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:54:0) after 1m0s
[02:37:03.232] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:54:0)
[02:37:03.232] Timer tick, asking Buildbucket for the build status
[02:37:03.525] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:37:03.525] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:55:0) after 1m0s
[02:38:03.605] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:55:0)
[02:38:03.606] Timer tick, asking Buildbucket for the build status
[02:38:03.885] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:38:03.885] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:56:0) after 1m0s
[02:39:03.968] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:56:0)
[02:39:03.968] Timer tick, asking Buildbucket for the build status
[02:39:04.087] Build 8858622130388925536: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:39:04.087] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:57:0) after 1m0s
[02:39:14.054] Received PubSub notification, asking Buildbucket for the build status
[02:39:14.119] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:04.105] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:57:0)
[02:40:04.105] Timer tick, asking Buildbucket for the build status
[02:40:04.242] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:04.242] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:59:0) after 1m0s
[02:41:04.264] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:59:0)
[02:41:04.264] Timer tick, asking Buildbucket for the build status
[02:41:04.554] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:04.554] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:60:0) after 1m0s
[02:42:04.610] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:60:0)
[02:42:04.610] Timer tick, asking Buildbucket for the build status
[02:42:04.953] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:04.953] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:61:0) after 1m0s
[02:43:04.959] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:61:0)
[02:43:04.959] Timer tick, asking Buildbucket for the build status
[02:43:05.023] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:05.023] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:62:0) after 1m0s
[02:44:05.014] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:62:0)
[02:44:05.015] Timer tick, asking Buildbucket for the build status
[02:44:05.235] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:05.235] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:63:0) after 1m0s
[02:45:05.307] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:63:0)
[02:45:05.307] Timer tick, asking Buildbucket for the build status
[02:45:05.419] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:05.419] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:64:0) after 1m0s
[02:46:05.439] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:64:0)
[02:46:05.439] Timer tick, asking Buildbucket for the build status
[02:46:05.893] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:05.893] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:65:0) after 1m0s
[02:47:05.943] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:65:0)
[02:47:05.943] Timer tick, asking Buildbucket for the build status
[02:47:06.396] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:06.396] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:66:0) after 1m0s
[02:48:06.425] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:66:0)
[02:48:06.425] Timer tick, asking Buildbucket for the build status
[02:48:06.541] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:06.541] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:67:0) after 1m0s
[02:49:06.569] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:67:0)
[02:49:06.569] Timer tick, asking Buildbucket for the build status
[02:49:07.293] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:07.293] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:68:0) after 1m0s
[02:50:07.355] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:68:0)
[02:50:07.355] Timer tick, asking Buildbucket for the build status
[02:50:07.644] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:07.644] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:69:0) after 1m0s
[02:51:07.734] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:69:0)
[02:51:07.734] Timer tick, asking Buildbucket for the build status
[02:51:07.846] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:07.846] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:70:0) after 1m0s
[02:52:07.890] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:70:0)
[02:52:07.890] Timer tick, asking Buildbucket for the build status
[02:52:08.101] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:08.101] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:71:0) after 1m0s
[02:53:08.183] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:71:0)
[02:53:08.183] Timer tick, asking Buildbucket for the build status
[02:53:08.400] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:08.400] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:72:0) after 1m0s
[02:54:08.420] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:72:0)
[02:54:08.420] Timer tick, asking Buildbucket for the build status
[02:54:08.552] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:08.552] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:73:0) after 1m0s
[02:55:08.548] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:73:0)
[02:55:08.548] Timer tick, asking Buildbucket for the build status
[02:55:08.608] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:08.608] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:74:0) after 1m0s
[02:56:08.632] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:74:0)
[02:56:08.632] Timer tick, asking Buildbucket for the build status
[02:56:08.704] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:08.704] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:75:0) after 1m0s
[02:57:08.758] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:75:0)
[02:57:08.758] Timer tick, asking Buildbucket for the build status
[02:57:08.830] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:08.830] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:76:0) after 1m0s
[02:58:08.899] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:76:0)
[02:58:08.899] Timer tick, asking Buildbucket for the build status
[02:58:08.987] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:08.987] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:77:0) after 1m0s
[02:59:08.995] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:77:0)
[02:59:08.995] Timer tick, asking Buildbucket for the build status
[02:59:09.107] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:09.107] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:78:0) after 1m0s
[03:00:09.163] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:78:0)
[03:00:09.163] Timer tick, asking Buildbucket for the build status
[03:00:09.315] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:09.315] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:79:0) after 1m0s
[03:01:09.378] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:79:0)
[03:01:09.378] Timer tick, asking Buildbucket for the build status
[03:01:09.782] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:09.782] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:80:0) after 1m0s
[03:02:09.805] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:80:0)
[03:02:09.805] Timer tick, asking Buildbucket for the build status
[03:02:09.934] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:09.934] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:81:0) after 1m0s
[03:03:10.005] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:81:0)
[03:03:10.005] Timer tick, asking Buildbucket for the build status
[03:03:10.145] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:10.145] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:82:0) after 1m0s
[03:04:10.224] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:82:0)
[03:04:10.224] Timer tick, asking Buildbucket for the build status
[03:04:10.335] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:10.335] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:83:0) after 1m0s
[03:05:10.386] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:83:0)
[03:05:10.386] Timer tick, asking Buildbucket for the build status
[03:05:10.709] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:10.709] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:84:0) after 1m0s
[03:06:10.794] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:84:0)
[03:06:10.794] Timer tick, asking Buildbucket for the build status
[03:06:10.871] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:10.871] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:85:0) after 1m0s
[03:07:10.934] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:85:0)
[03:07:10.934] Timer tick, asking Buildbucket for the build status
[03:07:11.047] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:11.047] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:86:0) after 1m0s
[03:08:11.111] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:86:0)
[03:08:11.111] Timer tick, asking Buildbucket for the build status
[03:08:11.173] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:11.173] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:87:0) after 1m0s
[03:09:11.268] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:87:0)
[03:09:11.268] Timer tick, asking Buildbucket for the build status
[03:09:11.568] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:11.568] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:88:0) after 1m0s
[03:10:11.612] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:88:0)
[03:10:11.612] Timer tick, asking Buildbucket for the build status
[03:10:11.734] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:11.734] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:89:0) after 1m0s
[03:11:11.767] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:89:0)
[03:11:11.767] Timer tick, asking Buildbucket for the build status
[03:11:12.001] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:12.001] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:90:0) after 1m0s
[03:12:12.037] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:90:0)
[03:12:12.037] Timer tick, asking Buildbucket for the build status
[03:12:12.141] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:12.141] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:91:0) after 1m0s
[03:13:12.204] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:91:0)
[03:13:12.204] Timer tick, asking Buildbucket for the build status
[03:13:12.265] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:12.266] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:92:0) after 1m0s
[03:14:12.404] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:92:0)
[03:14:12.404] Timer tick, asking Buildbucket for the build status
[03:14:12.500] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:12.500] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:93:0) after 1m0s
[03:15:12.599] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:93:0)
[03:15:12.599] Timer tick, asking Buildbucket for the build status
[03:15:12.871] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:12.871] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:94:0) after 1m0s
[03:16:12.959] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:94:0)
[03:16:12.959] Timer tick, asking Buildbucket for the build status
[03:16:13.049] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:13.049] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:95:0) after 1m0s
[03:17:13.131] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:95:0)
[03:17:13.131] Timer tick, asking Buildbucket for the build status
[03:17:15.054] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:15.054] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:96:0) after 1m0s
[03:18:15.141] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:96:0)
[03:18:15.141] Timer tick, asking Buildbucket for the build status
[03:18:15.204] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:15.204] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:97:0) after 1m0s
[03:19:15.265] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:97:0)
[03:19:15.265] Timer tick, asking Buildbucket for the build status
[03:19:15.770] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:15.770] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:98:0) after 1m0s
[03:20:15.850] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:98:0)
[03:20:15.850] Timer tick, asking Buildbucket for the build status
[03:20:15.975] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:15.975] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:99:0) after 1m0s
[03:21:16.127] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:99:0)
[03:21:16.127] Timer tick, asking Buildbucket for the build status
[03:21:16.328] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:16.328] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:100:0) after 1m0s
[03:22:16.542] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:100:0)
[03:22:16.542] Timer tick, asking Buildbucket for the build status
[03:22:16.713] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:16.713] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:101:0) after 1m0s
[03:23:16.765] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:101:0)
[03:23:16.765] Timer tick, asking Buildbucket for the build status
[03:23:17.126] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:17.126] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:102:0) after 1m0s
[03:24:17.206] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:102:0)
[03:24:17.206] Timer tick, asking Buildbucket for the build status
[03:24:17.326] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:17.326] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:103:0) after 1m0s
[03:25:17.353] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:103:0)
[03:25:17.353] Timer tick, asking Buildbucket for the build status
[03:25:17.716] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:17.716] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:104:0) after 1m0s
[03:26:17.815] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:104:0)
[03:26:17.815] Timer tick, asking Buildbucket for the build status
[03:26:17.920] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:17.920] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:105:0) after 1m0s
[03:27:17.950] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:105:0)
[03:27:17.950] Timer tick, asking Buildbucket for the build status
[03:27:18.016] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:18.016] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:106:0) after 1m0s
[03:28:18.129] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:106:0)
[03:28:18.129] Timer tick, asking Buildbucket for the build status
[03:28:18.208] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:18.208] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:107:0) after 1m0s
[03:29:18.310] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:107:0)
[03:29:18.310] Timer tick, asking Buildbucket for the build status
[03:29:18.422] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:18.422] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:108:0) after 1m0s
[03:30:18.411] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:108:0)
[03:30:18.411] Timer tick, asking Buildbucket for the build status
[03:30:18.532] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:18.532] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:109:0) after 1m0s
[03:31:18.646] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:109:0)
[03:31:18.646] Timer tick, asking Buildbucket for the build status
[03:31:18.868] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:18.868] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:110:0) after 1m0s
[03:32:19.018] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:110:0)
[03:32:19.018] Timer tick, asking Buildbucket for the build status
[03:32:19.093] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:19.093] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:111:0) after 1m0s
[03:33:19.089] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:111:0)
[03:33:19.089] Timer tick, asking Buildbucket for the build status
[03:33:19.154] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:19.154] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:112:0) after 1m0s
[03:34:19.239] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:112:0)
[03:34:19.239] Timer tick, asking Buildbucket for the build status
[03:34:19.355] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:19.355] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:113:0) after 1m0s
[03:35:19.459] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:113:0)
[03:35:19.459] Timer tick, asking Buildbucket for the build status
[03:35:19.520] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:19.520] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:114:0) after 1m0s
[03:36:19.617] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:114:0)
[03:36:19.617] Timer tick, asking Buildbucket for the build status
[03:36:19.673] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:19.673] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:115:0) after 1m0s
[03:37:19.750] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:115:0)
[03:37:19.750] Timer tick, asking Buildbucket for the build status
[03:37:19.949] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:19.949] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:116:0) after 1m0s
[03:38:20.052] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:116:0)
[03:38:20.052] Timer tick, asking Buildbucket for the build status
[03:38:20.282] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:20.282] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:117:0) after 1m0s
[03:39:20.449] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:117:0)
[03:39:20.449] Timer tick, asking Buildbucket for the build status
[03:39:20.780] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:20.780] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:118:0) after 1m0s
[03:40:20.809] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:118:0)
[03:40:20.809] Timer tick, asking Buildbucket for the build status
[03:40:20.867] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:20.867] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:119:0) after 1m0s
[03:41:20.981] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:119:0)
[03:41:20.981] Timer tick, asking Buildbucket for the build status
[03:41:21.223] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:21.223] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:120:0) after 1m0s
[03:42:21.222] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:120:0)
[03:42:21.222] Timer tick, asking Buildbucket for the build status
[03:42:21.276] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:21.276] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:121:0) after 1m0s
[03:43:21.305] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:121:0)
[03:43:21.305] Timer tick, asking Buildbucket for the build status
[03:43:22.836] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:22.836] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:122:0) after 1m0s
[03:44:22.889] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:122:0)
[03:44:22.889] Timer tick, asking Buildbucket for the build status
[03:44:23.216] Build 8858622130388925536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:23.216] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024052192410184128:123:0) after 1m0s
[03:44:28.156] Received PubSub notification, asking Buildbucket for the build status
[03:44:28.867] Build 8858622130388925536: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:44:28.867] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"completed_ts": "1610163867062819",
"created_by": "project:emscripten-releases",
"created_ts": "1610156617708203",
"id": "8858622130388925536",
"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\": \"f36e69f27261fd0fa9e3d3decbcce1ba271fd25b\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@f36e69f27261fd0fa9e3d3decbcce1ba271fd25b\", \"title\": \"f36e69f27261fd0fa9e3d3decbcce1ba271fd25b\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/f36e69f27261fd0fa9e3d3decbcce1ba271fd25b\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"f36e69f27261fd0fa9e3d3decbcce1ba271fd25b\"}}",
"project": "emscripten-releases",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"f36e69f27261fd0fa9e3d3decbcce1ba271fd25b\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@f36e69f27261fd0fa9e3d3decbcce1ba271fd25b\", \"title\": \"f36e69f27261fd0fa9e3d3decbcce1ba271fd25b\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/f36e69f27261fd0fa9e3d3decbcce1ba271fd25b\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-win10-0-pkix\", \"branch\": \"refs/heads/master\", \"buildername\": \"win\", \"got_revision\": \"f36e69f27261fd0fa9e3d3decbcce1ba271fd25b\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"f36e69f27261fd0fa9e3d3decbcce1ba271fd25b\"}, \"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-pkix\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"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\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1610159953261505",
"status": "COMPLETED",
"status_changed_ts": "1610163867741684",
"tags": [
"builder:win",
"buildset:commit/git/f36e69f27261fd0fa9e3d3decbcce1ba271fd25b",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/f36e69f27261fd0fa9e3d3decbcce1ba271fd25b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024052192410184128",
"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/8858622130388925536/+/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:50fda1bb8f089610",
"user_agent:luci-scheduler"
],
"updated_ts": "1610163867768873",
"url": "https://ci.chromium.org/b/8858622130388925536",
"utcnow_ts": "1610163868859279"
}
}
[03:44:28.867] Invocation finished in 2h0m52.470791095s with status SUCCEEDED