[01:40:52.188] New invocation is queued and will start shortly
[01:40:53.383] Starting the invocation (attempt 1)
[01:40:53.430] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:40:53.430] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:40:53.430] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9021787440450372320",
"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\":\"358c9a79bfd7f414101bbb7057660dc87418f2b5\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@358c9a79bfd7f414101bbb7057660dc87418f2b5\",\"title\":\"358c9a79bfd7f414101bbb7057660dc87418f2b5\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/358c9a79bfd7f414101bbb7057660dc87418f2b5\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"358c9a79bfd7f414101bbb7057660dc87418f2b5\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win",
"scheduler_invocation_id:9021787440450372320",
"scheduler_job_id:emscripten-releases/win",
"user_agent:luci-scheduler",
"buildset:commit/git/358c9a79bfd7f414101bbb7057660dc87418f2b5",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/358c9a79bfd7f414101bbb7057660dc87418f2b5",
"gitiles_ref:refs/heads/master"
]
}
[01:40:53.953] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:emscripten-releases",
"created_ts": "1612316453587826",
"id": "8856357378321377968",
"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\": \"358c9a79bfd7f414101bbb7057660dc87418f2b5\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@358c9a79bfd7f414101bbb7057660dc87418f2b5\", \"title\": \"358c9a79bfd7f414101bbb7057660dc87418f2b5\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/358c9a79bfd7f414101bbb7057660dc87418f2b5\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"358c9a79bfd7f414101bbb7057660dc87418f2b5\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612316453827549",
"tags": [
"builder:win",
"buildset:commit/git/358c9a79bfd7f414101bbb7057660dc87418f2b5",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/358c9a79bfd7f414101bbb7057660dc87418f2b5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021787440450372320",
"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/8856357378321377968/+/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": "1612316453827656",
"url": "https://ci.chromium.org/b/8856357378321377968",
"utcnow_ts": "1612316453945796"
}
}
[01:40:53.953] Task URL: https://ci.chromium.org/b/8856357378321377968
[01:40:53.953] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:2:0) after 1m0s
[01:41:54.103] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:2:0)
[01:41:54.103] Timer tick, asking Buildbucket for the build status
[01:41:54.306] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:41:54.306] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:3:0) after 1m0s
[01:42:54.588] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:3:0)
[01:42:54.588] Timer tick, asking Buildbucket for the build status
[01:42:54.839] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:42:54.839] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:4:0) after 1m0s
[01:43:54.937] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:4:0)
[01:43:54.937] Timer tick, asking Buildbucket for the build status
[01:43:55.255] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:43:55.255] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:5:0) after 1m0s
[01:44:55.316] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:5:0)
[01:44:55.316] Timer tick, asking Buildbucket for the build status
[01:44:55.590] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:44:55.590] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:6:0) after 1m0s
[01:45:55.615] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:6:0)
[01:45:55.615] Timer tick, asking Buildbucket for the build status
[01:45:55.709] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:45:55.709] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:7:0) after 1m0s
[01:46:55.735] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:7:0)
[01:46:55.735] Timer tick, asking Buildbucket for the build status
[01:46:55.816] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:46:55.816] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:8:0) after 1m0s
[01:47:55.834] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:8:0)
[01:47:55.834] Timer tick, asking Buildbucket for the build status
[01:47:55.915] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:47:55.915] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:9:0) after 1m0s
[01:48:55.930] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:9:0)
[01:48:55.930] Timer tick, asking Buildbucket for the build status
[01:48:56.012] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:48:56.012] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:10:0) after 1m0s
[01:49:56.094] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:10:0)
[01:49:56.094] Timer tick, asking Buildbucket for the build status
[01:49:56.215] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:49:56.215] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:11:0) after 1m0s
[01:50:56.241] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:11:0)
[01:50:56.241] Timer tick, asking Buildbucket for the build status
[01:50:56.601] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:50:56.601] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:12:0) after 1m0s
[01:51:56.738] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:12:0)
[01:51:56.739] Timer tick, asking Buildbucket for the build status
[01:51:56.835] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:51:56.835] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:13:0) after 1m0s
[01:52:56.858] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:13:0)
[01:52:56.858] Timer tick, asking Buildbucket for the build status
[01:52:57.132] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:52:57.132] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:14:0) after 1m0s
[01:53:57.520] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:14:0)
[01:53:57.520] Timer tick, asking Buildbucket for the build status
[01:53:57.919] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:53:57.919] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:15:0) after 1m0s
[01:54:58.083] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:15:0)
[01:54:58.083] Timer tick, asking Buildbucket for the build status
[01:54:58.154] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:54:58.154] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:16:0) after 1m0s
[01:55:58.741] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:16:0)
[01:55:58.741] Timer tick, asking Buildbucket for the build status
[01:55:58.837] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:55:58.837] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:17:0) after 1m0s
[01:56:58.921] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:17:0)
[01:56:58.921] Timer tick, asking Buildbucket for the build status
[01:56:58.994] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:56:58.994] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:18:0) after 1m0s
[01:57:59.012] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:18:0)
[01:57:59.012] Timer tick, asking Buildbucket for the build status
[01:57:59.352] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:57:59.352] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:19:0) after 1m0s
[01:58:59.399] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:19:0)
[01:58:59.399] Timer tick, asking Buildbucket for the build status
[01:58:59.487] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:58:59.487] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:20:0) after 1m0s
[01:59:59.593] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:20:0)
[01:59:59.593] Timer tick, asking Buildbucket for the build status
[01:59:59.804] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:59:59.804] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:21:0) after 1m0s
[02:00:59.870] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:21:0)
[02:00:59.870] Timer tick, asking Buildbucket for the build status
[02:01:00.382] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:01:00.382] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:22:0) after 1m0s
[02:02:00.693] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:22:0)
[02:02:00.693] Timer tick, asking Buildbucket for the build status
[02:02:00.848] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:02:00.848] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:23:0) after 1m0s
[02:03:01.712] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:23:0)
[02:03:01.712] Timer tick, asking Buildbucket for the build status
[02:03:01.931] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:03:01.931] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:24:0) after 1m0s
[02:04:01.954] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:24:0)
[02:04:01.954] Timer tick, asking Buildbucket for the build status
[02:04:02.046] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:04:02.046] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:25:0) after 1m0s
[02:05:02.129] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:25:0)
[02:05:02.129] Timer tick, asking Buildbucket for the build status
[02:05:02.239] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:05:02.239] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:26:0) after 1m0s
[02:06:02.644] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:26:0)
[02:06:02.644] Timer tick, asking Buildbucket for the build status
[02:06:02.751] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:06:02.751] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:27:0) after 1m0s
[02:07:02.766] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:27:0)
[02:07:02.766] Timer tick, asking Buildbucket for the build status
[02:07:02.848] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:07:02.848] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:28:0) after 1m0s
[02:08:02.850] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:28:0)
[02:08:02.850] Timer tick, asking Buildbucket for the build status
[02:08:03.282] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:08:03.282] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:29:0) after 1m0s
[02:09:03.298] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:29:0)
[02:09:03.298] Timer tick, asking Buildbucket for the build status
[02:09:03.460] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:09:03.460] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:30:0) after 1m0s
[02:10:03.475] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:30:0)
[02:10:03.475] Timer tick, asking Buildbucket for the build status
[02:10:03.660] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:10:03.660] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:31:0) after 1m0s
[02:11:03.710] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:31:0)
[02:11:03.710] Timer tick, asking Buildbucket for the build status
[02:11:03.918] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:11:03.918] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:32:0) after 1m0s
[02:12:03.935] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:32:0)
[02:12:03.935] Timer tick, asking Buildbucket for the build status
[02:12:04.026] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:12:04.026] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:33:0) after 1m0s
[02:13:04.076] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:33:0)
[02:13:04.076] Timer tick, asking Buildbucket for the build status
[02:13:04.152] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:13:04.152] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:34:0) after 1m0s
[02:14:04.244] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:34:0)
[02:14:04.244] Timer tick, asking Buildbucket for the build status
[02:14:04.340] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:14:04.340] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:35:0) after 1m0s
[02:15:04.469] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:35:0)
[02:15:04.469] Timer tick, asking Buildbucket for the build status
[02:15:04.601] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:15:04.601] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:36:0) after 1m0s
[02:16:04.670] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:36:0)
[02:16:04.670] Timer tick, asking Buildbucket for the build status
[02:16:04.784] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:16:04.784] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:37:0) after 1m0s
[02:17:04.910] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:37:0)
[02:17:04.910] Timer tick, asking Buildbucket for the build status
[02:17:05.152] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:17:05.152] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:38:0) after 1m0s
[02:18:05.213] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:38:0)
[02:18:05.213] Timer tick, asking Buildbucket for the build status
[02:18:05.315] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:18:05.315] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:39:0) after 1m0s
[02:19:05.339] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:39:0)
[02:19:05.339] Timer tick, asking Buildbucket for the build status
[02:19:05.456] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:19:05.456] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:40:0) after 1m0s
[02:20:05.550] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:40:0)
[02:20:05.550] Timer tick, asking Buildbucket for the build status
[02:20:05.650] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:20:05.650] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:41:0) after 1m0s
[02:21:05.741] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:41:0)
[02:21:05.741] Timer tick, asking Buildbucket for the build status
[02:21:05.965] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:21:05.965] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:42:0) after 1m0s
[02:22:06.120] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:42:0)
[02:22:06.120] Timer tick, asking Buildbucket for the build status
[02:22:06.450] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:22:06.450] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:43:0) after 1m0s
[02:23:06.469] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:43:0)
[02:23:06.469] Timer tick, asking Buildbucket for the build status
[02:23:06.552] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:23:06.552] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:44:0) after 1m0s
[02:24:06.595] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:44:0)
[02:24:06.595] Timer tick, asking Buildbucket for the build status
[02:24:06.911] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:24:06.911] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:45:0) after 1m0s
[02:25:06.929] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:45:0)
[02:25:06.929] Timer tick, asking Buildbucket for the build status
[02:25:07.003] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:25:07.004] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:46:0) after 1m0s
[02:26:07.034] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:46:0)
[02:26:07.034] Timer tick, asking Buildbucket for the build status
[02:26:07.139] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:26:07.139] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:47:0) after 1m0s
[02:27:07.201] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:47:0)
[02:27:07.201] Timer tick, asking Buildbucket for the build status
[02:27:07.292] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:27:07.292] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:48:0) after 1m0s
[02:28:07.367] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:48:0)
[02:28:07.367] Timer tick, asking Buildbucket for the build status
[02:28:07.551] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:28:07.551] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:49:0) after 1m0s
[02:29:07.578] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:49:0)
[02:29:07.578] Timer tick, asking Buildbucket for the build status
[02:29:07.715] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:29:07.715] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:50:0) after 1m0s
[02:30:07.750] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:50:0)
[02:30:07.750] Timer tick, asking Buildbucket for the build status
[02:30:07.927] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:30:07.927] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:51:0) after 1m0s
[02:31:07.919] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:51:0)
[02:31:07.919] Timer tick, asking Buildbucket for the build status
[02:31:08.049] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:31:08.049] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:52:0) after 1m0s
[02:32:08.054] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:52:0)
[02:32:08.054] Timer tick, asking Buildbucket for the build status
[02:32:08.438] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:32:08.438] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:53:0) after 1m0s
[02:33:08.559] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:53:0)
[02:33:08.559] Timer tick, asking Buildbucket for the build status
[02:33:08.641] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:33:08.641] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:54:0) after 1m0s
[02:34:08.813] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:54:0)
[02:34:08.813] Timer tick, asking Buildbucket for the build status
[02:34:09.046] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:34:09.046] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:55:0) after 1m0s
[02:35:09.207] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:55:0)
[02:35:09.207] Timer tick, asking Buildbucket for the build status
[02:35:09.308] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:35:09.308] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:56:0) after 1m0s
[02:36:09.390] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:56:0)
[02:36:09.390] Timer tick, asking Buildbucket for the build status
[02:36:09.698] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:36:09.698] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:57:0) after 1m0s
[02:37:09.735] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:57:0)
[02:37:09.735] Timer tick, asking Buildbucket for the build status
[02:37:09.820] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:37:09.820] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:58:0) after 1m0s
[02:38:09.816] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:58:0)
[02:38:09.816] Timer tick, asking Buildbucket for the build status
[02:38:09.908] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:38:09.908] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:59:0) after 1m0s
[02:39:09.920] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:59:0)
[02:39:09.920] Timer tick, asking Buildbucket for the build status
[02:39:10.007] Build 8856357378321377968: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:39:10.007] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:60:0) after 1m0s
[02:39:20.855] Received PubSub notification, asking Buildbucket for the build status
[02:39:21.042] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:10.040] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:60:0)
[02:40:10.040] Timer tick, asking Buildbucket for the build status
[02:40:10.153] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:10.153] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:62:0) after 1m0s
[02:41:10.227] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:62:0)
[02:41:10.227] Timer tick, asking Buildbucket for the build status
[02:41:10.328] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:10.328] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:63:0) after 1m0s
[02:42:10.363] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:63:0)
[02:42:10.363] Timer tick, asking Buildbucket for the build status
[02:42:10.478] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:10.478] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:64:0) after 1m0s
[02:43:10.512] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:64:0)
[02:43:10.512] Timer tick, asking Buildbucket for the build status
[02:43:10.653] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:10.653] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:65:0) after 1m0s
[02:44:10.708] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:65:0)
[02:44:10.708] Timer tick, asking Buildbucket for the build status
[02:44:10.920] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:10.920] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:66:0) after 1m0s
[02:45:10.949] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:66:0)
[02:45:10.949] Timer tick, asking Buildbucket for the build status
[02:45:11.023] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:11.023] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:67:0) after 1m0s
[02:46:11.125] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:67:0)
[02:46:11.125] Timer tick, asking Buildbucket for the build status
[02:46:11.302] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:11.302] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:68:0) after 1m0s
[02:47:11.418] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:68:0)
[02:47:11.418] Timer tick, asking Buildbucket for the build status
[02:47:11.503] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:11.503] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:69:0) after 1m0s
[02:48:11.766] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:69:0)
[02:48:11.766] Timer tick, asking Buildbucket for the build status
[02:48:11.832] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:11.832] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:70:0) after 1m0s
[02:49:12.006] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:70:0)
[02:49:12.006] Timer tick, asking Buildbucket for the build status
[02:49:12.094] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:12.094] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:71:0) after 1m0s
[02:50:12.162] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:71:0)
[02:50:12.162] Timer tick, asking Buildbucket for the build status
[02:50:12.229] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:12.229] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:72:0) after 1m0s
[02:51:12.340] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:72:0)
[02:51:12.341] Timer tick, asking Buildbucket for the build status
[02:51:12.545] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:12.545] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:73:0) after 1m0s
[02:52:12.621] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:73:0)
[02:52:12.621] Timer tick, asking Buildbucket for the build status
[02:52:12.834] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:12.834] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:74:0) after 1m0s
[02:53:12.895] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:74:0)
[02:53:12.895] Timer tick, asking Buildbucket for the build status
[02:53:12.956] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:12.956] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:75:0) after 1m0s
[02:54:13.001] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:75:0)
[02:54:13.001] Timer tick, asking Buildbucket for the build status
[02:54:13.130] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:13.130] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:76:0) after 1m0s
[02:55:13.220] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:76:0)
[02:55:13.220] Timer tick, asking Buildbucket for the build status
[02:55:13.330] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:13.330] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:77:0) after 1m0s
[02:56:13.473] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:77:0)
[02:56:13.473] Timer tick, asking Buildbucket for the build status
[02:56:13.567] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:13.567] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:78:0) after 1m0s
[02:57:13.670] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:78:0)
[02:57:13.670] Timer tick, asking Buildbucket for the build status
[02:57:13.739] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:13.739] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:79:0) after 1m0s
[02:58:13.782] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:79:0)
[02:58:13.782] Timer tick, asking Buildbucket for the build status
[02:58:13.945] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:13.945] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:80:0) after 1m0s
[02:59:13.963] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:80:0)
[02:59:13.963] Timer tick, asking Buildbucket for the build status
[02:59:14.042] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:14.042] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:81:0) after 1m0s
[03:00:14.084] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:81:0)
[03:00:14.084] Timer tick, asking Buildbucket for the build status
[03:00:14.277] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:14.277] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:82:0) after 1m0s
[03:01:14.475] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:82:0)
[03:01:14.475] Timer tick, asking Buildbucket for the build status
[03:01:14.751] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:14.751] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:83:0) after 1m0s
[03:02:14.861] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:83:0)
[03:02:14.861] Timer tick, asking Buildbucket for the build status
[03:02:14.975] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:14.975] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:84:0) after 1m0s
[03:03:15.118] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:84:0)
[03:03:15.118] Timer tick, asking Buildbucket for the build status
[03:03:15.351] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:15.351] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:85:0) after 1m0s
[03:04:15.513] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:85:0)
[03:04:15.513] Timer tick, asking Buildbucket for the build status
[03:04:15.581] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:15.581] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:86:0) after 1m0s
[03:05:15.574] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:86:0)
[03:05:15.574] Timer tick, asking Buildbucket for the build status
[03:05:15.833] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:15.833] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:87:0) after 1m0s
[03:06:15.933] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:87:0)
[03:06:15.933] Timer tick, asking Buildbucket for the build status
[03:06:16.059] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:16.059] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:88:0) after 1m0s
[03:07:16.165] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:88:0)
[03:07:16.165] Timer tick, asking Buildbucket for the build status
[03:07:16.257] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:16.257] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:89:0) after 1m0s
[03:08:16.390] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:89:0)
[03:08:16.390] Timer tick, asking Buildbucket for the build status
[03:08:16.492] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:16.492] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:90:0) after 1m0s
[03:09:16.566] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:90:0)
[03:09:16.566] Timer tick, asking Buildbucket for the build status
[03:09:16.930] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:16.930] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:91:0) after 1m0s
[03:10:16.975] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:91:0)
[03:10:16.975] Timer tick, asking Buildbucket for the build status
[03:10:17.034] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:17.034] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:92:0) after 1m0s
[03:11:17.086] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:92:0)
[03:11:17.087] Timer tick, asking Buildbucket for the build status
[03:11:17.254] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:17.254] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:93:0) after 1m0s
[03:12:17.312] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:93:0)
[03:12:17.312] Timer tick, asking Buildbucket for the build status
[03:12:17.368] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:17.368] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:94:0) after 1m0s
[03:13:17.452] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:94:0)
[03:13:17.452] Timer tick, asking Buildbucket for the build status
[03:13:17.521] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:17.521] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:95:0) after 1m0s
[03:14:17.545] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:95:0)
[03:14:17.545] Timer tick, asking Buildbucket for the build status
[03:14:17.770] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:17.770] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:96:0) after 1m0s
[03:15:17.821] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:96:0)
[03:15:17.821] Timer tick, asking Buildbucket for the build status
[03:15:17.914] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:17.914] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:97:0) after 1m0s
[03:16:17.934] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:97:0)
[03:16:17.934] Timer tick, asking Buildbucket for the build status
[03:16:18.035] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:18.035] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:98:0) after 1m0s
[03:17:18.051] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:98:0)
[03:17:18.051] Timer tick, asking Buildbucket for the build status
[03:17:18.113] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:18.113] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:99:0) after 1m0s
[03:18:18.256] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:99:0)
[03:18:18.256] Timer tick, asking Buildbucket for the build status
[03:18:18.327] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:18.327] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:100:0) after 1m0s
[03:19:18.403] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:100:0)
[03:19:18.403] Timer tick, asking Buildbucket for the build status
[03:19:18.553] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:18.553] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:101:0) after 1m0s
[03:20:18.615] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:101:0)
[03:20:18.615] Timer tick, asking Buildbucket for the build status
[03:20:18.679] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:18.679] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:102:0) after 1m0s
[03:21:18.687] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:102:0)
[03:21:18.687] Timer tick, asking Buildbucket for the build status
[03:21:18.788] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:18.788] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:103:0) after 1m0s
[03:22:18.873] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:103:0)
[03:22:18.873] Timer tick, asking Buildbucket for the build status
[03:22:19.001] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:19.001] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:104:0) after 1m0s
[03:23:19.011] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:104:0)
[03:23:19.012] Timer tick, asking Buildbucket for the build status
[03:23:19.147] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:19.147] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:105:0) after 1m0s
[03:24:19.254] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:105:0)
[03:24:19.254] Timer tick, asking Buildbucket for the build status
[03:24:19.371] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:19.371] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:106:0) after 1m0s
[03:25:19.734] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:106:0)
[03:25:19.734] Timer tick, asking Buildbucket for the build status
[03:25:21.333] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:21.333] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:107:0) after 1m0s
[03:26:21.414] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:107:0)
[03:26:21.414] Timer tick, asking Buildbucket for the build status
[03:26:21.510] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:21.510] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:108:0) after 1m0s
[03:27:21.649] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:108:0)
[03:27:21.649] Timer tick, asking Buildbucket for the build status
[03:27:21.730] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:21.730] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:109:0) after 1m0s
[03:28:21.764] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:109:0)
[03:28:21.764] Timer tick, asking Buildbucket for the build status
[03:28:21.833] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:21.833] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:110:0) after 1m0s
[03:29:22.098] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:110:0)
[03:29:22.098] Timer tick, asking Buildbucket for the build status
[03:29:22.152] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:22.152] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:111:0) after 1m0s
[03:30:22.267] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:111:0)
[03:30:22.267] Timer tick, asking Buildbucket for the build status
[03:30:22.348] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:22.348] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:112:0) after 1m0s
[03:31:22.458] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:112:0)
[03:31:22.458] Timer tick, asking Buildbucket for the build status
[03:31:22.591] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:22.591] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:113:0) after 1m0s
[03:32:22.642] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:113:0)
[03:32:22.642] Timer tick, asking Buildbucket for the build status
[03:32:22.696] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:22.696] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:114:0) after 1m0s
[03:33:22.719] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:114:0)
[03:33:22.719] Timer tick, asking Buildbucket for the build status
[03:33:22.962] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:22.962] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:115:0) after 1m0s
[03:34:23.057] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:115:0)
[03:34:23.057] Timer tick, asking Buildbucket for the build status
[03:34:23.167] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:23.167] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:116:0) after 1m0s
[03:35:23.249] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:116:0)
[03:35:23.249] Timer tick, asking Buildbucket for the build status
[03:35:23.332] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:23.332] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:117:0) after 1m0s
[03:36:23.388] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:117:0)
[03:36:23.388] Timer tick, asking Buildbucket for the build status
[03:36:23.490] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:23.491] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:118:0) after 1m0s
[03:37:23.550] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:118:0)
[03:37:23.550] Timer tick, asking Buildbucket for the build status
[03:37:23.738] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:23.738] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:119:0) after 1m0s
[03:38:23.766] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:119:0)
[03:38:23.766] Timer tick, asking Buildbucket for the build status
[03:38:23.848] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:23.848] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:120:0) after 1m0s
[03:39:23.898] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:120:0)
[03:39:23.898] Timer tick, asking Buildbucket for the build status
[03:39:24.102] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:24.102] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:121:0) after 1m0s
[03:40:24.127] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:121:0)
[03:40:24.127] Timer tick, asking Buildbucket for the build status
[03:40:24.187] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:24.187] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:122:0) after 1m0s
[03:41:24.206] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:122:0)
[03:41:24.206] Timer tick, asking Buildbucket for the build status
[03:41:24.318] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:24.318] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:123:0) after 1m0s
[03:42:24.326] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:123:0)
[03:42:24.326] Timer tick, asking Buildbucket for the build status
[03:42:24.387] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:24.387] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:124:0) after 1m0s
[03:43:24.499] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:124:0)
[03:43:24.499] Timer tick, asking Buildbucket for the build status
[03:43:24.557] Build 8856357378321377968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:24.557] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9021787440450372320:125:0) after 1m0s
[03:44:17.189] Received PubSub notification, asking Buildbucket for the build status
[03:44:17.503] Build 8856357378321377968: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:44:17.503] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1612323855997730",
"created_by": "project:emscripten-releases",
"created_ts": "1612316453587826",
"id": "8856357378321377968",
"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\": \"358c9a79bfd7f414101bbb7057660dc87418f2b5\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@358c9a79bfd7f414101bbb7057660dc87418f2b5\", \"title\": \"358c9a79bfd7f414101bbb7057660dc87418f2b5\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/358c9a79bfd7f414101bbb7057660dc87418f2b5\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"358c9a79bfd7f414101bbb7057660dc87418f2b5\"}}",
"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\": \"358c9a79bfd7f414101bbb7057660dc87418f2b5\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@358c9a79bfd7f414101bbb7057660dc87418f2b5\", \"title\": \"358c9a79bfd7f414101bbb7057660dc87418f2b5\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/358c9a79bfd7f414101bbb7057660dc87418f2b5\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-win10-0-zga0\", \"branch\": \"refs/heads/master\", \"buildername\": \"win\", \"got_revision\": \"358c9a79bfd7f414101bbb7057660dc87418f2b5\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"358c9a79bfd7f414101bbb7057660dc87418f2b5\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_0175bca77590805533ed6e20351c9bfa7effd036e42d11a5b619a6ce75a8e486_v2\", \"git\", \"goma_v2\", \"vpython\"], \"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-zga0\"], \"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\": [\"5676-c76598c\"], \"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": "1612319958627166",
"status": "COMPLETED",
"status_changed_ts": "1612323856515487",
"tags": [
"builder:win",
"buildset:commit/git/358c9a79bfd7f414101bbb7057660dc87418f2b5",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/358c9a79bfd7f414101bbb7057660dc87418f2b5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021787440450372320",
"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/8856357378321377968/+/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:517e5e35e136e610",
"user_agent:luci-scheduler"
],
"updated_ts": "1612323856683474",
"url": "https://ci.chromium.org/b/8856357378321377968",
"utcnow_ts": "1612323857490101"
}
}
[03:44:17.503] Invocation finished in 2h3m25.330272336s with status SUCCEEDED