[01:44:36.285] New invocation is queued and will start shortly
[01:44:37.586] Starting the invocation (attempt 1)
[01:44:37.698] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:44:37.698] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:44:37.698] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9040903165379272784",
"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\":\"641f9241173546557b9af5d0822ab971637a5bff\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@641f9241173546557b9af5d0822ab971637a5bff\",\"title\":\"641f9241173546557b9af5d0822ab971637a5bff\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/641f9241173546557b9af5d0822ab971637a5bff\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"641f9241173546557b9af5d0822ab971637a5bff\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win",
"scheduler_invocation_id:9040903165379272784",
"scheduler_job_id:emscripten-releases/win",
"user_agent:luci-scheduler",
"buildset:commit/git/641f9241173546557b9af5d0822ab971637a5bff",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/641f9241173546557b9af5d0822ab971637a5bff",
"gitiles_ref:refs/heads/master"
]
}
[01:44:38.510] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1594086277823479",
"id": "8875473103103708080",
"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\": \"641f9241173546557b9af5d0822ab971637a5bff\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@641f9241173546557b9af5d0822ab971637a5bff\", \"title\": \"641f9241173546557b9af5d0822ab971637a5bff\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/641f9241173546557b9af5d0822ab971637a5bff\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"641f9241173546557b9af5d0822ab971637a5bff\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1594086278315601",
"tags": [
"builder:win",
"buildset:commit/git/641f9241173546557b9af5d0822ab971637a5bff",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/641f9241173546557b9af5d0822ab971637a5bff",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9040903165379272784",
"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/8875473103103708080/+/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": "1594086278315737",
"url": "https://ci.chromium.org/b/8875473103103708080",
"utcnow_ts": "1594086278502215"
}
}
[01:44:38.510] Task URL: https://ci.chromium.org/b/8875473103103708080
[01:44:38.510] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:2:0) after 1m0s
[01:45:38.576] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:2:0)
[01:45:38.576] Timer tick, asking Buildbucket for the build status
[01:45:38.733] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:45:38.733] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:3:0) after 1m0s
[01:46:38.871] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:3:0)
[01:46:38.871] Timer tick, asking Buildbucket for the build status
[01:46:39.303] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:46:39.303] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:4:0) after 1m0s
[01:47:39.389] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:4:0)
[01:47:39.389] Timer tick, asking Buildbucket for the build status
[01:47:39.790] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:47:39.790] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:5:0) after 1m0s
[01:48:39.852] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:5:0)
[01:48:39.852] Timer tick, asking Buildbucket for the build status
[01:48:40.241] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:48:40.241] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:6:0) after 1m0s
[01:49:40.391] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:6:0)
[01:49:40.391] Timer tick, asking Buildbucket for the build status
[01:49:40.532] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:49:40.532] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:7:0) after 1m0s
[01:50:40.572] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:7:0)
[01:50:40.572] Timer tick, asking Buildbucket for the build status
[01:50:40.925] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:50:40.925] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:8:0) after 1m0s
[01:51:41.099] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:8:0)
[01:51:41.099] Timer tick, asking Buildbucket for the build status
[01:51:41.538] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:51:41.539] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:9:0) after 1m0s
[01:52:41.579] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:9:0)
[01:52:41.579] Timer tick, asking Buildbucket for the build status
[01:52:41.849] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:52:41.849] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:10:0) after 1m0s
[01:53:41.943] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:10:0)
[01:53:41.943] Timer tick, asking Buildbucket for the build status
[01:53:43.107] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:53:43.107] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:11:0) after 1m0s
[01:54:43.108] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:11:0)
[01:54:43.108] Timer tick, asking Buildbucket for the build status
[01:54:43.401] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:54:43.401] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:12:0) after 1m0s
[01:55:43.455] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:12:0)
[01:55:43.455] Timer tick, asking Buildbucket for the build status
[01:55:43.598] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:55:43.598] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:13:0) after 1m0s
[01:56:43.616] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:13:0)
[01:56:43.616] Timer tick, asking Buildbucket for the build status
[01:56:43.835] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:56:43.835] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:14:0) after 1m0s
[01:57:43.856] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:14:0)
[01:57:43.856] Timer tick, asking Buildbucket for the build status
[01:57:44.021] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:57:44.021] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:15:0) after 1m0s
[01:58:44.104] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:15:0)
[01:58:44.104] Timer tick, asking Buildbucket for the build status
[01:58:50.298] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:58:50.298] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:16:0) after 1m0s
[01:59:50.312] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:16:0)
[01:59:50.312] Timer tick, asking Buildbucket for the build status
[01:59:51.101] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:59:51.101] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:17:0) after 1m0s
[02:00:51.129] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:17:0)
[02:00:51.129] Timer tick, asking Buildbucket for the build status
[02:00:51.390] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:00:51.390] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:18:0) after 1m0s
[02:01:51.439] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:18:0)
[02:01:51.439] Timer tick, asking Buildbucket for the build status
[02:01:53.341] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:01:53.341] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:19:0) after 1m0s
[02:02:53.417] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:19:0)
[02:02:53.417] Timer tick, asking Buildbucket for the build status
[02:02:53.520] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:02:53.520] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:20:0) after 1m0s
[02:03:53.547] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:20:0)
[02:03:53.547] Timer tick, asking Buildbucket for the build status
[02:03:53.794] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:03:53.794] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:21:0) after 1m0s
[02:04:54.131] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:21:0)
[02:04:54.131] Timer tick, asking Buildbucket for the build status
[02:04:54.765] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:04:54.765] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:22:0) after 1m0s
[02:05:54.949] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:22:0)
[02:05:54.949] Timer tick, asking Buildbucket for the build status
[02:05:55.374] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:05:55.374] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:23:0) after 1m0s
[02:06:55.401] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:23:0)
[02:06:55.401] Timer tick, asking Buildbucket for the build status
[02:06:55.686] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:06:55.686] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:24:0) after 1m0s
[02:07:55.749] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:24:0)
[02:07:55.749] Timer tick, asking Buildbucket for the build status
[02:07:56.037] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:07:56.037] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:25:0) after 1m0s
[02:08:56.061] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:25:0)
[02:08:56.061] Timer tick, asking Buildbucket for the build status
[02:08:56.649] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:08:56.649] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:26:0) after 1m0s
[02:09:56.738] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:26:0)
[02:09:56.738] Timer tick, asking Buildbucket for the build status
[02:09:56.903] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:09:56.903] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:27:0) after 1m0s
[02:10:56.946] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:27:0)
[02:10:56.946] Timer tick, asking Buildbucket for the build status
[02:10:57.107] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:10:57.107] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:28:0) after 1m0s
[02:11:57.148] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:28:0)
[02:11:57.148] Timer tick, asking Buildbucket for the build status
[02:11:57.489] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:11:57.489] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:29:0) after 1m0s
[02:12:57.512] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:29:0)
[02:12:57.512] Timer tick, asking Buildbucket for the build status
[02:12:57.661] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:12:57.662] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:30:0) after 1m0s
[02:13:57.667] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:30:0)
[02:13:57.667] Timer tick, asking Buildbucket for the build status
[02:13:59.910] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:13:59.910] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:31:0) after 1m0s
[02:14:59.954] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:31:0)
[02:14:59.954] Timer tick, asking Buildbucket for the build status
[02:15:00.288] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:15:00.288] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:32:0) after 1m0s
[02:16:00.342] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:32:0)
[02:16:00.342] Timer tick, asking Buildbucket for the build status
[02:16:00.455] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:16:00.455] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:33:0) after 1m0s
[02:17:00.843] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:33:0)
[02:17:00.843] Timer tick, asking Buildbucket for the build status
[02:17:01.004] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:17:01.004] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:34:0) after 1m0s
[02:18:01.180] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:34:0)
[02:18:01.180] Timer tick, asking Buildbucket for the build status
[02:18:01.593] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:18:01.593] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:35:0) after 1m0s
[02:19:01.743] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:35:0)
[02:19:01.743] Timer tick, asking Buildbucket for the build status
[02:19:02.009] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:19:02.009] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:36:0) after 1m0s
[02:20:02.780] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:36:0)
[02:20:02.780] Timer tick, asking Buildbucket for the build status
[02:20:02.979] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:20:02.979] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:37:0) after 1m0s
[02:21:03.130] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:37:0)
[02:21:03.130] Timer tick, asking Buildbucket for the build status
[02:21:03.297] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:21:03.297] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:38:0) after 1m0s
[02:22:03.546] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:38:0)
[02:22:03.546] Timer tick, asking Buildbucket for the build status
[02:22:03.657] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:22:03.657] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:39:0) after 1m0s
[02:23:03.869] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:39:0)
[02:23:03.869] Timer tick, asking Buildbucket for the build status
[02:23:04.222] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:23:04.222] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:40:0) after 1m0s
[02:24:04.224] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:40:0)
[02:24:04.224] Timer tick, asking Buildbucket for the build status
[02:24:04.464] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:24:04.464] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:41:0) after 1m0s
[02:25:04.965] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:41:0)
[02:25:04.965] Timer tick, asking Buildbucket for the build status
[02:25:05.196] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:25:05.196] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:42:0) after 1m0s
[02:26:05.465] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:42:0)
[02:26:05.465] Timer tick, asking Buildbucket for the build status
[02:26:05.614] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:26:05.614] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:43:0) after 1m0s
[02:27:05.639] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:43:0)
[02:27:05.639] Timer tick, asking Buildbucket for the build status
[02:27:06.405] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:27:06.405] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:44:0) after 1m0s
[02:28:06.478] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:44:0)
[02:28:06.478] Timer tick, asking Buildbucket for the build status
[02:28:06.773] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:28:06.773] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:45:0) after 1m0s
[02:29:06.946] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:45:0)
[02:29:06.946] Timer tick, asking Buildbucket for the build status
[02:29:08.811] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:29:08.811] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:46:0) after 1m0s
[02:30:08.847] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:46:0)
[02:30:08.847] Timer tick, asking Buildbucket for the build status
[02:30:08.992] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:30:08.992] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:47:0) after 1m0s
[02:31:09.065] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:47:0)
[02:31:09.065] Timer tick, asking Buildbucket for the build status
[02:31:09.233] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:31:09.233] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:48:0) after 1m0s
[02:32:09.302] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:48:0)
[02:32:09.302] Timer tick, asking Buildbucket for the build status
[02:32:09.653] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:32:09.653] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:49:0) after 1m0s
[02:33:09.721] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:49:0)
[02:33:09.721] Timer tick, asking Buildbucket for the build status
[02:33:10.092] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:33:10.092] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:50:0) after 1m0s
[02:34:10.091] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:50:0)
[02:34:10.091] Timer tick, asking Buildbucket for the build status
[02:34:13.227] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:34:13.227] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:51:0) after 1m0s
[02:35:13.501] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:51:0)
[02:35:13.501] Timer tick, asking Buildbucket for the build status
[02:35:13.890] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:35:13.890] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:52:0) after 1m0s
[02:36:13.897] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:52:0)
[02:36:13.897] Timer tick, asking Buildbucket for the build status
[02:36:14.240] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:36:14.240] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:53:0) after 1m0s
[02:37:14.299] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:53:0)
[02:37:14.299] Timer tick, asking Buildbucket for the build status
[02:37:14.462] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:37:14.462] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:54:0) after 1m0s
[02:38:14.600] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:54:0)
[02:38:14.600] Timer tick, asking Buildbucket for the build status
[02:38:15.050] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:38:15.050] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:55:0) after 1m0s
[02:39:15.135] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:55:0)
[02:39:15.135] Timer tick, asking Buildbucket for the build status
[02:39:15.368] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:39:15.368] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:56:0) after 1m0s
[02:40:15.504] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:56:0)
[02:40:15.504] Timer tick, asking Buildbucket for the build status
[02:40:15.867] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:40:15.867] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:57:0) after 1m0s
[02:41:15.922] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:57:0)
[02:41:15.922] Timer tick, asking Buildbucket for the build status
[02:41:16.089] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:41:16.089] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:58:0) after 1m0s
[02:42:16.114] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:58:0)
[02:42:16.114] Timer tick, asking Buildbucket for the build status
[02:42:16.477] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:42:16.477] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:59:0) after 1m0s
[02:43:16.495] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:59:0)
[02:43:16.495] Timer tick, asking Buildbucket for the build status
[02:43:16.648] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:43:16.648] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:60:0) after 1m0s
[02:44:16.687] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:60:0)
[02:44:16.687] Timer tick, asking Buildbucket for the build status
[02:44:18.655] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:44:18.655] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:61:0) after 1m0s
[02:45:18.745] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:61:0)
[02:45:18.745] Timer tick, asking Buildbucket for the build status
[02:45:18.936] Build 8875473103103708080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:45:18.936] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:62:0) after 1m0s
[02:46:09.403] Received PubSub notification, asking Buildbucket for the build status
[02:46:09.782] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:18.998] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:62:0)
[02:46:18.998] Timer tick, asking Buildbucket for the build status
[02:46:19.108] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:19.108] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:64:0) after 1m0s
[02:47:19.223] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:64:0)
[02:47:19.223] Timer tick, asking Buildbucket for the build status
[02:47:19.482] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:19.482] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:65:0) after 1m0s
[02:48:19.515] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:65:0)
[02:48:19.515] Timer tick, asking Buildbucket for the build status
[02:48:19.644] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:19.644] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:66:0) after 1m0s
[02:49:19.702] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:66:0)
[02:49:19.702] Timer tick, asking Buildbucket for the build status
[02:49:19.889] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:19.890] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:67:0) after 1m0s
[02:50:19.912] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:67:0)
[02:50:19.912] Timer tick, asking Buildbucket for the build status
[02:50:20.062] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:20.062] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:68:0) after 1m0s
[02:51:20.089] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:68:0)
[02:51:20.089] Timer tick, asking Buildbucket for the build status
[02:51:20.256] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:20.256] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:69:0) after 1m0s
[02:52:20.330] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:69:0)
[02:52:20.330] Timer tick, asking Buildbucket for the build status
[02:52:20.577] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:20.577] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:70:0) after 1m0s
[02:53:20.601] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:70:0)
[02:53:20.601] Timer tick, asking Buildbucket for the build status
[02:53:20.816] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:20.816] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:71:0) after 1m0s
[02:54:20.836] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:71:0)
[02:54:20.836] Timer tick, asking Buildbucket for the build status
[02:54:21.300] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:21.300] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:72:0) after 1m0s
[02:55:21.461] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:72:0)
[02:55:21.461] Timer tick, asking Buildbucket for the build status
[02:55:21.603] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:21.603] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:73:0) after 1m0s
[02:56:21.672] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:73:0)
[02:56:21.672] Timer tick, asking Buildbucket for the build status
[02:56:22.027] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:22.027] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:74:0) after 1m0s
[02:57:22.086] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:74:0)
[02:57:22.086] Timer tick, asking Buildbucket for the build status
[02:57:22.380] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:22.380] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:75:0) after 1m0s
[02:58:22.544] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:75:0)
[02:58:22.544] Timer tick, asking Buildbucket for the build status
[02:58:22.800] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:22.800] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:76:0) after 1m0s
[02:59:22.785] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:76:0)
[02:59:22.785] Timer tick, asking Buildbucket for the build status
[02:59:22.925] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:22.925] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:77:0) after 1m0s
[03:00:23.022] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:77:0)
[03:00:23.022] Timer tick, asking Buildbucket for the build status
[03:00:23.799] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:23.799] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:78:0) after 1m0s
[03:01:23.877] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:78:0)
[03:01:23.877] Timer tick, asking Buildbucket for the build status
[03:01:24.057] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:24.057] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:79:0) after 1m0s
[03:02:24.141] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:79:0)
[03:02:24.141] Timer tick, asking Buildbucket for the build status
[03:02:24.292] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:24.292] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:80:0) after 1m0s
[03:03:25.445] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:80:0)
[03:03:25.445] Timer tick, asking Buildbucket for the build status
[03:03:25.593] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:25.594] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:81:0) after 1m0s
[03:04:25.961] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:81:0)
[03:04:25.961] Timer tick, asking Buildbucket for the build status
[03:04:26.325] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:26.325] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:82:0) after 1m0s
[03:05:26.363] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:82:0)
[03:05:26.363] Timer tick, asking Buildbucket for the build status
[03:05:26.474] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:26.474] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:83:0) after 1m0s
[03:06:26.498] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:83:0)
[03:06:26.498] Timer tick, asking Buildbucket for the build status
[03:06:26.618] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:26.618] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:84:0) after 1m0s
[03:07:26.643] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:84:0)
[03:07:26.643] Timer tick, asking Buildbucket for the build status
[03:07:27.042] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:27.042] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:85:0) after 1m0s
[03:08:27.106] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:85:0)
[03:08:27.106] Timer tick, asking Buildbucket for the build status
[03:08:27.247] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:27.247] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:86:0) after 1m0s
[03:09:27.243] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:86:0)
[03:09:27.243] Timer tick, asking Buildbucket for the build status
[03:09:27.487] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:27.487] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:87:0) after 1m0s
[03:10:27.561] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:87:0)
[03:10:27.561] Timer tick, asking Buildbucket for the build status
[03:10:27.669] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:27.670] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:88:0) after 1m0s
[03:11:28.214] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:88:0)
[03:11:28.215] Timer tick, asking Buildbucket for the build status
[03:11:28.367] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:28.367] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:89:0) after 1m0s
[03:12:28.435] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:89:0)
[03:12:28.435] Timer tick, asking Buildbucket for the build status
[03:12:28.924] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:28.924] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:90:0) after 1m0s
[03:13:29.115] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:90:0)
[03:13:29.115] Timer tick, asking Buildbucket for the build status
[03:13:29.901] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:29.901] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:91:0) after 1m0s
[03:14:29.901] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:91:0)
[03:14:29.901] Timer tick, asking Buildbucket for the build status
[03:14:30.047] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:30.047] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:92:0) after 1m0s
[03:15:30.139] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:92:0)
[03:15:30.139] Timer tick, asking Buildbucket for the build status
[03:15:30.427] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:30.427] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:93:0) after 1m0s
[03:16:30.448] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:93:0)
[03:16:30.448] Timer tick, asking Buildbucket for the build status
[03:16:30.633] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:30.633] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:94:0) after 1m0s
[03:17:30.654] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:94:0)
[03:17:30.654] Timer tick, asking Buildbucket for the build status
[03:17:31.074] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:31.074] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:95:0) after 1m0s
[03:18:31.150] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:95:0)
[03:18:31.150] Timer tick, asking Buildbucket for the build status
[03:18:31.675] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:31.675] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:96:0) after 1m0s
[03:19:31.701] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:96:0)
[03:19:31.701] Timer tick, asking Buildbucket for the build status
[03:19:31.911] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:31.911] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:97:0) after 1m0s
[03:20:31.945] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:97:0)
[03:20:31.945] Timer tick, asking Buildbucket for the build status
[03:20:32.103] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:32.103] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:98:0) after 1m0s
[03:21:32.165] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:98:0)
[03:21:32.165] Timer tick, asking Buildbucket for the build status
[03:21:32.333] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:32.333] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:99:0) after 1m0s
[03:22:32.397] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:99:0)
[03:22:32.397] Timer tick, asking Buildbucket for the build status
[03:22:32.542] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:32.542] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:100:0) after 1m0s
[03:23:32.609] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:100:0)
[03:23:32.610] Timer tick, asking Buildbucket for the build status
[03:23:33.769] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:33.769] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:101:0) after 1m0s
[03:24:33.822] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:101:0)
[03:24:33.822] Timer tick, asking Buildbucket for the build status
[03:24:34.151] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:34.151] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:102:0) after 1m0s
[03:25:34.191] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:102:0)
[03:25:34.191] Timer tick, asking Buildbucket for the build status
[03:25:34.414] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:34.414] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:103:0) after 1m0s
[03:26:34.438] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:103:0)
[03:26:34.438] Timer tick, asking Buildbucket for the build status
[03:26:34.565] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:34.566] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:104:0) after 1m0s
[03:27:34.604] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:104:0)
[03:27:34.604] Timer tick, asking Buildbucket for the build status
[03:27:34.741] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:34.741] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:105:0) after 1m0s
[03:28:34.825] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:105:0)
[03:28:34.825] Timer tick, asking Buildbucket for the build status
[03:28:35.862] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:35.862] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:106:0) after 1m0s
[03:29:35.961] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:106:0)
[03:29:35.961] Timer tick, asking Buildbucket for the build status
[03:29:36.426] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:36.426] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:107:0) after 1m0s
[03:30:36.495] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:107:0)
[03:30:36.495] Timer tick, asking Buildbucket for the build status
[03:30:36.662] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:36.662] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:108:0) after 1m0s
[03:31:36.758] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:108:0)
[03:31:36.758] Timer tick, asking Buildbucket for the build status
[03:31:36.924] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:36.924] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:109:0) after 1m0s
[03:32:36.946] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:109:0)
[03:32:36.946] Timer tick, asking Buildbucket for the build status
[03:32:37.231] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:37.231] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:110:0) after 1m0s
[03:33:37.287] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:110:0)
[03:33:37.287] Timer tick, asking Buildbucket for the build status
[03:33:38.030] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:38.030] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:111:0) after 1m0s
[03:34:38.051] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:111:0)
[03:34:38.051] Timer tick, asking Buildbucket for the build status
[03:34:38.184] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:38.184] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:112:0) after 1m0s
[03:35:38.271] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:112:0)
[03:35:38.271] Timer tick, asking Buildbucket for the build status
[03:35:38.394] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:38.394] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:113:0) after 1m0s
[03:36:38.433] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:113:0)
[03:36:38.433] Timer tick, asking Buildbucket for the build status
[03:36:38.576] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:38.576] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:114:0) after 1m0s
[03:37:38.564] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:114:0)
[03:37:38.564] Timer tick, asking Buildbucket for the build status
[03:37:38.696] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:38.696] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:115:0) after 1m0s
[03:38:38.778] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:115:0)
[03:38:38.778] Timer tick, asking Buildbucket for the build status
[03:38:39.005] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:39.005] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:116:0) after 1m0s
[03:39:39.029] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:116:0)
[03:39:39.029] Timer tick, asking Buildbucket for the build status
[03:39:39.172] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:39.172] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:117:0) after 1m0s
[03:40:39.245] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:117:0)
[03:40:39.245] Timer tick, asking Buildbucket for the build status
[03:40:39.460] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:39.460] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:118:0) after 1m0s
[03:41:39.515] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:118:0)
[03:41:39.515] Timer tick, asking Buildbucket for the build status
[03:41:39.629] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:39.629] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:119:0) after 1m0s
[03:42:39.729] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:119:0)
[03:42:39.729] Timer tick, asking Buildbucket for the build status
[03:42:39.848] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:39.848] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:120:0) after 1m0s
[03:43:39.852] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:120:0)
[03:43:39.852] Timer tick, asking Buildbucket for the build status
[03:43:40.021] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:40.021] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:121:0) after 1m0s
[03:44:40.054] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:121:0)
[03:44:40.054] Timer tick, asking Buildbucket for the build status
[03:44:40.381] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:40.381] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:122:0) after 1m0s
[03:45:40.555] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:122:0)
[03:45:40.555] Timer tick, asking Buildbucket for the build status
[03:45:40.699] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:40.699] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:123:0) after 1m0s
[03:46:40.741] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:123:0)
[03:46:40.741] Timer tick, asking Buildbucket for the build status
[03:46:40.912] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:40.912] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:124:0) after 1m0s
[03:47:40.986] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:124:0)
[03:47:40.986] Timer tick, asking Buildbucket for the build status
[03:47:41.121] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:41.121] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:125:0) after 1m0s
[03:48:41.193] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:125:0)
[03:48:41.193] Timer tick, asking Buildbucket for the build status
[03:48:41.795] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:41.795] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:126:0) after 1m0s
[03:49:41.860] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:126:0)
[03:49:41.860] Timer tick, asking Buildbucket for the build status
[03:49:42.068] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:42.068] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:127:0) after 1m0s
[03:50:42.102] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:127:0)
[03:50:42.102] Timer tick, asking Buildbucket for the build status
[03:50:42.395] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:42.395] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:128:0) after 1m0s
[03:51:42.501] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:128:0)
[03:51:42.501] Timer tick, asking Buildbucket for the build status
[03:51:42.663] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:42.663] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:129:0) after 1m0s
[03:52:42.701] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:129:0)
[03:52:42.701] Timer tick, asking Buildbucket for the build status
[03:52:44.346] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:44.346] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:130:0) after 1m0s
[03:53:44.411] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:130:0)
[03:53:44.411] Timer tick, asking Buildbucket for the build status
[03:53:45.989] Build 8875473103103708080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:45.989] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9040903165379272784:131:0) after 1m0s
[03:53:56.587] Received PubSub notification, asking Buildbucket for the build status
[03:54:01.618] Build 8875473103103708080: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:54:01.618] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"completed_ts": "1594094035846025",
"created_by": "project:emscripten-releases",
"created_ts": "1594086277823479",
"id": "8875473103103708080",
"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\": \"641f9241173546557b9af5d0822ab971637a5bff\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@641f9241173546557b9af5d0822ab971637a5bff\", \"title\": \"641f9241173546557b9af5d0822ab971637a5bff\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/641f9241173546557b9af5d0822ab971637a5bff\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"641f9241173546557b9af5d0822ab971637a5bff\"}}",
"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\": \"641f9241173546557b9af5d0822ab971637a5bff\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@641f9241173546557b9af5d0822ab971637a5bff\", \"title\": \"641f9241173546557b9af5d0822ab971637a5bff\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/641f9241173546557b9af5d0822ab971637a5bff\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-win10-0-xccn\", \"branch\": \"refs/heads/master\", \"buildername\": \"win\", \"got_revision\": \"641f9241173546557b9af5d0822ab971637a5bff\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"641f9241173546557b9af5d0822ab971637a5bff\"}, \"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-xccn\"], \"image\": [\"chrome-win10-1703-20052900-58250aa4257\"], \"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\": [\"5320-752003c\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1594089968548662",
"status": "COMPLETED",
"status_changed_ts": "1594094036153973",
"tags": [
"builder:win",
"buildset:commit/git/641f9241173546557b9af5d0822ab971637a5bff",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/641f9241173546557b9af5d0822ab971637a5bff",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9040903165379272784",
"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/8875473103103708080/+/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:4d3fc3ce4cea8d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1594094036166888",
"url": "https://ci.chromium.org/b/8875473103103708080",
"utcnow_ts": "1594094041605784"
}
}
[03:54:01.618] Invocation finished in 2h9m25.349340549s with status SUCCEEDED