[01:15:08.425] New invocation is queued and will start shortly
[01:15:09.556] Starting the invocation (attempt 1)
[01:15:09.611] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:15:09.611] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:15:09.611] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9046612628000668640",
"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\":\"c0f6ab30af0750c063dcc3052f25ae6969aa918f\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@c0f6ab30af0750c063dcc3052f25ae6969aa918f\",\"title\":\"c0f6ab30af0750c063dcc3052f25ae6969aa918f\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/c0f6ab30af0750c063dcc3052f25ae6969aa918f\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"c0f6ab30af0750c063dcc3052f25ae6969aa918f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win",
"scheduler_invocation_id:9046612628000668640",
"scheduler_job_id:emscripten-releases/win",
"user_agent:luci-scheduler",
"buildset:commit/git/c0f6ab30af0750c063dcc3052f25ae6969aa918f",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/c0f6ab30af0750c063dcc3052f25ae6969aa918f",
"gitiles_ref:refs/heads/master"
]
}
[01:15:10.247] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:emscripten-releases",
"created_ts": "1588641309735242",
"id": "8881182565961781840",
"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\": \"c0f6ab30af0750c063dcc3052f25ae6969aa918f\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@c0f6ab30af0750c063dcc3052f25ae6969aa918f\", \"title\": \"c0f6ab30af0750c063dcc3052f25ae6969aa918f\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/c0f6ab30af0750c063dcc3052f25ae6969aa918f\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"c0f6ab30af0750c063dcc3052f25ae6969aa918f\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1588641310091999",
"tags": [
"builder:win",
"buildset:commit/git/c0f6ab30af0750c063dcc3052f25ae6969aa918f",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/c0f6ab30af0750c063dcc3052f25ae6969aa918f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9046612628000668640",
"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/8881182565961781840/+/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": "1588641310092349",
"url": "https://ci.chromium.org/b/8881182565961781840",
"utcnow_ts": "1588641310234194"
}
}
[01:15:10.247] Task URL: https://ci.chromium.org/b/8881182565961781840
[01:15:10.247] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:2:0) after 1m0s
[01:16:10.318] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:2:0)
[01:16:10.318] Timer tick, asking Buildbucket for the build status
[01:16:10.875] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:16:10.875] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:3:0) after 1m0s
[01:17:11.104] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:3:0)
[01:17:11.104] Timer tick, asking Buildbucket for the build status
[01:17:11.211] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:17:11.211] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:4:0) after 1m0s
[01:18:11.280] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:4:0)
[01:18:11.280] Timer tick, asking Buildbucket for the build status
[01:18:11.558] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:18:11.558] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:5:0) after 1m0s
[01:19:11.623] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:5:0)
[01:19:11.623] Timer tick, asking Buildbucket for the build status
[01:19:12.103] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:19:12.103] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:6:0) after 1m0s
[01:20:12.203] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:6:0)
[01:20:12.203] Timer tick, asking Buildbucket for the build status
[01:20:12.490] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:20:12.490] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:7:0) after 1m0s
[01:21:12.533] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:7:0)
[01:21:12.533] Timer tick, asking Buildbucket for the build status
[01:21:12.786] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:21:12.786] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:8:0) after 1m0s
[01:22:12.852] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:8:0)
[01:22:12.852] Timer tick, asking Buildbucket for the build status
[01:22:13.125] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:22:13.125] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:9:0) after 1m0s
[01:23:13.147] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:9:0)
[01:23:13.147] Timer tick, asking Buildbucket for the build status
[01:23:13.666] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:23:13.666] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:10:0) after 1m0s
[01:24:13.756] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:10:0)
[01:24:13.756] Timer tick, asking Buildbucket for the build status
[01:24:14.472] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:24:14.472] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:11:0) after 1m0s
[01:25:14.578] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:11:0)
[01:25:14.578] Timer tick, asking Buildbucket for the build status
[01:25:14.861] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:25:14.861] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:12:0) after 1m0s
[01:26:14.970] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:12:0)
[01:26:14.970] Timer tick, asking Buildbucket for the build status
[01:26:15.526] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:26:15.526] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:13:0) after 1m0s
[01:27:15.690] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:13:0)
[01:27:15.690] Timer tick, asking Buildbucket for the build status
[01:27:16.364] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:27:16.364] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:14:0) after 1m0s
[01:28:16.508] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:14:0)
[01:28:16.508] Timer tick, asking Buildbucket for the build status
[01:28:16.751] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:28:16.751] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:15:0) after 1m0s
[01:29:16.779] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:15:0)
[01:29:16.779] Timer tick, asking Buildbucket for the build status
[01:29:16.964] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:29:16.964] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:16:0) after 1m0s
[01:30:17.037] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:16:0)
[01:30:17.037] Timer tick, asking Buildbucket for the build status
[01:30:17.174] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:30:17.174] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:17:0) after 1m0s
[01:31:17.431] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:17:0)
[01:31:17.432] Timer tick, asking Buildbucket for the build status
[01:31:17.611] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:31:17.611] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:18:0) after 1m0s
[01:32:17.633] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:18:0)
[01:32:17.633] Timer tick, asking Buildbucket for the build status
[01:32:18.084] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:32:18.084] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:19:0) after 1m0s
[01:33:18.265] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:19:0)
[01:33:18.265] Timer tick, asking Buildbucket for the build status
[01:33:18.490] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:33:18.490] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:20:0) after 1m0s
[01:34:18.671] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:20:0)
[01:34:18.671] Timer tick, asking Buildbucket for the build status
[01:34:19.138] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:34:19.138] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:21:0) after 1m0s
[01:35:19.445] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:21:0)
[01:35:19.445] Timer tick, asking Buildbucket for the build status
[01:35:20.350] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:35:20.350] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:22:0) after 1m0s
[01:36:20.439] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:22:0)
[01:36:20.439] Timer tick, asking Buildbucket for the build status
[01:36:20.645] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:36:20.646] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:23:0) after 1m0s
[01:37:20.721] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:23:0)
[01:37:20.721] Timer tick, asking Buildbucket for the build status
[01:37:21.156] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:37:21.156] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:24:0) after 1m0s
[01:38:21.176] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:24:0)
[01:38:21.176] Timer tick, asking Buildbucket for the build status
[01:38:21.301] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:38:21.301] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:25:0) after 1m0s
[01:39:21.924] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:25:0)
[01:39:21.924] Timer tick, asking Buildbucket for the build status
[01:39:22.312] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:39:22.312] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:26:0) after 1m0s
[01:40:22.377] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:26:0)
[01:40:22.377] Timer tick, asking Buildbucket for the build status
[01:40:22.581] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:40:22.581] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:27:0) after 1m0s
[01:41:22.588] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:27:0)
[01:41:22.588] Timer tick, asking Buildbucket for the build status
[01:41:24.367] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:41:24.367] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:28:0) after 1m0s
[01:42:24.848] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:28:0)
[01:42:24.848] Timer tick, asking Buildbucket for the build status
[01:42:25.030] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:42:25.030] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:29:0) after 1m0s
[01:43:25.310] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:29:0)
[01:43:25.310] Timer tick, asking Buildbucket for the build status
[01:43:25.458] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:43:25.458] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:30:0) after 1m0s
[01:44:25.590] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:30:0)
[01:44:25.590] Timer tick, asking Buildbucket for the build status
[01:44:25.839] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:44:25.839] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:31:0) after 1m0s
[01:45:26.038] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:31:0)
[01:45:26.038] Timer tick, asking Buildbucket for the build status
[01:45:26.280] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:45:26.280] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:32:0) after 1m0s
[01:46:26.467] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:32:0)
[01:46:26.467] Timer tick, asking Buildbucket for the build status
[01:46:27.694] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:46:27.694] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:33:0) after 1m0s
[01:47:27.837] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:33:0)
[01:47:27.837] Timer tick, asking Buildbucket for the build status
[01:47:27.993] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:47:27.993] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:34:0) after 1m0s
[01:48:28.267] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:34:0)
[01:48:28.267] Timer tick, asking Buildbucket for the build status
[01:48:28.391] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:48:28.391] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:35:0) after 1m0s
[01:49:28.423] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:35:0)
[01:49:28.423] Timer tick, asking Buildbucket for the build status
[01:49:28.684] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:49:28.684] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:36:0) after 1m0s
[01:50:28.898] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:36:0)
[01:50:28.898] Timer tick, asking Buildbucket for the build status
[01:50:29.058] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:50:29.058] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:37:0) after 1m0s
[01:51:29.204] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:37:0)
[01:51:29.204] Timer tick, asking Buildbucket for the build status
[01:51:29.575] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:51:29.575] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:38:0) after 1m0s
[01:52:29.631] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:38:0)
[01:52:29.631] Timer tick, asking Buildbucket for the build status
[01:52:29.949] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:52:29.949] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:39:0) after 1m0s
[01:53:29.986] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:39:0)
[01:53:29.986] Timer tick, asking Buildbucket for the build status
[01:53:30.150] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:53:30.150] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:40:0) after 1m0s
[01:54:30.236] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:40:0)
[01:54:30.236] Timer tick, asking Buildbucket for the build status
[01:54:30.556] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:54:30.556] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:41:0) after 1m0s
[01:55:30.693] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:41:0)
[01:55:30.693] Timer tick, asking Buildbucket for the build status
[01:55:33.184] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:55:33.184] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:42:0) after 1m0s
[01:56:33.330] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:42:0)
[01:56:33.330] Timer tick, asking Buildbucket for the build status
[01:56:33.903] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:56:33.903] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:43:0) after 1m0s
[01:57:33.979] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:43:0)
[01:57:33.979] Timer tick, asking Buildbucket for the build status
[01:57:34.093] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:57:34.093] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:44:0) after 1m0s
[01:58:34.255] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:44:0)
[01:58:34.255] Timer tick, asking Buildbucket for the build status
[01:58:34.571] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:58:34.571] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:45:0) after 1m0s
[01:59:34.670] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:45:0)
[01:59:34.670] Timer tick, asking Buildbucket for the build status
[01:59:36.326] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:59:36.326] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:46:0) after 1m0s
[02:00:36.478] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:46:0)
[02:00:36.478] Timer tick, asking Buildbucket for the build status
[02:00:36.713] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:00:36.713] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:47:0) after 1m0s
[02:01:36.759] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:47:0)
[02:01:36.759] Timer tick, asking Buildbucket for the build status
[02:01:36.920] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:01:36.920] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:48:0) after 1m0s
[02:02:37.100] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:48:0)
[02:02:37.100] Timer tick, asking Buildbucket for the build status
[02:02:37.267] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:02:37.267] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:49:0) after 1m0s
[02:03:37.423] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:49:0)
[02:03:37.423] Timer tick, asking Buildbucket for the build status
[02:03:37.551] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:03:37.551] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:50:0) after 1m0s
[02:04:37.688] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:50:0)
[02:04:37.688] Timer tick, asking Buildbucket for the build status
[02:04:37.915] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:04:37.915] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:51:0) after 1m0s
[02:05:37.897] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:51:0)
[02:05:37.897] Timer tick, asking Buildbucket for the build status
[02:05:38.133] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:05:38.133] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:52:0) after 1m0s
[02:06:38.120] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:52:0)
[02:06:38.121] Timer tick, asking Buildbucket for the build status
[02:06:39.739] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:06:39.739] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:53:0) after 1m0s
[02:07:39.869] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:53:0)
[02:07:39.869] Timer tick, asking Buildbucket for the build status
[02:07:40.197] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:07:40.197] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:54:0) after 1m0s
[02:08:40.253] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:54:0)
[02:08:40.253] Timer tick, asking Buildbucket for the build status
[02:08:40.451] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:08:40.451] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:55:0) after 1m0s
[02:09:40.550] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:55:0)
[02:09:40.550] Timer tick, asking Buildbucket for the build status
[02:09:40.760] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:09:40.760] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:56:0) after 1m0s
[02:10:40.805] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:56:0)
[02:10:40.805] Timer tick, asking Buildbucket for the build status
[02:10:41.059] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:10:41.059] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:57:0) after 1m0s
[02:11:41.089] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:57:0)
[02:11:41.089] Timer tick, asking Buildbucket for the build status
[02:11:41.706] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:11:41.707] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:58:0) after 1m0s
[02:12:41.771] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:58:0)
[02:12:41.771] Timer tick, asking Buildbucket for the build status
[02:12:41.935] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:12:41.935] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:59:0) after 1m0s
[02:13:42.165] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:59:0)
[02:13:42.165] Timer tick, asking Buildbucket for the build status
[02:13:42.343] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:13:42.343] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:60:0) after 1m0s
[02:14:42.381] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:60:0)
[02:14:42.381] Timer tick, asking Buildbucket for the build status
[02:14:42.636] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:14:42.636] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:61:0) after 1m0s
[02:15:42.665] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:61:0)
[02:15:42.665] Timer tick, asking Buildbucket for the build status
[02:15:43.084] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:15:43.084] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:62:0) after 1m0s
[02:16:43.178] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:62:0)
[02:16:43.178] Timer tick, asking Buildbucket for the build status
[02:16:43.791] Build 8881182565961781840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:16:43.791] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:63:0) after 1m0s
[02:16:52.086] Received PubSub notification, asking Buildbucket for the build status
[02:16:52.508] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:43.910] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:63:0)
[02:17:43.910] Timer tick, asking Buildbucket for the build status
[02:17:43.997] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:43.997] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:65:0) after 1m0s
[02:18:43.983] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:65:0)
[02:18:43.983] Timer tick, asking Buildbucket for the build status
[02:18:44.167] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:44.168] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:66:0) after 1m0s
[02:19:44.208] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:66:0)
[02:19:44.208] Timer tick, asking Buildbucket for the build status
[02:19:44.344] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:44.344] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:67:0) after 1m0s
[02:20:44.531] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:67:0)
[02:20:44.531] Timer tick, asking Buildbucket for the build status
[02:20:44.702] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:44.702] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:68:0) after 1m0s
[02:21:44.918] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:68:0)
[02:21:44.918] Timer tick, asking Buildbucket for the build status
[02:21:45.682] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:45.682] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:69:0) after 1m0s
[02:22:45.724] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:69:0)
[02:22:45.724] Timer tick, asking Buildbucket for the build status
[02:22:45.869] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:45.869] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:70:0) after 1m0s
[02:23:45.930] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:70:0)
[02:23:45.930] Timer tick, asking Buildbucket for the build status
[02:23:46.207] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:46.207] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:71:0) after 1m0s
[02:24:46.188] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:71:0)
[02:24:46.188] Timer tick, asking Buildbucket for the build status
[02:24:46.395] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:46.395] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:72:0) after 1m0s
[02:25:46.559] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:72:0)
[02:25:46.559] Timer tick, asking Buildbucket for the build status
[02:25:46.742] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:46.742] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:73:0) after 1m0s
[02:26:46.893] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:73:0)
[02:26:46.893] Timer tick, asking Buildbucket for the build status
[02:26:47.117] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:47.117] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:74:0) after 1m0s
[02:27:47.430] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:74:0)
[02:27:47.430] Timer tick, asking Buildbucket for the build status
[02:27:47.523] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:47.523] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:75:0) after 1m0s
[02:28:47.776] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:75:0)
[02:28:47.776] Timer tick, asking Buildbucket for the build status
[02:28:47.884] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:47.885] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:76:0) after 1m0s
[02:29:47.947] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:76:0)
[02:29:47.947] Timer tick, asking Buildbucket for the build status
[02:29:48.121] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:48.121] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:77:0) after 1m0s
[02:30:48.256] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:77:0)
[02:30:48.256] Timer tick, asking Buildbucket for the build status
[02:30:48.601] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:48.601] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:78:0) after 1m0s
[02:31:48.731] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:78:0)
[02:31:48.731] Timer tick, asking Buildbucket for the build status
[02:31:48.932] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:48.932] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:79:0) after 1m0s
[02:32:48.991] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:79:0)
[02:32:48.991] Timer tick, asking Buildbucket for the build status
[02:32:49.128] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:49.128] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:80:0) after 1m0s
[02:33:49.275] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:80:0)
[02:33:49.275] Timer tick, asking Buildbucket for the build status
[02:33:49.684] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:49.684] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:81:0) after 1m0s
[02:34:49.734] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:81:0)
[02:34:49.734] Timer tick, asking Buildbucket for the build status
[02:34:50.202] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:50.202] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:82:0) after 1m0s
[02:35:50.480] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:82:0)
[02:35:50.480] Timer tick, asking Buildbucket for the build status
[02:35:50.879] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:50.879] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:83:0) after 1m0s
[02:36:50.963] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:83:0)
[02:36:50.963] Timer tick, asking Buildbucket for the build status
[02:36:51.547] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:51.547] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:84:0) after 1m0s
[02:37:51.699] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:84:0)
[02:37:51.699] Timer tick, asking Buildbucket for the build status
[02:37:51.901] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:51.901] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:85:0) after 1m0s
[02:38:52.156] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:85:0)
[02:38:52.156] Timer tick, asking Buildbucket for the build status
[02:38:52.334] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:52.334] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:86:0) after 1m0s
[02:39:52.458] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:86:0)
[02:39:52.458] Timer tick, asking Buildbucket for the build status
[02:39:52.669] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:52.669] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:87:0) after 1m0s
[02:40:52.853] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:87:0)
[02:40:52.853] Timer tick, asking Buildbucket for the build status
[02:40:53.815] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:53.815] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:88:0) after 1m0s
[02:41:53.849] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:88:0)
[02:41:53.849] Timer tick, asking Buildbucket for the build status
[02:41:54.034] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:54.034] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:89:0) after 1m0s
[02:42:54.111] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:89:0)
[02:42:54.111] Timer tick, asking Buildbucket for the build status
[02:42:54.632] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:54.632] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:90:0) after 1m0s
[02:43:54.668] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:90:0)
[02:43:54.668] Timer tick, asking Buildbucket for the build status
[02:43:54.859] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:54.859] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:91:0) after 1m0s
[02:44:54.945] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:91:0)
[02:44:54.945] Timer tick, asking Buildbucket for the build status
[02:44:55.447] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:55.447] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:92:0) after 1m0s
[02:45:55.498] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:92:0)
[02:45:55.498] Timer tick, asking Buildbucket for the build status
[02:45:55.667] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:55.667] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:93:0) after 1m0s
[02:46:55.771] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:93:0)
[02:46:55.771] Timer tick, asking Buildbucket for the build status
[02:46:56.376] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:56.376] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:94:0) after 1m0s
[02:47:56.521] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:94:0)
[02:47:56.521] Timer tick, asking Buildbucket for the build status
[02:47:57.761] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:57.761] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:95:0) after 1m0s
[02:48:58.048] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:95:0)
[02:48:58.048] Timer tick, asking Buildbucket for the build status
[02:48:58.269] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:58.269] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:96:0) after 1m0s
[02:49:58.411] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:96:0)
[02:49:58.411] Timer tick, asking Buildbucket for the build status
[02:49:58.621] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:58.621] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:97:0) after 1m0s
[02:50:58.789] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:97:0)
[02:50:58.789] Timer tick, asking Buildbucket for the build status
[02:50:58.932] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:58.932] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:98:0) after 1m0s
[02:51:58.924] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:98:0)
[02:51:58.924] Timer tick, asking Buildbucket for the build status
[02:51:59.298] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:59.298] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:99:0) after 1m0s
[02:52:59.399] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:99:0)
[02:52:59.399] Timer tick, asking Buildbucket for the build status
[02:52:59.886] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:59.886] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:100:0) after 1m0s
[02:54:00.031] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:100:0)
[02:54:00.031] Timer tick, asking Buildbucket for the build status
[02:54:00.506] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:00.506] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:101:0) after 1m0s
[02:55:00.989] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:101:0)
[02:55:00.989] Timer tick, asking Buildbucket for the build status
[02:55:01.155] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:01.155] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:102:0) after 1m0s
[02:56:02.076] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:102:0)
[02:56:02.076] Timer tick, asking Buildbucket for the build status
[02:56:02.252] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:02.252] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:103:0) after 1m0s
[02:57:02.707] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:103:0)
[02:57:02.707] Timer tick, asking Buildbucket for the build status
[02:57:03.167] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:03.167] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:104:0) after 1m0s
[02:58:03.551] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:104:0)
[02:58:03.551] Timer tick, asking Buildbucket for the build status
[02:58:03.755] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:03.755] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:105:0) after 1m0s
[02:59:04.289] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:105:0)
[02:59:04.289] Timer tick, asking Buildbucket for the build status
[02:59:04.497] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:04.497] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:106:0) after 1m0s
[03:00:04.696] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:106:0)
[03:00:04.696] Timer tick, asking Buildbucket for the build status
[03:00:04.920] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:04.920] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:107:0) after 1m0s
[03:01:05.397] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:107:0)
[03:01:05.397] Timer tick, asking Buildbucket for the build status
[03:01:06.986] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:06.986] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:108:0) after 1m0s
[03:02:07.035] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:108:0)
[03:02:07.035] Timer tick, asking Buildbucket for the build status
[03:02:07.422] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:07.422] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:109:0) after 1m0s
[03:03:07.497] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:109:0)
[03:03:07.497] Timer tick, asking Buildbucket for the build status
[03:03:07.983] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:07.983] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:110:0) after 1m0s
[03:04:08.130] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:110:0)
[03:04:08.130] Timer tick, asking Buildbucket for the build status
[03:04:08.377] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:08.377] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:111:0) after 1m0s
[03:05:08.442] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:111:0)
[03:05:08.442] Timer tick, asking Buildbucket for the build status
[03:05:08.859] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:08.859] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:112:0) after 1m0s
[03:06:08.936] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:112:0)
[03:06:08.936] Timer tick, asking Buildbucket for the build status
[03:06:09.115] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:09.115] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:113:0) after 1m0s
[03:07:09.238] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:113:0)
[03:07:09.238] Timer tick, asking Buildbucket for the build status
[03:07:09.348] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:09.348] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:114:0) after 1m0s
[03:08:09.536] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:114:0)
[03:08:09.536] Timer tick, asking Buildbucket for the build status
[03:08:09.796] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:09.796] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:115:0) after 1m0s
[03:09:09.946] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:115:0)
[03:09:09.946] Timer tick, asking Buildbucket for the build status
[03:09:10.238] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:10.238] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:116:0) after 1m0s
[03:10:10.368] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:116:0)
[03:10:10.368] Timer tick, asking Buildbucket for the build status
[03:10:10.755] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:10.755] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:117:0) after 1m0s
[03:11:10.870] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:117:0)
[03:11:10.870] Timer tick, asking Buildbucket for the build status
[03:11:11.959] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:11.959] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:118:0) after 1m0s
[03:12:11.991] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:118:0)
[03:12:11.991] Timer tick, asking Buildbucket for the build status
[03:12:12.210] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:12.210] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:119:0) after 1m0s
[03:13:12.289] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:119:0)
[03:13:12.289] Timer tick, asking Buildbucket for the build status
[03:13:13.169] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:13.169] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:120:0) after 1m0s
[03:14:13.226] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:120:0)
[03:14:13.226] Timer tick, asking Buildbucket for the build status
[03:14:13.762] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:13.762] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:121:0) after 1m0s
[03:15:13.882] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:121:0)
[03:15:13.882] Timer tick, asking Buildbucket for the build status
[03:15:14.286] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:14.286] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:122:0) after 1m0s
[03:16:14.344] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:122:0)
[03:16:14.344] Timer tick, asking Buildbucket for the build status
[03:16:14.728] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:14.728] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:123:0) after 1m0s
[03:17:14.757] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:123:0)
[03:17:14.757] Timer tick, asking Buildbucket for the build status
[03:17:14.937] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:14.937] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:124:0) after 1m0s
[03:18:14.969] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:124:0)
[03:18:14.969] Timer tick, asking Buildbucket for the build status
[03:18:15.216] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:15.217] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:125:0) after 1m0s
[03:19:15.270] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:125:0)
[03:19:15.270] Timer tick, asking Buildbucket for the build status
[03:19:15.433] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:15.433] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:126:0) after 1m0s
[03:20:15.461] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:126:0)
[03:20:15.461] Timer tick, asking Buildbucket for the build status
[03:20:15.807] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:15.807] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:127:0) after 1m0s
[03:21:15.902] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:127:0)
[03:21:15.902] Timer tick, asking Buildbucket for the build status
[03:21:16.163] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:16.163] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:128:0) after 1m0s
[03:22:16.231] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:128:0)
[03:22:16.231] Timer tick, asking Buildbucket for the build status
[03:22:16.661] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:16.661] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:129:0) after 1m0s
[03:23:16.776] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:129:0)
[03:23:16.776] Timer tick, asking Buildbucket for the build status
[03:23:16.898] Build 8881182565961781840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:16.899] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9046612628000668640:130:0) after 1m0s
[03:23:36.808] Received PubSub notification, asking Buildbucket for the build status
[03:23:36.887] Build 8881182565961781840: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:23:36.887] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1588649015571261",
"created_by": "project:emscripten-releases",
"created_ts": "1588641309735242",
"id": "8881182565961781840",
"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\": \"c0f6ab30af0750c063dcc3052f25ae6969aa918f\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@c0f6ab30af0750c063dcc3052f25ae6969aa918f\", \"title\": \"c0f6ab30af0750c063dcc3052f25ae6969aa918f\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/c0f6ab30af0750c063dcc3052f25ae6969aa918f\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"c0f6ab30af0750c063dcc3052f25ae6969aa918f\"}}",
"project": "emscripten-releases",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$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\": \"c0f6ab30af0750c063dcc3052f25ae6969aa918f\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@c0f6ab30af0750c063dcc3052f25ae6969aa918f\", \"title\": \"c0f6ab30af0750c063dcc3052f25ae6969aa918f\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/c0f6ab30af0750c063dcc3052f25ae6969aa918f\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-win10-0-2wck\", \"branch\": \"refs/heads/master\", \"buildername\": \"win\", \"got_revision\": \"c0f6ab30af0750c063dcc3052f25ae6969aa918f\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"c0f6ab30af0750c063dcc3052f25ae6969aa918f\"}, \"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-2wck\"], \"image\": [\"chrome-win10-1703-20042500-5e6af220c3f\"], \"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\": [\"5033-bf2739b\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1588645010836925",
"status": "COMPLETED",
"status_changed_ts": "1588649015983321",
"tags": [
"builder:win",
"buildset:commit/git/c0f6ab30af0750c063dcc3052f25ae6969aa918f",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/c0f6ab30af0750c063dcc3052f25ae6969aa918f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9046612628000668640",
"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/8881182565961781840/+/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:4bfb383dd0d11f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1588649016015194",
"url": "https://ci.chromium.org/b/8881182565961781840",
"utcnow_ts": "1588649016875369"
}
}
[03:23:36.887] Invocation finished in 2h8m28.480373336s with status SUCCEEDED