[01:35:17.007] New invocation is queued and will start shortly
[01:35:18.411] Starting the invocation (attempt 1)
[01:35:18.453] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:35:18.453] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:35:18.453] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9029397937092671568",
"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\":\"3d1014a5223cfb0e24b0cab99a45c3ba9cf82c94\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@3d1014a5223cfb0e24b0cab99a45c3ba9cf82c94\",\"title\":\"3d1014a5223cfb0e24b0cab99a45c3ba9cf82c94\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/3d1014a5223cfb0e24b0cab99a45c3ba9cf82c94\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"3d1014a5223cfb0e24b0cab99a45c3ba9cf82c94\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win",
"scheduler_invocation_id:9029397937092671568",
"scheduler_job_id:emscripten-releases/win",
"user_agent:luci-scheduler",
"buildset:commit/git/3d1014a5223cfb0e24b0cab99a45c3ba9cf82c94",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/3d1014a5223cfb0e24b0cab99a45c3ba9cf82c94",
"gitiles_ref:refs/heads/master"
]
}
[01:35:19.146] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1605058518560377",
"id": "8863967874801104624",
"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\": \"3d1014a5223cfb0e24b0cab99a45c3ba9cf82c94\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@3d1014a5223cfb0e24b0cab99a45c3ba9cf82c94\", \"title\": \"3d1014a5223cfb0e24b0cab99a45c3ba9cf82c94\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/3d1014a5223cfb0e24b0cab99a45c3ba9cf82c94\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"3d1014a5223cfb0e24b0cab99a45c3ba9cf82c94\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605058518887354",
"tags": [
"builder:win",
"buildset:commit/git/3d1014a5223cfb0e24b0cab99a45c3ba9cf82c94",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/3d1014a5223cfb0e24b0cab99a45c3ba9cf82c94",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029397937092671568",
"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/8863967874801104624/+/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": "1605058518887529",
"url": "https://ci.chromium.org/b/8863967874801104624",
"utcnow_ts": "1605058519133708"
}
}
[01:35:19.146] Task URL: https://ci.chromium.org/b/8863967874801104624
[01:35:19.146] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:2:0) after 1m0s
[01:36:19.173] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:2:0)
[01:36:19.173] Timer tick, asking Buildbucket for the build status
[01:36:19.289] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:36:19.289] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:3:0) after 1m0s
[01:37:19.348] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:3:0)
[01:37:19.348] Timer tick, asking Buildbucket for the build status
[01:37:19.842] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:37:19.842] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:4:0) after 1m0s
[01:38:19.872] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:4:0)
[01:38:19.872] Timer tick, asking Buildbucket for the build status
[01:38:19.948] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:38:19.948] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:5:0) after 1m0s
[01:39:19.967] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:5:0)
[01:39:19.967] Timer tick, asking Buildbucket for the build status
[01:39:20.183] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:39:20.183] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:6:0) after 1m0s
[01:40:20.224] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:6:0)
[01:40:20.224] Timer tick, asking Buildbucket for the build status
[01:40:21.046] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:40:21.046] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:7:0) after 1m0s
[01:41:21.079] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:7:0)
[01:41:21.079] Timer tick, asking Buildbucket for the build status
[01:41:21.426] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:41:21.426] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:8:0) after 1m0s
[01:42:21.451] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:8:0)
[01:42:21.451] Timer tick, asking Buildbucket for the build status
[01:42:21.596] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:42:21.596] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:9:0) after 1m0s
[01:43:22.246] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:9:0)
[01:43:22.246] Timer tick, asking Buildbucket for the build status
[01:43:22.504] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:43:22.504] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:10:0) after 1m0s
[01:44:22.786] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:10:0)
[01:44:22.786] Timer tick, asking Buildbucket for the build status
[01:44:22.883] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:44:22.883] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:11:0) after 1m0s
[01:45:23.603] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:11:0)
[01:45:23.603] Timer tick, asking Buildbucket for the build status
[01:45:23.776] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:45:23.776] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:12:0) after 1m0s
[01:46:23.760] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:12:0)
[01:46:23.760] Timer tick, asking Buildbucket for the build status
[01:46:23.850] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:46:23.850] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:13:0) after 1m0s
[01:47:23.888] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:13:0)
[01:47:23.888] Timer tick, asking Buildbucket for the build status
[01:47:25.589] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:47:25.589] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:14:0) after 1m0s
[01:48:25.642] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:14:0)
[01:48:25.642] Timer tick, asking Buildbucket for the build status
[01:48:25.724] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:48:25.724] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:15:0) after 1m0s
[01:49:25.757] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:15:0)
[01:49:25.757] Timer tick, asking Buildbucket for the build status
[01:49:25.832] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:49:25.832] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:16:0) after 1m0s
[01:50:25.949] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:16:0)
[01:50:25.949] Timer tick, asking Buildbucket for the build status
[01:50:26.341] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:50:26.341] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:17:0) after 1m0s
[01:51:26.433] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:17:0)
[01:51:26.433] Timer tick, asking Buildbucket for the build status
[01:51:26.749] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:51:26.749] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:18:0) after 1m0s
[01:52:26.863] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:18:0)
[01:52:26.863] Timer tick, asking Buildbucket for the build status
[01:52:26.970] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:52:26.970] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:19:0) after 1m0s
[01:53:27.091] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:19:0)
[01:53:27.091] Timer tick, asking Buildbucket for the build status
[01:53:27.191] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:53:27.191] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:20:0) after 1m0s
[01:54:27.214] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:20:0)
[01:54:27.214] Timer tick, asking Buildbucket for the build status
[01:54:27.293] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:54:27.293] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:21:0) after 1m0s
[01:55:27.310] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:21:0)
[01:55:27.310] Timer tick, asking Buildbucket for the build status
[01:55:27.691] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:55:27.691] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:22:0) after 1m0s
[01:56:27.700] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:22:0)
[01:56:27.700] Timer tick, asking Buildbucket for the build status
[01:56:27.784] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:56:27.784] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:23:0) after 1m0s
[01:57:27.792] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:23:0)
[01:57:27.792] Timer tick, asking Buildbucket for the build status
[01:57:28.111] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:57:28.111] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:24:0) after 1m0s
[01:58:28.090] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:24:0)
[01:58:28.090] Timer tick, asking Buildbucket for the build status
[01:58:28.172] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:58:28.172] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:25:0) after 1m0s
[01:59:28.193] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:25:0)
[01:59:28.193] Timer tick, asking Buildbucket for the build status
[01:59:28.297] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:59:28.297] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:26:0) after 1m0s
[02:00:28.432] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:26:0)
[02:00:28.432] Timer tick, asking Buildbucket for the build status
[02:00:28.655] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:00:28.655] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:27:0) after 1m0s
[02:01:28.689] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:27:0)
[02:01:28.689] Timer tick, asking Buildbucket for the build status
[02:01:28.784] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:01:28.784] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:28:0) after 1m0s
[02:02:28.828] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:28:0)
[02:02:28.828] Timer tick, asking Buildbucket for the build status
[02:02:28.904] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:02:28.904] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:29:0) after 1m0s
[02:03:28.927] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:29:0)
[02:03:28.927] Timer tick, asking Buildbucket for the build status
[02:03:29.716] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:03:29.716] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:30:0) after 1m0s
[02:04:29.767] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:30:0)
[02:04:29.767] Timer tick, asking Buildbucket for the build status
[02:04:31.648] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:04:31.648] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:31:0) after 1m0s
[02:05:31.655] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:31:0)
[02:05:31.655] Timer tick, asking Buildbucket for the build status
[02:05:31.876] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:05:31.876] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:32:0) after 1m0s
[02:06:31.923] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:32:0)
[02:06:31.923] Timer tick, asking Buildbucket for the build status
[02:06:32.019] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:06:32.019] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:33:0) after 1m0s
[02:07:32.055] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:33:0)
[02:07:32.055] Timer tick, asking Buildbucket for the build status
[02:07:32.666] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:07:32.666] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:34:0) after 1m0s
[02:08:32.688] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:34:0)
[02:08:32.688] Timer tick, asking Buildbucket for the build status
[02:08:32.776] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:08:32.776] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:35:0) after 1m0s
[02:09:32.785] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:35:0)
[02:09:32.785] Timer tick, asking Buildbucket for the build status
[02:09:32.865] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:09:32.865] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:36:0) after 1m0s
[02:10:32.920] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:36:0)
[02:10:32.920] Timer tick, asking Buildbucket for the build status
[02:10:33.028] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:10:33.028] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:37:0) after 1m0s
[02:11:33.041] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:37:0)
[02:11:33.041] Timer tick, asking Buildbucket for the build status
[02:11:33.148] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:11:33.148] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:38:0) after 1m0s
[02:12:33.144] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:38:0)
[02:12:33.144] Timer tick, asking Buildbucket for the build status
[02:12:33.386] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:12:33.386] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:39:0) after 1m0s
[02:13:33.511] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:39:0)
[02:13:33.511] Timer tick, asking Buildbucket for the build status
[02:13:33.698] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:13:33.698] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:40:0) after 1m0s
[02:14:33.674] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:40:0)
[02:14:33.674] Timer tick, asking Buildbucket for the build status
[02:14:33.870] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:14:33.870] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:41:0) after 1m0s
[02:15:33.895] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:41:0)
[02:15:33.895] Timer tick, asking Buildbucket for the build status
[02:15:33.993] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:15:33.993] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:42:0) after 1m0s
[02:16:34.023] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:42:0)
[02:16:34.023] Timer tick, asking Buildbucket for the build status
[02:16:35.568] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:16:35.568] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:43:0) after 1m0s
[02:17:35.596] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:43:0)
[02:17:35.596] Timer tick, asking Buildbucket for the build status
[02:17:35.682] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:17:35.682] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:44:0) after 1m0s
[02:18:35.702] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:44:0)
[02:18:35.702] Timer tick, asking Buildbucket for the build status
[02:18:35.914] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:18:35.914] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:45:0) after 1m0s
[02:19:35.936] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:45:0)
[02:19:35.936] Timer tick, asking Buildbucket for the build status
[02:19:36.670] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:19:36.670] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:46:0) after 1m0s
[02:20:36.798] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:46:0)
[02:20:36.798] Timer tick, asking Buildbucket for the build status
[02:20:36.903] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:20:36.904] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:47:0) after 1m0s
[02:21:36.925] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:47:0)
[02:21:36.925] Timer tick, asking Buildbucket for the build status
[02:21:37.011] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:21:37.011] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:48:0) after 1m0s
[02:22:37.047] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:48:0)
[02:22:37.047] Timer tick, asking Buildbucket for the build status
[02:22:37.163] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:22:37.163] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:49:0) after 1m0s
[02:23:37.214] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:49:0)
[02:23:37.214] Timer tick, asking Buildbucket for the build status
[02:23:37.605] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:23:37.605] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:50:0) after 1m0s
[02:24:37.595] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:50:0)
[02:24:37.595] Timer tick, asking Buildbucket for the build status
[02:24:37.695] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:24:37.696] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:51:0) after 1m0s
[02:25:37.821] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:51:0)
[02:25:37.821] Timer tick, asking Buildbucket for the build status
[02:25:37.948] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:25:37.948] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:52:0) after 1m0s
[02:26:38.044] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:52:0)
[02:26:38.044] Timer tick, asking Buildbucket for the build status
[02:26:38.389] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:26:38.389] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:53:0) after 1m0s
[02:27:38.435] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:53:0)
[02:27:38.435] Timer tick, asking Buildbucket for the build status
[02:27:38.542] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:27:38.542] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:54:0) after 1m0s
[02:28:38.565] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:54:0)
[02:28:38.565] Timer tick, asking Buildbucket for the build status
[02:28:38.667] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:28:38.667] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:55:0) after 1m0s
[02:29:38.685] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:55:0)
[02:29:38.686] Timer tick, asking Buildbucket for the build status
[02:29:38.800] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:29:38.800] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:56:0) after 1m0s
[02:30:38.946] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:56:0)
[02:30:38.946] Timer tick, asking Buildbucket for the build status
[02:30:39.902] Build 8863967874801104624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:30:39.902] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:57:0) after 1m0s
[02:30:49.749] Received PubSub notification, asking Buildbucket for the build status
[02:30:49.830] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:40.065] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:57:0)
[02:31:40.065] Timer tick, asking Buildbucket for the build status
[02:31:40.188] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:40.188] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:59:0) after 1m0s
[02:32:40.273] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:59:0)
[02:32:40.273] Timer tick, asking Buildbucket for the build status
[02:32:40.584] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:40.584] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:60:0) after 1m0s
[02:33:40.664] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:60:0)
[02:33:40.664] Timer tick, asking Buildbucket for the build status
[02:33:40.769] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:40.769] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:61:0) after 1m0s
[02:34:40.793] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:61:0)
[02:34:40.793] Timer tick, asking Buildbucket for the build status
[02:34:40.979] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:40.979] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:62:0) after 1m0s
[02:35:41.033] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:62:0)
[02:35:41.033] Timer tick, asking Buildbucket for the build status
[02:35:41.155] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:41.155] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:63:0) after 1m0s
[02:36:41.185] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:63:0)
[02:36:41.185] Timer tick, asking Buildbucket for the build status
[02:36:41.284] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:41.284] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:64:0) after 1m0s
[02:37:41.356] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:64:0)
[02:37:41.356] Timer tick, asking Buildbucket for the build status
[02:37:41.601] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:41.601] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:65:0) after 1m0s
[02:38:41.635] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:65:0)
[02:38:41.635] Timer tick, asking Buildbucket for the build status
[02:38:41.703] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:41.703] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:66:0) after 1m0s
[02:39:41.715] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:66:0)
[02:39:41.715] Timer tick, asking Buildbucket for the build status
[02:39:42.005] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:42.005] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:67:0) after 1m0s
[02:40:42.031] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:67:0)
[02:40:42.031] Timer tick, asking Buildbucket for the build status
[02:40:42.163] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:42.163] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:68:0) after 1m0s
[02:41:42.203] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:68:0)
[02:41:42.203] Timer tick, asking Buildbucket for the build status
[02:41:42.323] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:42.323] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:69:0) after 1m0s
[02:42:42.346] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:69:0)
[02:42:42.346] Timer tick, asking Buildbucket for the build status
[02:42:42.430] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:42.430] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:70:0) after 1m0s
[02:43:42.452] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:70:0)
[02:43:42.452] Timer tick, asking Buildbucket for the build status
[02:43:42.689] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:42.689] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:71:0) after 1m0s
[02:44:42.725] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:71:0)
[02:44:42.725] Timer tick, asking Buildbucket for the build status
[02:44:42.789] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:42.789] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:72:0) after 1m0s
[02:45:42.817] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:72:0)
[02:45:42.817] Timer tick, asking Buildbucket for the build status
[02:45:42.952] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:42.953] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:73:0) after 1m0s
[02:46:43.033] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:73:0)
[02:46:43.033] Timer tick, asking Buildbucket for the build status
[02:46:43.111] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:43.111] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:74:0) after 1m0s
[02:47:43.169] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:74:0)
[02:47:43.169] Timer tick, asking Buildbucket for the build status
[02:47:43.269] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:43.269] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:75:0) after 1m0s
[02:48:43.317] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:75:0)
[02:48:43.317] Timer tick, asking Buildbucket for the build status
[02:48:43.388] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:43.388] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:76:0) after 1m0s
[02:49:43.576] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:76:0)
[02:49:43.576] Timer tick, asking Buildbucket for the build status
[02:49:43.656] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:43.656] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:77:0) after 1m0s
[02:50:43.724] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:77:0)
[02:50:43.724] Timer tick, asking Buildbucket for the build status
[02:50:43.824] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:43.824] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:78:0) after 1m0s
[02:51:43.813] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:78:0)
[02:51:43.813] Timer tick, asking Buildbucket for the build status
[02:51:43.960] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:43.960] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:79:0) after 1m0s
[02:52:44.071] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:79:0)
[02:52:44.071] Timer tick, asking Buildbucket for the build status
[02:52:44.305] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:44.305] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:80:0) after 1m0s
[02:53:44.334] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:80:0)
[02:53:44.334] Timer tick, asking Buildbucket for the build status
[02:53:44.426] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:44.426] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:81:0) after 1m0s
[02:54:44.494] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:81:0)
[02:54:44.494] Timer tick, asking Buildbucket for the build status
[02:54:44.645] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:44.645] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:82:0) after 1m0s
[02:55:44.718] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:82:0)
[02:55:44.718] Timer tick, asking Buildbucket for the build status
[02:55:44.880] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:44.880] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:83:0) after 1m0s
[02:56:45.017] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:83:0)
[02:56:45.017] Timer tick, asking Buildbucket for the build status
[02:56:45.102] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:45.102] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:84:0) after 1m0s
[02:57:45.302] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:84:0)
[02:57:45.302] Timer tick, asking Buildbucket for the build status
[02:57:45.607] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:45.607] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:85:0) after 1m0s
[02:58:45.972] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:85:0)
[02:58:45.972] Timer tick, asking Buildbucket for the build status
[02:58:46.118] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:46.118] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:86:0) after 1m0s
[02:59:46.215] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:86:0)
[02:59:46.215] Timer tick, asking Buildbucket for the build status
[02:59:46.371] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:46.371] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:87:0) after 1m0s
[03:00:47.213] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:87:0)
[03:00:47.213] Timer tick, asking Buildbucket for the build status
[03:00:47.514] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:47.514] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:88:0) after 1m0s
[03:01:47.540] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:88:0)
[03:01:47.540] Timer tick, asking Buildbucket for the build status
[03:01:47.650] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:47.650] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:89:0) after 1m0s
[03:02:47.663] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:89:0)
[03:02:47.663] Timer tick, asking Buildbucket for the build status
[03:02:47.988] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:47.988] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:90:0) after 1m0s
[03:03:48.023] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:90:0)
[03:03:48.023] Timer tick, asking Buildbucket for the build status
[03:03:48.109] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:48.109] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:91:0) after 1m0s
[03:04:48.156] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:91:0)
[03:04:48.156] Timer tick, asking Buildbucket for the build status
[03:04:48.283] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:48.283] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:92:0) after 1m0s
[03:05:48.310] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:92:0)
[03:05:48.310] Timer tick, asking Buildbucket for the build status
[03:05:48.433] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:48.433] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:93:0) after 1m0s
[03:06:48.525] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:93:0)
[03:06:48.525] Timer tick, asking Buildbucket for the build status
[03:06:48.606] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:48.606] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:94:0) after 1m0s
[03:07:48.630] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:94:0)
[03:07:48.630] Timer tick, asking Buildbucket for the build status
[03:07:48.731] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:48.731] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:95:0) after 1m0s
[03:08:48.756] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:95:0)
[03:08:48.756] Timer tick, asking Buildbucket for the build status
[03:08:48.827] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:48.827] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:96:0) after 1m0s
[03:09:48.902] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:96:0)
[03:09:48.902] Timer tick, asking Buildbucket for the build status
[03:09:48.958] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:48.959] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:97:0) after 1m0s
[03:10:48.978] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:97:0)
[03:10:48.978] Timer tick, asking Buildbucket for the build status
[03:10:49.095] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:49.095] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:98:0) after 1m0s
[03:11:49.118] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:98:0)
[03:11:49.118] Timer tick, asking Buildbucket for the build status
[03:11:49.189] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:49.189] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:99:0) after 1m0s
[03:12:49.227] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:99:0)
[03:12:49.227] Timer tick, asking Buildbucket for the build status
[03:12:49.318] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:49.318] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:100:0) after 1m0s
[03:13:49.321] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:100:0)
[03:13:49.321] Timer tick, asking Buildbucket for the build status
[03:13:49.394] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:49.394] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:101:0) after 1m0s
[03:14:49.418] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:101:0)
[03:14:49.418] Timer tick, asking Buildbucket for the build status
[03:14:49.591] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:49.591] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:102:0) after 1m0s
[03:15:50.051] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:102:0)
[03:15:50.051] Timer tick, asking Buildbucket for the build status
[03:15:50.169] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:50.169] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:103:0) after 1m0s
[03:16:50.441] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:103:0)
[03:16:50.441] Timer tick, asking Buildbucket for the build status
[03:16:50.630] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:50.630] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:104:0) after 1m0s
[03:17:51.093] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:104:0)
[03:17:51.093] Timer tick, asking Buildbucket for the build status
[03:17:51.191] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:51.191] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:105:0) after 1m0s
[03:18:51.302] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:105:0)
[03:18:51.302] Timer tick, asking Buildbucket for the build status
[03:18:51.361] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:51.361] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:106:0) after 1m0s
[03:19:51.391] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:106:0)
[03:19:51.391] Timer tick, asking Buildbucket for the build status
[03:19:51.465] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:51.465] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:107:0) after 1m0s
[03:20:51.624] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:107:0)
[03:20:51.624] Timer tick, asking Buildbucket for the build status
[03:20:51.901] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:51.901] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:108:0) after 1m0s
[03:21:51.998] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:108:0)
[03:21:51.998] Timer tick, asking Buildbucket for the build status
[03:21:52.073] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:52.073] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:109:0) after 1m0s
[03:22:52.314] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:109:0)
[03:22:52.314] Timer tick, asking Buildbucket for the build status
[03:22:52.540] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:52.540] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:110:0) after 1m0s
[03:23:52.727] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:110:0)
[03:23:52.727] Timer tick, asking Buildbucket for the build status
[03:23:57.699] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:57.699] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:111:0) after 1m0s
[03:24:58.210] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:111:0)
[03:24:58.210] Timer tick, asking Buildbucket for the build status
[03:24:58.523] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:58.523] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:112:0) after 1m0s
[03:25:58.615] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:112:0)
[03:25:58.615] Timer tick, asking Buildbucket for the build status
[03:25:58.848] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:58.848] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:113:0) after 1m0s
[03:26:58.936] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:113:0)
[03:26:58.936] Timer tick, asking Buildbucket for the build status
[03:26:59.181] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:59.181] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:114:0) after 1m0s
[03:27:59.265] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:114:0)
[03:27:59.265] Timer tick, asking Buildbucket for the build status
[03:27:59.498] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:59.498] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:115:0) after 1m0s
[03:28:59.470] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:115:0)
[03:28:59.471] Timer tick, asking Buildbucket for the build status
[03:29:00.256] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:00.256] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:116:0) after 1m0s
[03:30:00.355] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:116:0)
[03:30:00.355] Timer tick, asking Buildbucket for the build status
[03:30:01.216] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:01.216] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:117:0) after 1m0s
[03:31:04.355] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:117:0)
[03:31:04.355] Timer tick, asking Buildbucket for the build status
[03:31:04.821] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:04.821] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:118:0) after 1m0s
[03:32:04.845] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:118:0)
[03:32:04.845] Timer tick, asking Buildbucket for the build status
[03:32:04.917] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:04.917] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:119:0) after 1m0s
[03:33:04.956] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:119:0)
[03:33:04.957] Timer tick, asking Buildbucket for the build status
[03:33:06.002] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:06.002] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:120:0) after 1m0s
[03:34:06.043] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:120:0)
[03:34:06.043] Timer tick, asking Buildbucket for the build status
[03:34:06.585] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:06.585] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:121:0) after 1m0s
[03:35:06.622] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:121:0)
[03:35:06.622] Timer tick, asking Buildbucket for the build status
[03:35:06.933] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:06.934] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:122:0) after 1m0s
[03:36:07.258] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:122:0)
[03:36:07.258] Timer tick, asking Buildbucket for the build status
[03:36:07.748] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:07.748] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:123:0) after 1m0s
[03:37:07.855] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:123:0)
[03:37:07.855] Timer tick, asking Buildbucket for the build status
[03:37:07.994] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:07.994] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:124:0) after 1m0s
[03:38:08.072] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:124:0)
[03:38:08.072] Timer tick, asking Buildbucket for the build status
[03:38:08.159] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:08.159] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:125:0) after 1m0s
[03:39:08.188] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:125:0)
[03:39:08.188] Timer tick, asking Buildbucket for the build status
[03:39:08.515] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:08.515] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:126:0) after 1m0s
[03:40:08.592] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:126:0)
[03:40:08.592] Timer tick, asking Buildbucket for the build status
[03:40:08.776] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:08.776] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:127:0) after 1m0s
[03:41:08.955] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:127:0)
[03:41:08.955] Timer tick, asking Buildbucket for the build status
[03:41:09.069] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:09.069] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:128:0) after 1m0s
[03:42:09.139] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:128:0)
[03:42:09.139] Timer tick, asking Buildbucket for the build status
[03:42:09.365] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:09.365] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:129:0) after 1m0s
[03:43:09.393] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:129:0)
[03:43:09.393] Timer tick, asking Buildbucket for the build status
[03:43:09.463] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:09.463] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:130:0) after 1m0s
[03:44:09.511] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:130:0)
[03:44:09.511] Timer tick, asking Buildbucket for the build status
[03:44:09.571] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:09.571] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:131:0) after 1m0s
[03:45:09.610] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:131:0)
[03:45:09.610] Timer tick, asking Buildbucket for the build status
[03:45:09.692] Build 8863967874801104624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:09.692] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029397937092671568:132:0) after 1m0s
[03:46:03.990] Received PubSub notification, asking Buildbucket for the build status
[03:46:04.057] Build 8863967874801104624: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:46:04.057] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"completed_ts": "1605066363430850",
"created_by": "project:emscripten-releases",
"created_ts": "1605058518560377",
"id": "8863967874801104624",
"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\": \"3d1014a5223cfb0e24b0cab99a45c3ba9cf82c94\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@3d1014a5223cfb0e24b0cab99a45c3ba9cf82c94\", \"title\": \"3d1014a5223cfb0e24b0cab99a45c3ba9cf82c94\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/3d1014a5223cfb0e24b0cab99a45c3ba9cf82c94\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"3d1014a5223cfb0e24b0cab99a45c3ba9cf82c94\"}}",
"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\": \"3d1014a5223cfb0e24b0cab99a45c3ba9cf82c94\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@3d1014a5223cfb0e24b0cab99a45c3ba9cf82c94\", \"title\": \"3d1014a5223cfb0e24b0cab99a45c3ba9cf82c94\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/3d1014a5223cfb0e24b0cab99a45c3ba9cf82c94\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-win10-0-rkkg\", \"branch\": \"refs/heads/master\", \"buildername\": \"win\", \"got_revision\": \"3d1014a5223cfb0e24b0cab99a45c3ba9cf82c94\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"3d1014a5223cfb0e24b0cab99a45c3ba9cf82c94\"}, \"swarming\": {\"bot_dimensions\": {\"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"host_class\": [\"default\"], \"id\": [\"luci-emscripten-releases-ci-win10-0-rkkg\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"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\": [\"5626-39642e9\"], \"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": "1605061848879071",
"status": "COMPLETED",
"status_changed_ts": "1605066363741562",
"tags": [
"builder:win",
"buildset:commit/git/3d1014a5223cfb0e24b0cab99a45c3ba9cf82c94",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/3d1014a5223cfb0e24b0cab99a45c3ba9cf82c94",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029397937092671568",
"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/8863967874801104624/+/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:4fcdc2ebcb70e410",
"user_agent:luci-scheduler"
],
"updated_ts": "1605066363756420",
"url": "https://ci.chromium.org/b/8863967874801104624",
"utcnow_ts": "1605066364048839"
}
}
[03:46:04.057] Invocation finished in 2h10m47.065529202s with status SUCCEEDED