[00:50:24.762] New invocation is queued and will start shortly
[00:50:28.814] Starting the invocation (attempt 1)
[00:50:28.872] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:50:28.873] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:50:28.874] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9029944341926702928",
"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\":\"5ef3a1e297e868af0b537f19927bba95dc20b575\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@5ef3a1e297e868af0b537f19927bba95dc20b575\",\"title\":\"5ef3a1e297e868af0b537f19927bba95dc20b575\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/5ef3a1e297e868af0b537f19927bba95dc20b575\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"5ef3a1e297e868af0b537f19927bba95dc20b575\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win",
"scheduler_invocation_id:9029944341926702928",
"scheduler_job_id:emscripten-releases/win",
"user_agent:luci-scheduler",
"buildset:commit/git/5ef3a1e297e868af0b537f19927bba95dc20b575",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/5ef3a1e297e868af0b537f19927bba95dc20b575",
"gitiles_ref:refs/heads/master"
]
}
[00:50:29.488] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1604537428968176",
"id": "8864514276840877424",
"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\": \"5ef3a1e297e868af0b537f19927bba95dc20b575\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@5ef3a1e297e868af0b537f19927bba95dc20b575\", \"title\": \"5ef3a1e297e868af0b537f19927bba95dc20b575\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/5ef3a1e297e868af0b537f19927bba95dc20b575\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"5ef3a1e297e868af0b537f19927bba95dc20b575\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604537429234265",
"tags": [
"builder:win",
"buildset:commit/git/5ef3a1e297e868af0b537f19927bba95dc20b575",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/5ef3a1e297e868af0b537f19927bba95dc20b575",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029944341926702928",
"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/8864514276840877424/+/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": "1604537429234376",
"url": "https://ci.chromium.org/b/8864514276840877424",
"utcnow_ts": "1604537429476917"
}
}
[00:50:29.488] Task URL: https://ci.chromium.org/b/8864514276840877424
[00:50:29.488] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:2:0) after 1m0s
[00:51:29.851] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:2:0)
[00:51:29.851] Timer tick, asking Buildbucket for the build status
[00:51:29.980] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:51:29.980] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:3:0) after 1m0s
[00:52:30.066] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:3:0)
[00:52:30.066] Timer tick, asking Buildbucket for the build status
[00:52:30.155] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:52:30.155] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:4:0) after 1m0s
[00:53:30.249] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:4:0)
[00:53:30.249] Timer tick, asking Buildbucket for the build status
[00:53:30.326] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:53:30.327] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:5:0) after 1m0s
[00:54:30.366] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:5:0)
[00:54:30.366] Timer tick, asking Buildbucket for the build status
[00:54:30.473] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:54:30.473] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:6:0) after 1m0s
[00:55:30.608] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:6:0)
[00:55:30.608] Timer tick, asking Buildbucket for the build status
[00:55:30.696] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:55:30.696] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:7:0) after 1m0s
[00:56:30.912] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:7:0)
[00:56:30.912] Timer tick, asking Buildbucket for the build status
[00:56:31.031] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:56:31.031] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:8:0) after 1m0s
[00:57:31.151] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:8:0)
[00:57:31.151] Timer tick, asking Buildbucket for the build status
[00:57:31.250] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:57:31.250] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:9:0) after 1m0s
[00:58:31.304] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:9:0)
[00:58:31.304] Timer tick, asking Buildbucket for the build status
[00:58:31.583] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:58:31.583] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:10:0) after 1m0s
[00:59:31.637] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:10:0)
[00:59:31.637] Timer tick, asking Buildbucket for the build status
[00:59:31.736] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:59:31.736] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:11:0) after 1m0s
[01:00:31.894] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:11:0)
[01:00:31.894] Timer tick, asking Buildbucket for the build status
[01:00:33.911] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:00:33.911] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:12:0) after 1m0s
[01:01:34.308] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:12:0)
[01:01:34.308] Timer tick, asking Buildbucket for the build status
[01:01:34.395] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:01:34.395] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:13:0) after 1m0s
[01:02:34.499] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:13:0)
[01:02:34.499] Timer tick, asking Buildbucket for the build status
[01:02:34.588] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:02:34.588] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:14:0) after 1m0s
[01:03:34.758] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:14:0)
[01:03:34.758] Timer tick, asking Buildbucket for the build status
[01:03:34.852] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:03:34.852] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:15:0) after 1m0s
[01:04:34.876] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:15:0)
[01:04:34.876] Timer tick, asking Buildbucket for the build status
[01:04:34.949] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:04:34.949] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:16:0) after 1m0s
[01:05:35.031] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:16:0)
[01:05:35.031] Timer tick, asking Buildbucket for the build status
[01:05:35.145] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:05:35.145] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:17:0) after 1m0s
[01:06:35.210] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:17:0)
[01:06:35.210] Timer tick, asking Buildbucket for the build status
[01:06:35.567] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:06:35.568] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:18:0) after 1m0s
[01:07:35.629] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:18:0)
[01:07:35.629] Timer tick, asking Buildbucket for the build status
[01:07:35.703] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:07:35.703] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:19:0) after 1m0s
[01:08:35.906] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:19:0)
[01:08:35.906] Timer tick, asking Buildbucket for the build status
[01:08:36.093] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:08:36.093] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:20:0) after 1m0s
[01:09:36.215] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:20:0)
[01:09:36.215] Timer tick, asking Buildbucket for the build status
[01:09:36.287] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:09:36.287] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:21:0) after 1m0s
[01:10:36.479] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:21:0)
[01:10:36.479] Timer tick, asking Buildbucket for the build status
[01:10:36.618] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:10:36.618] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:22:0) after 1m0s
[01:11:36.685] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:22:0)
[01:11:36.685] Timer tick, asking Buildbucket for the build status
[01:11:36.901] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:11:36.901] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:23:0) after 1m0s
[01:12:37.030] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:23:0)
[01:12:37.030] Timer tick, asking Buildbucket for the build status
[01:12:37.133] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:12:37.133] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:24:0) after 1m0s
[01:13:37.258] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:24:0)
[01:13:37.258] Timer tick, asking Buildbucket for the build status
[01:13:37.351] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:13:37.351] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:25:0) after 1m0s
[01:14:37.500] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:25:0)
[01:14:37.500] Timer tick, asking Buildbucket for the build status
[01:14:39.375] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:14:39.375] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:26:0) after 1m0s
[01:15:40.158] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:26:0)
[01:15:40.158] Timer tick, asking Buildbucket for the build status
[01:15:40.262] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:15:40.262] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:27:0) after 1m0s
[01:16:40.377] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:27:0)
[01:16:40.377] Timer tick, asking Buildbucket for the build status
[01:16:40.479] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:16:40.479] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:28:0) after 1m0s
[01:17:40.598] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:28:0)
[01:17:40.598] Timer tick, asking Buildbucket for the build status
[01:17:40.812] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:17:40.812] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:29:0) after 1m0s
[01:18:40.843] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:29:0)
[01:18:40.843] Timer tick, asking Buildbucket for the build status
[01:18:40.993] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:18:40.993] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:30:0) after 1m0s
[01:19:41.015] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:30:0)
[01:19:41.015] Timer tick, asking Buildbucket for the build status
[01:19:41.117] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:19:41.117] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:31:0) after 1m0s
[01:20:41.167] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:31:0)
[01:20:41.167] Timer tick, asking Buildbucket for the build status
[01:20:41.305] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:20:41.305] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:32:0) after 1m0s
[01:21:41.380] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:32:0)
[01:21:41.380] Timer tick, asking Buildbucket for the build status
[01:21:41.487] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:21:41.487] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:33:0) after 1m0s
[01:22:41.532] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:33:0)
[01:22:41.532] Timer tick, asking Buildbucket for the build status
[01:22:41.770] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:22:41.770] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:34:0) after 1m0s
[01:23:41.834] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:34:0)
[01:23:41.834] Timer tick, asking Buildbucket for the build status
[01:23:41.914] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:23:41.914] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:35:0) after 1m0s
[01:24:41.965] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:35:0)
[01:24:41.965] Timer tick, asking Buildbucket for the build status
[01:24:42.053] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:24:42.053] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:36:0) after 1m0s
[01:25:42.046] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:36:0)
[01:25:42.046] Timer tick, asking Buildbucket for the build status
[01:25:42.218] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:25:42.218] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:37:0) after 1m0s
[01:26:42.200] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:37:0)
[01:26:42.200] Timer tick, asking Buildbucket for the build status
[01:26:42.729] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:26:42.729] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:38:0) after 1m0s
[01:27:42.780] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:38:0)
[01:27:42.780] Timer tick, asking Buildbucket for the build status
[01:27:43.022] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:27:43.022] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:39:0) after 1m0s
[01:28:43.044] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:39:0)
[01:28:43.044] Timer tick, asking Buildbucket for the build status
[01:28:43.150] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:28:43.150] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:40:0) after 1m0s
[01:29:43.197] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:40:0)
[01:29:43.197] Timer tick, asking Buildbucket for the build status
[01:29:43.410] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:29:43.410] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:41:0) after 1m0s
[01:30:43.467] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:41:0)
[01:30:43.467] Timer tick, asking Buildbucket for the build status
[01:30:43.726] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:30:43.726] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:42:0) after 1m0s
[01:31:43.775] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:42:0)
[01:31:43.775] Timer tick, asking Buildbucket for the build status
[01:31:44.046] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:31:44.046] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:43:0) after 1m0s
[01:32:44.115] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:43:0)
[01:32:44.115] Timer tick, asking Buildbucket for the build status
[01:32:44.576] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:32:44.576] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:44:0) after 1m0s
[01:33:44.597] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:44:0)
[01:33:44.597] Timer tick, asking Buildbucket for the build status
[01:33:44.720] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:33:44.720] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:45:0) after 1m0s
[01:34:44.743] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:45:0)
[01:34:44.743] Timer tick, asking Buildbucket for the build status
[01:34:44.840] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:34:44.840] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:46:0) after 1m0s
[01:35:44.861] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:46:0)
[01:35:44.861] Timer tick, asking Buildbucket for the build status
[01:35:44.980] Build 8864514276840877424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:35:44.980] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:47:0) after 1m0s
[01:36:06.189] Received PubSub notification, asking Buildbucket for the build status
[01:36:06.278] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:44.984] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:47:0)
[01:36:44.984] Timer tick, asking Buildbucket for the build status
[01:36:45.192] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:45.192] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:49:0) after 1m0s
[01:37:45.225] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:49:0)
[01:37:45.225] Timer tick, asking Buildbucket for the build status
[01:37:45.347] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:45.347] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:50:0) after 1m0s
[01:38:45.384] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:50:0)
[01:38:45.384] Timer tick, asking Buildbucket for the build status
[01:38:46.147] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:46.147] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:51:0) after 1m0s
[01:39:46.213] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:51:0)
[01:39:46.213] Timer tick, asking Buildbucket for the build status
[01:39:46.430] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:46.430] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:52:0) after 1m0s
[01:40:46.447] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:52:0)
[01:40:46.448] Timer tick, asking Buildbucket for the build status
[01:40:46.573] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:46.573] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:53:0) after 1m0s
[01:41:46.617] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:53:0)
[01:41:46.617] Timer tick, asking Buildbucket for the build status
[01:41:46.921] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:46.921] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:54:0) after 1m0s
[01:42:47.018] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:54:0)
[01:42:47.018] Timer tick, asking Buildbucket for the build status
[01:42:47.352] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:47.352] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:55:0) after 1m0s
[01:43:47.426] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:55:0)
[01:43:47.427] Timer tick, asking Buildbucket for the build status
[01:43:47.569] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:47.569] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:56:0) after 1m0s
[01:44:47.593] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:56:0)
[01:44:47.593] Timer tick, asking Buildbucket for the build status
[01:44:47.738] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:47.738] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:57:0) after 1m0s
[01:45:47.764] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:57:0)
[01:45:47.764] Timer tick, asking Buildbucket for the build status
[01:45:47.878] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:47.878] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:58:0) after 1m0s
[01:46:47.897] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:58:0)
[01:46:47.898] Timer tick, asking Buildbucket for the build status
[01:46:47.984] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:47.984] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:59:0) after 1m0s
[01:47:48.006] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:59:0)
[01:47:48.006] Timer tick, asking Buildbucket for the build status
[01:47:48.083] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:48.083] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:60:0) after 1m0s
[01:48:48.135] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:60:0)
[01:48:48.135] Timer tick, asking Buildbucket for the build status
[01:48:49.206] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:49.206] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:61:0) after 1m0s
[01:49:49.228] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:61:0)
[01:49:49.228] Timer tick, asking Buildbucket for the build status
[01:49:49.430] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:49.430] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:62:0) after 1m0s
[01:50:49.527] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:62:0)
[01:50:49.527] Timer tick, asking Buildbucket for the build status
[01:50:49.963] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:49.963] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:63:0) after 1m0s
[01:51:49.996] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:63:0)
[01:51:49.996] Timer tick, asking Buildbucket for the build status
[01:51:50.277] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:50.277] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:64:0) after 1m0s
[01:52:50.312] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:64:0)
[01:52:50.312] Timer tick, asking Buildbucket for the build status
[01:52:50.385] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:50.385] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:65:0) after 1m0s
[01:53:50.470] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:65:0)
[01:53:50.470] Timer tick, asking Buildbucket for the build status
[01:53:50.567] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:50.567] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:66:0) after 1m0s
[01:54:50.588] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:66:0)
[01:54:50.589] Timer tick, asking Buildbucket for the build status
[01:54:50.656] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:50.656] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:67:0) after 1m0s
[01:55:50.696] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:67:0)
[01:55:50.696] Timer tick, asking Buildbucket for the build status
[01:55:50.887] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:50.887] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:68:0) after 1m0s
[01:56:50.923] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:68:0)
[01:56:50.923] Timer tick, asking Buildbucket for the build status
[01:56:51.022] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:51.022] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:69:0) after 1m0s
[01:57:51.078] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:69:0)
[01:57:51.078] Timer tick, asking Buildbucket for the build status
[01:57:51.373] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:51.373] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:70:0) after 1m0s
[01:58:51.371] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:70:0)
[01:58:51.371] Timer tick, asking Buildbucket for the build status
[01:58:51.454] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:51.454] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:71:0) after 1m0s
[01:59:51.475] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:71:0)
[01:59:51.475] Timer tick, asking Buildbucket for the build status
[01:59:51.540] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:51.540] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:72:0) after 1m0s
[02:00:51.616] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:72:0)
[02:00:51.616] Timer tick, asking Buildbucket for the build status
[02:00:51.729] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:51.729] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:73:0) after 1m0s
[02:01:51.793] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:73:0)
[02:01:51.793] Timer tick, asking Buildbucket for the build status
[02:01:52.114] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:52.114] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:74:0) after 1m0s
[02:02:52.147] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:74:0)
[02:02:52.147] Timer tick, asking Buildbucket for the build status
[02:02:52.223] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:52.223] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:75:0) after 1m0s
[02:03:52.293] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:75:0)
[02:03:52.293] Timer tick, asking Buildbucket for the build status
[02:03:52.357] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:52.357] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:76:0) after 1m0s
[02:04:52.401] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:76:0)
[02:04:52.401] Timer tick, asking Buildbucket for the build status
[02:04:52.499] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:52.499] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:77:0) after 1m0s
[02:05:52.563] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:77:0)
[02:05:52.563] Timer tick, asking Buildbucket for the build status
[02:05:52.665] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:52.665] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:78:0) after 1m0s
[02:06:52.690] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:78:0)
[02:06:52.690] Timer tick, asking Buildbucket for the build status
[02:06:52.787] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:52.787] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:79:0) after 1m0s
[02:07:52.829] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:79:0)
[02:07:52.829] Timer tick, asking Buildbucket for the build status
[02:07:52.973] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:52.973] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:80:0) after 1m0s
[02:08:52.999] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:80:0)
[02:08:52.999] Timer tick, asking Buildbucket for the build status
[02:08:53.088] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:53.088] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:81:0) after 1m0s
[02:09:53.156] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:81:0)
[02:09:53.156] Timer tick, asking Buildbucket for the build status
[02:09:53.224] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:53.224] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:82:0) after 1m0s
[02:10:53.279] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:82:0)
[02:10:53.279] Timer tick, asking Buildbucket for the build status
[02:10:53.383] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:53.383] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:83:0) after 1m0s
[02:11:53.439] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:83:0)
[02:11:53.439] Timer tick, asking Buildbucket for the build status
[02:11:53.500] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:53.500] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:84:0) after 1m0s
[02:12:53.580] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:84:0)
[02:12:53.580] Timer tick, asking Buildbucket for the build status
[02:12:53.654] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:53.654] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:85:0) after 1m0s
[02:13:53.728] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:85:0)
[02:13:53.728] Timer tick, asking Buildbucket for the build status
[02:13:53.801] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:53.801] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:86:0) after 1m0s
[02:14:53.954] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:86:0)
[02:14:53.954] Timer tick, asking Buildbucket for the build status
[02:14:54.018] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:54.018] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:87:0) after 1m0s
[02:15:54.124] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:87:0)
[02:15:54.124] Timer tick, asking Buildbucket for the build status
[02:15:54.383] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:54.383] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:88:0) after 1m0s
[02:16:54.470] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:88:0)
[02:16:54.471] Timer tick, asking Buildbucket for the build status
[02:16:54.549] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:54.549] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:89:0) after 1m0s
[02:17:54.591] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:89:0)
[02:17:54.591] Timer tick, asking Buildbucket for the build status
[02:17:54.769] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:54.769] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:90:0) after 1m0s
[02:18:54.875] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:90:0)
[02:18:54.875] Timer tick, asking Buildbucket for the build status
[02:18:54.999] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:54.999] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:91:0) after 1m0s
[02:19:55.346] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:91:0)
[02:19:55.346] Timer tick, asking Buildbucket for the build status
[02:19:55.418] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:55.418] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:92:0) after 1m0s
[02:20:55.666] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:92:0)
[02:20:55.666] Timer tick, asking Buildbucket for the build status
[02:20:55.858] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:55.858] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:93:0) after 1m0s
[02:21:55.997] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:93:0)
[02:21:55.997] Timer tick, asking Buildbucket for the build status
[02:21:56.495] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:56.495] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:94:0) after 1m0s
[02:22:56.594] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:94:0)
[02:22:56.594] Timer tick, asking Buildbucket for the build status
[02:22:56.726] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:56.726] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:95:0) after 1m0s
[02:23:56.788] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:95:0)
[02:23:56.788] Timer tick, asking Buildbucket for the build status
[02:23:56.909] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:56.909] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:96:0) after 1m0s
[02:24:57.066] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:96:0)
[02:24:57.066] Timer tick, asking Buildbucket for the build status
[02:24:57.154] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:57.154] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:97:0) after 1m0s
[02:25:57.196] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:97:0)
[02:25:57.196] Timer tick, asking Buildbucket for the build status
[02:25:57.285] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:57.285] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:98:0) after 1m0s
[02:26:57.392] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:98:0)
[02:26:57.392] Timer tick, asking Buildbucket for the build status
[02:26:57.608] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:57.608] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:99:0) after 1m0s
[02:27:57.667] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:99:0)
[02:27:57.667] Timer tick, asking Buildbucket for the build status
[02:27:58.035] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:58.035] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:100:0) after 1m0s
[02:28:58.079] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:100:0)
[02:28:58.079] Timer tick, asking Buildbucket for the build status
[02:28:58.157] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:58.157] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:101:0) after 1m0s
[02:29:58.231] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:101:0)
[02:29:58.231] Timer tick, asking Buildbucket for the build status
[02:29:58.371] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:58.371] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:102:0) after 1m0s
[02:30:58.441] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:102:0)
[02:30:58.441] Timer tick, asking Buildbucket for the build status
[02:30:58.591] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:58.591] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:103:0) after 1m0s
[02:31:58.636] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:103:0)
[02:31:58.636] Timer tick, asking Buildbucket for the build status
[02:31:58.707] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:58.707] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:104:0) after 1m0s
[02:32:58.728] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:104:0)
[02:32:58.728] Timer tick, asking Buildbucket for the build status
[02:32:58.808] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:58.808] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:105:0) after 1m0s
[02:33:58.874] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:105:0)
[02:33:58.874] Timer tick, asking Buildbucket for the build status
[02:33:59.109] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:59.109] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:106:0) after 1m0s
[02:34:59.092] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:106:0)
[02:34:59.092] Timer tick, asking Buildbucket for the build status
[02:34:59.177] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:59.177] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:107:0) after 1m0s
[02:35:59.258] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:107:0)
[02:35:59.258] Timer tick, asking Buildbucket for the build status
[02:35:59.435] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:59.435] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:108:0) after 1m0s
[02:36:59.456] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:108:0)
[02:36:59.456] Timer tick, asking Buildbucket for the build status
[02:36:59.632] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:59.632] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:109:0) after 1m0s
[02:37:59.686] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:109:0)
[02:37:59.686] Timer tick, asking Buildbucket for the build status
[02:37:59.766] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:59.766] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:110:0) after 1m0s
[02:39:00.645] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:110:0)
[02:39:00.645] Timer tick, asking Buildbucket for the build status
[02:39:00.935] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:00.935] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:111:0) after 1m0s
[02:40:01.448] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:111:0)
[02:40:01.448] Timer tick, asking Buildbucket for the build status
[02:40:01.513] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:01.513] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:112:0) after 1m0s
[02:41:01.586] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:112:0)
[02:41:01.586] Timer tick, asking Buildbucket for the build status
[02:41:01.703] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:01.703] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:113:0) after 1m0s
[02:42:01.857] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:113:0)
[02:42:01.857] Timer tick, asking Buildbucket for the build status
[02:42:01.939] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:01.939] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:114:0) after 1m0s
[02:43:01.999] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:114:0)
[02:43:01.999] Timer tick, asking Buildbucket for the build status
[02:43:02.067] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:02.067] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:115:0) after 1m0s
[02:44:02.117] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:115:0)
[02:44:02.117] Timer tick, asking Buildbucket for the build status
[02:44:02.207] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:02.207] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:116:0) after 1m0s
[02:45:02.255] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:116:0)
[02:45:02.255] Timer tick, asking Buildbucket for the build status
[02:45:02.320] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:02.320] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:117:0) after 1m0s
[02:46:02.384] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:117:0)
[02:46:02.384] Timer tick, asking Buildbucket for the build status
[02:46:02.554] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:02.554] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:118:0) after 1m0s
[02:47:02.791] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:118:0)
[02:47:02.791] Timer tick, asking Buildbucket for the build status
[02:47:03.139] Build 8864514276840877424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:03.139] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9029944341926702928:119:0) after 1m0s
[02:47:38.937] Received PubSub notification, asking Buildbucket for the build status
[02:47:39.017] Build 8864514276840877424: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:47:39.018] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"completed_ts": "1604544458025967",
"created_by": "project:emscripten-releases",
"created_ts": "1604537428968176",
"id": "8864514276840877424",
"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\": \"5ef3a1e297e868af0b537f19927bba95dc20b575\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@5ef3a1e297e868af0b537f19927bba95dc20b575\", \"title\": \"5ef3a1e297e868af0b537f19927bba95dc20b575\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/5ef3a1e297e868af0b537f19927bba95dc20b575\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"5ef3a1e297e868af0b537f19927bba95dc20b575\"}}",
"project": "emscripten-releases",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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\": \"5ef3a1e297e868af0b537f19927bba95dc20b575\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@5ef3a1e297e868af0b537f19927bba95dc20b575\", \"title\": \"5ef3a1e297e868af0b537f19927bba95dc20b575\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/5ef3a1e297e868af0b537f19927bba95dc20b575\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-win10-0-dzb1\", \"branch\": \"refs/heads/master\", \"buildername\": \"win\", \"got_revision\": \"5ef3a1e297e868af0b537f19927bba95dc20b575\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"5ef3a1e297e868af0b537f19927bba95dc20b575\"}, \"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-dzb1\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"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\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604540165639772",
"status": "COMPLETED",
"status_changed_ts": "1604544458456646",
"tags": [
"builder:win",
"buildset:commit/git/5ef3a1e297e868af0b537f19927bba95dc20b575",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/5ef3a1e297e868af0b537f19927bba95dc20b575",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029944341926702928",
"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/8864514276840877424/+/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:4faeb3b7ec674c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1604544458467977",
"url": "https://ci.chromium.org/b/8864514276840877424",
"utcnow_ts": "1604544458999964"
}
}
[02:47:39.018] Invocation finished in 1h57m14.284009176s with status SUCCEEDED