[22:44:19.701] New invocation is queued and will start shortly
[22:44:20.883] Starting the invocation (attempt 1)
[22:44:20.924] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:44:20.924] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:44:20.924] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9020439592983320608",
"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\":\"77fa257167d7efb23b53616c29121cd02baf37a4\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@77fa257167d7efb23b53616c29121cd02baf37a4\",\"title\":\"77fa257167d7efb23b53616c29121cd02baf37a4\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/77fa257167d7efb23b53616c29121cd02baf37a4\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"77fa257167d7efb23b53616c29121cd02baf37a4\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win",
"scheduler_invocation_id:9020439592983320608",
"scheduler_job_id:emscripten-releases/win",
"user_agent:luci-scheduler",
"buildset:commit/git/77fa257167d7efb23b53616c29121cd02baf37a4",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/77fa257167d7efb23b53616c29121cd02baf37a4",
"gitiles_ref:refs/heads/master"
]
}
[22:44:21.484] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1613601861026412",
"id": "8855009530930844432",
"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\": \"77fa257167d7efb23b53616c29121cd02baf37a4\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@77fa257167d7efb23b53616c29121cd02baf37a4\", \"title\": \"77fa257167d7efb23b53616c29121cd02baf37a4\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/77fa257167d7efb23b53616c29121cd02baf37a4\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"77fa257167d7efb23b53616c29121cd02baf37a4\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613601861231558",
"tags": [
"builder:win",
"buildset:commit/git/77fa257167d7efb23b53616c29121cd02baf37a4",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/77fa257167d7efb23b53616c29121cd02baf37a4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020439592983320608",
"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/8855009530930844432/+/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": "1613601861231658",
"url": "https://ci.chromium.org/b/8855009530930844432",
"utcnow_ts": "1613601861477704"
}
}
[22:44:21.484] Task URL: https://ci.chromium.org/b/8855009530930844432
[22:44:21.484] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:2:0) after 1m0s
[22:45:21.481] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:2:0)
[22:45:21.481] Timer tick, asking Buildbucket for the build status
[22:45:21.688] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:45:21.688] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:3:0) after 1m0s
[22:46:21.709] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:3:0)
[22:46:21.709] Timer tick, asking Buildbucket for the build status
[22:46:21.779] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:46:21.779] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:4:0) after 1m0s
[22:47:21.761] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:4:0)
[22:47:21.761] Timer tick, asking Buildbucket for the build status
[22:47:21.828] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:47:21.828] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:5:0) after 1m0s
[22:48:21.815] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:5:0)
[22:48:21.815] Timer tick, asking Buildbucket for the build status
[22:48:21.979] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:48:21.979] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:6:0) after 1m0s
[22:49:22.006] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:6:0)
[22:49:22.006] Timer tick, asking Buildbucket for the build status
[22:49:22.296] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:49:22.296] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:7:0) after 1m0s
[22:50:22.394] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:7:0)
[22:50:22.394] Timer tick, asking Buildbucket for the build status
[22:50:22.616] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:50:22.616] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:8:0) after 1m0s
[22:51:22.639] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:8:0)
[22:51:22.639] Timer tick, asking Buildbucket for the build status
[22:51:22.878] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:51:22.878] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:9:0) after 1m0s
[22:52:22.890] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:9:0)
[22:52:22.890] Timer tick, asking Buildbucket for the build status
[22:52:22.970] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:52:22.970] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:10:0) after 1m0s
[22:53:22.967] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:10:0)
[22:53:22.967] Timer tick, asking Buildbucket for the build status
[22:53:23.124] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:53:23.124] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:11:0) after 1m0s
[22:54:23.203] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:11:0)
[22:54:23.203] Timer tick, asking Buildbucket for the build status
[22:54:23.289] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:54:23.289] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:12:0) after 1m0s
[22:55:23.345] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:12:0)
[22:55:23.345] Timer tick, asking Buildbucket for the build status
[22:55:23.465] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:55:23.465] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:13:0) after 1m0s
[22:56:23.509] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:13:0)
[22:56:23.509] Timer tick, asking Buildbucket for the build status
[22:56:23.583] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:56:23.583] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:14:0) after 1m0s
[22:57:23.602] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:14:0)
[22:57:23.602] Timer tick, asking Buildbucket for the build status
[22:57:23.681] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:57:23.681] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:15:0) after 1m0s
[22:58:23.709] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:15:0)
[22:58:23.709] Timer tick, asking Buildbucket for the build status
[22:58:23.779] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:58:23.779] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:16:0) after 1m0s
[22:59:23.798] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:16:0)
[22:59:23.798] Timer tick, asking Buildbucket for the build status
[22:59:23.868] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:59:23.868] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:17:0) after 1m0s
[23:00:23.956] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:17:0)
[23:00:23.956] Timer tick, asking Buildbucket for the build status
[23:00:24.078] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:00:24.078] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:18:0) after 1m0s
[23:01:24.077] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:18:0)
[23:01:24.077] Timer tick, asking Buildbucket for the build status
[23:01:24.178] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:01:24.178] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:19:0) after 1m0s
[23:02:24.261] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:19:0)
[23:02:24.261] Timer tick, asking Buildbucket for the build status
[23:02:24.351] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:02:24.351] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:20:0) after 1m0s
[23:03:24.388] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:20:0)
[23:03:24.388] Timer tick, asking Buildbucket for the build status
[23:03:24.714] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:03:24.715] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:21:0) after 1m0s
[23:04:24.761] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:21:0)
[23:04:24.761] Timer tick, asking Buildbucket for the build status
[23:04:24.846] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:04:24.846] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:22:0) after 1m0s
[23:05:24.873] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:22:0)
[23:05:24.873] Timer tick, asking Buildbucket for the build status
[23:05:24.955] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:05:24.955] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:23:0) after 1m0s
[23:06:25.045] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:23:0)
[23:06:25.045] Timer tick, asking Buildbucket for the build status
[23:06:25.138] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:06:25.138] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:24:0) after 1m0s
[23:07:25.188] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:24:0)
[23:07:25.188] Timer tick, asking Buildbucket for the build status
[23:07:25.571] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:07:25.571] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:25:0) after 1m0s
[23:08:25.664] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:25:0)
[23:08:25.664] Timer tick, asking Buildbucket for the build status
[23:08:25.734] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:08:25.734] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:26:0) after 1m0s
[23:09:25.775] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:26:0)
[23:09:25.775] Timer tick, asking Buildbucket for the build status
[23:09:25.844] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:09:25.844] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:27:0) after 1m0s
[23:10:25.892] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:27:0)
[23:10:25.892] Timer tick, asking Buildbucket for the build status
[23:10:25.981] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:10:25.981] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:28:0) after 1m0s
[23:11:26.064] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:28:0)
[23:11:26.064] Timer tick, asking Buildbucket for the build status
[23:11:26.141] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:11:26.141] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:29:0) after 1m0s
[23:12:26.197] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:29:0)
[23:12:26.197] Timer tick, asking Buildbucket for the build status
[23:12:26.429] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:12:26.429] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:30:0) after 1m0s
[23:13:26.417] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:30:0)
[23:13:26.418] Timer tick, asking Buildbucket for the build status
[23:13:26.692] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:13:26.692] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:31:0) after 1m0s
[23:14:28.782] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:31:0)
[23:14:28.782] Timer tick, asking Buildbucket for the build status
[23:14:28.895] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:14:28.895] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:32:0) after 1m0s
[23:15:28.963] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:32:0)
[23:15:28.963] Timer tick, asking Buildbucket for the build status
[23:15:29.076] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:15:29.076] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:33:0) after 1m0s
[23:16:29.135] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:33:0)
[23:16:29.136] Timer tick, asking Buildbucket for the build status
[23:16:29.211] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:16:29.211] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:34:0) after 1m0s
[23:17:29.269] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:34:0)
[23:17:29.269] Timer tick, asking Buildbucket for the build status
[23:17:29.353] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:17:29.353] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:35:0) after 1m0s
[23:18:29.415] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:35:0)
[23:18:29.415] Timer tick, asking Buildbucket for the build status
[23:18:29.489] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:18:29.489] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:36:0) after 1m0s
[23:19:29.564] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:36:0)
[23:19:29.564] Timer tick, asking Buildbucket for the build status
[23:19:29.647] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:19:29.647] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:37:0) after 1m0s
[23:20:29.774] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:37:0)
[23:20:29.774] Timer tick, asking Buildbucket for the build status
[23:20:29.898] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:20:29.898] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:38:0) after 1m0s
[23:21:29.946] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:38:0)
[23:21:29.946] Timer tick, asking Buildbucket for the build status
[23:21:30.056] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:21:30.056] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:39:0) after 1m0s
[23:22:30.125] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:39:0)
[23:22:30.125] Timer tick, asking Buildbucket for the build status
[23:22:30.220] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:22:30.220] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:40:0) after 1m0s
[23:23:30.319] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:40:0)
[23:23:30.319] Timer tick, asking Buildbucket for the build status
[23:23:30.393] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:23:30.393] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:41:0) after 1m0s
[23:24:30.461] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:41:0)
[23:24:30.461] Timer tick, asking Buildbucket for the build status
[23:24:30.544] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:24:30.544] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:42:0) after 1m0s
[23:25:30.575] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:42:0)
[23:25:30.575] Timer tick, asking Buildbucket for the build status
[23:25:30.797] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:25:30.797] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:43:0) after 1m0s
[23:26:30.914] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:43:0)
[23:26:30.914] Timer tick, asking Buildbucket for the build status
[23:26:31.064] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:26:31.064] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:44:0) after 1m0s
[23:27:31.211] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:44:0)
[23:27:31.211] Timer tick, asking Buildbucket for the build status
[23:27:31.284] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:27:31.284] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:45:0) after 1m0s
[23:28:31.322] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:45:0)
[23:28:31.323] Timer tick, asking Buildbucket for the build status
[23:28:31.423] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:28:31.423] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:46:0) after 1m0s
[23:29:31.618] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:46:0)
[23:29:31.618] Timer tick, asking Buildbucket for the build status
[23:29:31.820] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:29:31.820] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:47:0) after 1m0s
[23:30:31.792] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:47:0)
[23:30:31.792] Timer tick, asking Buildbucket for the build status
[23:30:32.015] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:30:32.015] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:48:0) after 1m0s
[23:31:32.059] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:48:0)
[23:31:32.059] Timer tick, asking Buildbucket for the build status
[23:31:32.141] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:31:32.141] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:49:0) after 1m0s
[23:32:32.154] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:49:0)
[23:32:32.154] Timer tick, asking Buildbucket for the build status
[23:32:32.240] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:32:32.240] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:50:0) after 1m0s
[23:33:32.321] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:50:0)
[23:33:32.322] Timer tick, asking Buildbucket for the build status
[23:33:32.402] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:33:32.402] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:51:0) after 1m0s
[23:34:32.472] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:51:0)
[23:34:32.472] Timer tick, asking Buildbucket for the build status
[23:34:32.556] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:34:32.556] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:52:0) after 1m0s
[23:35:32.606] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:52:0)
[23:35:32.606] Timer tick, asking Buildbucket for the build status
[23:35:32.745] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:35:32.745] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:53:0) after 1m0s
[23:36:32.829] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:53:0)
[23:36:32.829] Timer tick, asking Buildbucket for the build status
[23:36:32.922] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:36:32.922] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:54:0) after 1m0s
[23:37:32.942] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:54:0)
[23:37:32.942] Timer tick, asking Buildbucket for the build status
[23:37:33.072] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:37:33.072] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:55:0) after 1m0s
[23:38:33.228] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:55:0)
[23:38:33.228] Timer tick, asking Buildbucket for the build status
[23:38:33.524] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:38:33.524] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:56:0) after 1m0s
[23:39:33.579] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:56:0)
[23:39:33.579] Timer tick, asking Buildbucket for the build status
[23:39:33.664] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:39:33.664] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:57:0) after 1m0s
[23:40:33.726] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:57:0)
[23:40:33.726] Timer tick, asking Buildbucket for the build status
[23:40:34.013] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:40:34.013] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:58:0) after 1m0s
[23:41:34.035] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:58:0)
[23:41:34.035] Timer tick, asking Buildbucket for the build status
[23:41:34.099] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:41:34.099] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:59:0) after 1m0s
[23:42:34.103] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:59:0)
[23:42:34.104] Timer tick, asking Buildbucket for the build status
[23:42:34.383] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:42:34.383] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:60:0) after 1m0s
[23:43:34.440] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:60:0)
[23:43:34.440] Timer tick, asking Buildbucket for the build status
[23:43:34.505] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:43:34.505] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:61:0) after 1m0s
[23:44:34.587] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:61:0)
[23:44:34.587] Timer tick, asking Buildbucket for the build status
[23:44:34.677] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:44:34.677] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:62:0) after 1m0s
[23:45:34.718] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:62:0)
[23:45:34.718] Timer tick, asking Buildbucket for the build status
[23:45:34.850] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:45:34.850] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:63:0) after 1m0s
[23:46:34.922] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:63:0)
[23:46:34.922] Timer tick, asking Buildbucket for the build status
[23:46:35.014] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:46:35.014] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:64:0) after 1m0s
[23:47:35.038] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:64:0)
[23:47:35.038] Timer tick, asking Buildbucket for the build status
[23:47:35.115] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:47:35.115] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:65:0) after 1m0s
[23:48:35.781] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:65:0)
[23:48:35.781] Timer tick, asking Buildbucket for the build status
[23:48:35.874] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:48:35.874] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:66:0) after 1m0s
[23:49:35.958] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:66:0)
[23:49:35.958] Timer tick, asking Buildbucket for the build status
[23:49:36.218] Build 8855009530930844432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:49:36.218] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:67:0) after 1m0s
[23:49:39.312] Received PubSub notification, asking Buildbucket for the build status
[23:49:39.386] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:36.291] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:67:0)
[23:50:36.291] Timer tick, asking Buildbucket for the build status
[23:50:36.405] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:36.405] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:69:0) after 1m0s
[23:51:36.454] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:69:0)
[23:51:36.454] Timer tick, asking Buildbucket for the build status
[23:51:36.721] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:36.721] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:70:0) after 1m0s
[23:52:36.808] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:70:0)
[23:52:36.808] Timer tick, asking Buildbucket for the build status
[23:52:37.000] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:37.000] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:71:0) after 1m0s
[23:53:37.052] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:71:0)
[23:53:37.052] Timer tick, asking Buildbucket for the build status
[23:53:37.122] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:37.122] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:72:0) after 1m0s
[23:54:37.176] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:72:0)
[23:54:37.176] Timer tick, asking Buildbucket for the build status
[23:54:37.291] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:37.291] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:73:0) after 1m0s
[23:55:37.394] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:73:0)
[23:55:37.394] Timer tick, asking Buildbucket for the build status
[23:55:37.491] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:37.491] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:74:0) after 1m0s
[23:56:37.590] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:74:0)
[23:56:37.590] Timer tick, asking Buildbucket for the build status
[23:56:37.678] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:37.678] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:75:0) after 1m0s
[23:57:37.781] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:75:0)
[23:57:37.781] Timer tick, asking Buildbucket for the build status
[23:57:37.861] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:37.861] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:76:0) after 1m0s
[23:58:37.901] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:76:0)
[23:58:37.901] Timer tick, asking Buildbucket for the build status
[23:58:38.015] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:38.015] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:77:0) after 1m0s
[23:59:38.060] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:77:0)
[23:59:38.060] Timer tick, asking Buildbucket for the build status
[23:59:38.395] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:38.395] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:78:0) after 1m0s
[00:00:38.453] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:78:0)
[00:00:38.453] Timer tick, asking Buildbucket for the build status
[00:00:38.571] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:38.571] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:79:0) after 1m0s
[00:01:38.693] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:79:0)
[00:01:38.693] Timer tick, asking Buildbucket for the build status
[00:01:38.816] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:38.816] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:80:0) after 1m0s
[00:02:38.893] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:80:0)
[00:02:38.893] Timer tick, asking Buildbucket for the build status
[00:02:39.009] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:39.009] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:81:0) after 1m0s
[00:03:39.196] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:81:0)
[00:03:39.196] Timer tick, asking Buildbucket for the build status
[00:03:39.459] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:39.459] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:82:0) after 1m0s
[00:04:39.512] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:82:0)
[00:04:39.512] Timer tick, asking Buildbucket for the build status
[00:04:39.697] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:39.697] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:83:0) after 1m0s
[00:05:39.799] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:83:0)
[00:05:39.799] Timer tick, asking Buildbucket for the build status
[00:05:39.908] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:39.908] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:84:0) after 1m0s
[00:06:39.952] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:84:0)
[00:06:39.952] Timer tick, asking Buildbucket for the build status
[00:06:40.261] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:40.261] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:85:0) after 1m0s
[00:07:40.298] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:85:0)
[00:07:40.298] Timer tick, asking Buildbucket for the build status
[00:07:40.598] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:40.598] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:86:0) after 1m0s
[00:08:40.713] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:86:0)
[00:08:40.713] Timer tick, asking Buildbucket for the build status
[00:08:40.793] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:40.793] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:87:0) after 1m0s
[00:09:40.885] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:87:0)
[00:09:40.885] Timer tick, asking Buildbucket for the build status
[00:09:41.029] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:41.029] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:88:0) after 1m0s
[00:10:41.084] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:88:0)
[00:10:41.084] Timer tick, asking Buildbucket for the build status
[00:10:41.300] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:41.300] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:89:0) after 1m0s
[00:11:41.408] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:89:0)
[00:11:41.408] Timer tick, asking Buildbucket for the build status
[00:11:41.799] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:41.799] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:90:0) after 1m0s
[00:12:41.870] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:90:0)
[00:12:41.870] Timer tick, asking Buildbucket for the build status
[00:12:42.114] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:42.114] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:91:0) after 1m0s
[00:13:42.158] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:91:0)
[00:13:42.158] Timer tick, asking Buildbucket for the build status
[00:13:42.618] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:42.618] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:92:0) after 1m0s
[00:14:42.767] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:92:0)
[00:14:42.767] Timer tick, asking Buildbucket for the build status
[00:14:42.976] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:42.976] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:93:0) after 1m0s
[00:15:43.039] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:93:0)
[00:15:43.039] Timer tick, asking Buildbucket for the build status
[00:15:43.199] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:43.199] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:94:0) after 1m0s
[00:16:43.229] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:94:0)
[00:16:43.229] Timer tick, asking Buildbucket for the build status
[00:16:43.311] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:43.311] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:95:0) after 1m0s
[00:17:43.544] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:95:0)
[00:17:43.544] Timer tick, asking Buildbucket for the build status
[00:17:43.611] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:43.611] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:96:0) after 1m0s
[00:18:43.666] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:96:0)
[00:18:43.666] Timer tick, asking Buildbucket for the build status
[00:18:43.764] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:43.764] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:97:0) after 1m0s
[00:19:43.915] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:97:0)
[00:19:43.915] Timer tick, asking Buildbucket for the build status
[00:19:44.005] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:44.005] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:98:0) after 1m0s
[00:20:44.116] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:98:0)
[00:20:44.116] Timer tick, asking Buildbucket for the build status
[00:20:44.213] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:44.213] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:99:0) after 1m0s
[00:21:44.234] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:99:0)
[00:21:44.234] Timer tick, asking Buildbucket for the build status
[00:21:44.611] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:44.611] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:100:0) after 1m0s
[00:22:44.728] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:100:0)
[00:22:44.728] Timer tick, asking Buildbucket for the build status
[00:22:45.243] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:45.243] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:101:0) after 1m0s
[00:23:45.315] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:101:0)
[00:23:45.315] Timer tick, asking Buildbucket for the build status
[00:23:45.458] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:45.458] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:102:0) after 1m0s
[00:24:45.590] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:102:0)
[00:24:45.590] Timer tick, asking Buildbucket for the build status
[00:24:45.698] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:45.698] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:103:0) after 1m0s
[00:25:45.763] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:103:0)
[00:25:45.763] Timer tick, asking Buildbucket for the build status
[00:25:45.860] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:45.861] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:104:0) after 1m0s
[00:26:45.918] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:104:0)
[00:26:45.918] Timer tick, asking Buildbucket for the build status
[00:26:46.220] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:46.220] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:105:0) after 1m0s
[00:27:46.279] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:105:0)
[00:27:46.279] Timer tick, asking Buildbucket for the build status
[00:27:46.362] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:46.362] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:106:0) after 1m0s
[00:28:46.470] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:106:0)
[00:28:46.470] Timer tick, asking Buildbucket for the build status
[00:28:46.549] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:46.549] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:107:0) after 1m0s
[00:29:46.618] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:107:0)
[00:29:46.618] Timer tick, asking Buildbucket for the build status
[00:29:46.812] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:46.812] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:108:0) after 1m0s
[00:30:46.831] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:108:0)
[00:30:46.831] Timer tick, asking Buildbucket for the build status
[00:30:46.943] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:46.943] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:109:0) after 1m0s
[00:31:46.962] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:109:0)
[00:31:46.962] Timer tick, asking Buildbucket for the build status
[00:31:47.097] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:47.097] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:110:0) after 1m0s
[00:32:47.106] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:110:0)
[00:32:47.106] Timer tick, asking Buildbucket for the build status
[00:32:47.337] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:47.337] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:111:0) after 1m0s
[00:33:47.361] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:111:0)
[00:33:47.361] Timer tick, asking Buildbucket for the build status
[00:33:47.650] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:47.650] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:112:0) after 1m0s
[00:34:47.686] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:112:0)
[00:34:47.686] Timer tick, asking Buildbucket for the build status
[00:34:47.894] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:47.894] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:113:0) after 1m0s
[00:35:47.956] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:113:0)
[00:35:47.956] Timer tick, asking Buildbucket for the build status
[00:35:48.137] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:48.137] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:114:0) after 1m0s
[00:36:48.213] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:114:0)
[00:36:48.213] Timer tick, asking Buildbucket for the build status
[00:36:48.292] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:48.292] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:115:0) after 1m0s
[00:37:48.331] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:115:0)
[00:37:48.332] Timer tick, asking Buildbucket for the build status
[00:37:48.622] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:48.622] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:116:0) after 1m0s
[00:38:48.669] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:116:0)
[00:38:48.669] Timer tick, asking Buildbucket for the build status
[00:38:48.781] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:48.781] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:117:0) after 1m0s
[00:39:48.777] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:117:0)
[00:39:48.777] Timer tick, asking Buildbucket for the build status
[00:39:48.889] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:48.889] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:118:0) after 1m0s
[00:40:48.919] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:118:0)
[00:40:48.919] Timer tick, asking Buildbucket for the build status
[00:40:48.985] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:48.985] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:119:0) after 1m0s
[00:41:49.021] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:119:0)
[00:41:49.021] Timer tick, asking Buildbucket for the build status
[00:41:49.104] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:49.105] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:120:0) after 1m0s
[00:42:49.152] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:120:0)
[00:42:49.152] Timer tick, asking Buildbucket for the build status
[00:42:49.438] Build 8855009530930844432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:49.438] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9020439592983320608:121:0) after 1m0s
[00:43:34.459] Received PubSub notification, asking Buildbucket for the build status
[00:43:34.885] Build 8855009530930844432: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:43:34.885] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"completed_ts": "1613609013547756",
"created_by": "project:emscripten-releases",
"created_ts": "1613601861026412",
"id": "8855009530930844432",
"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\": \"77fa257167d7efb23b53616c29121cd02baf37a4\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@77fa257167d7efb23b53616c29121cd02baf37a4\", \"title\": \"77fa257167d7efb23b53616c29121cd02baf37a4\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/77fa257167d7efb23b53616c29121cd02baf37a4\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"77fa257167d7efb23b53616c29121cd02baf37a4\"}}",
"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\": \"77fa257167d7efb23b53616c29121cd02baf37a4\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@77fa257167d7efb23b53616c29121cd02baf37a4\", \"title\": \"77fa257167d7efb23b53616c29121cd02baf37a4\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/77fa257167d7efb23b53616c29121cd02baf37a4\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-win10-0-h7zf\", \"branch\": \"refs/heads/master\", \"buildername\": \"win\", \"got_revision\": \"77fa257167d7efb23b53616c29121cd02baf37a4\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"77fa257167d7efb23b53616c29121cd02baf37a4\"}, \"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-h7zf\"], \"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\": [\"5700-b36f18b\"], \"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": "1613605778615840",
"status": "COMPLETED",
"status_changed_ts": "1613609014096917",
"tags": [
"builder:win",
"buildset:commit/git/77fa257167d7efb23b53616c29121cd02baf37a4",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/77fa257167d7efb23b53616c29121cd02baf37a4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020439592983320608",
"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/8855009530930844432/+/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:51cafbfa2db2e210",
"user_agent:luci-scheduler"
],
"updated_ts": "1613609014110713",
"url": "https://ci.chromium.org/b/8855009530930844432",
"utcnow_ts": "1613609014860661"
}
}
[00:43:34.885] Invocation finished in 1h59m15.199907897s with status SUCCEEDED