[22:21:36.102] New invocation is queued and will start shortly
[22:21:41.616] Starting the invocation (attempt 1)
[22:21:41.702] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:21:41.702] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:21:41.703] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9043362055321542800",
"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\":\"22581b39618fd0b4ceff2f4ad3226657839f287c\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@22581b39618fd0b4ceff2f4ad3226657839f287c\",\"title\":\"22581b39618fd0b4ceff2f4ad3226657839f287c\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/22581b39618fd0b4ceff2f4ad3226657839f287c\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"22581b39618fd0b4ceff2f4ad3226657839f287c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win",
"scheduler_invocation_id:9043362055321542800",
"scheduler_job_id:emscripten-releases/win",
"user_agent:luci-scheduler",
"buildset:commit/git/22581b39618fd0b4ceff2f4ad3226657839f287c",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/22581b39618fd0b4ceff2f4ad3226657839f287c",
"gitiles_ref:refs/heads/master"
]
}
[22:21:45.834] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1591741304625594",
"id": "8877931985719816048",
"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\": \"22581b39618fd0b4ceff2f4ad3226657839f287c\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@22581b39618fd0b4ceff2f4ad3226657839f287c\", \"title\": \"22581b39618fd0b4ceff2f4ad3226657839f287c\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/22581b39618fd0b4ceff2f4ad3226657839f287c\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"22581b39618fd0b4ceff2f4ad3226657839f287c\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1591741305385691",
"tags": [
"builder:win",
"buildset:commit/git/22581b39618fd0b4ceff2f4ad3226657839f287c",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/22581b39618fd0b4ceff2f4ad3226657839f287c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9043362055321542800",
"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/8877931985719816048/+/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": "1591741305385847",
"url": "https://ci.chromium.org/b/8877931985719816048",
"utcnow_ts": "1591741305792336"
}
}
[22:21:45.834] Task URL: https://ci.chromium.org/b/8877931985719816048
[22:21:45.834] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:2:0) after 1m0s
[22:22:45.832] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:2:0)
[22:22:45.832] Timer tick, asking Buildbucket for the build status
[22:22:46.107] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:22:46.107] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:3:0) after 1m0s
[22:23:46.141] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:3:0)
[22:23:46.141] Timer tick, asking Buildbucket for the build status
[22:23:46.285] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:23:46.285] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:4:0) after 1m0s
[22:24:46.300] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:4:0)
[22:24:46.300] Timer tick, asking Buildbucket for the build status
[22:24:46.450] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:24:46.450] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:5:0) after 1m0s
[22:25:46.532] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:5:0)
[22:25:46.532] Timer tick, asking Buildbucket for the build status
[22:25:47.660] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:25:47.660] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:6:0) after 1m0s
[22:26:47.755] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:6:0)
[22:26:47.755] Timer tick, asking Buildbucket for the build status
[22:26:47.934] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:26:47.934] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:7:0) after 1m0s
[22:27:47.986] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:7:0)
[22:27:47.986] Timer tick, asking Buildbucket for the build status
[22:27:48.599] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:27:48.600] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:8:0) after 1m0s
[22:28:48.601] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:8:0)
[22:28:48.601] Timer tick, asking Buildbucket for the build status
[22:28:48.735] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:28:48.735] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:9:0) after 1m0s
[22:29:48.776] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:9:0)
[22:29:48.776] Timer tick, asking Buildbucket for the build status
[22:29:48.883] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:29:48.883] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:10:0) after 1m0s
[22:30:48.960] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:10:0)
[22:30:48.960] Timer tick, asking Buildbucket for the build status
[22:30:49.348] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:30:49.348] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:11:0) after 1m0s
[22:31:49.415] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:11:0)
[22:31:49.415] Timer tick, asking Buildbucket for the build status
[22:31:49.878] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:31:49.878] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:12:0) after 1m0s
[22:32:50.246] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:12:0)
[22:32:50.246] Timer tick, asking Buildbucket for the build status
[22:32:50.483] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:32:50.483] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:13:0) after 1m0s
[22:33:50.614] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:13:0)
[22:33:50.614] Timer tick, asking Buildbucket for the build status
[22:33:50.738] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:33:50.738] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:14:0) after 1m0s
[22:34:51.041] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:14:0)
[22:34:51.041] Timer tick, asking Buildbucket for the build status
[22:34:51.219] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:34:51.219] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:15:0) after 1m0s
[22:35:51.444] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:15:0)
[22:35:51.444] Timer tick, asking Buildbucket for the build status
[22:35:51.617] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:35:51.617] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:16:0) after 1m0s
[22:36:51.712] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:16:0)
[22:36:51.712] Timer tick, asking Buildbucket for the build status
[22:36:52.601] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:36:52.602] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:17:0) after 1m0s
[22:37:52.633] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:17:0)
[22:37:52.633] Timer tick, asking Buildbucket for the build status
[22:37:52.936] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:37:52.936] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:18:0) after 1m0s
[22:38:52.952] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:18:0)
[22:38:52.952] Timer tick, asking Buildbucket for the build status
[22:38:53.073] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:38:53.073] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:19:0) after 1m0s
[22:39:53.189] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:19:0)
[22:39:53.189] Timer tick, asking Buildbucket for the build status
[22:39:53.381] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:39:53.381] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:20:0) after 1m0s
[22:40:53.597] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:20:0)
[22:40:53.597] Timer tick, asking Buildbucket for the build status
[22:40:53.916] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:40:53.916] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:21:0) after 1m0s
[22:41:54.231] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:21:0)
[22:41:54.231] Timer tick, asking Buildbucket for the build status
[22:41:54.437] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:41:54.437] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:22:0) after 1m0s
[22:42:54.998] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:22:0)
[22:42:54.998] Timer tick, asking Buildbucket for the build status
[22:42:55.199] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:42:55.199] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:23:0) after 1m0s
[22:43:55.441] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:23:0)
[22:43:55.441] Timer tick, asking Buildbucket for the build status
[22:43:55.817] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:43:55.817] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:24:0) after 1m0s
[22:44:55.946] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:24:0)
[22:44:55.946] Timer tick, asking Buildbucket for the build status
[22:44:56.087] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:44:56.087] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:25:0) after 1m0s
[22:45:56.354] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:25:0)
[22:45:56.354] Timer tick, asking Buildbucket for the build status
[22:45:56.616] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:45:56.616] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:26:0) after 1m0s
[22:46:56.776] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:26:0)
[22:46:56.776] Timer tick, asking Buildbucket for the build status
[22:46:56.963] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:46:56.963] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:27:0) after 1m0s
[22:47:57.136] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:27:0)
[22:47:57.136] Timer tick, asking Buildbucket for the build status
[22:47:57.269] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:47:57.269] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:28:0) after 1m0s
[22:48:57.509] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:28:0)
[22:48:57.509] Timer tick, asking Buildbucket for the build status
[22:48:57.653] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:48:57.653] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:29:0) after 1m0s
[22:49:57.737] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:29:0)
[22:49:57.737] Timer tick, asking Buildbucket for the build status
[22:49:57.887] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:49:57.887] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:30:0) after 1m0s
[22:50:58.167] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:30:0)
[22:50:58.167] Timer tick, asking Buildbucket for the build status
[22:50:58.375] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:50:58.375] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:31:0) after 1m0s
[22:51:58.536] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:31:0)
[22:51:58.536] Timer tick, asking Buildbucket for the build status
[22:51:58.822] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:51:58.822] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:32:0) after 1m0s
[22:52:58.886] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:32:0)
[22:52:58.886] Timer tick, asking Buildbucket for the build status
[22:52:59.024] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:52:59.024] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:33:0) after 1m0s
[22:53:59.036] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:33:0)
[22:53:59.036] Timer tick, asking Buildbucket for the build status
[22:53:59.191] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:53:59.191] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:34:0) after 1m0s
[22:54:59.246] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:34:0)
[22:54:59.246] Timer tick, asking Buildbucket for the build status
[22:54:59.361] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:54:59.361] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:35:0) after 1m0s
[22:55:59.442] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:35:0)
[22:55:59.442] Timer tick, asking Buildbucket for the build status
[22:55:59.642] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:55:59.642] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:36:0) after 1m0s
[22:56:59.663] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:36:0)
[22:56:59.663] Timer tick, asking Buildbucket for the build status
[22:57:00.148] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:57:00.148] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:37:0) after 1m0s
[22:58:00.148] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:37:0)
[22:58:00.148] Timer tick, asking Buildbucket for the build status
[22:58:00.449] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:58:00.449] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:38:0) after 1m0s
[22:59:01.006] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:38:0)
[22:59:01.006] Timer tick, asking Buildbucket for the build status
[22:59:01.120] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:59:01.120] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:39:0) after 1m0s
[23:00:01.294] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:39:0)
[23:00:01.294] Timer tick, asking Buildbucket for the build status
[23:00:01.665] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:00:01.665] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:40:0) after 1m0s
[23:01:01.976] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:40:0)
[23:01:01.976] Timer tick, asking Buildbucket for the build status
[23:01:02.111] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:01:02.111] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:41:0) after 1m0s
[23:02:02.147] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:41:0)
[23:02:02.147] Timer tick, asking Buildbucket for the build status
[23:02:03.093] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:02:03.093] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:42:0) after 1m0s
[23:03:03.216] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:42:0)
[23:03:03.216] Timer tick, asking Buildbucket for the build status
[23:03:03.544] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:03:03.544] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:43:0) after 1m0s
[23:04:03.551] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:43:0)
[23:04:03.551] Timer tick, asking Buildbucket for the build status
[23:04:03.883] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:04:03.883] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:44:0) after 1m0s
[23:05:03.945] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:44:0)
[23:05:03.945] Timer tick, asking Buildbucket for the build status
[23:05:04.767] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:05:04.767] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:45:0) after 1m0s
[23:06:04.834] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:45:0)
[23:06:04.834] Timer tick, asking Buildbucket for the build status
[23:06:04.932] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:06:04.932] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:46:0) after 1m0s
[23:07:04.983] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:46:0)
[23:07:04.983] Timer tick, asking Buildbucket for the build status
[23:07:05.201] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:07:05.201] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:47:0) after 1m0s
[23:08:05.268] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:47:0)
[23:08:05.268] Timer tick, asking Buildbucket for the build status
[23:08:05.508] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:08:05.508] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:48:0) after 1m0s
[23:09:05.725] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:48:0)
[23:09:05.725] Timer tick, asking Buildbucket for the build status
[23:09:06.176] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:09:06.176] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:49:0) after 1m0s
[23:10:06.207] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:49:0)
[23:10:06.207] Timer tick, asking Buildbucket for the build status
[23:10:06.316] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:10:06.316] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:50:0) after 1m0s
[23:11:06.379] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:50:0)
[23:11:06.379] Timer tick, asking Buildbucket for the build status
[23:11:06.693] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:11:06.693] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:51:0) after 1m0s
[23:12:06.725] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:51:0)
[23:12:06.725] Timer tick, asking Buildbucket for the build status
[23:12:06.896] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:12:06.896] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:52:0) after 1m0s
[23:13:06.945] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:52:0)
[23:13:06.945] Timer tick, asking Buildbucket for the build status
[23:13:07.234] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:13:07.234] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:53:0) after 1m0s
[23:14:07.354] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:53:0)
[23:14:07.354] Timer tick, asking Buildbucket for the build status
[23:14:07.489] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:14:07.489] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:54:0) after 1m0s
[23:15:07.504] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:54:0)
[23:15:07.504] Timer tick, asking Buildbucket for the build status
[23:15:07.627] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:15:07.627] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:55:0) after 1m0s
[23:16:07.772] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:55:0)
[23:16:07.772] Timer tick, asking Buildbucket for the build status
[23:16:08.054] Build 8877931985719816048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:16:08.054] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:56:0) after 1m0s
[23:16:56.698] Received PubSub notification, asking Buildbucket for the build status
[23:16:56.791] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:08.174] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:56:0)
[23:17:08.174] Timer tick, asking Buildbucket for the build status
[23:17:08.427] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:08.427] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:58:0) after 1m0s
[23:18:08.480] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:58:0)
[23:18:08.480] Timer tick, asking Buildbucket for the build status
[23:18:08.708] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:08.708] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:59:0) after 1m0s
[23:19:08.783] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:59:0)
[23:19:08.783] Timer tick, asking Buildbucket for the build status
[23:19:09.014] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:09.014] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:60:0) after 1m0s
[23:20:09.071] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:60:0)
[23:20:09.071] Timer tick, asking Buildbucket for the build status
[23:20:09.545] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:09.545] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:61:0) after 1m0s
[23:21:09.549] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:61:0)
[23:21:09.549] Timer tick, asking Buildbucket for the build status
[23:21:10.184] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:10.184] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:62:0) after 1m0s
[23:22:10.189] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:62:0)
[23:22:10.189] Timer tick, asking Buildbucket for the build status
[23:22:11.815] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:11.815] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:63:0) after 1m0s
[23:23:11.850] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:63:0)
[23:23:11.850] Timer tick, asking Buildbucket for the build status
[23:23:13.283] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:13.283] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:64:0) after 1m0s
[23:24:13.326] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:64:0)
[23:24:13.326] Timer tick, asking Buildbucket for the build status
[23:24:13.454] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:13.454] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:65:0) after 1m0s
[23:25:13.539] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:65:0)
[23:25:13.539] Timer tick, asking Buildbucket for the build status
[23:25:13.942] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:13.942] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:66:0) after 1m0s
[23:26:14.056] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:66:0)
[23:26:14.056] Timer tick, asking Buildbucket for the build status
[23:26:14.508] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:14.508] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:67:0) after 1m0s
[23:27:14.628] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:67:0)
[23:27:14.628] Timer tick, asking Buildbucket for the build status
[23:27:14.789] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:14.789] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:68:0) after 1m0s
[23:28:14.869] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:68:0)
[23:28:14.869] Timer tick, asking Buildbucket for the build status
[23:28:15.126] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:15.126] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:69:0) after 1m0s
[23:29:15.273] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:69:0)
[23:29:15.273] Timer tick, asking Buildbucket for the build status
[23:29:15.550] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:15.551] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:70:0) after 1m0s
[23:30:15.655] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:70:0)
[23:30:15.655] Timer tick, asking Buildbucket for the build status
[23:30:15.786] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:15.786] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:71:0) after 1m0s
[23:31:15.847] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:71:0)
[23:31:15.847] Timer tick, asking Buildbucket for the build status
[23:31:16.052] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:16.052] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:72:0) after 1m0s
[23:32:16.140] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:72:0)
[23:32:16.140] Timer tick, asking Buildbucket for the build status
[23:32:16.334] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:16.334] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:73:0) after 1m0s
[23:33:16.435] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:73:0)
[23:33:16.435] Timer tick, asking Buildbucket for the build status
[23:33:16.616] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:16.616] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:74:0) after 1m0s
[23:34:16.698] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:74:0)
[23:34:16.698] Timer tick, asking Buildbucket for the build status
[23:34:17.109] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:17.109] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:75:0) after 1m0s
[23:35:17.139] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:75:0)
[23:35:17.139] Timer tick, asking Buildbucket for the build status
[23:35:17.537] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:17.537] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:76:0) after 1m0s
[23:36:17.612] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:76:0)
[23:36:17.612] Timer tick, asking Buildbucket for the build status
[23:36:18.673] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:18.673] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:77:0) after 1m0s
[23:37:18.767] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:77:0)
[23:37:18.767] Timer tick, asking Buildbucket for the build status
[23:37:18.979] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:18.979] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:78:0) after 1m0s
[23:38:19.097] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:78:0)
[23:38:19.097] Timer tick, asking Buildbucket for the build status
[23:38:19.307] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:19.307] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:79:0) after 1m0s
[23:39:19.452] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:79:0)
[23:39:19.452] Timer tick, asking Buildbucket for the build status
[23:39:19.580] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:19.580] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:80:0) after 1m0s
[23:40:19.633] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:80:0)
[23:40:19.633] Timer tick, asking Buildbucket for the build status
[23:40:19.768] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:19.768] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:81:0) after 1m0s
[23:41:19.768] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:81:0)
[23:41:19.768] Timer tick, asking Buildbucket for the build status
[23:41:21.021] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:21.021] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:82:0) after 1m0s
[23:42:21.214] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:82:0)
[23:42:21.214] Timer tick, asking Buildbucket for the build status
[23:42:22.255] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:22.255] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:83:0) after 1m0s
[23:43:22.310] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:83:0)
[23:43:22.310] Timer tick, asking Buildbucket for the build status
[23:43:22.762] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:22.762] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:84:0) after 1m0s
[23:44:22.887] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:84:0)
[23:44:22.887] Timer tick, asking Buildbucket for the build status
[23:44:23.055] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:23.055] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:85:0) after 1m0s
[23:45:23.175] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:85:0)
[23:45:23.175] Timer tick, asking Buildbucket for the build status
[23:45:23.295] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:23.295] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:86:0) after 1m0s
[23:46:23.336] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:86:0)
[23:46:23.336] Timer tick, asking Buildbucket for the build status
[23:46:23.697] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:23.697] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:87:0) after 1m0s
[23:47:23.735] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:87:0)
[23:47:23.735] Timer tick, asking Buildbucket for the build status
[23:47:24.004] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:24.004] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:88:0) after 1m0s
[23:48:23.979] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:88:0)
[23:48:23.979] Timer tick, asking Buildbucket for the build status
[23:48:24.135] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:24.135] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:89:0) after 1m0s
[23:49:24.169] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:89:0)
[23:49:24.169] Timer tick, asking Buildbucket for the build status
[23:49:24.603] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:24.603] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:90:0) after 1m0s
[23:50:24.664] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:90:0)
[23:50:24.664] Timer tick, asking Buildbucket for the build status
[23:50:24.883] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:24.883] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:91:0) after 1m0s
[23:51:24.908] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:91:0)
[23:51:24.908] Timer tick, asking Buildbucket for the build status
[23:51:25.062] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:25.062] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:92:0) after 1m0s
[23:52:25.145] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:92:0)
[23:52:25.145] Timer tick, asking Buildbucket for the build status
[23:52:25.364] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:25.364] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:93:0) after 1m0s
[23:53:25.463] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:93:0)
[23:53:25.463] Timer tick, asking Buildbucket for the build status
[23:53:25.754] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:25.754] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:94:0) after 1m0s
[23:54:25.839] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:94:0)
[23:54:25.839] Timer tick, asking Buildbucket for the build status
[23:54:26.058] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:26.058] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:95:0) after 1m0s
[23:55:26.072] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:95:0)
[23:55:26.072] Timer tick, asking Buildbucket for the build status
[23:55:26.358] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:26.358] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:96:0) after 1m0s
[23:56:26.457] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:96:0)
[23:56:26.457] Timer tick, asking Buildbucket for the build status
[23:56:31.130] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:31.130] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:97:0) after 1m0s
[23:57:31.161] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:97:0)
[23:57:31.161] Timer tick, asking Buildbucket for the build status
[23:57:31.446] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:31.446] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:98:0) after 1m0s
[23:58:31.513] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:98:0)
[23:58:31.513] Timer tick, asking Buildbucket for the build status
[23:58:31.649] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:31.650] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:99:0) after 1m0s
[23:59:31.661] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:99:0)
[23:59:31.661] Timer tick, asking Buildbucket for the build status
[23:59:31.792] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:31.792] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:100:0) after 1m0s
[00:00:31.911] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:100:0)
[00:00:31.911] Timer tick, asking Buildbucket for the build status
[00:00:32.110] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:32.110] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:101:0) after 1m0s
[00:01:32.323] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:101:0)
[00:01:32.323] Timer tick, asking Buildbucket for the build status
[00:01:32.634] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:32.634] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:102:0) after 1m0s
[00:02:32.710] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:102:0)
[00:02:32.710] Timer tick, asking Buildbucket for the build status
[00:02:32.890] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:32.890] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:103:0) after 1m0s
[00:03:33.202] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:103:0)
[00:03:33.202] Timer tick, asking Buildbucket for the build status
[00:03:33.381] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:33.381] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:104:0) after 1m0s
[00:04:33.782] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:104:0)
[00:04:33.782] Timer tick, asking Buildbucket for the build status
[00:04:33.924] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:33.924] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:105:0) after 1m0s
[00:05:33.954] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:105:0)
[00:05:33.954] Timer tick, asking Buildbucket for the build status
[00:05:34.114] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:34.114] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:106:0) after 1m0s
[00:06:34.113] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:106:0)
[00:06:34.113] Timer tick, asking Buildbucket for the build status
[00:06:35.223] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:35.223] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:107:0) after 1m0s
[00:07:35.201] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:107:0)
[00:07:35.201] Timer tick, asking Buildbucket for the build status
[00:07:35.383] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:35.383] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:108:0) after 1m0s
[00:08:35.449] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:108:0)
[00:08:35.449] Timer tick, asking Buildbucket for the build status
[00:08:35.618] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:35.618] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:109:0) after 1m0s
[00:09:35.638] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:109:0)
[00:09:35.638] Timer tick, asking Buildbucket for the build status
[00:09:35.841] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:35.841] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:110:0) after 1m0s
[00:10:35.866] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:110:0)
[00:10:35.866] Timer tick, asking Buildbucket for the build status
[00:10:35.967] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:35.967] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:111:0) after 1m0s
[00:11:35.985] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:111:0)
[00:11:35.985] Timer tick, asking Buildbucket for the build status
[00:11:36.589] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:36.589] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:112:0) after 1m0s
[00:12:36.644] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:112:0)
[00:12:36.644] Timer tick, asking Buildbucket for the build status
[00:12:36.812] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:36.812] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:113:0) after 1m0s
[00:13:36.887] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:113:0)
[00:13:36.887] Timer tick, asking Buildbucket for the build status
[00:13:37.042] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:37.042] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:114:0) after 1m0s
[00:14:37.108] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:114:0)
[00:14:37.108] Timer tick, asking Buildbucket for the build status
[00:14:37.361] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:37.361] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:115:0) after 1m0s
[00:15:37.378] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:115:0)
[00:15:37.378] Timer tick, asking Buildbucket for the build status
[00:15:37.557] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:37.557] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:116:0) after 1m0s
[00:16:37.667] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:116:0)
[00:16:37.667] Timer tick, asking Buildbucket for the build status
[00:16:39.520] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:39.520] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:117:0) after 1m0s
[00:17:39.566] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:117:0)
[00:17:39.566] Timer tick, asking Buildbucket for the build status
[00:17:40.899] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:40.899] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:118:0) after 1m0s
[00:18:41.077] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:118:0)
[00:18:41.077] Timer tick, asking Buildbucket for the build status
[00:18:41.252] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:41.252] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:119:0) after 1m0s
[00:19:41.381] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:119:0)
[00:19:41.381] Timer tick, asking Buildbucket for the build status
[00:19:41.508] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:41.508] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:120:0) after 1m0s
[00:20:41.690] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:120:0)
[00:20:41.690] Timer tick, asking Buildbucket for the build status
[00:20:41.947] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:41.947] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:121:0) after 1m0s
[00:21:41.991] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:121:0)
[00:21:41.991] Timer tick, asking Buildbucket for the build status
[00:21:43.078] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:43.078] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:122:0) after 1m0s
[00:22:43.220] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:122:0)
[00:22:43.220] Timer tick, asking Buildbucket for the build status
[00:22:43.402] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:43.402] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:123:0) after 1m0s
[00:23:43.434] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:123:0)
[00:23:43.434] Timer tick, asking Buildbucket for the build status
[00:23:43.582] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:43.582] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:124:0) after 1m0s
[00:24:43.715] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:124:0)
[00:24:43.715] Timer tick, asking Buildbucket for the build status
[00:24:44.082] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:44.082] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:125:0) after 1m0s
[00:25:44.104] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:125:0)
[00:25:44.104] Timer tick, asking Buildbucket for the build status
[00:25:44.280] Build 8877931985719816048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:44.281] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9043362055321542800:126:0) after 1m0s
[00:25:49.544] Received PubSub notification, asking Buildbucket for the build status
[00:25:49.628] Build 8877931985719816048: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:25:49.628] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"completed_ts": "1591748748531561",
"created_by": "project:emscripten-releases",
"created_ts": "1591741304625594",
"id": "8877931985719816048",
"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\": \"22581b39618fd0b4ceff2f4ad3226657839f287c\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@22581b39618fd0b4ceff2f4ad3226657839f287c\", \"title\": \"22581b39618fd0b4ceff2f4ad3226657839f287c\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/22581b39618fd0b4ceff2f4ad3226657839f287c\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"22581b39618fd0b4ceff2f4ad3226657839f287c\"}}",
"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\": \"22581b39618fd0b4ceff2f4ad3226657839f287c\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@22581b39618fd0b4ceff2f4ad3226657839f287c\", \"title\": \"22581b39618fd0b4ceff2f4ad3226657839f287c\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/22581b39618fd0b4ceff2f4ad3226657839f287c\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-win10-0-r5r4\", \"branch\": \"refs/heads/master\", \"buildername\": \"win\", \"got_revision\": \"22581b39618fd0b4ceff2f4ad3226657839f287c\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"22581b39618fd0b4ceff2f4ad3226657839f287c\"}, \"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-r5r4\"], \"image\": [\"chrome-win10-1703-20052900-58250aa4257\"], \"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\": [\"5190-b7dcd03\"], \"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": "1591744615232274",
"status": "COMPLETED",
"status_changed_ts": "1591748749122510",
"tags": [
"builder:win",
"buildset:commit/git/22581b39618fd0b4ceff2f4ad3226657839f287c",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/22581b39618fd0b4ceff2f4ad3226657839f287c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9043362055321542800",
"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/8877931985719816048/+/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:4cb3fe6560a60d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1591748749144452",
"url": "https://ci.chromium.org/b/8877931985719816048",
"utcnow_ts": "1591748749607327"
}
}
[00:25:49.628] Invocation finished in 2h4m13.543311835s with status SUCCEEDED