[10:01:09.161] New invocation is queued and will start shortly
[10:01:10.970] Starting the invocation (attempt 1)
[10:01:11.032] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:01:11.032] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:01:11.032] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9045764161473472208",
"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\":\"6f1466ef7addcbae7bd4956712ad0cb5312d3149\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@6f1466ef7addcbae7bd4956712ad0cb5312d3149\",\"title\":\"6f1466ef7addcbae7bd4956712ad0cb5312d3149\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/6f1466ef7addcbae7bd4956712ad0cb5312d3149\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"6f1466ef7addcbae7bd4956712ad0cb5312d3149\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win",
"scheduler_invocation_id:9045764161473472208",
"scheduler_job_id:emscripten-releases/win",
"user_agent:luci-scheduler",
"buildset:commit/git/6f1466ef7addcbae7bd4956712ad0cb5312d3149",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/6f1466ef7addcbae7bd4956712ad0cb5312d3149",
"gitiles_ref:refs/heads/master"
]
}
[10:01:12.195] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:emscripten-releases",
"created_ts": "1589450471198330",
"id": "8880334098671169824",
"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\": \"6f1466ef7addcbae7bd4956712ad0cb5312d3149\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@6f1466ef7addcbae7bd4956712ad0cb5312d3149\", \"title\": \"6f1466ef7addcbae7bd4956712ad0cb5312d3149\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/6f1466ef7addcbae7bd4956712ad0cb5312d3149\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"6f1466ef7addcbae7bd4956712ad0cb5312d3149\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1589450471854332",
"tags": [
"builder:win",
"buildset:commit/git/6f1466ef7addcbae7bd4956712ad0cb5312d3149",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/6f1466ef7addcbae7bd4956712ad0cb5312d3149",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9045764161473472208",
"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/8880334098671169824/+/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": "1589450471854473",
"url": "https://ci.chromium.org/b/8880334098671169824",
"utcnow_ts": "1589450472140573"
}
}
[10:01:12.195] Task URL: https://ci.chromium.org/b/8880334098671169824
[10:01:12.195] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:2:0) after 1m0s
[10:02:12.235] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:2:0)
[10:02:12.235] Timer tick, asking Buildbucket for the build status
[10:02:12.613] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:02:12.613] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:3:0) after 1m0s
[10:03:12.758] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:3:0)
[10:03:12.758] Timer tick, asking Buildbucket for the build status
[10:03:13.202] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:03:13.202] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:4:0) after 1m0s
[10:04:13.319] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:4:0)
[10:04:13.319] Timer tick, asking Buildbucket for the build status
[10:04:13.688] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:04:13.688] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:5:0) after 1m0s
[10:05:13.740] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:5:0)
[10:05:13.740] Timer tick, asking Buildbucket for the build status
[10:05:13.900] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:05:13.900] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:6:0) after 1m0s
[10:06:13.907] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:6:0)
[10:06:13.907] Timer tick, asking Buildbucket for the build status
[10:06:14.155] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:06:14.155] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:7:0) after 1m0s
[10:07:14.259] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:7:0)
[10:07:14.259] Timer tick, asking Buildbucket for the build status
[10:07:14.438] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:07:14.438] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:8:0) after 1m0s
[10:08:14.574] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:8:0)
[10:08:14.574] Timer tick, asking Buildbucket for the build status
[10:08:14.700] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:08:14.700] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:9:0) after 1m0s
[10:09:14.813] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:9:0)
[10:09:14.813] Timer tick, asking Buildbucket for the build status
[10:09:15.089] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:09:15.089] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:10:0) after 1m0s
[10:10:15.255] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:10:0)
[10:10:15.255] Timer tick, asking Buildbucket for the build status
[10:10:15.423] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:10:15.423] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:11:0) after 1m0s
[10:11:15.480] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:11:0)
[10:11:15.481] Timer tick, asking Buildbucket for the build status
[10:11:15.640] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:11:15.640] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:12:0) after 1m0s
[10:12:15.658] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:12:0)
[10:12:15.658] Timer tick, asking Buildbucket for the build status
[10:12:15.786] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:12:15.786] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:13:0) after 1m0s
[10:13:15.985] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:13:0)
[10:13:15.985] Timer tick, asking Buildbucket for the build status
[10:13:16.375] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:13:16.375] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:14:0) after 1m0s
[10:14:16.460] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:14:0)
[10:14:16.460] Timer tick, asking Buildbucket for the build status
[10:14:16.734] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:14:16.734] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:15:0) after 1m0s
[10:15:16.834] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:15:0)
[10:15:16.834] Timer tick, asking Buildbucket for the build status
[10:15:17.080] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:15:17.081] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:16:0) after 1m0s
[10:16:17.096] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:16:0)
[10:16:17.096] Timer tick, asking Buildbucket for the build status
[10:16:17.393] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:16:17.393] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:17:0) after 1m0s
[10:17:17.433] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:17:0)
[10:17:17.433] Timer tick, asking Buildbucket for the build status
[10:17:17.842] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:17:17.842] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:18:0) after 1m0s
[10:18:17.831] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:18:0)
[10:18:17.831] Timer tick, asking Buildbucket for the build status
[10:18:17.950] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:18:17.950] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:19:0) after 1m0s
[10:19:18.057] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:19:0)
[10:19:18.057] Timer tick, asking Buildbucket for the build status
[10:19:18.182] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:19:18.182] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:20:0) after 1m0s
[10:20:18.335] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:20:0)
[10:20:18.335] Timer tick, asking Buildbucket for the build status
[10:20:18.454] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:20:18.454] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:21:0) after 1m0s
[10:21:18.459] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:21:0)
[10:21:18.459] Timer tick, asking Buildbucket for the build status
[10:21:18.623] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:21:18.623] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:22:0) after 1m0s
[10:22:18.707] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:22:0)
[10:22:18.707] Timer tick, asking Buildbucket for the build status
[10:22:18.846] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:22:18.846] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:23:0) after 1m0s
[10:23:19.018] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:23:0)
[10:23:19.018] Timer tick, asking Buildbucket for the build status
[10:23:19.222] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:23:19.222] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:24:0) after 1m0s
[10:24:19.284] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:24:0)
[10:24:19.284] Timer tick, asking Buildbucket for the build status
[10:24:19.416] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:24:19.416] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:25:0) after 1m0s
[10:25:19.493] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:25:0)
[10:25:19.493] Timer tick, asking Buildbucket for the build status
[10:25:20.067] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:25:20.067] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:26:0) after 1m0s
[10:26:20.125] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:26:0)
[10:26:20.125] Timer tick, asking Buildbucket for the build status
[10:26:20.300] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:26:20.300] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:27:0) after 1m0s
[10:27:20.429] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:27:0)
[10:27:20.429] Timer tick, asking Buildbucket for the build status
[10:27:20.952] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:27:20.952] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:28:0) after 1m0s
[10:28:21.055] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:28:0)
[10:28:21.055] Timer tick, asking Buildbucket for the build status
[10:28:21.327] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:28:21.327] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:29:0) after 1m0s
[10:29:21.408] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:29:0)
[10:29:21.408] Timer tick, asking Buildbucket for the build status
[10:29:21.795] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:29:21.795] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:30:0) after 1m0s
[10:30:21.850] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:30:0)
[10:30:21.850] Timer tick, asking Buildbucket for the build status
[10:30:22.010] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:30:22.010] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:31:0) after 1m0s
[10:31:22.044] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:31:0)
[10:31:22.044] Timer tick, asking Buildbucket for the build status
[10:31:22.193] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:31:22.193] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:32:0) after 1m0s
[10:32:22.438] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:32:0)
[10:32:22.438] Timer tick, asking Buildbucket for the build status
[10:32:22.858] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:32:22.858] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:33:0) after 1m0s
[10:33:22.964] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:33:0)
[10:33:22.964] Timer tick, asking Buildbucket for the build status
[10:33:23.168] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:33:23.168] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:34:0) after 1m0s
[10:34:23.333] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:34:0)
[10:34:23.333] Timer tick, asking Buildbucket for the build status
[10:34:23.734] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:34:23.734] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:35:0) after 1m0s
[10:35:24.036] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:35:0)
[10:35:24.036] Timer tick, asking Buildbucket for the build status
[10:35:24.266] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:35:24.266] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:36:0) after 1m0s
[10:36:25.219] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:36:0)
[10:36:25.219] Timer tick, asking Buildbucket for the build status
[10:36:25.438] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:36:25.438] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:37:0) after 1m0s
[10:37:25.630] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:37:0)
[10:37:25.630] Timer tick, asking Buildbucket for the build status
[10:37:25.902] Build 8880334098671169824: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:37:25.902] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:38:0) after 1m0s
[10:38:08.665] Received PubSub notification, asking Buildbucket for the build status
[10:38:08.947] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:26.121] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:38:0)
[10:38:26.121] Timer tick, asking Buildbucket for the build status
[10:38:26.243] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:26.243] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:40:0) after 1m0s
[10:39:26.324] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:40:0)
[10:39:26.324] Timer tick, asking Buildbucket for the build status
[10:39:27.441] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:27.441] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:41:0) after 1m0s
[10:40:27.635] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:41:0)
[10:40:27.635] Timer tick, asking Buildbucket for the build status
[10:40:27.817] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:27.817] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:42:0) after 1m0s
[10:41:27.952] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:42:0)
[10:41:27.952] Timer tick, asking Buildbucket for the build status
[10:41:28.113] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:28.113] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:43:0) after 1m0s
[10:42:28.244] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:43:0)
[10:42:28.244] Timer tick, asking Buildbucket for the build status
[10:42:28.440] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:28.440] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:44:0) after 1m0s
[10:43:28.534] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:44:0)
[10:43:28.534] Timer tick, asking Buildbucket for the build status
[10:43:28.983] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:28.983] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:45:0) after 1m0s
[10:44:29.124] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:45:0)
[10:44:29.124] Timer tick, asking Buildbucket for the build status
[10:44:29.679] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:29.679] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:46:0) after 1m0s
[10:45:29.736] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:46:0)
[10:45:29.736] Timer tick, asking Buildbucket for the build status
[10:45:29.860] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:29.860] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:47:0) after 1m0s
[10:46:30.049] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:47:0)
[10:46:30.049] Timer tick, asking Buildbucket for the build status
[10:46:30.455] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:30.455] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:48:0) after 1m0s
[10:47:30.544] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:48:0)
[10:47:30.544] Timer tick, asking Buildbucket for the build status
[10:47:30.936] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:30.936] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:49:0) after 1m0s
[10:48:31.078] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:49:0)
[10:48:31.078] Timer tick, asking Buildbucket for the build status
[10:48:31.245] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:31.245] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:50:0) after 1m0s
[10:49:31.247] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:50:0)
[10:49:31.247] Timer tick, asking Buildbucket for the build status
[10:49:31.651] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:31.651] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:51:0) after 1m0s
[10:50:31.702] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:51:0)
[10:50:31.702] Timer tick, asking Buildbucket for the build status
[10:50:31.827] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:31.827] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:52:0) after 1m0s
[10:51:31.915] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:52:0)
[10:51:31.915] Timer tick, asking Buildbucket for the build status
[10:51:32.850] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:32.850] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:53:0) after 1m0s
[10:52:33.065] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:53:0)
[10:52:33.065] Timer tick, asking Buildbucket for the build status
[10:52:33.189] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:33.189] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:54:0) after 1m0s
[10:53:33.321] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:54:0)
[10:53:33.321] Timer tick, asking Buildbucket for the build status
[10:53:33.739] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:33.739] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:55:0) after 1m0s
[10:54:33.847] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:55:0)
[10:54:33.847] Timer tick, asking Buildbucket for the build status
[10:54:34.031] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:34.031] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:56:0) after 1m0s
[10:55:34.180] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:56:0)
[10:55:34.180] Timer tick, asking Buildbucket for the build status
[10:55:34.734] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:34.734] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:57:0) after 1m0s
[10:56:34.790] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:57:0)
[10:56:34.790] Timer tick, asking Buildbucket for the build status
[10:56:35.173] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:35.173] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:58:0) after 1m0s
[10:57:35.217] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:58:0)
[10:57:35.217] Timer tick, asking Buildbucket for the build status
[10:57:35.658] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:35.658] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:59:0) after 1m0s
[10:58:35.661] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:59:0)
[10:58:35.661] Timer tick, asking Buildbucket for the build status
[10:58:35.831] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:35.831] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:60:0) after 1m0s
[10:59:35.920] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:60:0)
[10:59:35.920] Timer tick, asking Buildbucket for the build status
[10:59:36.094] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:36.094] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:61:0) after 1m0s
[11:00:36.192] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:61:0)
[11:00:36.192] Timer tick, asking Buildbucket for the build status
[11:00:36.633] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:36.633] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:62:0) after 1m0s
[11:01:36.669] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:62:0)
[11:01:36.669] Timer tick, asking Buildbucket for the build status
[11:01:36.860] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:36.860] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:63:0) after 1m0s
[11:02:36.893] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:63:0)
[11:02:36.893] Timer tick, asking Buildbucket for the build status
[11:02:37.106] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:37.106] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:64:0) after 1m0s
[11:03:37.217] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:64:0)
[11:03:37.217] Timer tick, asking Buildbucket for the build status
[11:03:37.486] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:37.486] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:65:0) after 1m0s
[11:04:37.763] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:65:0)
[11:04:37.763] Timer tick, asking Buildbucket for the build status
[11:04:38.255] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:38.255] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:66:0) after 1m0s
[11:05:38.312] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:66:0)
[11:05:38.312] Timer tick, asking Buildbucket for the build status
[11:05:38.727] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:38.727] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:67:0) after 1m0s
[11:06:38.759] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:67:0)
[11:06:38.759] Timer tick, asking Buildbucket for the build status
[11:06:38.936] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:38.936] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:68:0) after 1m0s
[11:07:39.033] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:68:0)
[11:07:39.033] Timer tick, asking Buildbucket for the build status
[11:07:39.458] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:39.458] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:69:0) after 1m0s
[11:08:39.499] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:69:0)
[11:08:39.499] Timer tick, asking Buildbucket for the build status
[11:08:39.831] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:39.831] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:70:0) after 1m0s
[11:09:39.856] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:70:0)
[11:09:39.856] Timer tick, asking Buildbucket for the build status
[11:09:40.147] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:40.147] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:71:0) after 1m0s
[11:10:40.172] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:71:0)
[11:10:40.172] Timer tick, asking Buildbucket for the build status
[11:10:40.334] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:40.335] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:72:0) after 1m0s
[11:11:40.444] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:72:0)
[11:11:40.444] Timer tick, asking Buildbucket for the build status
[11:11:40.623] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:40.623] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:73:0) after 1m0s
[11:12:40.818] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:73:0)
[11:12:40.818] Timer tick, asking Buildbucket for the build status
[11:12:41.546] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:41.546] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:74:0) after 1m0s
[11:13:41.535] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:74:0)
[11:13:41.535] Timer tick, asking Buildbucket for the build status
[11:13:41.836] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:41.836] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:75:0) after 1m0s
[11:14:41.882] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:75:0)
[11:14:41.882] Timer tick, asking Buildbucket for the build status
[11:14:42.569] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:42.569] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:76:0) after 1m0s
[11:15:42.650] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:76:0)
[11:15:42.650] Timer tick, asking Buildbucket for the build status
[11:15:42.930] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:42.930] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:77:0) after 1m0s
[11:16:42.954] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:77:0)
[11:16:42.954] Timer tick, asking Buildbucket for the build status
[11:16:43.095] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:43.095] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:78:0) after 1m0s
[11:17:43.141] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:78:0)
[11:17:43.141] Timer tick, asking Buildbucket for the build status
[11:17:43.249] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:43.249] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:79:0) after 1m0s
[11:18:43.287] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:79:0)
[11:18:43.287] Timer tick, asking Buildbucket for the build status
[11:18:43.549] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:43.549] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:80:0) after 1m0s
[11:19:43.607] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:80:0)
[11:19:43.607] Timer tick, asking Buildbucket for the build status
[11:19:43.945] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:43.945] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:81:0) after 1m0s
[11:20:43.960] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:81:0)
[11:20:43.960] Timer tick, asking Buildbucket for the build status
[11:20:44.083] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:44.083] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:82:0) after 1m0s
[11:21:44.139] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:82:0)
[11:21:44.139] Timer tick, asking Buildbucket for the build status
[11:21:44.376] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:44.376] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:83:0) after 1m0s
[11:22:44.416] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:83:0)
[11:22:44.416] Timer tick, asking Buildbucket for the build status
[11:22:44.738] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:44.738] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:84:0) after 1m0s
[11:23:44.827] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:84:0)
[11:23:44.827] Timer tick, asking Buildbucket for the build status
[11:23:45.064] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:45.064] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:85:0) after 1m0s
[11:24:45.187] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:85:0)
[11:24:45.187] Timer tick, asking Buildbucket for the build status
[11:24:45.364] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:45.364] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:86:0) after 1m0s
[11:25:45.441] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:86:0)
[11:25:45.441] Timer tick, asking Buildbucket for the build status
[11:25:45.625] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:45.625] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:87:0) after 1m0s
[11:26:45.653] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:87:0)
[11:26:45.653] Timer tick, asking Buildbucket for the build status
[11:26:45.764] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:45.764] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:88:0) after 1m0s
[11:27:45.856] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:88:0)
[11:27:45.856] Timer tick, asking Buildbucket for the build status
[11:27:46.043] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:46.043] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:89:0) after 1m0s
[11:28:46.100] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:89:0)
[11:28:46.100] Timer tick, asking Buildbucket for the build status
[11:28:46.240] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:46.240] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:90:0) after 1m0s
[11:29:46.323] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:90:0)
[11:29:46.323] Timer tick, asking Buildbucket for the build status
[11:29:46.934] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:46.934] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:91:0) after 1m0s
[11:30:47.034] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:91:0)
[11:30:47.034] Timer tick, asking Buildbucket for the build status
[11:30:47.192] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:47.192] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:92:0) after 1m0s
[11:31:47.242] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:92:0)
[11:31:47.242] Timer tick, asking Buildbucket for the build status
[11:31:47.418] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:47.419] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:93:0) after 1m0s
[11:32:47.540] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:93:0)
[11:32:47.540] Timer tick, asking Buildbucket for the build status
[11:32:47.791] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:47.791] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:94:0) after 1m0s
[11:33:47.823] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:94:0)
[11:33:47.823] Timer tick, asking Buildbucket for the build status
[11:33:48.057] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:48.057] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:95:0) after 1m0s
[11:34:48.147] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:95:0)
[11:34:48.147] Timer tick, asking Buildbucket for the build status
[11:34:48.625] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:48.625] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:96:0) after 1m0s
[11:35:48.735] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:96:0)
[11:35:48.735] Timer tick, asking Buildbucket for the build status
[11:35:48.966] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:48.966] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:97:0) after 1m0s
[11:36:49.033] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:97:0)
[11:36:49.033] Timer tick, asking Buildbucket for the build status
[11:36:49.172] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:49.172] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:98:0) after 1m0s
[11:37:49.346] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:98:0)
[11:37:49.346] Timer tick, asking Buildbucket for the build status
[11:37:49.493] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:49.493] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:99:0) after 1m0s
[11:38:49.762] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:99:0)
[11:38:49.762] Timer tick, asking Buildbucket for the build status
[11:38:50.049] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:50.050] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:100:0) after 1m0s
[11:39:50.280] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:100:0)
[11:39:50.280] Timer tick, asking Buildbucket for the build status
[11:39:50.839] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:50.839] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:101:0) after 1m0s
[11:40:50.867] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:101:0)
[11:40:50.867] Timer tick, asking Buildbucket for the build status
[11:40:51.582] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:51.582] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:102:0) after 1m0s
[11:41:51.609] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:102:0)
[11:41:51.609] Timer tick, asking Buildbucket for the build status
[11:41:52.205] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:52.205] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:103:0) after 1m0s
[11:42:52.286] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:103:0)
[11:42:52.286] Timer tick, asking Buildbucket for the build status
[11:42:52.440] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:52.440] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:104:0) after 1m0s
[11:43:52.528] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:104:0)
[11:43:52.528] Timer tick, asking Buildbucket for the build status
[11:43:52.738] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:52.738] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:105:0) after 1m0s
[11:44:52.769] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:105:0)
[11:44:52.769] Timer tick, asking Buildbucket for the build status
[11:44:53.075] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:53.075] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:106:0) after 1m0s
[11:45:53.170] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:106:0)
[11:45:53.170] Timer tick, asking Buildbucket for the build status
[11:45:53.295] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:53.295] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:107:0) after 1m0s
[11:46:53.342] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:107:0)
[11:46:53.342] Timer tick, asking Buildbucket for the build status
[11:46:53.567] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:53.567] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:108:0) after 1m0s
[11:47:53.620] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:108:0)
[11:47:53.620] Timer tick, asking Buildbucket for the build status
[11:47:54.042] Build 8880334098671169824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:54.042] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045764161473472208:109:0) after 1m0s
[11:48:02.631] Received PubSub notification, asking Buildbucket for the build status
[11:48:02.705] Build 8880334098671169824: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:48:02.705] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1589456881861187",
"created_by": "project:emscripten-releases",
"created_ts": "1589450471198330",
"id": "8880334098671169824",
"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\": \"6f1466ef7addcbae7bd4956712ad0cb5312d3149\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@6f1466ef7addcbae7bd4956712ad0cb5312d3149\", \"title\": \"6f1466ef7addcbae7bd4956712ad0cb5312d3149\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/6f1466ef7addcbae7bd4956712ad0cb5312d3149\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"6f1466ef7addcbae7bd4956712ad0cb5312d3149\"}}",
"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\": \"6f1466ef7addcbae7bd4956712ad0cb5312d3149\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@6f1466ef7addcbae7bd4956712ad0cb5312d3149\", \"title\": \"6f1466ef7addcbae7bd4956712ad0cb5312d3149\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/6f1466ef7addcbae7bd4956712ad0cb5312d3149\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-win10-0-i3ot\", \"branch\": \"refs/heads/master\", \"buildername\": \"win\", \"got_revision\": \"6f1466ef7addcbae7bd4956712ad0cb5312d3149\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"6f1466ef7addcbae7bd4956712ad0cb5312d3149\"}, \"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-i3ot\"], \"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\": [\"5086-72f8a5a\"], \"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": "1589452687924671",
"status": "COMPLETED",
"status_changed_ts": "1589456882349504",
"tags": [
"builder:win",
"buildset:commit/git/6f1466ef7addcbae7bd4956712ad0cb5312d3149",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/6f1466ef7addcbae7bd4956712ad0cb5312d3149",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9045764161473472208",
"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/8880334098671169824/+/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:4c2b73032fe7b010",
"user_agent:luci-scheduler"
],
"updated_ts": "1589456882362535",
"url": "https://ci.chromium.org/b/8880334098671169824",
"utcnow_ts": "1589456882697649"
}
}
[11:48:02.705] Invocation finished in 1h46m53.563600259s with status SUCCEEDED