[13:49:20.935] New invocation is queued and will start shortly
[13:49:22.159] Starting the invocation (attempt 1)
[13:49:22.193] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:49:22.194] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:49:22.195] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9020835638843752432",
"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\":\"117565c8cd064de09abe65155c80f697783117d5\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@117565c8cd064de09abe65155c80f697783117d5\",\"title\":\"117565c8cd064de09abe65155c80f697783117d5\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/117565c8cd064de09abe65155c80f697783117d5\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"117565c8cd064de09abe65155c80f697783117d5\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win",
"scheduler_invocation_id:9020835638843752432",
"scheduler_job_id:emscripten-releases/win",
"user_agent:luci-scheduler",
"buildset:commit/git/117565c8cd064de09abe65155c80f697783117d5",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/117565c8cd064de09abe65155c80f697783117d5",
"gitiles_ref:refs/heads/master"
]
}
[13:49:23.089] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1613224162329712",
"id": "8855405576720211344",
"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\": \"117565c8cd064de09abe65155c80f697783117d5\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@117565c8cd064de09abe65155c80f697783117d5\", \"title\": \"117565c8cd064de09abe65155c80f697783117d5\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/117565c8cd064de09abe65155c80f697783117d5\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"117565c8cd064de09abe65155c80f697783117d5\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613224162691565",
"tags": [
"builder:win",
"buildset:commit/git/117565c8cd064de09abe65155c80f697783117d5",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/117565c8cd064de09abe65155c80f697783117d5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020835638843752432",
"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/8855405576720211344/+/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": "1613224162691734",
"url": "https://ci.chromium.org/b/8855405576720211344",
"utcnow_ts": "1613224163076872"
}
}
[13:49:23.089] Task URL: https://ci.chromium.org/b/8855405576720211344
[13:49:23.089] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:2:0) after 1m0s
[13:50:23.204] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:2:0)
[13:50:23.204] Timer tick, asking Buildbucket for the build status
[13:50:23.692] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:50:23.692] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:3:0) after 1m0s
[13:51:23.716] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:3:0)
[13:51:23.716] Timer tick, asking Buildbucket for the build status
[13:51:23.996] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:51:23.996] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:4:0) after 1m0s
[13:52:24.094] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:4:0)
[13:52:24.094] Timer tick, asking Buildbucket for the build status
[13:52:24.170] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:52:24.170] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:5:0) after 1m0s
[13:53:24.296] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:5:0)
[13:53:24.296] Timer tick, asking Buildbucket for the build status
[13:53:24.406] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:53:24.406] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:6:0) after 1m0s
[13:54:24.437] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:6:0)
[13:54:24.437] Timer tick, asking Buildbucket for the build status
[13:54:24.507] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:54:24.507] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:7:0) after 1m0s
[13:55:24.579] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:7:0)
[13:55:24.579] Timer tick, asking Buildbucket for the build status
[13:55:24.892] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:55:24.892] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:8:0) after 1m0s
[13:56:24.939] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:8:0)
[13:56:24.939] Timer tick, asking Buildbucket for the build status
[13:56:25.004] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:56:25.004] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:9:0) after 1m0s
[13:57:25.055] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:9:0)
[13:57:25.055] Timer tick, asking Buildbucket for the build status
[13:57:25.132] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:57:25.132] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:10:0) after 1m0s
[13:58:25.444] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:10:0)
[13:58:25.444] Timer tick, asking Buildbucket for the build status
[13:58:25.520] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:58:25.520] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:11:0) after 1m0s
[13:59:25.604] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:11:0)
[13:59:25.605] Timer tick, asking Buildbucket for the build status
[13:59:25.701] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:59:25.701] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:12:0) after 1m0s
[14:00:25.819] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:12:0)
[14:00:25.819] Timer tick, asking Buildbucket for the build status
[14:00:25.919] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:00:25.919] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:13:0) after 1m0s
[14:01:26.082] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:13:0)
[14:01:26.082] Timer tick, asking Buildbucket for the build status
[14:01:26.157] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:01:26.157] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:14:0) after 1m0s
[14:02:26.292] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:14:0)
[14:02:26.292] Timer tick, asking Buildbucket for the build status
[14:02:26.601] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:02:26.601] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:15:0) after 1m0s
[14:03:26.623] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:15:0)
[14:03:26.623] Timer tick, asking Buildbucket for the build status
[14:03:26.799] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:03:26.799] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:16:0) after 1m0s
[14:04:26.835] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:16:0)
[14:04:26.835] Timer tick, asking Buildbucket for the build status
[14:04:26.953] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:04:26.954] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:17:0) after 1m0s
[14:05:26.982] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:17:0)
[14:05:26.982] Timer tick, asking Buildbucket for the build status
[14:05:27.117] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:05:27.117] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:18:0) after 1m0s
[14:06:27.169] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:18:0)
[14:06:27.169] Timer tick, asking Buildbucket for the build status
[14:06:27.261] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:06:27.261] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:19:0) after 1m0s
[14:07:27.254] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:19:0)
[14:07:27.254] Timer tick, asking Buildbucket for the build status
[14:07:27.323] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:07:27.323] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:20:0) after 1m0s
[14:08:27.337] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:20:0)
[14:08:27.337] Timer tick, asking Buildbucket for the build status
[14:08:27.415] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:08:27.415] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:21:0) after 1m0s
[14:09:27.471] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:21:0)
[14:09:27.471] Timer tick, asking Buildbucket for the build status
[14:09:27.541] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:09:27.541] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:22:0) after 1m0s
[14:10:27.584] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:22:0)
[14:10:27.584] Timer tick, asking Buildbucket for the build status
[14:10:27.767] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:10:27.767] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:23:0) after 1m0s
[14:11:27.852] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:23:0)
[14:11:27.852] Timer tick, asking Buildbucket for the build status
[14:11:27.955] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:11:27.955] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:24:0) after 1m0s
[14:12:27.972] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:24:0)
[14:12:27.972] Timer tick, asking Buildbucket for the build status
[14:12:28.036] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:12:28.036] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:25:0) after 1m0s
[14:13:28.095] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:25:0)
[14:13:28.095] Timer tick, asking Buildbucket for the build status
[14:13:28.164] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:13:28.164] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:26:0) after 1m0s
[14:14:28.312] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:26:0)
[14:14:28.312] Timer tick, asking Buildbucket for the build status
[14:14:28.385] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:14:28.385] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:27:0) after 1m0s
[14:15:28.408] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:27:0)
[14:15:28.408] Timer tick, asking Buildbucket for the build status
[14:15:28.660] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:15:28.660] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:28:0) after 1m0s
[14:16:28.885] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:28:0)
[14:16:28.885] Timer tick, asking Buildbucket for the build status
[14:16:28.980] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:16:28.980] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:29:0) after 1m0s
[14:17:29.006] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:29:0)
[14:17:29.007] Timer tick, asking Buildbucket for the build status
[14:17:29.096] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:17:29.096] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:30:0) after 1m0s
[14:18:29.122] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:30:0)
[14:18:29.122] Timer tick, asking Buildbucket for the build status
[14:18:29.190] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:18:29.190] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:31:0) after 1m0s
[14:19:29.208] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:31:0)
[14:19:29.208] Timer tick, asking Buildbucket for the build status
[14:19:29.281] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:19:29.281] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:32:0) after 1m0s
[14:20:29.348] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:32:0)
[14:20:29.348] Timer tick, asking Buildbucket for the build status
[14:20:29.441] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:20:29.441] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:33:0) after 1m0s
[14:21:29.459] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:33:0)
[14:21:29.459] Timer tick, asking Buildbucket for the build status
[14:21:29.589] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:21:29.589] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:34:0) after 1m0s
[14:22:29.623] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:34:0)
[14:22:29.623] Timer tick, asking Buildbucket for the build status
[14:22:29.703] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:22:29.703] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:35:0) after 1m0s
[14:23:29.730] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:35:0)
[14:23:29.730] Timer tick, asking Buildbucket for the build status
[14:23:29.903] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:23:29.903] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:36:0) after 1m0s
[14:24:29.963] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:36:0)
[14:24:29.963] Timer tick, asking Buildbucket for the build status
[14:24:30.141] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:24:30.141] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:37:0) after 1m0s
[14:25:30.201] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:37:0)
[14:25:30.201] Timer tick, asking Buildbucket for the build status
[14:25:30.309] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:25:30.309] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:38:0) after 1m0s
[14:26:30.340] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:38:0)
[14:26:30.340] Timer tick, asking Buildbucket for the build status
[14:26:30.415] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:26:30.415] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:39:0) after 1m0s
[14:27:30.484] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:39:0)
[14:27:30.484] Timer tick, asking Buildbucket for the build status
[14:27:30.568] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:27:30.568] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:40:0) after 1m0s
[14:28:30.586] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:40:0)
[14:28:30.586] Timer tick, asking Buildbucket for the build status
[14:28:30.736] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:28:30.736] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:41:0) after 1m0s
[14:29:30.765] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:41:0)
[14:29:30.765] Timer tick, asking Buildbucket for the build status
[14:29:31.175] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:29:31.175] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:42:0) after 1m0s
[14:30:31.242] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:42:0)
[14:30:31.242] Timer tick, asking Buildbucket for the build status
[14:30:31.337] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:30:31.337] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:43:0) after 1m0s
[14:31:31.395] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:43:0)
[14:31:31.395] Timer tick, asking Buildbucket for the build status
[14:31:31.470] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:31:31.470] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:44:0) after 1m0s
[14:32:31.449] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:44:0)
[14:32:31.449] Timer tick, asking Buildbucket for the build status
[14:32:31.525] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:32:31.525] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:45:0) after 1m0s
[14:33:31.590] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:45:0)
[14:33:31.590] Timer tick, asking Buildbucket for the build status
[14:33:31.824] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:33:31.824] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:46:0) after 1m0s
[14:34:31.840] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:46:0)
[14:34:31.840] Timer tick, asking Buildbucket for the build status
[14:34:31.907] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:34:31.907] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:47:0) after 1m0s
[14:35:31.959] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:47:0)
[14:35:31.959] Timer tick, asking Buildbucket for the build status
[14:35:32.035] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:35:32.035] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:48:0) after 1m0s
[14:36:32.088] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:48:0)
[14:36:32.088] Timer tick, asking Buildbucket for the build status
[14:36:32.152] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:36:32.152] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:49:0) after 1m0s
[14:37:32.149] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:49:0)
[14:37:32.149] Timer tick, asking Buildbucket for the build status
[14:37:32.400] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:37:32.400] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:50:0) after 1m0s
[14:38:32.467] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:50:0)
[14:38:32.467] Timer tick, asking Buildbucket for the build status
[14:38:32.554] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:38:32.554] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:51:0) after 1m0s
[14:39:32.594] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:51:0)
[14:39:32.594] Timer tick, asking Buildbucket for the build status
[14:39:32.678] Build 8855405576720211344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:39:32.678] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:52:0) after 1m0s
[14:39:53.272] Received PubSub notification, asking Buildbucket for the build status
[14:39:53.394] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:32.746] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:52:0)
[14:40:32.746] Timer tick, asking Buildbucket for the build status
[14:40:32.822] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:32.822] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:54:0) after 1m0s
[14:41:32.940] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:54:0)
[14:41:32.940] Timer tick, asking Buildbucket for the build status
[14:41:33.191] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:33.191] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:55:0) after 1m0s
[14:42:33.235] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:55:0)
[14:42:33.235] Timer tick, asking Buildbucket for the build status
[14:42:33.388] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:33.388] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:56:0) after 1m0s
[14:43:33.446] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:56:0)
[14:43:33.446] Timer tick, asking Buildbucket for the build status
[14:43:33.552] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:33.552] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:57:0) after 1m0s
[14:44:33.641] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:57:0)
[14:44:33.641] Timer tick, asking Buildbucket for the build status
[14:44:33.718] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:33.718] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:58:0) after 1m0s
[14:45:33.701] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:58:0)
[14:45:33.701] Timer tick, asking Buildbucket for the build status
[14:45:34.113] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:34.113] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:59:0) after 1m0s
[14:46:34.167] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:59:0)
[14:46:34.167] Timer tick, asking Buildbucket for the build status
[14:46:34.262] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:34.262] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:60:0) after 1m0s
[14:47:34.352] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:60:0)
[14:47:34.352] Timer tick, asking Buildbucket for the build status
[14:47:34.469] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:34.469] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:61:0) after 1m0s
[14:48:34.512] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:61:0)
[14:48:34.512] Timer tick, asking Buildbucket for the build status
[14:48:35.026] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:35.026] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:62:0) after 1m0s
[14:49:35.044] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:62:0)
[14:49:35.044] Timer tick, asking Buildbucket for the build status
[14:49:35.311] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:35.311] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:63:0) after 1m0s
[14:50:35.401] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:63:0)
[14:50:35.401] Timer tick, asking Buildbucket for the build status
[14:50:35.471] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:35.471] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:64:0) after 1m0s
[14:51:35.605] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:64:0)
[14:51:35.605] Timer tick, asking Buildbucket for the build status
[14:51:35.721] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:35.721] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:65:0) after 1m0s
[14:52:35.758] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:65:0)
[14:52:35.758] Timer tick, asking Buildbucket for the build status
[14:52:35.843] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:35.843] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:66:0) after 1m0s
[14:53:35.848] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:66:0)
[14:53:35.848] Timer tick, asking Buildbucket for the build status
[14:53:35.932] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:35.932] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:67:0) after 1m0s
[14:54:35.988] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:67:0)
[14:54:35.988] Timer tick, asking Buildbucket for the build status
[14:54:36.520] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:36.520] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:68:0) after 1m0s
[14:55:36.565] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:68:0)
[14:55:36.565] Timer tick, asking Buildbucket for the build status
[14:55:36.656] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:36.656] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:69:0) after 1m0s
[14:56:36.665] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:69:0)
[14:56:36.665] Timer tick, asking Buildbucket for the build status
[14:56:36.747] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:36.747] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:70:0) after 1m0s
[14:57:36.793] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:70:0)
[14:57:36.793] Timer tick, asking Buildbucket for the build status
[14:57:36.877] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:36.877] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:71:0) after 1m0s
[14:58:36.972] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:71:0)
[14:58:36.972] Timer tick, asking Buildbucket for the build status
[14:58:37.049] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:37.049] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:72:0) after 1m0s
[14:59:37.059] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:72:0)
[14:59:37.059] Timer tick, asking Buildbucket for the build status
[14:59:37.294] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:37.294] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:73:0) after 1m0s
[15:00:37.318] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:73:0)
[15:00:37.318] Timer tick, asking Buildbucket for the build status
[15:00:37.520] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:37.520] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:74:0) after 1m0s
[15:01:37.498] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:74:0)
[15:01:37.498] Timer tick, asking Buildbucket for the build status
[15:01:37.572] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:37.572] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:75:0) after 1m0s
[15:02:37.626] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:75:0)
[15:02:37.626] Timer tick, asking Buildbucket for the build status
[15:02:37.803] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:37.803] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:76:0) after 1m0s
[15:03:37.822] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:76:0)
[15:03:37.822] Timer tick, asking Buildbucket for the build status
[15:03:38.054] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:38.054] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:77:0) after 1m0s
[15:04:38.148] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:77:0)
[15:04:38.148] Timer tick, asking Buildbucket for the build status
[15:04:38.255] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:38.255] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:78:0) after 1m0s
[15:05:38.308] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:78:0)
[15:05:38.308] Timer tick, asking Buildbucket for the build status
[15:05:38.376] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:38.376] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:79:0) after 1m0s
[15:06:38.435] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:79:0)
[15:06:38.435] Timer tick, asking Buildbucket for the build status
[15:06:38.891] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:38.891] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:80:0) after 1m0s
[15:07:38.915] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:80:0)
[15:07:38.915] Timer tick, asking Buildbucket for the build status
[15:07:39.011] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:39.011] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:81:0) after 1m0s
[15:08:39.030] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:81:0)
[15:08:39.030] Timer tick, asking Buildbucket for the build status
[15:08:39.327] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:39.327] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:82:0) after 1m0s
[15:09:39.360] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:82:0)
[15:09:39.360] Timer tick, asking Buildbucket for the build status
[15:09:39.450] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:39.450] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:83:0) after 1m0s
[15:10:39.478] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:83:0)
[15:10:39.478] Timer tick, asking Buildbucket for the build status
[15:10:39.559] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:39.559] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:84:0) after 1m0s
[15:11:39.601] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:84:0)
[15:11:39.601] Timer tick, asking Buildbucket for the build status
[15:11:39.799] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:39.799] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:85:0) after 1m0s
[15:12:39.835] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:85:0)
[15:12:39.835] Timer tick, asking Buildbucket for the build status
[15:12:39.922] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:39.922] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:86:0) after 1m0s
[15:13:39.977] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:86:0)
[15:13:39.977] Timer tick, asking Buildbucket for the build status
[15:13:40.161] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:40.161] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:87:0) after 1m0s
[15:14:40.185] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:87:0)
[15:14:40.185] Timer tick, asking Buildbucket for the build status
[15:14:40.432] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:40.432] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:88:0) after 1m0s
[15:15:40.489] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:88:0)
[15:15:40.489] Timer tick, asking Buildbucket for the build status
[15:15:40.568] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:40.568] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:89:0) after 1m0s
[15:16:40.594] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:89:0)
[15:16:40.594] Timer tick, asking Buildbucket for the build status
[15:16:40.999] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:40.999] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:90:0) after 1m0s
[15:17:41.018] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:90:0)
[15:17:41.018] Timer tick, asking Buildbucket for the build status
[15:17:41.150] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:41.150] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:91:0) after 1m0s
[15:18:41.179] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:91:0)
[15:18:41.179] Timer tick, asking Buildbucket for the build status
[15:18:41.255] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:41.255] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:92:0) after 1m0s
[15:19:41.307] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:92:0)
[15:19:41.307] Timer tick, asking Buildbucket for the build status
[15:19:41.442] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:41.442] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:93:0) after 1m0s
[15:20:41.460] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:93:0)
[15:20:41.460] Timer tick, asking Buildbucket for the build status
[15:20:41.757] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:41.757] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:94:0) after 1m0s
[15:21:41.776] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:94:0)
[15:21:41.776] Timer tick, asking Buildbucket for the build status
[15:21:43.488] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:43.488] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:95:0) after 1m0s
[15:22:43.605] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:95:0)
[15:22:43.605] Timer tick, asking Buildbucket for the build status
[15:22:43.689] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:43.689] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:96:0) after 1m0s
[15:23:43.709] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:96:0)
[15:23:43.709] Timer tick, asking Buildbucket for the build status
[15:23:43.851] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:43.851] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:97:0) after 1m0s
[15:24:43.971] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:97:0)
[15:24:43.971] Timer tick, asking Buildbucket for the build status
[15:24:44.069] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:44.069] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:98:0) after 1m0s
[15:25:44.110] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:98:0)
[15:25:44.110] Timer tick, asking Buildbucket for the build status
[15:25:44.207] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:44.207] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:99:0) after 1m0s
[15:26:44.227] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:99:0)
[15:26:44.227] Timer tick, asking Buildbucket for the build status
[15:26:44.702] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:44.702] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:100:0) after 1m0s
[15:27:44.774] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:100:0)
[15:27:44.774] Timer tick, asking Buildbucket for the build status
[15:27:44.855] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:44.855] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:101:0) after 1m0s
[15:28:44.830] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:101:0)
[15:28:44.830] Timer tick, asking Buildbucket for the build status
[15:28:44.899] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:44.899] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:102:0) after 1m0s
[15:29:44.922] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:102:0)
[15:29:44.922] Timer tick, asking Buildbucket for the build status
[15:29:45.004] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:45.004] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:103:0) after 1m0s
[15:30:45.126] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:103:0)
[15:30:45.126] Timer tick, asking Buildbucket for the build status
[15:30:45.206] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:45.206] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:104:0) after 1m0s
[15:31:45.231] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:104:0)
[15:31:45.231] Timer tick, asking Buildbucket for the build status
[15:31:45.303] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:45.303] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:105:0) after 1m0s
[15:32:45.400] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:105:0)
[15:32:45.400] Timer tick, asking Buildbucket for the build status
[15:32:45.472] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:45.472] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:106:0) after 1m0s
[15:33:45.549] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:106:0)
[15:33:45.549] Timer tick, asking Buildbucket for the build status
[15:33:45.646] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:45.646] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:107:0) after 1m0s
[15:34:45.687] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:107:0)
[15:34:45.687] Timer tick, asking Buildbucket for the build status
[15:34:45.901] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:45.901] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:108:0) after 1m0s
[15:35:45.971] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:108:0)
[15:35:45.971] Timer tick, asking Buildbucket for the build status
[15:35:46.298] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:46.298] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:109:0) after 1m0s
[15:36:46.368] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:109:0)
[15:36:46.368] Timer tick, asking Buildbucket for the build status
[15:36:46.825] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:46.826] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:110:0) after 1m0s
[15:37:46.885] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:110:0)
[15:37:46.885] Timer tick, asking Buildbucket for the build status
[15:37:47.155] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:47.155] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:111:0) after 1m0s
[15:38:47.235] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:111:0)
[15:38:47.235] Timer tick, asking Buildbucket for the build status
[15:38:47.408] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:47.408] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:112:0) after 1m0s
[15:39:47.443] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:112:0)
[15:39:47.443] Timer tick, asking Buildbucket for the build status
[15:39:47.543] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:47.543] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:113:0) after 1m0s
[15:40:47.590] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:113:0)
[15:40:47.590] Timer tick, asking Buildbucket for the build status
[15:40:48.004] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:48.004] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:114:0) after 1m0s
[15:41:48.028] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:114:0)
[15:41:48.028] Timer tick, asking Buildbucket for the build status
[15:41:48.105] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:48.105] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:115:0) after 1m0s
[15:42:48.130] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:115:0)
[15:42:48.130] Timer tick, asking Buildbucket for the build status
[15:42:48.212] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:48.212] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:116:0) after 1m0s
[15:43:48.233] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:116:0)
[15:43:48.233] Timer tick, asking Buildbucket for the build status
[15:43:48.460] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:48.460] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:117:0) after 1m0s
[15:44:48.481] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:117:0)
[15:44:48.481] Timer tick, asking Buildbucket for the build status
[15:44:48.586] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:48.586] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:118:0) after 1m0s
[15:45:48.566] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:118:0)
[15:45:48.566] Timer tick, asking Buildbucket for the build status
[15:45:48.653] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:48.653] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:119:0) after 1m0s
[15:46:48.678] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:119:0)
[15:46:48.678] Timer tick, asking Buildbucket for the build status
[15:46:48.745] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:48.745] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:120:0) after 1m0s
[15:47:49.228] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:120:0)
[15:47:49.228] Timer tick, asking Buildbucket for the build status
[15:47:49.378] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:49.378] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:121:0) after 1m0s
[15:48:49.624] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:121:0)
[15:48:49.624] Timer tick, asking Buildbucket for the build status
[15:48:49.961] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:49.961] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:122:0) after 1m0s
[15:49:50.082] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:122:0)
[15:49:50.082] Timer tick, asking Buildbucket for the build status
[15:49:50.188] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:50.188] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:123:0) after 1m0s
[15:50:50.340] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:123:0)
[15:50:50.340] Timer tick, asking Buildbucket for the build status
[15:50:50.417] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:50.417] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:124:0) after 1m0s
[15:51:50.693] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:124:0)
[15:51:50.693] Timer tick, asking Buildbucket for the build status
[15:51:50.779] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:50.779] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:125:0) after 1m0s
[15:52:51.020] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:125:0)
[15:52:51.020] Timer tick, asking Buildbucket for the build status
[15:52:51.103] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:51.103] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:126:0) after 1m0s
[15:53:51.143] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:126:0)
[15:53:51.143] Timer tick, asking Buildbucket for the build status
[15:53:51.224] Build 8855405576720211344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:51.224] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020835638843752432:127:0) after 1m0s
[15:54:39.569] Received PubSub notification, asking Buildbucket for the build status
[15:54:39.803] Build 8855405576720211344: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:54:39.803] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"completed_ts": "1613231678840608",
"created_by": "project:emscripten-releases",
"created_ts": "1613224162329712",
"id": "8855405576720211344",
"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\": \"117565c8cd064de09abe65155c80f697783117d5\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@117565c8cd064de09abe65155c80f697783117d5\", \"title\": \"117565c8cd064de09abe65155c80f697783117d5\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/117565c8cd064de09abe65155c80f697783117d5\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"117565c8cd064de09abe65155c80f697783117d5\"}}",
"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\": \"117565c8cd064de09abe65155c80f697783117d5\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@117565c8cd064de09abe65155c80f697783117d5\", \"title\": \"117565c8cd064de09abe65155c80f697783117d5\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/117565c8cd064de09abe65155c80f697783117d5\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-win10-0-mh08\", \"branch\": \"refs/heads/master\", \"buildername\": \"win\", \"got_revision\": \"117565c8cd064de09abe65155c80f697783117d5\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"117565c8cd064de09abe65155c80f697783117d5\"}, \"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-mh08\"], \"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\": [\"5690-40331dd\"], \"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": "1613227192297234",
"status": "COMPLETED",
"status_changed_ts": "1613231679242929",
"tags": [
"builder:win",
"buildset:commit/git/117565c8cd064de09abe65155c80f697783117d5",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/117565c8cd064de09abe65155c80f697783117d5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020835638843752432",
"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/8855405576720211344/+/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:51b478de18977410",
"user_agent:luci-scheduler"
],
"updated_ts": "1613231679254420",
"url": "https://ci.chromium.org/b/8855405576720211344",
"utcnow_ts": "1613231679739030"
}
}
[15:54:39.803] Invocation finished in 2h5m18.882815118s with status SUCCEEDED