[05:29:39.017] New invocation is queued and will start shortly
[05:29:40.727] Starting the invocation (attempt 1)
[05:29:40.923] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:29:40.923] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:29:40.923] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9052213627539041040",
"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\":\"55ff86e2549ef94331de8ab625a5d8d7fc48ef33\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@55ff86e2549ef94331de8ab625a5d8d7fc48ef33\",\"title\":\"55ff86e2549ef94331de8ab625a5d8d7fc48ef33\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/55ff86e2549ef94331de8ab625a5d8d7fc48ef33\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"55ff86e2549ef94331de8ab625a5d8d7fc48ef33\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win",
"scheduler_invocation_id:9052213627539041040",
"scheduler_job_id:emscripten-releases/win",
"user_agent:luci-scheduler",
"buildset:commit/git/55ff86e2549ef94331de8ab625a5d8d7fc48ef33",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/55ff86e2549ef94331de8ab625a5d8d7fc48ef33",
"gitiles_ref:refs/heads/master"
]
}
[05:29:41.960] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1583299781201810",
"id": "8886783564586127136",
"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\": \"55ff86e2549ef94331de8ab625a5d8d7fc48ef33\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@55ff86e2549ef94331de8ab625a5d8d7fc48ef33\", \"title\": \"55ff86e2549ef94331de8ab625a5d8d7fc48ef33\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/55ff86e2549ef94331de8ab625a5d8d7fc48ef33\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"55ff86e2549ef94331de8ab625a5d8d7fc48ef33\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1583299781484880",
"tags": [
"builder:win",
"buildset:commit/git/55ff86e2549ef94331de8ab625a5d8d7fc48ef33",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/55ff86e2549ef94331de8ab625a5d8d7fc48ef33",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052213627539041040",
"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/8886783564586127136/+/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": "1583299781485030",
"url": "https://ci.chromium.org/b/8886783564586127136",
"utcnow_ts": "1583299781934980"
}
}
[05:29:41.960] Task URL: https://ci.chromium.org/b/8886783564586127136
[05:29:41.960] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:2:0) after 1m0s
[05:30:41.996] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:2:0)
[05:30:41.996] Timer tick, asking Buildbucket for the build status
[05:30:42.363] Build 8886783564586127136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:30:42.363] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:3:0) after 1m0s
[05:31:42.392] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:3:0)
[05:31:42.392] Timer tick, asking Buildbucket for the build status
[05:31:42.598] Build 8886783564586127136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:31:42.598] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:4:0) after 1m0s
[05:32:42.620] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:4:0)
[05:32:42.620] Timer tick, asking Buildbucket for the build status
[05:32:42.723] Build 8886783564586127136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:32:42.723] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:5:0) after 1m0s
[05:33:42.813] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:5:0)
[05:33:42.813] Timer tick, asking Buildbucket for the build status
[05:33:43.643] Build 8886783564586127136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:33:43.643] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:6:0) after 1m0s
[05:34:43.694] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:6:0)
[05:34:43.694] Timer tick, asking Buildbucket for the build status
[05:34:43.808] Build 8886783564586127136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:34:43.808] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:7:0) after 1m0s
[05:35:43.939] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:7:0)
[05:35:43.940] Timer tick, asking Buildbucket for the build status
[05:35:44.219] Build 8886783564586127136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:35:44.219] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:8:0) after 1m0s
[05:36:44.389] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:8:0)
[05:36:44.389] Timer tick, asking Buildbucket for the build status
[05:36:44.843] Build 8886783564586127136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:36:44.843] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:9:0) after 1m0s
[05:37:44.864] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:9:0)
[05:37:44.864] Timer tick, asking Buildbucket for the build status
[05:37:47.315] Build 8886783564586127136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:37:47.315] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:10:0) after 1m0s
[05:38:47.352] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:10:0)
[05:38:47.352] Timer tick, asking Buildbucket for the build status
[05:38:47.489] Build 8886783564586127136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:38:47.489] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:11:0) after 1m0s
[05:39:47.516] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:11:0)
[05:39:47.516] Timer tick, asking Buildbucket for the build status
[05:39:47.668] Build 8886783564586127136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:39:47.668] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:12:0) after 1m0s
[05:40:47.777] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:12:0)
[05:40:47.777] Timer tick, asking Buildbucket for the build status
[05:40:47.900] Build 8886783564586127136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:40:47.901] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:13:0) after 1m0s
[05:41:48.068] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:13:0)
[05:41:48.068] Timer tick, asking Buildbucket for the build status
[05:41:48.217] Build 8886783564586127136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:41:48.217] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:14:0) after 1m0s
[05:42:48.263] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:14:0)
[05:42:48.263] Timer tick, asking Buildbucket for the build status
[05:42:48.375] Build 8886783564586127136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:42:48.376] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:15:0) after 1m0s
[05:43:48.450] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:15:0)
[05:43:48.450] Timer tick, asking Buildbucket for the build status
[05:43:48.639] Build 8886783564586127136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:43:48.639] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:16:0) after 1m0s
[05:44:48.748] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:16:0)
[05:44:48.748] Timer tick, asking Buildbucket for the build status
[05:44:48.966] Build 8886783564586127136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:44:48.966] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:17:0) after 1m0s
[05:45:49.022] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:17:0)
[05:45:49.022] Timer tick, asking Buildbucket for the build status
[05:45:49.228] Build 8886783564586127136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:45:49.228] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:18:0) after 1m0s
[05:46:49.416] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:18:0)
[05:46:49.416] Timer tick, asking Buildbucket for the build status
[05:46:49.527] Build 8886783564586127136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:46:49.527] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:19:0) after 1m0s
[05:47:49.648] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:19:0)
[05:47:49.648] Timer tick, asking Buildbucket for the build status
[05:47:49.752] Build 8886783564586127136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:47:49.752] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:20:0) after 1m0s
[05:48:49.816] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:20:0)
[05:48:49.816] Timer tick, asking Buildbucket for the build status
[05:48:50.065] Build 8886783564586127136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:48:50.065] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:21:0) after 1m0s
[05:49:50.100] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:21:0)
[05:49:50.100] Timer tick, asking Buildbucket for the build status
[05:49:50.312] Build 8886783564586127136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:49:50.312] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:22:0) after 1m0s
[05:50:50.353] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:22:0)
[05:50:50.353] Timer tick, asking Buildbucket for the build status
[05:50:50.487] Build 8886783564586127136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:50:50.487] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:23:0) after 1m0s
[05:51:50.645] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:23:0)
[05:51:50.645] Timer tick, asking Buildbucket for the build status
[05:51:50.799] Build 8886783564586127136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:51:50.799] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:24:0) after 1m0s
[05:52:50.800] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:24:0)
[05:52:50.800] Timer tick, asking Buildbucket for the build status
[05:52:50.905] Build 8886783564586127136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:52:50.905] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:25:0) after 1m0s
[05:53:50.988] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:25:0)
[05:53:50.988] Timer tick, asking Buildbucket for the build status
[05:53:52.168] Build 8886783564586127136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:53:52.168] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:26:0) after 1m0s
[05:54:52.441] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:26:0)
[05:54:52.441] Timer tick, asking Buildbucket for the build status
[05:54:52.537] Build 8886783564586127136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:54:52.537] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:27:0) after 1m0s
[05:55:52.625] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:27:0)
[05:55:52.625] Timer tick, asking Buildbucket for the build status
[05:55:52.859] Build 8886783564586127136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:55:52.859] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:28:0) after 1m0s
[05:56:52.932] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:28:0)
[05:56:52.932] Timer tick, asking Buildbucket for the build status
[05:56:53.052] Build 8886783564586127136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:56:53.052] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:29:0) after 1m0s
[05:57:53.152] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:29:0)
[05:57:53.152] Timer tick, asking Buildbucket for the build status
[05:57:53.472] Build 8886783564586127136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:57:53.472] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:30:0) after 1m0s
[05:58:53.477] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:30:0)
[05:58:53.477] Timer tick, asking Buildbucket for the build status
[05:58:53.590] Build 8886783564586127136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:58:53.590] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:31:0) after 1m0s
[05:59:53.682] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:31:0)
[05:59:53.682] Timer tick, asking Buildbucket for the build status
[05:59:53.793] Build 8886783564586127136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:59:53.793] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:32:0) after 1m0s
[06:00:53.793] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:32:0)
[06:00:53.793] Timer tick, asking Buildbucket for the build status
[06:00:54.059] Build 8886783564586127136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:00:54.059] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:33:0) after 1m0s
[06:01:54.068] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:33:0)
[06:01:54.068] Timer tick, asking Buildbucket for the build status
[06:01:54.283] Build 8886783564586127136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:01:54.283] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:34:0) after 1m0s
[06:02:54.371] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:34:0)
[06:02:54.371] Timer tick, asking Buildbucket for the build status
[06:02:54.842] Build 8886783564586127136: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:02:54.842] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:35:0) after 1m0s
[06:03:53.244] Received PubSub notification, asking Buildbucket for the build status
[06:03:53.331] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:55.004] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:35:0)
[06:03:55.004] Timer tick, asking Buildbucket for the build status
[06:03:55.081] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:55.081] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:37:0) after 1m0s
[06:04:55.169] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:37:0)
[06:04:55.169] Timer tick, asking Buildbucket for the build status
[06:04:55.292] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:55.292] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:38:0) after 1m0s
[06:05:55.312] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:38:0)
[06:05:55.312] Timer tick, asking Buildbucket for the build status
[06:05:55.425] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:55.425] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:39:0) after 1m0s
[06:06:55.414] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:39:0)
[06:06:55.414] Timer tick, asking Buildbucket for the build status
[06:06:55.662] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:55.662] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:40:0) after 1m0s
[06:07:55.691] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:40:0)
[06:07:55.691] Timer tick, asking Buildbucket for the build status
[06:07:55.793] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:55.793] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:41:0) after 1m0s
[06:08:55.819] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:41:0)
[06:08:55.819] Timer tick, asking Buildbucket for the build status
[06:08:55.962] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:55.962] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:42:0) after 1m0s
[06:09:55.993] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:42:0)
[06:09:55.993] Timer tick, asking Buildbucket for the build status
[06:09:56.184] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:56.185] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:43:0) after 1m0s
[06:10:56.206] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:43:0)
[06:10:56.206] Timer tick, asking Buildbucket for the build status
[06:10:56.312] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:56.312] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:44:0) after 1m0s
[06:11:56.414] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:44:0)
[06:11:56.414] Timer tick, asking Buildbucket for the build status
[06:11:56.559] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:56.559] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:45:0) after 1m0s
[06:12:56.594] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:45:0)
[06:12:56.594] Timer tick, asking Buildbucket for the build status
[06:12:56.701] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:56.701] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:46:0) after 1m0s
[06:13:56.719] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:46:0)
[06:13:56.719] Timer tick, asking Buildbucket for the build status
[06:13:56.857] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:56.857] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:47:0) after 1m0s
[06:14:56.933] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:47:0)
[06:14:56.934] Timer tick, asking Buildbucket for the build status
[06:14:57.129] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:57.129] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:48:0) after 1m0s
[06:15:57.186] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:48:0)
[06:15:57.186] Timer tick, asking Buildbucket for the build status
[06:15:57.386] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:57.386] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:49:0) after 1m0s
[06:16:57.571] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:49:0)
[06:16:57.571] Timer tick, asking Buildbucket for the build status
[06:16:57.952] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:57.952] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:50:0) after 1m0s
[06:17:58.007] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:50:0)
[06:17:58.007] Timer tick, asking Buildbucket for the build status
[06:17:58.537] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:58.537] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:51:0) after 1m0s
[06:18:58.566] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:51:0)
[06:18:58.566] Timer tick, asking Buildbucket for the build status
[06:18:58.727] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:58.727] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:52:0) after 1m0s
[06:19:58.793] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:52:0)
[06:19:58.793] Timer tick, asking Buildbucket for the build status
[06:19:58.977] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:58.977] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:53:0) after 1m0s
[06:20:59.106] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:53:0)
[06:20:59.106] Timer tick, asking Buildbucket for the build status
[06:20:59.205] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:59.205] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:54:0) after 1m0s
[06:21:59.361] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:54:0)
[06:21:59.361] Timer tick, asking Buildbucket for the build status
[06:21:59.497] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:59.497] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:55:0) after 1m0s
[06:22:59.624] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:55:0)
[06:22:59.624] Timer tick, asking Buildbucket for the build status
[06:22:59.799] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:59.799] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:56:0) after 1m0s
[06:23:59.886] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:56:0)
[06:23:59.886] Timer tick, asking Buildbucket for the build status
[06:24:00.136] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:00.136] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:57:0) after 1m0s
[06:25:00.246] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:57:0)
[06:25:00.246] Timer tick, asking Buildbucket for the build status
[06:25:00.390] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:00.390] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:58:0) after 1m0s
[06:26:00.457] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:58:0)
[06:26:00.457] Timer tick, asking Buildbucket for the build status
[06:26:00.663] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:00.663] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:59:0) after 1m0s
[06:27:00.684] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:59:0)
[06:27:00.684] Timer tick, asking Buildbucket for the build status
[06:27:00.984] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:00.984] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:60:0) after 1m0s
[06:28:00.965] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:60:0)
[06:28:00.965] Timer tick, asking Buildbucket for the build status
[06:28:01.195] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:01.195] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:61:0) after 1m0s
[06:29:01.289] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:61:0)
[06:29:01.289] Timer tick, asking Buildbucket for the build status
[06:29:01.518] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:01.518] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:62:0) after 1m0s
[06:30:01.568] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:62:0)
[06:30:01.568] Timer tick, asking Buildbucket for the build status
[06:30:02.475] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:02.475] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:63:0) after 1m0s
[06:31:02.591] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:63:0)
[06:31:02.591] Timer tick, asking Buildbucket for the build status
[06:31:02.912] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:02.912] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:64:0) after 1m0s
[06:32:02.945] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:64:0)
[06:32:02.945] Timer tick, asking Buildbucket for the build status
[06:32:03.186] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:03.186] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:65:0) after 1m0s
[06:33:03.335] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:65:0)
[06:33:03.335] Timer tick, asking Buildbucket for the build status
[06:33:03.659] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:03.659] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:66:0) after 1m0s
[06:34:03.714] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:66:0)
[06:34:03.714] Timer tick, asking Buildbucket for the build status
[06:34:03.957] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:03.957] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:67:0) after 1m0s
[06:35:03.959] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:67:0)
[06:35:03.959] Timer tick, asking Buildbucket for the build status
[06:35:04.082] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:04.082] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:68:0) after 1m0s
[06:36:04.165] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:68:0)
[06:36:04.165] Timer tick, asking Buildbucket for the build status
[06:36:04.288] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:04.288] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:69:0) after 1m0s
[06:37:04.332] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:69:0)
[06:37:04.332] Timer tick, asking Buildbucket for the build status
[06:37:04.527] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:04.527] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:70:0) after 1m0s
[06:38:04.550] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:70:0)
[06:38:04.550] Timer tick, asking Buildbucket for the build status
[06:38:04.858] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:04.858] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:71:0) after 1m0s
[06:39:04.876] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:71:0)
[06:39:04.876] Timer tick, asking Buildbucket for the build status
[06:39:05.257] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:05.257] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:72:0) after 1m0s
[06:40:05.432] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:72:0)
[06:40:05.432] Timer tick, asking Buildbucket for the build status
[06:40:05.665] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:05.665] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:73:0) after 1m0s
[06:41:05.681] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:73:0)
[06:41:05.681] Timer tick, asking Buildbucket for the build status
[06:41:05.815] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:05.815] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:74:0) after 1m0s
[06:42:05.827] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:74:0)
[06:42:05.827] Timer tick, asking Buildbucket for the build status
[06:42:06.022] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:06.022] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:75:0) after 1m0s
[06:43:06.119] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:75:0)
[06:43:06.119] Timer tick, asking Buildbucket for the build status
[06:43:06.235] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:06.235] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:76:0) after 1m0s
[06:44:06.364] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:76:0)
[06:44:06.364] Timer tick, asking Buildbucket for the build status
[06:44:06.480] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:06.480] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:77:0) after 1m0s
[06:45:06.545] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:77:0)
[06:45:06.545] Timer tick, asking Buildbucket for the build status
[06:45:08.801] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:08.801] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:78:0) after 1m0s
[06:46:08.825] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:78:0)
[06:46:08.825] Timer tick, asking Buildbucket for the build status
[06:46:08.947] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:08.947] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:79:0) after 1m0s
[06:47:09.105] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:79:0)
[06:47:09.105] Timer tick, asking Buildbucket for the build status
[06:47:09.202] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:09.202] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:80:0) after 1m0s
[06:48:09.290] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:80:0)
[06:48:09.290] Timer tick, asking Buildbucket for the build status
[06:48:09.409] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:09.409] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:81:0) after 1m0s
[06:49:09.744] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:81:0)
[06:49:09.744] Timer tick, asking Buildbucket for the build status
[06:49:09.880] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:09.880] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:82:0) after 1m0s
[06:50:10.117] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:82:0)
[06:50:10.117] Timer tick, asking Buildbucket for the build status
[06:50:10.503] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:10.503] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:83:0) after 1m0s
[06:51:10.745] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:83:0)
[06:51:10.745] Timer tick, asking Buildbucket for the build status
[06:51:10.936] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:10.936] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:84:0) after 1m0s
[06:52:10.964] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:84:0)
[06:52:10.964] Timer tick, asking Buildbucket for the build status
[06:52:11.101] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:11.101] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:85:0) after 1m0s
[06:53:11.203] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:85:0)
[06:53:11.203] Timer tick, asking Buildbucket for the build status
[06:53:11.368] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:11.368] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:86:0) after 1m0s
[06:54:11.509] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:86:0)
[06:54:11.509] Timer tick, asking Buildbucket for the build status
[06:54:11.626] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:11.626] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:87:0) after 1m0s
[06:55:11.755] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:87:0)
[06:55:11.755] Timer tick, asking Buildbucket for the build status
[06:55:11.849] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:11.849] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:88:0) after 1m0s
[06:56:12.105] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:88:0)
[06:56:12.105] Timer tick, asking Buildbucket for the build status
[06:56:14.114] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:14.114] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:89:0) after 1m0s
[06:57:14.187] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:89:0)
[06:57:14.187] Timer tick, asking Buildbucket for the build status
[06:57:14.322] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:14.322] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:90:0) after 1m0s
[06:58:14.427] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:90:0)
[06:58:14.427] Timer tick, asking Buildbucket for the build status
[06:58:14.635] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:14.635] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:91:0) after 1m0s
[06:59:14.791] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:91:0)
[06:59:14.791] Timer tick, asking Buildbucket for the build status
[06:59:14.977] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:14.977] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:92:0) after 1m0s
[07:00:15.031] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:92:0)
[07:00:15.031] Timer tick, asking Buildbucket for the build status
[07:00:15.209] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:15.209] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:93:0) after 1m0s
[07:01:15.882] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:93:0)
[07:01:15.882] Timer tick, asking Buildbucket for the build status
[07:01:16.195] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:16.195] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:94:0) after 1m0s
[07:02:16.290] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:94:0)
[07:02:16.290] Timer tick, asking Buildbucket for the build status
[07:02:16.397] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:16.397] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:95:0) after 1m0s
[07:03:16.468] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:95:0)
[07:03:16.469] Timer tick, asking Buildbucket for the build status
[07:03:16.576] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:16.576] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:96:0) after 1m0s
[07:04:16.597] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:96:0)
[07:04:16.597] Timer tick, asking Buildbucket for the build status
[07:04:16.678] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:16.678] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:97:0) after 1m0s
[07:05:16.709] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:97:0)
[07:05:16.709] Timer tick, asking Buildbucket for the build status
[07:05:16.814] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:16.814] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:98:0) after 1m0s
[07:06:16.886] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:98:0)
[07:06:16.886] Timer tick, asking Buildbucket for the build status
[07:06:17.046] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:17.046] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:99:0) after 1m0s
[07:07:17.135] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:99:0)
[07:07:17.135] Timer tick, asking Buildbucket for the build status
[07:07:17.490] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:17.490] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:100:0) after 1m0s
[07:08:17.546] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:100:0)
[07:08:17.546] Timer tick, asking Buildbucket for the build status
[07:08:18.011] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:18.011] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:101:0) after 1m0s
[07:09:18.039] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:101:0)
[07:09:18.039] Timer tick, asking Buildbucket for the build status
[07:09:18.203] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:18.203] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:102:0) after 1m0s
[07:10:18.230] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:102:0)
[07:10:18.230] Timer tick, asking Buildbucket for the build status
[07:10:18.459] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:18.459] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:103:0) after 1m0s
[07:11:18.488] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:103:0)
[07:11:18.488] Timer tick, asking Buildbucket for the build status
[07:11:18.596] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:18.596] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:104:0) after 1m0s
[07:12:18.684] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:104:0)
[07:12:18.684] Timer tick, asking Buildbucket for the build status
[07:12:18.798] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:18.798] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:105:0) after 1m0s
[07:13:18.901] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:105:0)
[07:13:18.901] Timer tick, asking Buildbucket for the build status
[07:13:19.194] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:19.194] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:106:0) after 1m0s
[07:14:19.219] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:106:0)
[07:14:19.219] Timer tick, asking Buildbucket for the build status
[07:14:19.460] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:19.460] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:107:0) after 1m0s
[07:15:19.482] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:107:0)
[07:15:19.482] Timer tick, asking Buildbucket for the build status
[07:15:19.745] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:19.745] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:108:0) after 1m0s
[07:16:19.780] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:108:0)
[07:16:19.780] Timer tick, asking Buildbucket for the build status
[07:16:20.073] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:20.073] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:109:0) after 1m0s
[07:17:20.217] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:109:0)
[07:17:20.217] Timer tick, asking Buildbucket for the build status
[07:17:20.565] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:20.565] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:110:0) after 1m0s
[07:18:20.567] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:110:0)
[07:18:20.567] Timer tick, asking Buildbucket for the build status
[07:18:20.848] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:20.848] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:111:0) after 1m0s
[07:19:20.997] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:111:0)
[07:19:20.997] Timer tick, asking Buildbucket for the build status
[07:19:21.267] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:21.267] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:112:0) after 1m0s
[07:20:21.293] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:112:0)
[07:20:21.293] Timer tick, asking Buildbucket for the build status
[07:20:21.426] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:21.426] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:113:0) after 1m0s
[07:21:21.507] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:113:0)
[07:21:21.507] Timer tick, asking Buildbucket for the build status
[07:21:21.646] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:21.646] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:114:0) after 1m0s
[07:22:21.668] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:114:0)
[07:22:21.668] Timer tick, asking Buildbucket for the build status
[07:22:21.855] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:21.855] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:115:0) after 1m0s
[07:23:21.911] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:115:0)
[07:23:21.911] Timer tick, asking Buildbucket for the build status
[07:23:22.031] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:22.031] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:116:0) after 1m0s
[07:24:22.298] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:116:0)
[07:24:22.298] Timer tick, asking Buildbucket for the build status
[07:24:22.442] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:22.442] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:117:0) after 1m0s
[07:25:22.584] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:117:0)
[07:25:22.584] Timer tick, asking Buildbucket for the build status
[07:25:23.048] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:23.048] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:118:0) after 1m0s
[07:26:23.067] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:118:0)
[07:26:23.067] Timer tick, asking Buildbucket for the build status
[07:26:23.146] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:23.146] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:119:0) after 1m0s
[07:27:23.183] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:119:0)
[07:27:23.183] Timer tick, asking Buildbucket for the build status
[07:27:23.765] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:23.765] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:120:0) after 1m0s
[07:28:23.835] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:120:0)
[07:28:23.835] Timer tick, asking Buildbucket for the build status
[07:28:24.055] Build 8886783564586127136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:24.055] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9052213627539041040:121:0) after 1m0s
[07:28:44.385] Received PubSub notification, asking Buildbucket for the build status
[07:28:44.461] Build 8886783564586127136: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:28:44.461] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"completed_ts": "1583306923379005",
"created_by": "project:emscripten-releases",
"created_ts": "1583299781201810",
"id": "8886783564586127136",
"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\": \"55ff86e2549ef94331de8ab625a5d8d7fc48ef33\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@55ff86e2549ef94331de8ab625a5d8d7fc48ef33\", \"title\": \"55ff86e2549ef94331de8ab625a5d8d7fc48ef33\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/55ff86e2549ef94331de8ab625a5d8d7fc48ef33\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"55ff86e2549ef94331de8ab625a5d8d7fc48ef33\"}}",
"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\": \"55ff86e2549ef94331de8ab625a5d8d7fc48ef33\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@55ff86e2549ef94331de8ab625a5d8d7fc48ef33\", \"title\": \"55ff86e2549ef94331de8ab625a5d8d7fc48ef33\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/55ff86e2549ef94331de8ab625a5d8d7fc48ef33\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-win10-0-t4d5\", \"branch\": \"refs/heads/master\", \"buildername\": \"win\", \"got_revision\": \"55ff86e2549ef94331de8ab625a5d8d7fc48ef33\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"55ff86e2549ef94331de8ab625a5d8d7fc48ef33\"}, \"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-t4d5\"], \"image\": [\"chrome-win10-1703-19112100-3085293b610\"], \"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\": [\"4851-268d16b\"], \"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": "1583301831162373",
"status": "COMPLETED",
"status_changed_ts": "1583306923732384",
"tags": [
"builder:win",
"buildset:commit/git/55ff86e2549ef94331de8ab625a5d8d7fc48ef33",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/55ff86e2549ef94331de8ab625a5d8d7fc48ef33",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052213627539041040",
"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/8886783564586127136/+/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:4abcd6ede1e15f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1583306923781962",
"url": "https://ci.chromium.org/b/8886783564586127136",
"utcnow_ts": "1583306924449266"
}
}
[07:28:44.461] Invocation finished in 1h59m5.460153692s with status SUCCEEDED