[00:09:04.278] New invocation is queued and will start shortly
[00:09:05.432] Starting the invocation (attempt 1)
[00:09:05.581] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:09:05.583] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:09:05.583] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9024239334007315072",
"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\":\"e4d1128776a93a6e4f848809a7d05426914e98f7\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@e4d1128776a93a6e4f848809a7d05426914e98f7\",\"title\":\"e4d1128776a93a6e4f848809a7d05426914e98f7\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/e4d1128776a93a6e4f848809a7d05426914e98f7\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"e4d1128776a93a6e4f848809a7d05426914e98f7\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win",
"scheduler_invocation_id:9024239334007315072",
"scheduler_job_id:emscripten-releases/win",
"user_agent:luci-scheduler",
"buildset:commit/git/e4d1128776a93a6e4f848809a7d05426914e98f7",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/e4d1128776a93a6e4f848809a7d05426914e98f7",
"gitiles_ref:refs/heads/master"
]
}
[00:09:06.257] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1609978145729241",
"id": "8858809271821920624",
"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\": \"e4d1128776a93a6e4f848809a7d05426914e98f7\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@e4d1128776a93a6e4f848809a7d05426914e98f7\", \"title\": \"e4d1128776a93a6e4f848809a7d05426914e98f7\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/e4d1128776a93a6e4f848809a7d05426914e98f7\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"e4d1128776a93a6e4f848809a7d05426914e98f7\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1609978146091279",
"tags": [
"builder:win",
"buildset:commit/git/e4d1128776a93a6e4f848809a7d05426914e98f7",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/e4d1128776a93a6e4f848809a7d05426914e98f7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024239334007315072",
"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/8858809271821920624/+/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": "1609978146091536",
"url": "https://ci.chromium.org/b/8858809271821920624",
"utcnow_ts": "1609978146248056"
}
}
[00:09:06.257] Task URL: https://ci.chromium.org/b/8858809271821920624
[00:09:06.257] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:2:0) after 1m0s
[00:10:06.274] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:2:0)
[00:10:06.274] Timer tick, asking Buildbucket for the build status
[00:10:06.450] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:10:06.450] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:3:0) after 1m0s
[00:11:06.543] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:3:0)
[00:11:06.543] Timer tick, asking Buildbucket for the build status
[00:11:06.751] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:11:06.751] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:4:0) after 1m0s
[00:12:06.763] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:4:0)
[00:12:06.763] Timer tick, asking Buildbucket for the build status
[00:12:06.897] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:12:06.897] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:5:0) after 1m0s
[00:13:06.899] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:5:0)
[00:13:06.899] Timer tick, asking Buildbucket for the build status
[00:13:07.076] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:13:07.076] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:6:0) after 1m0s
[00:14:07.135] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:6:0)
[00:14:07.135] Timer tick, asking Buildbucket for the build status
[00:14:07.297] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:14:07.297] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:7:0) after 1m0s
[00:15:07.318] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:7:0)
[00:15:07.318] Timer tick, asking Buildbucket for the build status
[00:15:07.500] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:15:07.501] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:8:0) after 1m0s
[00:16:07.594] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:8:0)
[00:16:07.594] Timer tick, asking Buildbucket for the build status
[00:16:07.713] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:16:07.713] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:9:0) after 1m0s
[00:17:07.717] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:9:0)
[00:17:07.717] Timer tick, asking Buildbucket for the build status
[00:17:07.899] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:17:07.899] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:10:0) after 1m0s
[00:18:07.913] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:10:0)
[00:18:07.913] Timer tick, asking Buildbucket for the build status
[00:18:08.044] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:18:08.044] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:11:0) after 1m0s
[00:19:08.083] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:11:0)
[00:19:08.083] Timer tick, asking Buildbucket for the build status
[00:19:08.252] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:19:08.252] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:12:0) after 1m0s
[00:20:08.383] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:12:0)
[00:20:08.383] Timer tick, asking Buildbucket for the build status
[00:20:08.498] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:20:08.498] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:13:0) after 1m0s
[00:21:08.585] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:13:0)
[00:21:08.585] Timer tick, asking Buildbucket for the build status
[00:21:08.694] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:21:08.694] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:14:0) after 1m0s
[00:22:08.756] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:14:0)
[00:22:08.756] Timer tick, asking Buildbucket for the build status
[00:22:08.829] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:22:08.829] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:15:0) after 1m0s
[00:23:08.891] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:15:0)
[00:23:08.891] Timer tick, asking Buildbucket for the build status
[00:23:09.042] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:23:09.042] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:16:0) after 1m0s
[00:24:09.113] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:16:0)
[00:24:09.113] Timer tick, asking Buildbucket for the build status
[00:24:09.202] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:24:09.202] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:17:0) after 1m0s
[00:25:09.334] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:17:0)
[00:25:09.334] Timer tick, asking Buildbucket for the build status
[00:25:09.492] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:25:09.492] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:18:0) after 1m0s
[00:26:09.581] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:18:0)
[00:26:09.581] Timer tick, asking Buildbucket for the build status
[00:26:09.707] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:26:09.707] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:19:0) after 1m0s
[00:27:09.757] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:19:0)
[00:27:09.757] Timer tick, asking Buildbucket for the build status
[00:27:09.844] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:27:09.844] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:20:0) after 1m0s
[00:28:09.985] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:20:0)
[00:28:09.985] Timer tick, asking Buildbucket for the build status
[00:28:10.158] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:28:10.158] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:21:0) after 1m0s
[00:29:10.262] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:21:0)
[00:29:10.262] Timer tick, asking Buildbucket for the build status
[00:29:10.347] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:29:10.347] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:22:0) after 1m0s
[00:30:10.404] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:22:0)
[00:30:10.404] Timer tick, asking Buildbucket for the build status
[00:30:10.536] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:30:10.536] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:23:0) after 1m0s
[00:31:10.551] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:23:0)
[00:31:10.551] Timer tick, asking Buildbucket for the build status
[00:31:10.629] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:31:10.629] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:24:0) after 1m0s
[00:32:10.630] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:24:0)
[00:32:10.630] Timer tick, asking Buildbucket for the build status
[00:32:10.730] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:32:10.730] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:25:0) after 1m0s
[00:33:10.820] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:25:0)
[00:33:10.820] Timer tick, asking Buildbucket for the build status
[00:33:10.920] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:33:10.920] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:26:0) after 1m0s
[00:34:10.992] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:26:0)
[00:34:10.993] Timer tick, asking Buildbucket for the build status
[00:34:11.143] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:34:11.143] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:27:0) after 1m0s
[00:35:11.209] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:27:0)
[00:35:11.209] Timer tick, asking Buildbucket for the build status
[00:35:11.452] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:35:11.452] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:28:0) after 1m0s
[00:36:11.467] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:28:0)
[00:36:11.467] Timer tick, asking Buildbucket for the build status
[00:36:11.612] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:36:11.612] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:29:0) after 1m0s
[00:37:11.635] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:29:0)
[00:37:11.635] Timer tick, asking Buildbucket for the build status
[00:37:11.722] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:37:11.722] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:30:0) after 1m0s
[00:38:11.754] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:30:0)
[00:38:11.754] Timer tick, asking Buildbucket for the build status
[00:38:11.823] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:38:11.823] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:31:0) after 1m0s
[00:39:11.944] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:31:0)
[00:39:11.944] Timer tick, asking Buildbucket for the build status
[00:39:12.072] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:39:12.072] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:32:0) after 1m0s
[00:40:12.200] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:32:0)
[00:40:12.200] Timer tick, asking Buildbucket for the build status
[00:40:12.372] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:40:12.372] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:33:0) after 1m0s
[00:41:12.430] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:33:0)
[00:41:12.430] Timer tick, asking Buildbucket for the build status
[00:41:12.521] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:41:12.521] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:34:0) after 1m0s
[00:42:12.597] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:34:0)
[00:42:12.597] Timer tick, asking Buildbucket for the build status
[00:42:12.698] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:42:12.698] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:35:0) after 1m0s
[00:43:12.797] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:35:0)
[00:43:12.797] Timer tick, asking Buildbucket for the build status
[00:43:13.068] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:43:13.068] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:36:0) after 1m0s
[00:44:13.116] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:36:0)
[00:44:13.116] Timer tick, asking Buildbucket for the build status
[00:44:13.349] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:44:13.349] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:37:0) after 1m0s
[00:45:13.454] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:37:0)
[00:45:13.454] Timer tick, asking Buildbucket for the build status
[00:45:15.205] Build 8858809271821920624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:45:15.205] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:38:0) after 1m0s
[00:45:18.037] Received PubSub notification, asking Buildbucket for the build status
[00:45:18.255] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:15.232] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:38:0)
[00:46:15.232] Timer tick, asking Buildbucket for the build status
[00:46:15.341] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:15.341] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:40:0) after 1m0s
[00:47:15.369] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:40:0)
[00:47:15.369] Timer tick, asking Buildbucket for the build status
[00:47:15.506] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:15.506] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:41:0) after 1m0s
[00:48:15.514] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:41:0)
[00:48:15.514] Timer tick, asking Buildbucket for the build status
[00:48:15.745] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:15.745] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:42:0) after 1m0s
[00:49:15.772] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:42:0)
[00:49:15.772] Timer tick, asking Buildbucket for the build status
[00:49:15.896] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:15.896] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:43:0) after 1m0s
[00:50:15.950] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:43:0)
[00:50:15.950] Timer tick, asking Buildbucket for the build status
[00:50:16.819] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:16.819] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:44:0) after 1m0s
[00:51:16.934] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:44:0)
[00:51:16.934] Timer tick, asking Buildbucket for the build status
[00:51:17.240] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:17.240] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:45:0) after 1m0s
[00:52:17.233] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:45:0)
[00:52:17.233] Timer tick, asking Buildbucket for the build status
[00:52:17.359] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:17.359] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:46:0) after 1m0s
[00:53:17.432] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:46:0)
[00:53:17.432] Timer tick, asking Buildbucket for the build status
[00:53:17.726] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:17.726] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:47:0) after 1m0s
[00:54:17.790] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:47:0)
[00:54:17.790] Timer tick, asking Buildbucket for the build status
[00:54:18.470] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:18.470] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:48:0) after 1m0s
[00:55:18.499] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:48:0)
[00:55:18.499] Timer tick, asking Buildbucket for the build status
[00:55:18.674] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:18.674] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:49:0) after 1m0s
[00:56:19.092] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:49:0)
[00:56:19.092] Timer tick, asking Buildbucket for the build status
[00:56:19.240] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:19.240] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:50:0) after 1m0s
[00:57:19.482] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:50:0)
[00:57:19.482] Timer tick, asking Buildbucket for the build status
[00:57:19.548] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:19.548] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:51:0) after 1m0s
[00:58:19.698] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:51:0)
[00:58:19.698] Timer tick, asking Buildbucket for the build status
[00:58:19.805] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:19.805] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:52:0) after 1m0s
[00:59:20.034] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:52:0)
[00:59:20.034] Timer tick, asking Buildbucket for the build status
[00:59:20.390] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:20.390] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:53:0) after 1m0s
[01:00:20.716] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:53:0)
[01:00:20.716] Timer tick, asking Buildbucket for the build status
[01:00:21.098] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:21.098] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:54:0) after 1m0s
[01:01:21.189] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:54:0)
[01:01:21.189] Timer tick, asking Buildbucket for the build status
[01:01:21.449] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:21.449] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:55:0) after 1m0s
[01:02:21.498] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:55:0)
[01:02:21.498] Timer tick, asking Buildbucket for the build status
[01:02:21.590] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:21.590] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:56:0) after 1m0s
[01:03:21.607] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:56:0)
[01:03:21.607] Timer tick, asking Buildbucket for the build status
[01:03:21.681] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:21.681] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:57:0) after 1m0s
[01:04:21.762] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:57:0)
[01:04:21.762] Timer tick, asking Buildbucket for the build status
[01:04:21.906] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:21.906] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:58:0) after 1m0s
[01:05:22.003] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:58:0)
[01:05:22.003] Timer tick, asking Buildbucket for the build status
[01:05:22.073] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:22.073] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:59:0) after 1m0s
[01:06:22.142] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:59:0)
[01:06:22.142] Timer tick, asking Buildbucket for the build status
[01:06:22.396] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:22.396] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:60:0) after 1m0s
[01:07:22.483] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:60:0)
[01:07:22.483] Timer tick, asking Buildbucket for the build status
[01:07:22.584] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:22.584] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:61:0) after 1m0s
[01:08:22.612] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:61:0)
[01:08:22.612] Timer tick, asking Buildbucket for the build status
[01:08:22.790] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:22.790] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:62:0) after 1m0s
[01:09:22.775] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:62:0)
[01:09:22.775] Timer tick, asking Buildbucket for the build status
[01:09:22.986] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:22.986] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:63:0) after 1m0s
[01:10:23.022] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:63:0)
[01:10:23.022] Timer tick, asking Buildbucket for the build status
[01:10:23.098] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:23.098] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:64:0) after 1m0s
[01:11:23.185] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:64:0)
[01:11:23.185] Timer tick, asking Buildbucket for the build status
[01:11:23.492] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:23.492] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:65:0) after 1m0s
[01:12:23.618] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:65:0)
[01:12:23.618] Timer tick, asking Buildbucket for the build status
[01:12:23.742] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:23.742] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:66:0) after 1m0s
[01:13:23.795] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:66:0)
[01:13:23.795] Timer tick, asking Buildbucket for the build status
[01:13:23.889] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:23.889] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:67:0) after 1m0s
[01:14:24.098] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:67:0)
[01:14:24.098] Timer tick, asking Buildbucket for the build status
[01:14:24.255] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:24.255] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:68:0) after 1m0s
[01:15:24.340] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:68:0)
[01:15:24.340] Timer tick, asking Buildbucket for the build status
[01:15:24.568] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:24.568] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:69:0) after 1m0s
[01:16:24.623] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:69:0)
[01:16:24.623] Timer tick, asking Buildbucket for the build status
[01:16:24.711] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:24.711] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:70:0) after 1m0s
[01:17:24.706] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:70:0)
[01:17:24.706] Timer tick, asking Buildbucket for the build status
[01:17:24.974] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:24.974] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:71:0) after 1m0s
[01:18:25.133] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:71:0)
[01:18:25.133] Timer tick, asking Buildbucket for the build status
[01:18:25.209] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:25.209] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:72:0) after 1m0s
[01:19:25.357] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:72:0)
[01:19:25.357] Timer tick, asking Buildbucket for the build status
[01:19:25.717] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:25.717] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:73:0) after 1m0s
[01:20:25.739] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:73:0)
[01:20:25.739] Timer tick, asking Buildbucket for the build status
[01:20:25.932] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:25.932] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:74:0) after 1m0s
[01:21:25.965] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:74:0)
[01:21:25.965] Timer tick, asking Buildbucket for the build status
[01:21:26.073] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:26.073] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:75:0) after 1m0s
[01:22:26.103] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:75:0)
[01:22:26.103] Timer tick, asking Buildbucket for the build status
[01:22:26.184] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:26.184] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:76:0) after 1m0s
[01:23:26.259] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:76:0)
[01:23:26.259] Timer tick, asking Buildbucket for the build status
[01:23:26.377] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:26.377] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:77:0) after 1m0s
[01:24:26.511] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:77:0)
[01:24:26.511] Timer tick, asking Buildbucket for the build status
[01:24:26.641] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:26.641] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:78:0) after 1m0s
[01:25:26.676] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:78:0)
[01:25:26.676] Timer tick, asking Buildbucket for the build status
[01:25:26.769] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:26.769] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:79:0) after 1m0s
[01:26:26.973] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:79:0)
[01:26:26.973] Timer tick, asking Buildbucket for the build status
[01:26:27.063] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:27.064] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:80:0) after 1m0s
[01:27:27.116] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:80:0)
[01:27:27.116] Timer tick, asking Buildbucket for the build status
[01:27:27.250] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:27.250] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:81:0) after 1m0s
[01:28:27.283] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:81:0)
[01:28:27.283] Timer tick, asking Buildbucket for the build status
[01:28:28.010] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:28.010] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:82:0) after 1m0s
[01:29:28.063] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:82:0)
[01:29:28.063] Timer tick, asking Buildbucket for the build status
[01:29:28.231] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:28.231] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:83:0) after 1m0s
[01:30:28.225] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:83:0)
[01:30:28.225] Timer tick, asking Buildbucket for the build status
[01:30:28.532] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:28.532] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:84:0) after 1m0s
[01:31:28.600] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:84:0)
[01:31:28.600] Timer tick, asking Buildbucket for the build status
[01:31:28.667] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:28.667] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:85:0) after 1m0s
[01:32:28.717] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:85:0)
[01:32:28.717] Timer tick, asking Buildbucket for the build status
[01:32:28.798] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:28.798] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:86:0) after 1m0s
[01:33:28.840] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:86:0)
[01:33:28.840] Timer tick, asking Buildbucket for the build status
[01:33:28.899] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:28.899] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:87:0) after 1m0s
[01:34:28.974] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:87:0)
[01:34:28.974] Timer tick, asking Buildbucket for the build status
[01:34:29.468] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:29.468] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:88:0) after 1m0s
[01:35:29.992] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:88:0)
[01:35:29.992] Timer tick, asking Buildbucket for the build status
[01:35:30.051] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:30.051] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:89:0) after 1m0s
[01:36:30.183] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:89:0)
[01:36:30.183] Timer tick, asking Buildbucket for the build status
[01:36:30.275] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:30.275] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:90:0) after 1m0s
[01:37:30.337] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:90:0)
[01:37:30.337] Timer tick, asking Buildbucket for the build status
[01:37:30.397] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:30.397] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:91:0) after 1m0s
[01:38:30.403] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:91:0)
[01:38:30.403] Timer tick, asking Buildbucket for the build status
[01:38:30.506] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:30.506] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:92:0) after 1m0s
[01:39:30.553] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:92:0)
[01:39:30.553] Timer tick, asking Buildbucket for the build status
[01:39:30.649] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:30.649] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:93:0) after 1m0s
[01:40:30.719] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:93:0)
[01:40:30.719] Timer tick, asking Buildbucket for the build status
[01:40:30.785] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:30.785] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:94:0) after 1m0s
[01:41:30.784] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:94:0)
[01:41:30.784] Timer tick, asking Buildbucket for the build status
[01:41:32.541] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:32.541] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:95:0) after 1m0s
[01:42:32.601] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:95:0)
[01:42:32.601] Timer tick, asking Buildbucket for the build status
[01:42:32.754] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:32.754] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:96:0) after 1m0s
[01:43:32.846] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:96:0)
[01:43:32.846] Timer tick, asking Buildbucket for the build status
[01:43:32.953] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:32.953] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:97:0) after 1m0s
[01:44:33.057] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:97:0)
[01:44:33.057] Timer tick, asking Buildbucket for the build status
[01:44:33.629] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:33.629] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:98:0) after 1m0s
[01:45:33.655] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:98:0)
[01:45:33.655] Timer tick, asking Buildbucket for the build status
[01:45:34.043] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:34.043] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:99:0) after 1m0s
[01:46:34.098] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:99:0)
[01:46:34.098] Timer tick, asking Buildbucket for the build status
[01:46:34.289] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:34.289] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:100:0) after 1m0s
[01:47:34.308] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:100:0)
[01:47:34.308] Timer tick, asking Buildbucket for the build status
[01:47:34.514] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:34.514] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:101:0) after 1m0s
[01:48:34.533] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:101:0)
[01:48:34.533] Timer tick, asking Buildbucket for the build status
[01:48:34.592] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:34.592] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:102:0) after 1m0s
[01:49:34.617] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:102:0)
[01:49:34.617] Timer tick, asking Buildbucket for the build status
[01:49:34.836] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:34.836] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:103:0) after 1m0s
[01:50:34.863] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:103:0)
[01:50:34.863] Timer tick, asking Buildbucket for the build status
[01:50:34.985] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:34.985] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:104:0) after 1m0s
[01:51:34.967] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:104:0)
[01:51:34.967] Timer tick, asking Buildbucket for the build status
[01:51:35.252] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:35.252] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:105:0) after 1m0s
[01:52:35.340] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:105:0)
[01:52:35.340] Timer tick, asking Buildbucket for the build status
[01:52:35.469] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:35.469] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:106:0) after 1m0s
[01:53:35.493] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:106:0)
[01:53:35.493] Timer tick, asking Buildbucket for the build status
[01:53:35.894] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:35.894] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:107:0) after 1m0s
[01:54:35.913] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:107:0)
[01:54:35.913] Timer tick, asking Buildbucket for the build status
[01:54:36.024] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:36.024] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:108:0) after 1m0s
[01:55:36.042] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:108:0)
[01:55:36.042] Timer tick, asking Buildbucket for the build status
[01:55:36.119] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:36.119] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:109:0) after 1m0s
[01:56:36.166] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:109:0)
[01:56:36.166] Timer tick, asking Buildbucket for the build status
[01:56:36.252] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:36.252] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:110:0) after 1m0s
[01:57:36.276] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:110:0)
[01:57:36.276] Timer tick, asking Buildbucket for the build status
[01:57:36.364] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:36.364] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:111:0) after 1m0s
[01:58:36.390] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:111:0)
[01:58:36.390] Timer tick, asking Buildbucket for the build status
[01:58:36.450] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:36.450] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:112:0) after 1m0s
[01:59:36.485] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:112:0)
[01:59:36.485] Timer tick, asking Buildbucket for the build status
[01:59:36.633] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:36.633] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:113:0) after 1m0s
[02:00:36.693] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:113:0)
[02:00:36.693] Timer tick, asking Buildbucket for the build status
[02:00:36.784] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:36.785] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:114:0) after 1m0s
[02:01:36.809] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:114:0)
[02:01:36.809] Timer tick, asking Buildbucket for the build status
[02:01:36.895] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:36.895] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:115:0) after 1m0s
[02:02:36.985] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:115:0)
[02:02:36.985] Timer tick, asking Buildbucket for the build status
[02:02:37.492] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:37.492] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:116:0) after 1m0s
[02:03:37.508] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:116:0)
[02:03:37.508] Timer tick, asking Buildbucket for the build status
[02:03:37.897] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:37.897] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:117:0) after 1m0s
[02:04:37.945] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:117:0)
[02:04:37.945] Timer tick, asking Buildbucket for the build status
[02:04:38.395] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:38.395] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:118:0) after 1m0s
[02:05:38.461] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:118:0)
[02:05:38.461] Timer tick, asking Buildbucket for the build status
[02:05:38.686] Build 8858809271821920624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:38.686] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9024239334007315072:119:0) after 1m0s
[02:05:48.720] Received PubSub notification, asking Buildbucket for the build status
[02:05:48.818] Build 8858809271821920624: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:05:48.818] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"completed_ts": "1609985147723529",
"created_by": "project:emscripten-releases",
"created_ts": "1609978145729241",
"id": "8858809271821920624",
"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\": \"e4d1128776a93a6e4f848809a7d05426914e98f7\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@e4d1128776a93a6e4f848809a7d05426914e98f7\", \"title\": \"e4d1128776a93a6e4f848809a7d05426914e98f7\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/e4d1128776a93a6e4f848809a7d05426914e98f7\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"e4d1128776a93a6e4f848809a7d05426914e98f7\"}}",
"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\": \"e4d1128776a93a6e4f848809a7d05426914e98f7\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@e4d1128776a93a6e4f848809a7d05426914e98f7\", \"title\": \"e4d1128776a93a6e4f848809a7d05426914e98f7\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/e4d1128776a93a6e4f848809a7d05426914e98f7\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-win10-0-n9ub\", \"branch\": \"refs/heads/master\", \"buildername\": \"win\", \"got_revision\": \"e4d1128776a93a6e4f848809a7d05426914e98f7\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"e4d1128776a93a6e4f848809a7d05426914e98f7\"}, \"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-n9ub\"], \"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\": [\"5657-0417a3f\"], \"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": "1609980317390937",
"status": "COMPLETED",
"status_changed_ts": "1609985148292869",
"tags": [
"builder:win",
"buildset:commit/git/e4d1128776a93a6e4f848809a7d05426914e98f7",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/e4d1128776a93a6e4f848809a7d05426914e98f7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024239334007315072",
"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/8858809271821920624/+/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:50f2fe7cefb91b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1609985148330295",
"url": "https://ci.chromium.org/b/8858809271821920624",
"utcnow_ts": "1609985148809446"
}
}
[02:05:48.818] Invocation finished in 1h56m44.556384807s with status SUCCEEDED