[04:07:55.340] New invocation is queued and will start shortly
[04:07:56.424] Starting the invocation (attempt 1)
[04:07:56.468] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:07:56.468] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:07:56.468] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9048866681661470528",
"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\":\"8578a2c11b331bc7267ec7071aa22d823c5fff07\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@8578a2c11b331bc7267ec7071aa22d823c5fff07\",\"title\":\"8578a2c11b331bc7267ec7071aa22d823c5fff07\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/8578a2c11b331bc7267ec7071aa22d823c5fff07\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"8578a2c11b331bc7267ec7071aa22d823c5fff07\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win",
"scheduler_invocation_id:9048866681661470528",
"scheduler_job_id:emscripten-releases/win",
"user_agent:luci-scheduler",
"buildset:commit/git/8578a2c11b331bc7267ec7071aa22d823c5fff07",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/8578a2c11b331bc7267ec7071aa22d823c5fff07",
"gitiles_ref:refs/heads/master"
]
}
[04:07:57.736] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1586491676602134",
"id": "8883436619673638368",
"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\": \"8578a2c11b331bc7267ec7071aa22d823c5fff07\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@8578a2c11b331bc7267ec7071aa22d823c5fff07\", \"title\": \"8578a2c11b331bc7267ec7071aa22d823c5fff07\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/8578a2c11b331bc7267ec7071aa22d823c5fff07\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"8578a2c11b331bc7267ec7071aa22d823c5fff07\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1586491677395201",
"tags": [
"builder:win",
"buildset:commit/git/8578a2c11b331bc7267ec7071aa22d823c5fff07",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/8578a2c11b331bc7267ec7071aa22d823c5fff07",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9048866681661470528",
"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/8883436619673638368/+/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": "1586491677395818",
"url": "https://ci.chromium.org/b/8883436619673638368",
"utcnow_ts": "1586491677718286"
}
}
[04:07:57.736] Task URL: https://ci.chromium.org/b/8883436619673638368
[04:07:57.736] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:2:0) after 1m0s
[04:08:57.725] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:2:0)
[04:08:57.725] Timer tick, asking Buildbucket for the build status
[04:08:57.855] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:08:57.855] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:3:0) after 1m0s
[04:09:57.911] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:3:0)
[04:09:57.911] Timer tick, asking Buildbucket for the build status
[04:09:58.085] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:09:58.085] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:4:0) after 1m0s
[04:10:58.175] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:4:0)
[04:10:58.175] Timer tick, asking Buildbucket for the build status
[04:10:58.439] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:10:58.439] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:5:0) after 1m0s
[04:11:58.529] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:5:0)
[04:11:58.529] Timer tick, asking Buildbucket for the build status
[04:11:58.638] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:11:58.638] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:6:0) after 1m0s
[04:12:58.723] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:6:0)
[04:12:58.723] Timer tick, asking Buildbucket for the build status
[04:12:58.827] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:12:58.827] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:7:0) after 1m0s
[04:13:58.854] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:7:0)
[04:13:58.854] Timer tick, asking Buildbucket for the build status
[04:13:59.050] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:13:59.050] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:8:0) after 1m0s
[04:14:59.073] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:8:0)
[04:14:59.073] Timer tick, asking Buildbucket for the build status
[04:14:59.240] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:14:59.240] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:9:0) after 1m0s
[04:15:59.272] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:9:0)
[04:15:59.272] Timer tick, asking Buildbucket for the build status
[04:15:59.403] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:15:59.403] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:10:0) after 1m0s
[04:16:59.757] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:10:0)
[04:16:59.757] Timer tick, asking Buildbucket for the build status
[04:16:59.924] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:16:59.924] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:11:0) after 1m0s
[04:17:59.971] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:11:0)
[04:17:59.971] Timer tick, asking Buildbucket for the build status
[04:18:00.099] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:18:00.099] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:12:0) after 1m0s
[04:19:00.130] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:12:0)
[04:19:00.130] Timer tick, asking Buildbucket for the build status
[04:19:00.237] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:19:00.237] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:13:0) after 1m0s
[04:20:00.323] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:13:0)
[04:20:00.323] Timer tick, asking Buildbucket for the build status
[04:20:00.541] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:20:00.541] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:14:0) after 1m0s
[04:21:00.562] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:14:0)
[04:21:00.562] Timer tick, asking Buildbucket for the build status
[04:21:00.935] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:21:00.935] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:15:0) after 1m0s
[04:22:01.024] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:15:0)
[04:22:01.024] Timer tick, asking Buildbucket for the build status
[04:22:01.191] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:22:01.191] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:16:0) after 1m0s
[04:23:01.216] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:16:0)
[04:23:01.216] Timer tick, asking Buildbucket for the build status
[04:23:01.360] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:23:01.360] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:17:0) after 1m0s
[04:24:01.385] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:17:0)
[04:24:01.385] Timer tick, asking Buildbucket for the build status
[04:24:01.713] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:24:01.713] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:18:0) after 1m0s
[04:25:01.734] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:18:0)
[04:25:01.734] Timer tick, asking Buildbucket for the build status
[04:25:01.927] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:25:01.927] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:19:0) after 1m0s
[04:26:01.951] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:19:0)
[04:26:01.951] Timer tick, asking Buildbucket for the build status
[04:26:02.153] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:26:02.153] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:20:0) after 1m0s
[04:27:02.215] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:20:0)
[04:27:02.215] Timer tick, asking Buildbucket for the build status
[04:27:02.364] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:27:02.364] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:21:0) after 1m0s
[04:28:02.466] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:21:0)
[04:28:02.466] Timer tick, asking Buildbucket for the build status
[04:28:02.570] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:28:02.570] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:22:0) after 1m0s
[04:29:02.579] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:22:0)
[04:29:02.579] Timer tick, asking Buildbucket for the build status
[04:29:02.759] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:29:02.759] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:23:0) after 1m0s
[04:30:02.825] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:23:0)
[04:30:02.825] Timer tick, asking Buildbucket for the build status
[04:30:02.926] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:30:02.927] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:24:0) after 1m0s
[04:31:02.962] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:24:0)
[04:31:02.962] Timer tick, asking Buildbucket for the build status
[04:31:03.128] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:31:03.128] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:25:0) after 1m0s
[04:32:03.272] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:25:0)
[04:32:03.272] Timer tick, asking Buildbucket for the build status
[04:32:03.461] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:32:03.461] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:26:0) after 1m0s
[04:33:03.497] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:26:0)
[04:33:03.497] Timer tick, asking Buildbucket for the build status
[04:33:03.757] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:33:03.757] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:27:0) after 1m0s
[04:34:03.881] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:27:0)
[04:34:03.881] Timer tick, asking Buildbucket for the build status
[04:34:03.995] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:34:03.995] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:28:0) after 1m0s
[04:35:04.062] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:28:0)
[04:35:04.062] Timer tick, asking Buildbucket for the build status
[04:35:04.471] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:35:04.471] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:29:0) after 1m0s
[04:36:04.570] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:29:0)
[04:36:04.570] Timer tick, asking Buildbucket for the build status
[04:36:04.863] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:36:04.863] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:30:0) after 1m0s
[04:37:04.902] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:30:0)
[04:37:04.902] Timer tick, asking Buildbucket for the build status
[04:37:05.002] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:37:05.002] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:31:0) after 1m0s
[04:38:05.113] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:31:0)
[04:38:05.113] Timer tick, asking Buildbucket for the build status
[04:38:05.229] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:38:05.229] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:32:0) after 1m0s
[04:39:05.206] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:32:0)
[04:39:05.206] Timer tick, asking Buildbucket for the build status
[04:39:05.507] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:39:05.507] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:33:0) after 1m0s
[04:40:05.531] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:33:0)
[04:40:05.531] Timer tick, asking Buildbucket for the build status
[04:40:05.692] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:40:05.692] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:34:0) after 1m0s
[04:41:05.719] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:34:0)
[04:41:05.719] Timer tick, asking Buildbucket for the build status
[04:41:05.890] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:41:05.890] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:35:0) after 1m0s
[04:42:05.924] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:35:0)
[04:42:05.924] Timer tick, asking Buildbucket for the build status
[04:42:06.070] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:42:06.070] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:36:0) after 1m0s
[04:43:06.095] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:36:0)
[04:43:06.095] Timer tick, asking Buildbucket for the build status
[04:43:06.228] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:43:06.228] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:37:0) after 1m0s
[04:44:06.250] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:37:0)
[04:44:06.250] Timer tick, asking Buildbucket for the build status
[04:44:06.419] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:44:06.419] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:38:0) after 1m0s
[04:45:06.503] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:38:0)
[04:45:06.503] Timer tick, asking Buildbucket for the build status
[04:45:06.736] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:45:06.736] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:39:0) after 1m0s
[04:46:06.817] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:39:0)
[04:46:06.817] Timer tick, asking Buildbucket for the build status
[04:46:07.431] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:46:07.431] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:40:0) after 1m0s
[04:47:07.529] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:40:0)
[04:47:07.529] Timer tick, asking Buildbucket for the build status
[04:47:07.658] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:47:07.658] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:41:0) after 1m0s
[04:48:07.711] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:41:0)
[04:48:07.711] Timer tick, asking Buildbucket for the build status
[04:48:07.931] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:48:07.931] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:42:0) after 1m0s
[04:49:07.975] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:42:0)
[04:49:07.975] Timer tick, asking Buildbucket for the build status
[04:49:08.335] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:49:08.335] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:43:0) after 1m0s
[04:50:08.361] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:43:0)
[04:50:08.362] Timer tick, asking Buildbucket for the build status
[04:50:08.484] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:50:08.484] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:44:0) after 1m0s
[04:51:08.551] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:44:0)
[04:51:08.551] Timer tick, asking Buildbucket for the build status
[04:51:08.884] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:51:08.884] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:45:0) after 1m0s
[04:52:08.982] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:45:0)
[04:52:08.982] Timer tick, asking Buildbucket for the build status
[04:52:09.133] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:52:09.133] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:46:0) after 1m0s
[04:53:09.184] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:46:0)
[04:53:09.184] Timer tick, asking Buildbucket for the build status
[04:53:09.315] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:53:09.315] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:47:0) after 1m0s
[04:54:09.336] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:47:0)
[04:54:09.336] Timer tick, asking Buildbucket for the build status
[04:54:09.474] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:54:09.474] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:48:0) after 1m0s
[04:55:09.512] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:48:0)
[04:55:09.512] Timer tick, asking Buildbucket for the build status
[04:55:09.655] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:55:09.655] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:49:0) after 1m0s
[04:56:09.677] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:49:0)
[04:56:09.677] Timer tick, asking Buildbucket for the build status
[04:56:11.052] Build 8883436619673638368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:56:11.052] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:50:0) after 1m0s
[04:57:07.278] Received PubSub notification, asking Buildbucket for the build status
[04:57:07.395] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:11.076] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:50:0)
[04:57:11.076] Timer tick, asking Buildbucket for the build status
[04:57:11.257] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:11.257] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:52:0) after 1m0s
[04:58:11.358] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:52:0)
[04:58:11.358] Timer tick, asking Buildbucket for the build status
[04:58:11.462] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:11.462] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:53:0) after 1m0s
[04:59:11.567] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:53:0)
[04:59:11.567] Timer tick, asking Buildbucket for the build status
[04:59:11.710] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:11.710] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:54:0) after 1m0s
[05:00:11.764] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:54:0)
[05:00:11.764] Timer tick, asking Buildbucket for the build status
[05:00:13.054] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:13.054] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:55:0) after 1m0s
[05:01:13.099] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:55:0)
[05:01:13.099] Timer tick, asking Buildbucket for the build status
[05:01:14.249] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:14.249] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:56:0) after 1m0s
[05:02:14.311] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:56:0)
[05:02:14.311] Timer tick, asking Buildbucket for the build status
[05:02:14.509] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:14.509] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:57:0) after 1m0s
[05:03:14.537] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:57:0)
[05:03:14.537] Timer tick, asking Buildbucket for the build status
[05:03:14.889] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:14.889] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:58:0) after 1m0s
[05:04:14.905] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:58:0)
[05:04:14.905] Timer tick, asking Buildbucket for the build status
[05:04:16.064] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:16.064] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:59:0) after 1m0s
[05:05:16.084] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:59:0)
[05:05:16.084] Timer tick, asking Buildbucket for the build status
[05:05:16.210] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:16.210] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:60:0) after 1m0s
[05:06:16.243] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:60:0)
[05:06:16.243] Timer tick, asking Buildbucket for the build status
[05:06:16.370] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:16.370] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:61:0) after 1m0s
[05:07:16.396] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:61:0)
[05:07:16.396] Timer tick, asking Buildbucket for the build status
[05:07:16.537] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:16.537] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:62:0) after 1m0s
[05:08:16.586] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:62:0)
[05:08:16.586] Timer tick, asking Buildbucket for the build status
[05:08:17.596] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:17.596] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:63:0) after 1m0s
[05:09:17.607] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:63:0)
[05:09:17.607] Timer tick, asking Buildbucket for the build status
[05:09:17.705] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:17.705] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:64:0) after 1m0s
[05:10:17.732] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:64:0)
[05:10:17.732] Timer tick, asking Buildbucket for the build status
[05:10:17.961] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:17.961] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:65:0) after 1m0s
[05:11:18.009] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:65:0)
[05:11:18.009] Timer tick, asking Buildbucket for the build status
[05:11:18.132] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:18.132] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:66:0) after 1m0s
[05:12:18.175] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:66:0)
[05:12:18.175] Timer tick, asking Buildbucket for the build status
[05:12:18.733] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:18.733] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:67:0) after 1m0s
[05:13:18.788] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:67:0)
[05:13:18.788] Timer tick, asking Buildbucket for the build status
[05:13:18.952] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:18.952] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:68:0) after 1m0s
[05:14:19.399] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:68:0)
[05:14:19.399] Timer tick, asking Buildbucket for the build status
[05:14:19.520] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:19.520] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:69:0) after 1m0s
[05:15:19.590] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:69:0)
[05:15:19.590] Timer tick, asking Buildbucket for the build status
[05:15:19.820] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:19.820] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:70:0) after 1m0s
[05:16:19.982] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:70:0)
[05:16:19.982] Timer tick, asking Buildbucket for the build status
[05:16:20.346] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:20.346] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:71:0) after 1m0s
[05:17:20.376] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:71:0)
[05:17:20.376] Timer tick, asking Buildbucket for the build status
[05:17:20.550] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:20.550] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:72:0) after 1m0s
[05:18:20.563] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:72:0)
[05:18:20.563] Timer tick, asking Buildbucket for the build status
[05:18:20.724] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:20.724] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:73:0) after 1m0s
[05:19:20.749] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:73:0)
[05:19:20.749] Timer tick, asking Buildbucket for the build status
[05:19:20.922] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:20.922] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:74:0) after 1m0s
[05:20:20.955] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:74:0)
[05:20:20.955] Timer tick, asking Buildbucket for the build status
[05:20:21.194] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:21.194] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:75:0) after 1m0s
[05:21:21.239] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:75:0)
[05:21:21.239] Timer tick, asking Buildbucket for the build status
[05:21:21.634] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:21.634] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:76:0) after 1m0s
[05:22:21.675] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:76:0)
[05:22:21.675] Timer tick, asking Buildbucket for the build status
[05:22:21.783] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:21.783] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:77:0) after 1m0s
[05:23:21.814] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:77:0)
[05:23:21.814] Timer tick, asking Buildbucket for the build status
[05:23:21.947] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:21.947] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:78:0) after 1m0s
[05:24:22.164] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:78:0)
[05:24:22.164] Timer tick, asking Buildbucket for the build status
[05:24:22.483] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:22.483] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:79:0) after 1m0s
[05:25:22.537] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:79:0)
[05:25:22.537] Timer tick, asking Buildbucket for the build status
[05:25:22.911] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:22.911] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:80:0) after 1m0s
[05:26:22.959] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:80:0)
[05:26:22.959] Timer tick, asking Buildbucket for the build status
[05:26:23.097] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:23.097] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:81:0) after 1m0s
[05:27:23.153] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:81:0)
[05:27:23.153] Timer tick, asking Buildbucket for the build status
[05:27:23.511] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:23.511] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:82:0) after 1m0s
[05:28:23.509] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:82:0)
[05:28:23.509] Timer tick, asking Buildbucket for the build status
[05:28:23.624] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:23.624] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:83:0) after 1m0s
[05:29:23.687] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:83:0)
[05:29:23.687] Timer tick, asking Buildbucket for the build status
[05:29:24.267] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:24.267] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:84:0) after 1m0s
[05:30:24.356] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:84:0)
[05:30:24.356] Timer tick, asking Buildbucket for the build status
[05:30:25.065] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:25.065] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:85:0) after 1m0s
[05:31:25.092] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:85:0)
[05:31:25.092] Timer tick, asking Buildbucket for the build status
[05:31:26.083] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:26.083] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:86:0) after 1m0s
[05:32:26.171] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:86:0)
[05:32:26.171] Timer tick, asking Buildbucket for the build status
[05:32:26.284] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:26.284] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:87:0) after 1m0s
[05:33:26.332] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:87:0)
[05:33:26.332] Timer tick, asking Buildbucket for the build status
[05:33:26.852] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:26.852] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:88:0) after 1m0s
[05:34:26.901] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:88:0)
[05:34:26.901] Timer tick, asking Buildbucket for the build status
[05:34:27.023] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:27.023] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:89:0) after 1m0s
[05:35:27.057] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:89:0)
[05:35:27.057] Timer tick, asking Buildbucket for the build status
[05:35:27.349] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:27.349] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:90:0) after 1m0s
[05:36:27.371] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:90:0)
[05:36:27.371] Timer tick, asking Buildbucket for the build status
[05:36:27.484] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:27.484] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:91:0) after 1m0s
[05:37:27.556] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:91:0)
[05:37:27.556] Timer tick, asking Buildbucket for the build status
[05:37:27.749] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:27.749] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:92:0) after 1m0s
[05:38:27.777] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:92:0)
[05:38:27.777] Timer tick, asking Buildbucket for the build status
[05:38:27.963] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:27.964] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:93:0) after 1m0s
[05:39:27.984] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:93:0)
[05:39:27.984] Timer tick, asking Buildbucket for the build status
[05:39:28.456] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:28.456] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:94:0) after 1m0s
[05:40:28.460] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:94:0)
[05:40:28.460] Timer tick, asking Buildbucket for the build status
[05:40:28.705] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:28.705] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:95:0) after 1m0s
[05:41:28.734] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:95:0)
[05:41:28.734] Timer tick, asking Buildbucket for the build status
[05:41:29.073] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:29.073] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:96:0) after 1m0s
[05:42:29.145] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:96:0)
[05:42:29.145] Timer tick, asking Buildbucket for the build status
[05:42:29.381] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:29.381] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:97:0) after 1m0s
[05:43:29.467] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:97:0)
[05:43:29.467] Timer tick, asking Buildbucket for the build status
[05:43:29.587] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:29.587] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:98:0) after 1m0s
[05:44:29.651] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:98:0)
[05:44:29.651] Timer tick, asking Buildbucket for the build status
[05:44:29.754] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:29.754] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:99:0) after 1m0s
[05:45:29.826] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:99:0)
[05:45:29.826] Timer tick, asking Buildbucket for the build status
[05:45:29.919] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:29.919] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:100:0) after 1m0s
[05:47:31.840] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:100:0)
[05:47:31.840] Timer tick, asking Buildbucket for the build status
[05:47:32.142] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:32.142] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:101:0) after 1m0s
[05:48:33.304] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:101:0)
[05:48:33.304] Timer tick, asking Buildbucket for the build status
[05:48:33.780] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:33.780] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:102:0) after 1m0s
[05:49:34.087] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:102:0)
[05:49:34.087] Timer tick, asking Buildbucket for the build status
[05:49:34.199] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:34.199] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:103:0) after 1m0s
[05:50:34.368] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:103:0)
[05:50:34.368] Timer tick, asking Buildbucket for the build status
[05:50:34.570] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:34.570] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:104:0) after 1m0s
[05:51:34.692] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:104:0)
[05:51:34.692] Timer tick, asking Buildbucket for the build status
[05:51:34.884] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:34.884] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:105:0) after 1m0s
[05:52:35.039] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:105:0)
[05:52:35.039] Timer tick, asking Buildbucket for the build status
[05:52:35.323] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:35.323] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:106:0) after 1m0s
[05:53:35.419] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:106:0)
[05:53:35.419] Timer tick, asking Buildbucket for the build status
[05:53:35.868] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:35.868] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:107:0) after 1m0s
[05:54:35.930] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:107:0)
[05:54:35.930] Timer tick, asking Buildbucket for the build status
[05:54:36.111] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:36.111] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:108:0) after 1m0s
[05:55:36.241] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:108:0)
[05:55:36.241] Timer tick, asking Buildbucket for the build status
[05:55:36.446] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:36.446] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:109:0) after 1m0s
[05:56:36.453] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:109:0)
[05:56:36.453] Timer tick, asking Buildbucket for the build status
[05:56:36.574] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:36.574] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:110:0) after 1m0s
[05:57:36.625] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:110:0)
[05:57:36.625] Timer tick, asking Buildbucket for the build status
[05:57:36.856] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:36.856] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:111:0) after 1m0s
[05:58:36.885] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:111:0)
[05:58:36.885] Timer tick, asking Buildbucket for the build status
[05:58:37.301] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:37.301] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:112:0) after 1m0s
[05:59:37.306] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:112:0)
[05:59:37.306] Timer tick, asking Buildbucket for the build status
[05:59:37.676] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:37.676] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:113:0) after 1m0s
[06:00:37.737] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:113:0)
[06:00:37.737] Timer tick, asking Buildbucket for the build status
[06:00:37.877] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:37.877] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:114:0) after 1m0s
[06:01:37.926] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:114:0)
[06:01:37.926] Timer tick, asking Buildbucket for the build status
[06:01:38.350] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:38.350] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:115:0) after 1m0s
[06:02:38.365] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:115:0)
[06:02:38.365] Timer tick, asking Buildbucket for the build status
[06:02:39.494] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:39.494] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:116:0) after 1m0s
[06:03:39.593] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:116:0)
[06:03:39.593] Timer tick, asking Buildbucket for the build status
[06:03:39.827] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:39.827] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:117:0) after 1m0s
[06:04:39.837] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:117:0)
[06:04:39.837] Timer tick, asking Buildbucket for the build status
[06:04:40.013] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:40.013] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:118:0) after 1m0s
[06:05:40.050] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:118:0)
[06:05:40.050] Timer tick, asking Buildbucket for the build status
[06:05:40.508] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:40.508] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:119:0) after 1m0s
[06:06:40.639] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:119:0)
[06:06:40.639] Timer tick, asking Buildbucket for the build status
[06:06:40.879] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:40.879] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:120:0) after 1m0s
[06:07:40.996] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:120:0)
[06:07:40.996] Timer tick, asking Buildbucket for the build status
[06:07:41.261] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:41.261] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:121:0) after 1m0s
[06:08:41.324] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:121:0)
[06:08:41.324] Timer tick, asking Buildbucket for the build status
[06:08:41.543] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:41.543] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:122:0) after 1m0s
[06:09:41.593] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:122:0)
[06:09:41.593] Timer tick, asking Buildbucket for the build status
[06:09:41.812] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:41.812] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:123:0) after 1m0s
[06:10:41.930] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:123:0)
[06:10:41.930] Timer tick, asking Buildbucket for the build status
[06:10:42.084] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:42.084] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:124:0) after 1m0s
[06:11:42.215] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:124:0)
[06:11:42.215] Timer tick, asking Buildbucket for the build status
[06:11:42.655] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:42.655] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:125:0) after 1m0s
[06:12:43.971] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:125:0)
[06:12:43.971] Timer tick, asking Buildbucket for the build status
[06:12:44.119] Build 8883436619673638368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:44.119] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9048866681661470528:126:0) after 1m0s
[06:13:22.431] Received PubSub notification, asking Buildbucket for the build status
[06:13:22.505] Build 8883436619673638368: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:13:22.505] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"completed_ts": "1586499201451823",
"created_by": "project:emscripten-releases",
"created_ts": "1586491676602134",
"id": "8883436619673638368",
"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\": \"8578a2c11b331bc7267ec7071aa22d823c5fff07\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@8578a2c11b331bc7267ec7071aa22d823c5fff07\", \"title\": \"8578a2c11b331bc7267ec7071aa22d823c5fff07\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/8578a2c11b331bc7267ec7071aa22d823c5fff07\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"8578a2c11b331bc7267ec7071aa22d823c5fff07\"}}",
"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\": \"8578a2c11b331bc7267ec7071aa22d823c5fff07\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@8578a2c11b331bc7267ec7071aa22d823c5fff07\", \"title\": \"8578a2c11b331bc7267ec7071aa22d823c5fff07\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/8578a2c11b331bc7267ec7071aa22d823c5fff07\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-win10-0-hyhd\", \"branch\": \"refs/heads/master\", \"buildername\": \"win\", \"got_revision\": \"8578a2c11b331bc7267ec7071aa22d823c5fff07\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"8578a2c11b331bc7267ec7071aa22d823c5fff07\"}, \"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-hyhd\"], \"image\": [\"chrome-win10-1703-20040700-021aac15b85\"], \"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\": [\"4967-6d1ba8b\"], \"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": "1586494624793014",
"status": "COMPLETED",
"status_changed_ts": "1586499202058687",
"tags": [
"builder:win",
"buildset:commit/git/8578a2c11b331bc7267ec7071aa22d823c5fff07",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/8578a2c11b331bc7267ec7071aa22d823c5fff07",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9048866681661470528",
"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/8883436619673638368/+/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:4b7b1765a39c8e10",
"user_agent:luci-scheduler"
],
"updated_ts": "1586499202102919",
"url": "https://ci.chromium.org/b/8883436619673638368",
"utcnow_ts": "1586499202496773"
}
}
[06:13:22.505] Invocation finished in 2h5m27.182455047s with status SUCCEEDED