[11:23:50.519] New invocation is queued and will start shortly
[11:23:51.919] Starting the invocation (attempt 1)
[11:23:52.024] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:23:52.024] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:23:52.024] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9053187910377803184",
"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\":\"34dc7fefb96aeaeae8d99002caba9e3797ab2cf3\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@34dc7fefb96aeaeae8d99002caba9e3797ab2cf3\",\"title\":\"34dc7fefb96aeaeae8d99002caba9e3797ab2cf3\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/34dc7fefb96aeaeae8d99002caba9e3797ab2cf3\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"34dc7fefb96aeaeae8d99002caba9e3797ab2cf3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win",
"scheduler_invocation_id:9053187910377803184",
"scheduler_job_id:emscripten-releases/win",
"user_agent:luci-scheduler",
"buildset:commit/git/34dc7fefb96aeaeae8d99002caba9e3797ab2cf3",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/34dc7fefb96aeaeae8d99002caba9e3797ab2cf3",
"gitiles_ref:refs/heads/master"
]
}
[11:23:53.321] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1582370632391460",
"id": "8887757847727944320",
"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\": \"34dc7fefb96aeaeae8d99002caba9e3797ab2cf3\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@34dc7fefb96aeaeae8d99002caba9e3797ab2cf3\", \"title\": \"34dc7fefb96aeaeae8d99002caba9e3797ab2cf3\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/34dc7fefb96aeaeae8d99002caba9e3797ab2cf3\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"34dc7fefb96aeaeae8d99002caba9e3797ab2cf3\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1582370633001823",
"tags": [
"builder:win",
"buildset:commit/git/34dc7fefb96aeaeae8d99002caba9e3797ab2cf3",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/34dc7fefb96aeaeae8d99002caba9e3797ab2cf3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9053187910377803184",
"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/8887757847727944320/+/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": "1582370633001964",
"url": "https://ci.chromium.org/b/8887757847727944320",
"utcnow_ts": "1582370633308594"
}
}
[11:23:53.321] Task URL: https://ci.chromium.org/b/8887757847727944320
[11:23:53.321] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:2:0) after 1m0s
[11:24:53.489] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:2:0)
[11:24:53.489] Timer tick, asking Buildbucket for the build status
[11:24:54.012] Build 8887757847727944320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:24:54.012] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:3:0) after 1m0s
[11:25:54.181] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:3:0)
[11:25:54.181] Timer tick, asking Buildbucket for the build status
[11:25:54.413] Build 8887757847727944320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:25:54.413] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:4:0) after 1m0s
[11:26:54.485] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:4:0)
[11:26:54.485] Timer tick, asking Buildbucket for the build status
[11:26:54.618] Build 8887757847727944320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:26:54.618] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:5:0) after 1m0s
[11:27:54.822] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:5:0)
[11:27:54.822] Timer tick, asking Buildbucket for the build status
[11:27:54.973] Build 8887757847727944320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:27:54.973] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:6:0) after 1m0s
[11:28:55.018] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:6:0)
[11:28:55.018] Timer tick, asking Buildbucket for the build status
[11:28:55.215] Build 8887757847727944320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:28:55.215] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:7:0) after 1m0s
[11:29:55.362] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:7:0)
[11:29:55.362] Timer tick, asking Buildbucket for the build status
[11:29:55.470] Build 8887757847727944320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:29:55.470] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:8:0) after 1m0s
[11:30:55.537] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:8:0)
[11:30:55.537] Timer tick, asking Buildbucket for the build status
[11:30:55.639] Build 8887757847727944320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:30:55.639] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:9:0) after 1m0s
[11:31:55.674] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:9:0)
[11:31:55.674] Timer tick, asking Buildbucket for the build status
[11:31:55.809] Build 8887757847727944320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:31:55.809] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:10:0) after 1m0s
[11:32:55.956] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:10:0)
[11:32:55.956] Timer tick, asking Buildbucket for the build status
[11:32:56.106] Build 8887757847727944320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:32:56.106] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:11:0) after 1m0s
[11:33:56.216] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:11:0)
[11:33:56.216] Timer tick, asking Buildbucket for the build status
[11:33:56.334] Build 8887757847727944320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:33:56.334] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:12:0) after 1m0s
[11:34:56.370] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:12:0)
[11:34:56.370] Timer tick, asking Buildbucket for the build status
[11:34:56.522] Build 8887757847727944320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:34:56.522] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:13:0) after 1m0s
[11:35:56.577] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:13:0)
[11:35:56.577] Timer tick, asking Buildbucket for the build status
[11:35:56.680] Build 8887757847727944320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:35:56.680] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:14:0) after 1m0s
[11:36:56.732] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:14:0)
[11:36:56.732] Timer tick, asking Buildbucket for the build status
[11:36:56.821] Build 8887757847727944320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:36:56.821] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:15:0) after 1m0s
[11:37:56.863] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:15:0)
[11:37:56.863] Timer tick, asking Buildbucket for the build status
[11:37:56.986] Build 8887757847727944320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:37:56.986] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:16:0) after 1m0s
[11:38:57.052] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:16:0)
[11:38:57.052] Timer tick, asking Buildbucket for the build status
[11:38:58.393] Build 8887757847727944320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:38:58.393] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:17:0) after 1m0s
[11:39:58.507] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:17:0)
[11:39:58.507] Timer tick, asking Buildbucket for the build status
[11:39:58.721] Build 8887757847727944320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:39:58.723] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:18:0) after 1m0s
[11:40:58.766] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:18:0)
[11:40:58.766] Timer tick, asking Buildbucket for the build status
[11:40:58.870] Build 8887757847727944320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:40:58.870] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:19:0) after 1m0s
[11:41:59.004] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:19:0)
[11:41:59.004] Timer tick, asking Buildbucket for the build status
[11:41:59.197] Build 8887757847727944320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:41:59.197] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:20:0) after 1m0s
[11:42:59.295] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:20:0)
[11:42:59.295] Timer tick, asking Buildbucket for the build status
[11:42:59.402] Build 8887757847727944320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:42:59.402] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:21:0) after 1m0s
[11:43:59.422] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:21:0)
[11:43:59.422] Timer tick, asking Buildbucket for the build status
[11:43:59.640] Build 8887757847727944320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:43:59.640] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:22:0) after 1m0s
[11:44:59.661] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:22:0)
[11:44:59.661] Timer tick, asking Buildbucket for the build status
[11:45:00.087] Build 8887757847727944320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:45:00.087] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:23:0) after 1m0s
[11:46:00.086] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:23:0)
[11:46:00.086] Timer tick, asking Buildbucket for the build status
[11:46:00.229] Build 8887757847727944320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:46:00.229] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:24:0) after 1m0s
[11:47:00.298] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:24:0)
[11:47:00.298] Timer tick, asking Buildbucket for the build status
[11:47:00.411] Build 8887757847727944320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:47:00.411] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:25:0) after 1m0s
[11:48:00.484] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:25:0)
[11:48:00.484] Timer tick, asking Buildbucket for the build status
[11:48:00.599] Build 8887757847727944320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:48:00.599] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:26:0) after 1m0s
[11:49:00.617] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:26:0)
[11:49:00.617] Timer tick, asking Buildbucket for the build status
[11:49:00.703] Build 8887757847727944320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:49:00.703] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:27:0) after 1m0s
[11:50:00.776] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:27:0)
[11:50:00.776] Timer tick, asking Buildbucket for the build status
[11:50:01.160] Build 8887757847727944320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:50:01.160] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:28:0) after 1m0s
[11:51:01.199] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:28:0)
[11:51:01.199] Timer tick, asking Buildbucket for the build status
[11:51:01.314] Build 8887757847727944320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:51:01.314] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:29:0) after 1m0s
[11:52:01.336] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:29:0)
[11:52:01.337] Timer tick, asking Buildbucket for the build status
[11:52:01.569] Build 8887757847727944320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:52:01.569] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:30:0) after 1m0s
[11:53:01.655] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:30:0)
[11:53:01.655] Timer tick, asking Buildbucket for the build status
[11:53:01.992] Build 8887757847727944320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:53:01.992] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:31:0) after 1m0s
[11:54:02.088] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:31:0)
[11:54:02.088] Timer tick, asking Buildbucket for the build status
[11:54:02.776] Build 8887757847727944320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:54:02.776] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:32:0) after 1m0s
[11:54:48.967] Received PubSub notification, asking Buildbucket for the build status
[11:54:49.061] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:02.766] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:32:0)
[11:55:02.766] Timer tick, asking Buildbucket for the build status
[11:55:02.863] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:02.863] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:34:0) after 1m0s
[11:56:02.907] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:34:0)
[11:56:02.908] Timer tick, asking Buildbucket for the build status
[11:56:03.041] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:03.041] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:35:0) after 1m0s
[11:57:03.066] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:35:0)
[11:57:03.066] Timer tick, asking Buildbucket for the build status
[11:57:03.222] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:03.222] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:36:0) after 1m0s
[11:58:03.233] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:36:0)
[11:58:03.233] Timer tick, asking Buildbucket for the build status
[11:58:03.385] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:03.385] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:37:0) after 1m0s
[11:59:03.412] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:37:0)
[11:59:03.412] Timer tick, asking Buildbucket for the build status
[11:59:03.542] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:03.542] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:38:0) after 1m0s
[12:00:03.602] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:38:0)
[12:00:03.602] Timer tick, asking Buildbucket for the build status
[12:00:03.878] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:03.878] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:39:0) after 1m0s
[12:01:03.912] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:39:0)
[12:01:03.912] Timer tick, asking Buildbucket for the build status
[12:01:04.218] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:04.218] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:40:0) after 1m0s
[12:02:04.246] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:40:0)
[12:02:04.246] Timer tick, asking Buildbucket for the build status
[12:02:04.380] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:04.380] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:41:0) after 1m0s
[12:03:04.475] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:41:0)
[12:03:04.475] Timer tick, asking Buildbucket for the build status
[12:03:04.675] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:04.675] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:42:0) after 1m0s
[12:04:04.768] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:42:0)
[12:04:04.768] Timer tick, asking Buildbucket for the build status
[12:04:04.876] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:04.876] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:43:0) after 1m0s
[12:05:04.946] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:43:0)
[12:05:04.946] Timer tick, asking Buildbucket for the build status
[12:05:05.276] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:05.276] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:44:0) after 1m0s
[12:06:05.302] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:44:0)
[12:06:05.302] Timer tick, asking Buildbucket for the build status
[12:06:05.473] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:05.473] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:45:0) after 1m0s
[12:07:05.542] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:45:0)
[12:07:05.542] Timer tick, asking Buildbucket for the build status
[12:07:05.667] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:05.667] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:46:0) after 1m0s
[12:08:05.838] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:46:0)
[12:08:05.838] Timer tick, asking Buildbucket for the build status
[12:08:06.118] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:06.118] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:47:0) after 1m0s
[12:09:06.293] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:47:0)
[12:09:06.293] Timer tick, asking Buildbucket for the build status
[12:09:06.379] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:06.379] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:48:0) after 1m0s
[12:10:06.584] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:48:0)
[12:10:06.584] Timer tick, asking Buildbucket for the build status
[12:10:06.709] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:06.709] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:49:0) after 1m0s
[12:11:06.725] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:49:0)
[12:11:06.725] Timer tick, asking Buildbucket for the build status
[12:11:07.012] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:07.012] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:50:0) after 1m0s
[12:12:07.126] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:50:0)
[12:12:07.126] Timer tick, asking Buildbucket for the build status
[12:12:07.328] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:07.328] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:51:0) after 1m0s
[12:13:07.439] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:51:0)
[12:13:07.439] Timer tick, asking Buildbucket for the build status
[12:13:07.579] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:07.579] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:52:0) after 1m0s
[12:14:07.600] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:52:0)
[12:14:07.600] Timer tick, asking Buildbucket for the build status
[12:14:07.765] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:07.765] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:53:0) after 1m0s
[12:15:07.797] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:53:0)
[12:15:07.797] Timer tick, asking Buildbucket for the build status
[12:15:08.351] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:08.351] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:54:0) after 1m0s
[12:16:08.520] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:54:0)
[12:16:08.520] Timer tick, asking Buildbucket for the build status
[12:16:08.645] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:08.645] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:55:0) after 1m0s
[12:17:08.716] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:55:0)
[12:17:08.716] Timer tick, asking Buildbucket for the build status
[12:17:08.809] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:08.809] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:56:0) after 1m0s
[12:18:09.012] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:56:0)
[12:18:09.012] Timer tick, asking Buildbucket for the build status
[12:18:09.156] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:09.156] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:57:0) after 1m0s
[12:19:09.231] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:57:0)
[12:19:09.231] Timer tick, asking Buildbucket for the build status
[12:19:09.396] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:09.396] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:58:0) after 1m0s
[12:20:09.398] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:58:0)
[12:20:09.398] Timer tick, asking Buildbucket for the build status
[12:20:09.522] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:09.522] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:59:0) after 1m0s
[12:21:09.544] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:59:0)
[12:21:09.544] Timer tick, asking Buildbucket for the build status
[12:21:09.656] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:09.656] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:60:0) after 1m0s
[12:22:09.735] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:60:0)
[12:22:09.735] Timer tick, asking Buildbucket for the build status
[12:22:09.968] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:09.968] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:61:0) after 1m0s
[12:23:10.174] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:61:0)
[12:23:10.174] Timer tick, asking Buildbucket for the build status
[12:23:10.380] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:10.380] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:62:0) after 1m0s
[12:24:10.385] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:62:0)
[12:24:10.385] Timer tick, asking Buildbucket for the build status
[12:24:10.890] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:10.890] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:63:0) after 1m0s
[12:25:10.891] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:63:0)
[12:25:10.892] Timer tick, asking Buildbucket for the build status
[12:25:11.064] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:11.064] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:64:0) after 1m0s
[12:26:11.149] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:64:0)
[12:26:11.149] Timer tick, asking Buildbucket for the build status
[12:26:11.259] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:11.259] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:65:0) after 1m0s
[12:27:11.327] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:65:0)
[12:27:11.327] Timer tick, asking Buildbucket for the build status
[12:27:11.441] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:11.441] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:66:0) after 1m0s
[12:28:11.518] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:66:0)
[12:28:11.518] Timer tick, asking Buildbucket for the build status
[12:28:11.612] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:11.612] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:67:0) after 1m0s
[12:29:11.711] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:67:0)
[12:29:11.711] Timer tick, asking Buildbucket for the build status
[12:29:11.803] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:11.803] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:68:0) after 1m0s
[12:30:11.880] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:68:0)
[12:30:11.880] Timer tick, asking Buildbucket for the build status
[12:30:12.000] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:12.001] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:69:0) after 1m0s
[12:31:12.062] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:69:0)
[12:31:12.062] Timer tick, asking Buildbucket for the build status
[12:31:12.237] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:12.237] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:70:0) after 1m0s
[12:32:12.322] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:70:0)
[12:32:12.322] Timer tick, asking Buildbucket for the build status
[12:32:12.436] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:12.436] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:71:0) after 1m0s
[12:33:12.529] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:71:0)
[12:33:12.529] Timer tick, asking Buildbucket for the build status
[12:33:12.683] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:12.683] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:72:0) after 1m0s
[12:34:12.764] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:72:0)
[12:34:12.764] Timer tick, asking Buildbucket for the build status
[12:34:12.877] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:12.877] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:73:0) after 1m0s
[12:35:12.939] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:73:0)
[12:35:12.939] Timer tick, asking Buildbucket for the build status
[12:35:13.038] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:13.038] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:74:0) after 1m0s
[12:36:13.076] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:74:0)
[12:36:13.076] Timer tick, asking Buildbucket for the build status
[12:36:13.315] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:13.315] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:75:0) after 1m0s
[12:37:13.418] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:75:0)
[12:37:13.418] Timer tick, asking Buildbucket for the build status
[12:37:13.683] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:13.683] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:76:0) after 1m0s
[12:38:13.871] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:76:0)
[12:38:13.871] Timer tick, asking Buildbucket for the build status
[12:38:14.192] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:14.192] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:77:0) after 1m0s
[12:39:14.278] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:77:0)
[12:39:14.278] Timer tick, asking Buildbucket for the build status
[12:39:14.555] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:14.555] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:78:0) after 1m0s
[12:40:14.555] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:78:0)
[12:40:14.555] Timer tick, asking Buildbucket for the build status
[12:40:14.871] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:14.871] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:79:0) after 1m0s
[12:41:14.922] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:79:0)
[12:41:14.922] Timer tick, asking Buildbucket for the build status
[12:41:15.017] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:15.017] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:80:0) after 1m0s
[12:42:15.043] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:80:0)
[12:42:15.043] Timer tick, asking Buildbucket for the build status
[12:42:15.149] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:15.149] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:81:0) after 1m0s
[12:43:15.212] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:81:0)
[12:43:15.212] Timer tick, asking Buildbucket for the build status
[12:43:15.395] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:15.395] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:82:0) after 1m0s
[12:44:15.435] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:82:0)
[12:44:15.435] Timer tick, asking Buildbucket for the build status
[12:44:15.556] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:15.556] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:83:0) after 1m0s
[12:45:15.607] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:83:0)
[12:45:15.607] Timer tick, asking Buildbucket for the build status
[12:45:15.875] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:15.875] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:84:0) after 1m0s
[12:46:15.934] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:84:0)
[12:46:15.934] Timer tick, asking Buildbucket for the build status
[12:46:16.232] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:16.232] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:85:0) after 1m0s
[12:47:16.432] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:85:0)
[12:47:16.432] Timer tick, asking Buildbucket for the build status
[12:47:16.587] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:16.587] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:86:0) after 1m0s
[12:48:16.647] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:86:0)
[12:48:16.647] Timer tick, asking Buildbucket for the build status
[12:48:16.976] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:16.976] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:87:0) after 1m0s
[12:49:17.001] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:87:0)
[12:49:17.001] Timer tick, asking Buildbucket for the build status
[12:49:17.114] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:17.114] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:88:0) after 1m0s
[12:50:17.123] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:88:0)
[12:50:17.123] Timer tick, asking Buildbucket for the build status
[12:50:17.418] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:17.418] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:89:0) after 1m0s
[12:51:17.453] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:89:0)
[12:51:17.453] Timer tick, asking Buildbucket for the build status
[12:51:17.917] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:17.917] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:90:0) after 1m0s
[12:52:17.961] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:90:0)
[12:52:17.961] Timer tick, asking Buildbucket for the build status
[12:52:18.321] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:18.322] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:91:0) after 1m0s
[12:53:18.358] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:91:0)
[12:53:18.358] Timer tick, asking Buildbucket for the build status
[12:53:18.494] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:18.494] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:92:0) after 1m0s
[12:54:18.525] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:92:0)
[12:54:18.525] Timer tick, asking Buildbucket for the build status
[12:54:18.823] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:18.823] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:93:0) after 1m0s
[12:55:18.923] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:93:0)
[12:55:18.923] Timer tick, asking Buildbucket for the build status
[12:55:19.331] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:19.331] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:94:0) after 1m0s
[12:56:19.464] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:94:0)
[12:56:19.464] Timer tick, asking Buildbucket for the build status
[12:56:20.182] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:20.182] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:95:0) after 1m0s
[12:57:20.332] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:95:0)
[12:57:20.332] Timer tick, asking Buildbucket for the build status
[12:57:20.444] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:20.444] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:96:0) after 1m0s
[12:58:20.548] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:96:0)
[12:58:20.548] Timer tick, asking Buildbucket for the build status
[12:58:20.689] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:20.689] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:97:0) after 1m0s
[12:59:20.729] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:97:0)
[12:59:20.729] Timer tick, asking Buildbucket for the build status
[12:59:20.845] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:20.845] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:98:0) after 1m0s
[13:00:20.895] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:98:0)
[13:00:20.895] Timer tick, asking Buildbucket for the build status
[13:00:21.033] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:21.033] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:99:0) after 1m0s
[13:01:21.115] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:99:0)
[13:01:21.115] Timer tick, asking Buildbucket for the build status
[13:01:21.860] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:21.860] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:100:0) after 1m0s
[13:02:21.895] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:100:0)
[13:02:21.895] Timer tick, asking Buildbucket for the build status
[13:02:22.081] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:22.081] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:101:0) after 1m0s
[13:03:22.131] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:101:0)
[13:03:22.131] Timer tick, asking Buildbucket for the build status
[13:03:23.447] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:23.447] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:102:0) after 1m0s
[13:04:23.717] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:102:0)
[13:04:23.717] Timer tick, asking Buildbucket for the build status
[13:04:23.866] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:23.866] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:103:0) after 1m0s
[13:05:23.974] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:103:0)
[13:05:23.974] Timer tick, asking Buildbucket for the build status
[13:05:24.408] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:24.408] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:104:0) after 1m0s
[13:06:24.441] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:104:0)
[13:06:24.441] Timer tick, asking Buildbucket for the build status
[13:06:25.845] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:25.845] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:105:0) after 1m0s
[13:07:25.981] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:105:0)
[13:07:25.981] Timer tick, asking Buildbucket for the build status
[13:07:26.141] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:26.141] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:106:0) after 1m0s
[13:08:26.166] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:106:0)
[13:08:26.166] Timer tick, asking Buildbucket for the build status
[13:08:26.375] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:26.375] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:107:0) after 1m0s
[13:09:26.454] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:107:0)
[13:09:26.454] Timer tick, asking Buildbucket for the build status
[13:09:26.614] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:26.614] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:108:0) after 1m0s
[13:10:26.670] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:108:0)
[13:10:26.670] Timer tick, asking Buildbucket for the build status
[13:10:27.965] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:27.965] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:109:0) after 1m0s
[13:11:28.028] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:109:0)
[13:11:28.028] Timer tick, asking Buildbucket for the build status
[13:11:28.274] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:28.275] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:110:0) after 1m0s
[13:12:28.365] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:110:0)
[13:12:28.365] Timer tick, asking Buildbucket for the build status
[13:12:28.563] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:28.563] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:111:0) after 1m0s
[13:13:28.875] Handling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:111:0)
[13:13:28.875] Timer tick, asking Buildbucket for the build status
[13:13:31.399] Build 8887757847727944320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:31.399] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/win:9053187910377803184:112:0) after 1m0s
[13:13:31.664] Received PubSub notification, asking Buildbucket for the build status
[13:13:31.769] Build 8887757847727944320: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[13:13:31.769] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"completed_ts": "1582377210762306",
"created_by": "project:emscripten-releases",
"created_ts": "1582370632391460",
"id": "8887757847727944320",
"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\": \"34dc7fefb96aeaeae8d99002caba9e3797ab2cf3\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@34dc7fefb96aeaeae8d99002caba9e3797ab2cf3\", \"title\": \"34dc7fefb96aeaeae8d99002caba9e3797ab2cf3\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/34dc7fefb96aeaeae8d99002caba9e3797ab2cf3\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"34dc7fefb96aeaeae8d99002caba9e3797ab2cf3\"}}",
"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\": \"34dc7fefb96aeaeae8d99002caba9e3797ab2cf3\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@34dc7fefb96aeaeae8d99002caba9e3797ab2cf3\", \"title\": \"34dc7fefb96aeaeae8d99002caba9e3797ab2cf3\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/34dc7fefb96aeaeae8d99002caba9e3797ab2cf3\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-win10-0-v6gd\", \"branch\": \"refs/heads/master\", \"buildername\": \"win\", \"got_revision\": \"34dc7fefb96aeaeae8d99002caba9e3797ab2cf3\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"34dc7fefb96aeaeae8d99002caba9e3797ab2cf3\"}, \"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-v6gd\"], \"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\": [\"4825-3d129d6\"], \"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": "1582372488216207",
"status": "COMPLETED",
"status_changed_ts": "1582377211217157",
"tags": [
"builder:win",
"buildset:commit/git/34dc7fefb96aeaeae8d99002caba9e3797ab2cf3",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/34dc7fefb96aeaeae8d99002caba9e3797ab2cf3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9053187910377803184",
"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/8887757847727944320/+/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:4a85753efb5a3b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1582377211225184",
"url": "https://ci.chromium.org/b/8887757847727944320",
"utcnow_ts": "1582377211762717"
}
}
[13:13:31.769] Invocation finished in 1h49m41.288181675s with status SUCCEEDED