[19:45:02.564] New invocation is queued and will start shortly
[19:45:03.695] Starting the invocation (attempt 1)
[19:45:03.775] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:45:03.775] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:45:03.775] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9045365038419981568",
"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\":\"e861e5fef3809154a6d4863970716f62d98e2bcc\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@e861e5fef3809154a6d4863970716f62d98e2bcc\",\"title\":\"e861e5fef3809154a6d4863970716f62d98e2bcc\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/e861e5fef3809154a6d4863970716f62d98e2bcc\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"e861e5fef3809154a6d4863970716f62d98e2bcc\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win",
"scheduler_invocation_id:9045365038419981568",
"scheduler_job_id:emscripten-releases/win",
"user_agent:luci-scheduler",
"buildset:commit/git/e861e5fef3809154a6d4863970716f62d98e2bcc",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/e861e5fef3809154a6d4863970716f62d98e2bcc",
"gitiles_ref:refs/heads/master"
]
}
[19:45:06.162] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1589831104146954",
"id": "8879934976097589696",
"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\": \"e861e5fef3809154a6d4863970716f62d98e2bcc\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@e861e5fef3809154a6d4863970716f62d98e2bcc\", \"title\": \"e861e5fef3809154a6d4863970716f62d98e2bcc\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/e861e5fef3809154a6d4863970716f62d98e2bcc\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"e861e5fef3809154a6d4863970716f62d98e2bcc\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1589831105506940",
"tags": [
"builder:win",
"buildset:commit/git/e861e5fef3809154a6d4863970716f62d98e2bcc",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/e861e5fef3809154a6d4863970716f62d98e2bcc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9045365038419981568",
"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/8879934976097589696/+/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": "1589831105507081",
"url": "https://ci.chromium.org/b/8879934976097589696",
"utcnow_ts": "1589831106037248"
}
}
[19:45:06.162] Task URL: https://ci.chromium.org/b/8879934976097589696
[19:45:06.162] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:2:0) after 1m0s
[19:46:06.184] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:2:0)
[19:46:06.184] Timer tick, asking Buildbucket for the build status
[19:46:06.516] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:46:06.516] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:3:0) after 1m0s
[19:47:06.582] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:3:0)
[19:47:06.582] Timer tick, asking Buildbucket for the build status
[19:47:06.794] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:47:06.794] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:4:0) after 1m0s
[19:48:06.898] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:4:0)
[19:48:06.898] Timer tick, asking Buildbucket for the build status
[19:48:07.116] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:48:07.116] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:5:0) after 1m0s
[19:49:07.324] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:5:0)
[19:49:07.324] Timer tick, asking Buildbucket for the build status
[19:49:08.087] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:49:08.087] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:6:0) after 1m0s
[19:50:08.159] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:6:0)
[19:50:08.159] Timer tick, asking Buildbucket for the build status
[19:50:08.557] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:50:08.557] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:7:0) after 1m0s
[19:51:08.626] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:7:0)
[19:51:08.626] Timer tick, asking Buildbucket for the build status
[19:51:08.865] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:51:08.865] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:8:0) after 1m0s
[19:52:08.981] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:8:0)
[19:52:08.981] Timer tick, asking Buildbucket for the build status
[19:52:09.217] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:52:09.217] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:9:0) after 1m0s
[19:53:09.235] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:9:0)
[19:53:09.235] Timer tick, asking Buildbucket for the build status
[19:53:09.716] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:53:09.716] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:10:0) after 1m0s
[19:54:09.735] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:10:0)
[19:54:09.735] Timer tick, asking Buildbucket for the build status
[19:54:09.881] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:54:09.881] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:11:0) after 1m0s
[19:55:09.903] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:11:0)
[19:55:09.903] Timer tick, asking Buildbucket for the build status
[19:55:10.012] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:55:10.012] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:12:0) after 1m0s
[19:56:10.091] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:12:0)
[19:56:10.091] Timer tick, asking Buildbucket for the build status
[19:56:10.247] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:56:10.247] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:13:0) after 1m0s
[19:57:10.276] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:13:0)
[19:57:10.276] Timer tick, asking Buildbucket for the build status
[19:57:10.879] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:57:10.879] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:14:0) after 1m0s
[19:58:10.913] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:14:0)
[19:58:10.913] Timer tick, asking Buildbucket for the build status
[19:58:11.097] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:58:11.097] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:15:0) after 1m0s
[19:59:11.126] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:15:0)
[19:59:11.126] Timer tick, asking Buildbucket for the build status
[19:59:11.357] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:59:11.357] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:16:0) after 1m0s
[20:00:11.385] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:16:0)
[20:00:11.385] Timer tick, asking Buildbucket for the build status
[20:00:12.480] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:00:12.480] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:17:0) after 1m0s
[20:01:12.503] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:17:0)
[20:01:12.503] Timer tick, asking Buildbucket for the build status
[20:01:12.716] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:01:12.716] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:18:0) after 1m0s
[20:02:12.748] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:18:0)
[20:02:12.748] Timer tick, asking Buildbucket for the build status
[20:02:13.313] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:02:13.313] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:19:0) after 1m0s
[20:03:13.381] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:19:0)
[20:03:13.381] Timer tick, asking Buildbucket for the build status
[20:03:13.908] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:03:13.908] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:20:0) after 1m0s
[20:04:13.893] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:20:0)
[20:04:13.893] Timer tick, asking Buildbucket for the build status
[20:04:14.487] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:04:14.487] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:21:0) after 1m0s
[20:05:14.533] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:21:0)
[20:05:14.533] Timer tick, asking Buildbucket for the build status
[20:05:14.762] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:05:14.762] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:22:0) after 1m0s
[20:06:14.822] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:22:0)
[20:06:14.822] Timer tick, asking Buildbucket for the build status
[20:06:15.479] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:06:15.479] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:23:0) after 1m0s
[20:07:15.504] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:23:0)
[20:07:15.504] Timer tick, asking Buildbucket for the build status
[20:07:15.670] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:07:15.670] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:24:0) after 1m0s
[20:08:15.722] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:24:0)
[20:08:15.722] Timer tick, asking Buildbucket for the build status
[20:08:15.838] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:08:15.838] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:25:0) after 1m0s
[20:09:15.902] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:25:0)
[20:09:15.902] Timer tick, asking Buildbucket for the build status
[20:09:16.038] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:09:16.038] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:26:0) after 1m0s
[20:10:16.145] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:26:0)
[20:10:16.145] Timer tick, asking Buildbucket for the build status
[20:10:16.362] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:10:16.362] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:27:0) after 1m0s
[20:11:16.388] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:27:0)
[20:11:16.388] Timer tick, asking Buildbucket for the build status
[20:11:16.936] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:11:16.936] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:28:0) after 1m0s
[20:12:16.984] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:28:0)
[20:12:16.984] Timer tick, asking Buildbucket for the build status
[20:12:17.265] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:12:17.265] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:29:0) after 1m0s
[20:13:17.313] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:29:0)
[20:13:17.313] Timer tick, asking Buildbucket for the build status
[20:13:17.528] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:13:17.528] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:30:0) after 1m0s
[20:14:17.567] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:30:0)
[20:14:17.567] Timer tick, asking Buildbucket for the build status
[20:14:18.534] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:14:18.534] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:31:0) after 1m0s
[20:15:18.576] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:31:0)
[20:15:18.576] Timer tick, asking Buildbucket for the build status
[20:15:19.074] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:15:19.074] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:32:0) after 1m0s
[20:16:19.131] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:32:0)
[20:16:19.131] Timer tick, asking Buildbucket for the build status
[20:16:19.346] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:16:19.346] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:33:0) after 1m0s
[20:17:19.399] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:33:0)
[20:17:19.399] Timer tick, asking Buildbucket for the build status
[20:17:19.742] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:17:19.742] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:34:0) after 1m0s
[20:18:19.781] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:34:0)
[20:18:19.781] Timer tick, asking Buildbucket for the build status
[20:18:20.634] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:18:20.634] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:35:0) after 1m0s
[20:19:20.626] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:35:0)
[20:19:20.626] Timer tick, asking Buildbucket for the build status
[20:19:21.867] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:19:21.868] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:36:0) after 1m0s
[20:20:21.947] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:36:0)
[20:20:21.947] Timer tick, asking Buildbucket for the build status
[20:20:22.143] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:20:22.143] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:37:0) after 1m0s
[20:21:22.177] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:37:0)
[20:21:22.177] Timer tick, asking Buildbucket for the build status
[20:21:22.401] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:21:22.401] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:38:0) after 1m0s
[20:22:22.430] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:38:0)
[20:22:22.430] Timer tick, asking Buildbucket for the build status
[20:22:24.111] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:22:24.111] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:39:0) after 1m0s
[20:23:24.137] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:39:0)
[20:23:24.137] Timer tick, asking Buildbucket for the build status
[20:23:24.340] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:23:24.340] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:40:0) after 1m0s
[20:24:24.391] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:40:0)
[20:24:24.391] Timer tick, asking Buildbucket for the build status
[20:24:24.760] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:24:24.760] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:41:0) after 1m0s
[20:25:24.794] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:41:0)
[20:25:24.794] Timer tick, asking Buildbucket for the build status
[20:25:25.122] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:25:25.122] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:42:0) after 1m0s
[20:26:25.177] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:42:0)
[20:26:25.177] Timer tick, asking Buildbucket for the build status
[20:26:25.327] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:26:25.327] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:43:0) after 1m0s
[20:27:25.377] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:43:0)
[20:27:25.377] Timer tick, asking Buildbucket for the build status
[20:27:25.529] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:27:25.529] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:44:0) after 1m0s
[20:28:25.536] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:44:0)
[20:28:25.536] Timer tick, asking Buildbucket for the build status
[20:28:25.959] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:28:25.960] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:45:0) after 1m0s
[20:29:26.064] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:45:0)
[20:29:26.064] Timer tick, asking Buildbucket for the build status
[20:29:26.603] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:29:26.603] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:46:0) after 1m0s
[20:30:26.665] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:46:0)
[20:30:26.665] Timer tick, asking Buildbucket for the build status
[20:30:26.888] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:30:26.888] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:47:0) after 1m0s
[20:31:26.936] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:47:0)
[20:31:26.936] Timer tick, asking Buildbucket for the build status
[20:31:27.778] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:31:27.778] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:48:0) after 1m0s
[20:32:27.851] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:48:0)
[20:32:27.851] Timer tick, asking Buildbucket for the build status
[20:32:28.401] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:32:28.401] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:49:0) after 1m0s
[20:33:28.479] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:49:0)
[20:33:28.479] Timer tick, asking Buildbucket for the build status
[20:33:28.722] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:33:28.722] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:50:0) after 1m0s
[20:34:28.787] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:50:0)
[20:34:28.787] Timer tick, asking Buildbucket for the build status
[20:34:28.963] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:34:28.964] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:51:0) after 1m0s
[20:35:29.034] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:51:0)
[20:35:29.034] Timer tick, asking Buildbucket for the build status
[20:35:29.491] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:35:29.491] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:52:0) after 1m0s
[20:36:29.591] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:52:0)
[20:36:29.591] Timer tick, asking Buildbucket for the build status
[20:36:29.768] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:36:29.768] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:53:0) after 1m0s
[20:37:29.794] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:53:0)
[20:37:29.794] Timer tick, asking Buildbucket for the build status
[20:37:29.940] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:37:29.940] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:54:0) after 1m0s
[20:38:29.958] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:54:0)
[20:38:29.958] Timer tick, asking Buildbucket for the build status
[20:38:30.309] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:38:30.309] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:55:0) after 1m0s
[20:39:30.344] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:55:0)
[20:39:30.344] Timer tick, asking Buildbucket for the build status
[20:39:30.600] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:39:30.600] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:56:0) after 1m0s
[20:40:30.627] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:56:0)
[20:40:30.627] Timer tick, asking Buildbucket for the build status
[20:40:30.921] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:40:30.921] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:57:0) after 1m0s
[20:41:30.987] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:57:0)
[20:41:30.987] Timer tick, asking Buildbucket for the build status
[20:41:31.183] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:41:31.183] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:58:0) after 1m0s
[20:42:31.204] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:58:0)
[20:42:31.204] Timer tick, asking Buildbucket for the build status
[20:42:31.433] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:42:31.433] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:59:0) after 1m0s
[20:43:31.480] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:59:0)
[20:43:31.480] Timer tick, asking Buildbucket for the build status
[20:43:31.797] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:43:31.797] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:60:0) after 1m0s
[20:44:31.866] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:60:0)
[20:44:31.866] Timer tick, asking Buildbucket for the build status
[20:44:32.019] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:44:32.019] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:61:0) after 1m0s
[20:45:32.035] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:61:0)
[20:45:32.035] Timer tick, asking Buildbucket for the build status
[20:45:34.571] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:45:34.571] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:62:0) after 1m0s
[20:46:34.634] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:62:0)
[20:46:34.634] Timer tick, asking Buildbucket for the build status
[20:46:34.815] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:46:34.815] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:63:0) after 1m0s
[20:47:34.793] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:63:0)
[20:47:34.793] Timer tick, asking Buildbucket for the build status
[20:47:35.202] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:47:35.202] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:64:0) after 1m0s
[20:48:35.258] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:64:0)
[20:48:35.258] Timer tick, asking Buildbucket for the build status
[20:48:35.417] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:48:35.417] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:65:0) after 1m0s
[20:49:35.432] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:65:0)
[20:49:35.432] Timer tick, asking Buildbucket for the build status
[20:49:35.543] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:49:35.543] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:66:0) after 1m0s
[20:50:35.550] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:66:0)
[20:50:35.550] Timer tick, asking Buildbucket for the build status
[20:50:35.807] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:50:35.807] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:67:0) after 1m0s
[20:51:35.881] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:67:0)
[20:51:35.881] Timer tick, asking Buildbucket for the build status
[20:51:36.081] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:51:36.081] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:68:0) after 1m0s
[20:52:36.137] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:68:0)
[20:52:36.137] Timer tick, asking Buildbucket for the build status
[20:52:36.516] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:52:36.516] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:69:0) after 1m0s
[20:53:36.571] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:69:0)
[20:53:36.571] Timer tick, asking Buildbucket for the build status
[20:53:36.712] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:53:36.712] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:70:0) after 1m0s
[20:54:36.738] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:70:0)
[20:54:36.738] Timer tick, asking Buildbucket for the build status
[20:54:36.996] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:54:36.996] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:71:0) after 1m0s
[20:55:37.039] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:71:0)
[20:55:37.039] Timer tick, asking Buildbucket for the build status
[20:55:37.367] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:55:37.367] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:72:0) after 1m0s
[20:56:37.355] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:72:0)
[20:56:37.355] Timer tick, asking Buildbucket for the build status
[20:56:37.856] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:56:37.857] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:73:0) after 1m0s
[20:57:37.896] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:73:0)
[20:57:37.896] Timer tick, asking Buildbucket for the build status
[20:57:38.055] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:57:38.055] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:74:0) after 1m0s
[20:58:38.139] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:74:0)
[20:58:38.139] Timer tick, asking Buildbucket for the build status
[20:58:38.488] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:58:38.488] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:75:0) after 1m0s
[20:59:38.523] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:75:0)
[20:59:38.523] Timer tick, asking Buildbucket for the build status
[20:59:38.948] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:59:38.948] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:76:0) after 1m0s
[21:00:39.035] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:76:0)
[21:00:39.035] Timer tick, asking Buildbucket for the build status
[21:00:39.341] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:00:39.341] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:77:0) after 1m0s
[21:01:39.339] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:77:0)
[21:01:39.339] Timer tick, asking Buildbucket for the build status
[21:01:39.539] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:01:39.539] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:78:0) after 1m0s
[21:02:39.575] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:78:0)
[21:02:39.575] Timer tick, asking Buildbucket for the build status
[21:02:39.924] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:02:39.924] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:79:0) after 1m0s
[21:03:39.949] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:79:0)
[21:03:39.949] Timer tick, asking Buildbucket for the build status
[21:03:40.189] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:03:40.189] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:80:0) after 1m0s
[21:04:40.233] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:80:0)
[21:04:40.233] Timer tick, asking Buildbucket for the build status
[21:04:40.549] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:04:40.549] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:81:0) after 1m0s
[21:05:40.555] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:81:0)
[21:05:40.555] Timer tick, asking Buildbucket for the build status
[21:05:44.081] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:05:44.081] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:82:0) after 1m0s
[21:06:44.130] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:82:0)
[21:06:44.130] Timer tick, asking Buildbucket for the build status
[21:06:44.276] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:06:44.276] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:83:0) after 1m0s
[21:07:44.304] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:83:0)
[21:07:44.304] Timer tick, asking Buildbucket for the build status
[21:07:44.419] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:07:44.419] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:84:0) after 1m0s
[21:08:44.450] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:84:0)
[21:08:44.450] Timer tick, asking Buildbucket for the build status
[21:08:44.662] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:08:44.662] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:85:0) after 1m0s
[21:09:44.693] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:85:0)
[21:09:44.693] Timer tick, asking Buildbucket for the build status
[21:09:44.889] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:09:44.889] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:86:0) after 1m0s
[21:10:44.983] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:86:0)
[21:10:44.983] Timer tick, asking Buildbucket for the build status
[21:10:45.362] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:10:45.362] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:87:0) after 1m0s
[21:11:45.407] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:87:0)
[21:11:45.407] Timer tick, asking Buildbucket for the build status
[21:11:45.653] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:11:45.653] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:88:0) after 1m0s
[21:12:45.687] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:88:0)
[21:12:45.687] Timer tick, asking Buildbucket for the build status
[21:12:45.897] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:12:45.897] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:89:0) after 1m0s
[21:13:45.957] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:89:0)
[21:13:45.957] Timer tick, asking Buildbucket for the build status
[21:13:46.181] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:13:46.181] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:90:0) after 1m0s
[21:14:46.237] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:90:0)
[21:14:46.237] Timer tick, asking Buildbucket for the build status
[21:14:46.469] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:14:46.469] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:91:0) after 1m0s
[21:15:46.495] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:91:0)
[21:15:46.495] Timer tick, asking Buildbucket for the build status
[21:15:46.686] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:15:46.686] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:92:0) after 1m0s
[21:16:46.764] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:92:0)
[21:16:46.765] Timer tick, asking Buildbucket for the build status
[21:16:47.187] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:16:47.187] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:93:0) after 1m0s
[21:17:47.212] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:93:0)
[21:17:47.212] Timer tick, asking Buildbucket for the build status
[21:17:47.384] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:17:47.384] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:94:0) after 1m0s
[21:18:47.431] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:94:0)
[21:18:47.431] Timer tick, asking Buildbucket for the build status
[21:18:47.556] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:18:47.556] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:95:0) after 1m0s
[21:19:47.607] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:95:0)
[21:19:47.607] Timer tick, asking Buildbucket for the build status
[21:19:47.754] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:19:47.754] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:96:0) after 1m0s
[21:20:47.796] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:96:0)
[21:20:47.796] Timer tick, asking Buildbucket for the build status
[21:20:48.017] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:20:48.017] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:97:0) after 1m0s
[21:21:48.177] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:97:0)
[21:21:48.177] Timer tick, asking Buildbucket for the build status
[21:21:48.372] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:21:48.372] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:98:0) after 1m0s
[21:22:48.532] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:98:0)
[21:22:48.532] Timer tick, asking Buildbucket for the build status
[21:22:48.965] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:22:48.965] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:99:0) after 1m0s
[21:23:49.166] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:99:0)
[21:23:49.166] Timer tick, asking Buildbucket for the build status
[21:23:49.465] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:23:49.466] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:100:0) after 1m0s
[21:24:49.525] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:100:0)
[21:24:49.525] Timer tick, asking Buildbucket for the build status
[21:24:50.019] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:24:50.019] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:101:0) after 1m0s
[21:25:50.081] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:101:0)
[21:25:50.081] Timer tick, asking Buildbucket for the build status
[21:25:50.672] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:25:50.672] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:102:0) after 1m0s
[21:26:50.854] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:102:0)
[21:26:50.854] Timer tick, asking Buildbucket for the build status
[21:26:51.808] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:26:51.808] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:103:0) after 1m0s
[21:27:52.021] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:103:0)
[21:27:52.021] Timer tick, asking Buildbucket for the build status
[21:27:52.201] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:27:52.201] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:104:0) after 1m0s
[21:28:52.391] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:104:0)
[21:28:52.391] Timer tick, asking Buildbucket for the build status
[21:28:52.681] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:28:52.681] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:105:0) after 1m0s
[21:29:52.803] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:105:0)
[21:29:52.803] Timer tick, asking Buildbucket for the build status
[21:29:52.975] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:29:52.975] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:106:0) after 1m0s
[21:30:53.050] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:106:0)
[21:30:53.050] Timer tick, asking Buildbucket for the build status
[21:30:54.451] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:30:54.451] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:107:0) after 1m0s
[21:31:54.675] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:107:0)
[21:31:54.675] Timer tick, asking Buildbucket for the build status
[21:31:55.431] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:31:55.431] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:108:0) after 1m0s
[21:32:55.575] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:108:0)
[21:32:55.575] Timer tick, asking Buildbucket for the build status
[21:32:55.719] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:32:55.719] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:109:0) after 1m0s
[21:33:55.793] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:109:0)
[21:33:55.793] Timer tick, asking Buildbucket for the build status
[21:33:56.044] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:33:56.044] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:110:0) after 1m0s
[21:34:56.263] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:110:0)
[21:34:56.263] Timer tick, asking Buildbucket for the build status
[21:34:56.398] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:34:56.398] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:111:0) after 1m0s
[21:35:56.552] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:111:0)
[21:35:56.552] Timer tick, asking Buildbucket for the build status
[21:35:56.801] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:35:56.801] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:112:0) after 1m0s
[21:36:56.844] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:112:0)
[21:36:56.844] Timer tick, asking Buildbucket for the build status
[21:36:57.447] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:36:57.447] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:113:0) after 1m0s
[21:37:57.563] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:113:0)
[21:37:57.563] Timer tick, asking Buildbucket for the build status
[21:37:57.709] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:37:57.709] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:114:0) after 1m0s
[21:38:57.967] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:114:0)
[21:38:57.967] Timer tick, asking Buildbucket for the build status
[21:38:58.138] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:38:58.138] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:115:0) after 1m0s
[21:39:58.212] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:115:0)
[21:39:58.212] Timer tick, asking Buildbucket for the build status
[21:39:58.442] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:39:58.442] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:116:0) after 1m0s
[21:40:58.481] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:116:0)
[21:40:58.481] Timer tick, asking Buildbucket for the build status
[21:40:58.879] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:40:58.879] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:117:0) after 1m0s
[21:41:59.027] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:117:0)
[21:41:59.027] Timer tick, asking Buildbucket for the build status
[21:41:59.845] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:41:59.845] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:118:0) after 1m0s
[21:42:59.883] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:118:0)
[21:42:59.883] Timer tick, asking Buildbucket for the build status
[21:43:00.201] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:43:00.202] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:119:0) after 1m0s
[21:44:00.255] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:119:0)
[21:44:00.255] Timer tick, asking Buildbucket for the build status
[21:44:00.402] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:44:00.402] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:120:0) after 1m0s
[21:45:00.471] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:120:0)
[21:45:00.471] Timer tick, asking Buildbucket for the build status
[21:45:02.545] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:45:02.545] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:121:0) after 1m0s
[21:46:02.670] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:121:0)
[21:46:02.670] Timer tick, asking Buildbucket for the build status
[21:46:02.840] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:46:02.840] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:122:0) after 1m0s
[21:47:02.919] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:122:0)
[21:47:02.919] Timer tick, asking Buildbucket for the build status
[21:47:03.512] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:47:03.512] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:123:0) after 1m0s
[21:48:03.651] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:123:0)
[21:48:03.651] Timer tick, asking Buildbucket for the build status
[21:48:03.796] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:48:03.796] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:124:0) after 1m0s
[21:49:04.254] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:124:0)
[21:49:04.254] Timer tick, asking Buildbucket for the build status
[21:49:05.013] Build 8879934976097589696: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:49:05.013] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:125:0) after 1m0s
[21:49:17.773] Received PubSub notification, asking Buildbucket for the build status
[21:49:17.971] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:05.626] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:125:0)
[21:50:05.626] Timer tick, asking Buildbucket for the build status
[21:50:05.862] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:05.862] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:127:0) after 1m0s
[21:51:05.926] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:127:0)
[21:51:05.926] Timer tick, asking Buildbucket for the build status
[21:51:06.183] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:06.183] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:128:0) after 1m0s
[21:52:06.209] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:128:0)
[21:52:06.209] Timer tick, asking Buildbucket for the build status
[21:52:06.345] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:06.345] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:129:0) after 1m0s
[21:53:06.391] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:129:0)
[21:53:06.391] Timer tick, asking Buildbucket for the build status
[21:53:06.568] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:06.568] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:130:0) after 1m0s
[21:54:06.579] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:130:0)
[21:54:06.579] Timer tick, asking Buildbucket for the build status
[21:54:06.796] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:06.796] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:131:0) after 1m0s
[21:55:06.834] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:131:0)
[21:55:06.834] Timer tick, asking Buildbucket for the build status
[21:55:07.076] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:07.076] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:132:0) after 1m0s
[21:56:07.148] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:132:0)
[21:56:07.148] Timer tick, asking Buildbucket for the build status
[21:56:08.105] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:08.105] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:133:0) after 1m0s
[21:57:08.165] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:133:0)
[21:57:08.165] Timer tick, asking Buildbucket for the build status
[21:57:08.413] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:08.413] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:134:0) after 1m0s
[21:58:08.488] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:134:0)
[21:58:08.488] Timer tick, asking Buildbucket for the build status
[21:58:08.663] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:08.663] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:135:0) after 1m0s
[21:59:08.747] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:135:0)
[21:59:08.747] Timer tick, asking Buildbucket for the build status
[21:59:08.920] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:08.920] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:136:0) after 1m0s
[22:00:08.956] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:136:0)
[22:00:08.956] Timer tick, asking Buildbucket for the build status
[22:00:09.072] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:09.072] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:137:0) after 1m0s
[22:01:09.111] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:137:0)
[22:01:09.111] Timer tick, asking Buildbucket for the build status
[22:01:09.319] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:09.319] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:138:0) after 1m0s
[22:02:09.346] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:138:0)
[22:02:09.346] Timer tick, asking Buildbucket for the build status
[22:02:09.824] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:09.824] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:139:0) after 1m0s
[22:03:09.899] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:139:0)
[22:03:09.899] Timer tick, asking Buildbucket for the build status
[22:03:10.182] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:10.182] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:140:0) after 1m0s
[22:04:10.272] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:140:0)
[22:04:10.272] Timer tick, asking Buildbucket for the build status
[22:04:11.004] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:11.004] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:141:0) after 1m0s
[22:05:11.008] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:141:0)
[22:05:11.008] Timer tick, asking Buildbucket for the build status
[22:05:11.221] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:11.221] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:142:0) after 1m0s
[22:06:11.223] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:142:0)
[22:06:11.223] Timer tick, asking Buildbucket for the build status
[22:06:12.034] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:12.034] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:143:0) after 1m0s
[22:07:12.059] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:143:0)
[22:07:12.059] Timer tick, asking Buildbucket for the build status
[22:07:12.279] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:12.279] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:144:0) after 1m0s
[22:08:12.313] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:144:0)
[22:08:12.313] Timer tick, asking Buildbucket for the build status
[22:08:12.493] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:12.493] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:145:0) after 1m0s
[22:09:12.536] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:145:0)
[22:09:12.536] Timer tick, asking Buildbucket for the build status
[22:09:12.950] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:12.950] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:146:0) after 1m0s
[22:10:12.997] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:146:0)
[22:10:12.998] Timer tick, asking Buildbucket for the build status
[22:10:13.186] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:13.186] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:147:0) after 1m0s
[22:11:13.212] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:147:0)
[22:11:13.212] Timer tick, asking Buildbucket for the build status
[22:11:13.802] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:13.802] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:148:0) after 1m0s
[22:12:13.808] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:148:0)
[22:12:13.808] Timer tick, asking Buildbucket for the build status
[22:12:14.295] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:14.295] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:149:0) after 1m0s
[22:13:14.314] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:149:0)
[22:13:14.314] Timer tick, asking Buildbucket for the build status
[22:13:14.716] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:14.716] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:150:0) after 1m0s
[22:14:14.804] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:150:0)
[22:14:14.804] Timer tick, asking Buildbucket for the build status
[22:14:15.424] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:15.424] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:151:0) after 1m0s
[22:15:15.492] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:151:0)
[22:15:15.492] Timer tick, asking Buildbucket for the build status
[22:15:16.551] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:16.551] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:152:0) after 1m0s
[22:16:16.593] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:152:0)
[22:16:16.593] Timer tick, asking Buildbucket for the build status
[22:16:16.913] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:16.913] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:153:0) after 1m0s
[22:17:17.040] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:153:0)
[22:17:17.040] Timer tick, asking Buildbucket for the build status
[22:17:17.275] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:17.275] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:154:0) after 1m0s
[22:18:17.294] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:154:0)
[22:18:17.294] Timer tick, asking Buildbucket for the build status
[22:18:17.611] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:17.611] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:155:0) after 1m0s
[22:19:17.652] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:155:0)
[22:19:17.652] Timer tick, asking Buildbucket for the build status
[22:19:17.891] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:17.891] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:156:0) after 1m0s
[22:20:17.943] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:156:0)
[22:20:17.943] Timer tick, asking Buildbucket for the build status
[22:20:18.190] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:18.190] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:157:0) after 1m0s
[22:21:18.273] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:157:0)
[22:21:18.273] Timer tick, asking Buildbucket for the build status
[22:21:18.425] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:18.425] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:158:0) after 1m0s
[22:22:18.492] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:158:0)
[22:22:18.492] Timer tick, asking Buildbucket for the build status
[22:22:18.918] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:18.918] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:159:0) after 1m0s
[22:23:19.083] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:159:0)
[22:23:19.083] Timer tick, asking Buildbucket for the build status
[22:23:19.240] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:19.240] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:160:0) after 1m0s
[22:24:19.337] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:160:0)
[22:24:19.337] Timer tick, asking Buildbucket for the build status
[22:24:19.595] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:19.595] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:161:0) after 1m0s
[22:25:19.624] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:161:0)
[22:25:19.624] Timer tick, asking Buildbucket for the build status
[22:25:20.308] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:20.308] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:162:0) after 1m0s
[22:26:20.361] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:162:0)
[22:26:20.361] Timer tick, asking Buildbucket for the build status
[22:26:20.568] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:20.568] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:163:0) after 1m0s
[22:27:20.616] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:163:0)
[22:27:20.616] Timer tick, asking Buildbucket for the build status
[22:27:20.772] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:20.772] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:164:0) after 1m0s
[22:28:20.869] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:164:0)
[22:28:20.869] Timer tick, asking Buildbucket for the build status
[22:28:21.062] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:21.062] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:165:0) after 1m0s
[22:29:21.135] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:165:0)
[22:29:21.135] Timer tick, asking Buildbucket for the build status
[22:29:21.338] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:21.338] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:166:0) after 1m0s
[22:30:21.432] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:166:0)
[22:30:21.432] Timer tick, asking Buildbucket for the build status
[22:30:21.648] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:21.648] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:167:0) after 1m0s
[22:31:21.641] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:167:0)
[22:31:21.641] Timer tick, asking Buildbucket for the build status
[22:31:21.810] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:21.810] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:168:0) after 1m0s
[22:32:21.842] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:168:0)
[22:32:21.842] Timer tick, asking Buildbucket for the build status
[22:32:22.001] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:22.001] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:169:0) after 1m0s
[22:33:22.025] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:169:0)
[22:33:22.025] Timer tick, asking Buildbucket for the build status
[22:33:22.271] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:22.271] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:170:0) after 1m0s
[22:34:22.317] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:170:0)
[22:34:22.317] Timer tick, asking Buildbucket for the build status
[22:34:22.661] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:22.661] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:171:0) after 1m0s
[22:35:22.708] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:171:0)
[22:35:22.708] Timer tick, asking Buildbucket for the build status
[22:35:23.362] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:23.362] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:172:0) after 1m0s
[22:36:23.396] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:172:0)
[22:36:23.396] Timer tick, asking Buildbucket for the build status
[22:36:23.546] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:23.546] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:173:0) after 1m0s
[22:37:23.570] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:173:0)
[22:37:23.570] Timer tick, asking Buildbucket for the build status
[22:37:24.004] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:24.005] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:174:0) after 1m0s
[22:38:24.052] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:174:0)
[22:38:24.052] Timer tick, asking Buildbucket for the build status
[22:38:24.218] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:24.218] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:175:0) after 1m0s
[22:39:24.286] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:175:0)
[22:39:24.286] Timer tick, asking Buildbucket for the build status
[22:39:24.450] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:24.450] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:176:0) after 1m0s
[22:40:24.644] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:176:0)
[22:40:24.644] Timer tick, asking Buildbucket for the build status
[22:40:24.836] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:24.836] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:177:0) after 1m0s
[22:41:25.106] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:177:0)
[22:41:25.106] Timer tick, asking Buildbucket for the build status
[22:41:25.283] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:25.283] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:178:0) after 1m0s
[22:42:25.307] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:178:0)
[22:42:25.307] Timer tick, asking Buildbucket for the build status
[22:42:25.728] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:25.728] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:179:0) after 1m0s
[22:43:25.763] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:179:0)
[22:43:25.763] Timer tick, asking Buildbucket for the build status
[22:43:25.957] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:25.957] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:180:0) after 1m0s
[22:44:25.954] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:180:0)
[22:44:25.954] Timer tick, asking Buildbucket for the build status
[22:44:26.383] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:26.383] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:181:0) after 1m0s
[22:45:26.414] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:181:0)
[22:45:26.414] Timer tick, asking Buildbucket for the build status
[22:45:27.607] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:27.607] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:182:0) after 1m0s
[22:46:27.686] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:182:0)
[22:46:27.686] Timer tick, asking Buildbucket for the build status
[22:46:28.615] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:28.615] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:183:0) after 1m0s
[22:47:28.618] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:183:0)
[22:47:28.618] Timer tick, asking Buildbucket for the build status
[22:47:29.155] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:29.155] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:184:0) after 1m0s
[22:48:29.203] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:184:0)
[22:48:29.203] Timer tick, asking Buildbucket for the build status
[22:48:29.355] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:29.355] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:185:0) after 1m0s
[22:49:29.414] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:185:0)
[22:49:29.414] Timer tick, asking Buildbucket for the build status
[22:49:29.623] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:29.623] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:186:0) after 1m0s
[22:50:29.740] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:186:0)
[22:50:29.741] Timer tick, asking Buildbucket for the build status
[22:50:29.912] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:29.912] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:187:0) after 1m0s
[22:51:30.028] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:187:0)
[22:51:30.028] Timer tick, asking Buildbucket for the build status
[22:51:30.199] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:30.199] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:188:0) after 1m0s
[22:52:30.777] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:188:0)
[22:52:30.777] Timer tick, asking Buildbucket for the build status
[22:52:30.900] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:30.900] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:189:0) after 1m0s
[22:53:31.158] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:189:0)
[22:53:31.158] Timer tick, asking Buildbucket for the build status
[22:53:31.376] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:31.376] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:190:0) after 1m0s
[22:54:32.006] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:190:0)
[22:54:32.006] Timer tick, asking Buildbucket for the build status
[22:54:32.360] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:32.361] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:191:0) after 1m0s
[22:55:33.076] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:191:0)
[22:55:33.076] Timer tick, asking Buildbucket for the build status
[22:55:33.494] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:33.494] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:192:0) after 1m0s
[22:56:34.068] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:192:0)
[22:56:34.068] Timer tick, asking Buildbucket for the build status
[22:56:34.271] Build 8879934976097589696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:34.271] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9045365038419981568:193:0) after 1m0s
[22:57:23.253] Received PubSub notification, asking Buildbucket for the build status
[22:57:23.397] Build 8879934976097589696: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:57:23.397] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"completed_ts": "1589842641743636",
"created_by": "project:emscripten-releases",
"created_ts": "1589831104146954",
"id": "8879934976097589696",
"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\": \"e861e5fef3809154a6d4863970716f62d98e2bcc\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@e861e5fef3809154a6d4863970716f62d98e2bcc\", \"title\": \"e861e5fef3809154a6d4863970716f62d98e2bcc\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/e861e5fef3809154a6d4863970716f62d98e2bcc\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"e861e5fef3809154a6d4863970716f62d98e2bcc\"}}",
"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\": \"e861e5fef3809154a6d4863970716f62d98e2bcc\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@e861e5fef3809154a6d4863970716f62d98e2bcc\", \"title\": \"e861e5fef3809154a6d4863970716f62d98e2bcc\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/e861e5fef3809154a6d4863970716f62d98e2bcc\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-win10-0-yrvw\", \"branch\": \"refs/heads/master\", \"buildername\": \"win\", \"got_revision\": \"e861e5fef3809154a6d4863970716f62d98e2bcc\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"e861e5fef3809154a6d4863970716f62d98e2bcc\"}, \"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-yrvw\"], \"image\": [\"chrome-win10-1703-20042500-5e6af220c3f\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.emscripten-releases.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5088-a734129\"], \"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": "1589838556763815",
"status": "COMPLETED",
"status_changed_ts": "1589842642533536",
"tags": [
"builder:win",
"buildset:commit/git/e861e5fef3809154a6d4863970716f62d98e2bcc",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/e861e5fef3809154a6d4863970716f62d98e2bcc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9045365038419981568",
"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/8879934976097589696/+/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:4c42230927f8f310",
"user_agent:luci-scheduler"
],
"updated_ts": "1589842642549554",
"url": "https://ci.chromium.org/b/8879934976097589696",
"utcnow_ts": "1589842643381931"
}
}
[22:57:23.397] Invocation finished in 3h12m20.850175195s with status SUCCEEDED