[00:47:40.176] New invocation is queued and will start shortly
[00:47:41.437] Starting the invocation (attempt 1)
[00:47:41.478] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:47:41.478] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:47:41.478] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9064190167796636208",
"parameters_json": "{\"builder_name\":\"linux\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"3c4846ffb31107d2e7befd3bba94f1aaf16f1e4c\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@3c4846ffb31107d2e7befd3bba94f1aaf16f1e4c\",\"title\":\"3c4846ffb31107d2e7befd3bba94f1aaf16f1e4c\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/3c4846ffb31107d2e7befd3bba94f1aaf16f1e4c\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"3c4846ffb31107d2e7befd3bba94f1aaf16f1e4c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux",
"scheduler_invocation_id:9064190167796636208",
"scheduler_job_id:emscripten-releases/linux",
"user_agent:luci-scheduler",
"buildset:commit/git/3c4846ffb31107d2e7befd3bba94f1aaf16f1e4c",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/3c4846ffb31107d2e7befd3bba94f1aaf16f1e4c",
"gitiles_ref:refs/heads/master"
]
}
[00:47:43.063] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1571878061787804",
"id": "8898760105442346128",
"parameters_json": "{\"builder_name\": \"linux\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"3c4846ffb31107d2e7befd3bba94f1aaf16f1e4c\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@3c4846ffb31107d2e7befd3bba94f1aaf16f1e4c\", \"title\": \"3c4846ffb31107d2e7befd3bba94f1aaf16f1e4c\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/3c4846ffb31107d2e7befd3bba94f1aaf16f1e4c\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"3c4846ffb31107d2e7befd3bba94f1aaf16f1e4c\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1571878062555909",
"tags": [
"builder:linux",
"buildset:commit/git/3c4846ffb31107d2e7befd3bba94f1aaf16f1e4c",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/3c4846ffb31107d2e7befd3bba94f1aaf16f1e4c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9064190167796636208",
"scheduler_job_id:emscripten-releases/linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/emscripten-releases/buildbucket/cr-buildbucket.appspot.com/8898760105442346128/+/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": "1571878062556026",
"url": "https://ci.chromium.org/b/8898760105442346128",
"utcnow_ts": "1571878063043172"
}
}
[00:47:43.063] Task URL: https://ci.chromium.org/b/8898760105442346128
[00:47:43.063] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:2:0) after 1m0s
[00:48:43.092] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:2:0)
[00:48:43.092] Timer tick, asking Buildbucket for the build status
[00:48:43.260] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:48:43.260] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:3:0) after 1m0s
[00:49:43.289] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:3:0)
[00:49:43.289] Timer tick, asking Buildbucket for the build status
[00:49:43.924] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:49:43.924] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:4:0) after 1m0s
[00:50:43.904] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:4:0)
[00:50:43.904] Timer tick, asking Buildbucket for the build status
[00:50:44.971] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:50:44.971] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:5:0) after 1m0s
[00:51:45.085] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:5:0)
[00:51:45.085] Timer tick, asking Buildbucket for the build status
[00:51:45.222] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:51:45.223] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:6:0) after 1m0s
[00:52:45.345] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:6:0)
[00:52:45.345] Timer tick, asking Buildbucket for the build status
[00:52:46.911] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:52:46.911] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:7:0) after 1m0s
[00:53:46.975] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:7:0)
[00:53:46.975] Timer tick, asking Buildbucket for the build status
[00:53:47.422] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:53:47.423] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:8:0) after 1m0s
[00:54:47.458] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:8:0)
[00:54:47.458] Timer tick, asking Buildbucket for the build status
[00:54:48.546] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:54:48.547] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:9:0) after 1m0s
[00:55:48.645] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:9:0)
[00:55:48.645] Timer tick, asking Buildbucket for the build status
[00:55:48.788] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:55:48.788] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:10:0) after 1m0s
[00:56:48.953] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:10:0)
[00:56:48.953] Timer tick, asking Buildbucket for the build status
[00:56:50.003] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:56:50.003] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:11:0) after 1m0s
[00:57:50.069] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:11:0)
[00:57:50.069] Timer tick, asking Buildbucket for the build status
[00:57:50.249] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:57:50.249] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:12:0) after 1m0s
[00:58:50.237] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:12:0)
[00:58:50.237] Timer tick, asking Buildbucket for the build status
[00:58:50.424] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:58:50.424] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:13:0) after 1m0s
[00:59:50.428] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:13:0)
[00:59:50.428] Timer tick, asking Buildbucket for the build status
[00:59:50.753] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:59:50.753] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:14:0) after 1m0s
[01:00:50.771] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:14:0)
[01:00:50.771] Timer tick, asking Buildbucket for the build status
[01:00:51.992] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:00:51.992] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:15:0) after 1m0s
[01:01:51.999] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:15:0)
[01:01:51.999] Timer tick, asking Buildbucket for the build status
[01:01:52.433] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:01:52.433] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:16:0) after 1m0s
[01:02:52.465] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:16:0)
[01:02:52.465] Timer tick, asking Buildbucket for the build status
[01:02:53.845] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:02:53.845] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:17:0) after 1m0s
[01:03:53.832] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:17:0)
[01:03:53.832] Timer tick, asking Buildbucket for the build status
[01:03:54.062] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:03:54.062] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:18:0) after 1m0s
[01:04:54.122] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:18:0)
[01:04:54.122] Timer tick, asking Buildbucket for the build status
[01:04:54.439] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:04:54.439] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:19:0) after 1m0s
[01:05:54.535] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:19:0)
[01:05:54.535] Timer tick, asking Buildbucket for the build status
[01:05:54.867] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:05:54.867] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:20:0) after 1m0s
[01:06:55.063] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:20:0)
[01:06:55.063] Timer tick, asking Buildbucket for the build status
[01:06:56.284] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:06:56.284] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:21:0) after 1m0s
[01:07:56.308] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:21:0)
[01:07:56.308] Timer tick, asking Buildbucket for the build status
[01:07:56.469] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:07:56.469] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:22:0) after 1m0s
[01:08:56.497] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:22:0)
[01:08:56.497] Timer tick, asking Buildbucket for the build status
[01:08:56.692] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:08:56.692] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:23:0) after 1m0s
[01:09:56.776] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:23:0)
[01:09:56.776] Timer tick, asking Buildbucket for the build status
[01:09:57.158] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:09:57.158] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:24:0) after 1m0s
[01:10:57.214] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:24:0)
[01:10:57.214] Timer tick, asking Buildbucket for the build status
[01:10:58.566] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:10:58.566] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:25:0) after 1m0s
[01:11:58.601] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:25:0)
[01:11:58.601] Timer tick, asking Buildbucket for the build status
[01:12:00.640] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:12:00.640] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:26:0) after 1m0s
[01:13:00.689] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:26:0)
[01:13:00.689] Timer tick, asking Buildbucket for the build status
[01:13:00.983] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:13:00.983] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:27:0) after 1m0s
[01:14:00.982] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:27:0)
[01:14:00.982] Timer tick, asking Buildbucket for the build status
[01:14:01.486] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:14:01.486] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:28:0) after 1m0s
[01:15:01.872] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:28:0)
[01:15:01.872] Timer tick, asking Buildbucket for the build status
[01:15:02.197] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:15:02.197] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:29:0) after 1m0s
[01:16:02.278] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:29:0)
[01:16:02.278] Timer tick, asking Buildbucket for the build status
[01:16:02.588] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:16:02.588] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:30:0) after 1m0s
[01:17:02.643] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:30:0)
[01:17:02.643] Timer tick, asking Buildbucket for the build status
[01:17:02.906] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:17:02.906] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:31:0) after 1m0s
[01:18:02.931] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:31:0)
[01:18:02.931] Timer tick, asking Buildbucket for the build status
[01:18:04.724] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:18:04.724] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:32:0) after 1m0s
[01:19:04.778] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:32:0)
[01:19:04.778] Timer tick, asking Buildbucket for the build status
[01:19:05.232] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:19:05.232] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:33:0) after 1m0s
[01:20:05.257] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:33:0)
[01:20:05.257] Timer tick, asking Buildbucket for the build status
[01:20:05.723] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:20:05.723] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:34:0) after 1m0s
[01:21:05.752] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:34:0)
[01:21:05.752] Timer tick, asking Buildbucket for the build status
[01:21:06.039] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:21:06.039] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:35:0) after 1m0s
[01:22:06.042] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:35:0)
[01:22:06.042] Timer tick, asking Buildbucket for the build status
[01:22:07.188] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:22:07.188] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:36:0) after 1m0s
[01:23:07.259] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:36:0)
[01:23:07.259] Timer tick, asking Buildbucket for the build status
[01:23:08.653] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:23:08.653] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:37:0) after 1m0s
[01:24:08.907] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:37:0)
[01:24:08.907] Timer tick, asking Buildbucket for the build status
[01:24:09.209] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:24:09.209] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:38:0) after 1m0s
[01:25:09.273] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:38:0)
[01:25:09.273] Timer tick, asking Buildbucket for the build status
[01:25:09.579] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:25:09.579] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:39:0) after 1m0s
[01:26:09.773] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:39:0)
[01:26:09.773] Timer tick, asking Buildbucket for the build status
[01:26:09.960] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:26:09.960] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:40:0) after 1m0s
[01:27:10.045] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:40:0)
[01:27:10.045] Timer tick, asking Buildbucket for the build status
[01:27:10.247] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:27:10.247] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:41:0) after 1m0s
[01:28:10.421] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:41:0)
[01:28:10.421] Timer tick, asking Buildbucket for the build status
[01:28:10.961] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:28:10.961] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:42:0) after 1m0s
[01:29:11.108] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:42:0)
[01:29:11.108] Timer tick, asking Buildbucket for the build status
[01:29:11.615] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:29:11.615] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:43:0) after 1m0s
[01:30:11.782] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:43:0)
[01:30:11.782] Timer tick, asking Buildbucket for the build status
[01:30:12.026] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:30:12.027] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:44:0) after 1m0s
[01:31:12.044] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:44:0)
[01:31:12.044] Timer tick, asking Buildbucket for the build status
[01:31:12.435] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:31:12.435] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:45:0) after 1m0s
[01:32:12.452] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:45:0)
[01:32:12.453] Timer tick, asking Buildbucket for the build status
[01:32:12.564] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:32:12.565] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:46:0) after 1m0s
[01:33:12.615] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:46:0)
[01:33:12.615] Timer tick, asking Buildbucket for the build status
[01:33:13.129] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:33:13.129] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:47:0) after 1m0s
[01:34:13.168] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:47:0)
[01:34:13.168] Timer tick, asking Buildbucket for the build status
[01:34:13.313] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:34:13.313] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:48:0) after 1m0s
[01:35:13.405] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:48:0)
[01:35:13.405] Timer tick, asking Buildbucket for the build status
[01:35:14.645] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:35:14.645] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:49:0) after 1m0s
[01:36:14.721] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:49:0)
[01:36:14.721] Timer tick, asking Buildbucket for the build status
[01:36:14.999] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:36:14.999] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:50:0) after 1m0s
[01:37:15.077] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:50:0)
[01:37:15.077] Timer tick, asking Buildbucket for the build status
[01:37:16.150] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:37:16.150] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:51:0) after 1m0s
[01:38:16.261] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:51:0)
[01:38:16.261] Timer tick, asking Buildbucket for the build status
[01:38:16.912] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:38:16.912] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:52:0) after 1m0s
[01:39:16.981] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:52:0)
[01:39:16.981] Timer tick, asking Buildbucket for the build status
[01:39:17.117] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:39:17.117] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:53:0) after 1m0s
[01:40:17.211] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:53:0)
[01:40:17.211] Timer tick, asking Buildbucket for the build status
[01:40:17.651] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:40:17.651] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:54:0) after 1m0s
[01:41:17.709] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:54:0)
[01:41:17.709] Timer tick, asking Buildbucket for the build status
[01:41:17.995] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:41:17.995] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:55:0) after 1m0s
[01:42:18.019] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:55:0)
[01:42:18.019] Timer tick, asking Buildbucket for the build status
[01:42:18.283] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:42:18.283] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:56:0) after 1m0s
[01:43:18.309] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:56:0)
[01:43:18.309] Timer tick, asking Buildbucket for the build status
[01:43:19.003] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:43:19.003] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:57:0) after 1m0s
[01:44:19.082] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:57:0)
[01:44:19.082] Timer tick, asking Buildbucket for the build status
[01:44:19.327] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:44:19.327] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:58:0) after 1m0s
[01:45:19.387] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:58:0)
[01:45:19.387] Timer tick, asking Buildbucket for the build status
[01:45:20.250] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:45:20.250] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:59:0) after 1m0s
[01:46:20.356] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:59:0)
[01:46:20.356] Timer tick, asking Buildbucket for the build status
[01:46:20.566] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:46:20.566] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:60:0) after 1m0s
[01:47:20.625] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:60:0)
[01:47:20.625] Timer tick, asking Buildbucket for the build status
[01:47:20.765] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:47:20.765] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:61:0) after 1m0s
[01:48:20.828] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:61:0)
[01:48:20.828] Timer tick, asking Buildbucket for the build status
[01:48:21.217] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:48:21.217] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:62:0) after 1m0s
[01:49:21.316] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:62:0)
[01:49:21.316] Timer tick, asking Buildbucket for the build status
[01:49:22.554] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:49:22.554] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:63:0) after 1m0s
[01:50:22.570] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:63:0)
[01:50:22.570] Timer tick, asking Buildbucket for the build status
[01:50:22.723] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:50:22.723] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:64:0) after 1m0s
[01:51:22.814] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:64:0)
[01:51:22.814] Timer tick, asking Buildbucket for the build status
[01:51:23.669] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:51:23.669] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:65:0) after 1m0s
[01:52:23.740] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:65:0)
[01:52:23.740] Timer tick, asking Buildbucket for the build status
[01:52:24.007] Build 8898760105442346128: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:52:24.007] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:66:0) after 1m0s
[01:53:20.996] Received PubSub notification, asking Buildbucket for the build status
[01:53:21.321] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:24.057] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:66:0)
[01:53:24.057] Timer tick, asking Buildbucket for the build status
[01:53:24.520] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:24.520] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:68:0) after 1m0s
[01:54:24.594] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:68:0)
[01:54:24.594] Timer tick, asking Buildbucket for the build status
[01:54:25.055] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:25.055] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:69:0) after 1m0s
[01:55:25.085] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:69:0)
[01:55:25.085] Timer tick, asking Buildbucket for the build status
[01:55:25.382] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:25.382] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:70:0) after 1m0s
[01:56:25.472] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:70:0)
[01:56:25.472] Timer tick, asking Buildbucket for the build status
[01:56:25.674] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:25.674] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:71:0) after 1m0s
[01:57:25.867] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:71:0)
[01:57:25.867] Timer tick, asking Buildbucket for the build status
[01:57:26.373] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:26.373] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:72:0) after 1m0s
[01:58:26.662] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:72:0)
[01:58:26.662] Timer tick, asking Buildbucket for the build status
[01:58:26.822] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:26.822] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:73:0) after 1m0s
[01:59:26.862] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:73:0)
[01:59:26.862] Timer tick, asking Buildbucket for the build status
[01:59:27.194] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:27.194] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:74:0) after 1m0s
[02:00:27.232] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:74:0)
[02:00:27.232] Timer tick, asking Buildbucket for the build status
[02:00:27.442] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:27.442] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:75:0) after 1m0s
[02:01:27.512] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:75:0)
[02:01:27.512] Timer tick, asking Buildbucket for the build status
[02:01:29.326] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:29.326] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:76:0) after 1m0s
[02:02:29.424] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:76:0)
[02:02:29.424] Timer tick, asking Buildbucket for the build status
[02:02:30.644] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:30.644] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:77:0) after 1m0s
[02:03:31.024] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:77:0)
[02:03:31.024] Timer tick, asking Buildbucket for the build status
[02:03:31.312] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:31.312] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:78:0) after 1m0s
[02:04:31.584] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:78:0)
[02:04:31.584] Timer tick, asking Buildbucket for the build status
[02:04:32.757] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:32.757] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:79:0) after 1m0s
[02:05:32.844] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:79:0)
[02:05:32.844] Timer tick, asking Buildbucket for the build status
[02:05:33.056] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:33.056] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:80:0) after 1m0s
[02:06:33.345] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:80:0)
[02:06:33.345] Timer tick, asking Buildbucket for the build status
[02:06:33.499] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:33.499] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:81:0) after 1m0s
[02:07:33.806] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:81:0)
[02:07:33.806] Timer tick, asking Buildbucket for the build status
[02:07:34.153] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:34.153] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:82:0) after 1m0s
[02:08:34.552] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:82:0)
[02:08:34.552] Timer tick, asking Buildbucket for the build status
[02:08:34.738] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:34.738] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:83:0) after 1m0s
[02:09:35.389] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:83:0)
[02:09:35.389] Timer tick, asking Buildbucket for the build status
[02:09:35.696] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:35.696] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:84:0) after 1m0s
[02:10:35.899] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:84:0)
[02:10:35.899] Timer tick, asking Buildbucket for the build status
[02:10:36.211] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:36.211] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:85:0) after 1m0s
[02:11:36.258] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:85:0)
[02:11:36.258] Timer tick, asking Buildbucket for the build status
[02:11:36.544] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:36.544] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:86:0) after 1m0s
[02:12:36.566] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:86:0)
[02:12:36.566] Timer tick, asking Buildbucket for the build status
[02:12:36.685] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:36.685] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:87:0) after 1m0s
[02:13:36.837] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:87:0)
[02:13:36.837] Timer tick, asking Buildbucket for the build status
[02:13:36.946] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:36.946] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:88:0) after 1m0s
[02:14:37.028] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:88:0)
[02:14:37.028] Timer tick, asking Buildbucket for the build status
[02:14:37.441] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:37.441] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:89:0) after 1m0s
[02:15:37.477] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:89:0)
[02:15:37.477] Timer tick, asking Buildbucket for the build status
[02:15:37.709] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:37.709] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:90:0) after 1m0s
[02:16:37.767] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:90:0)
[02:16:37.767] Timer tick, asking Buildbucket for the build status
[02:16:37.922] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:37.922] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:91:0) after 1m0s
[02:17:38.059] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:91:0)
[02:17:38.059] Timer tick, asking Buildbucket for the build status
[02:17:38.244] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:38.244] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:92:0) after 1m0s
[02:18:38.348] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:92:0)
[02:18:38.348] Timer tick, asking Buildbucket for the build status
[02:18:38.607] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:38.607] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:93:0) after 1m0s
[02:19:38.690] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:93:0)
[02:19:38.690] Timer tick, asking Buildbucket for the build status
[02:19:39.024] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:39.024] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:94:0) after 1m0s
[02:20:39.144] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:94:0)
[02:20:39.144] Timer tick, asking Buildbucket for the build status
[02:20:39.334] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:39.334] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:95:0) after 1m0s
[02:21:39.367] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:95:0)
[02:21:39.367] Timer tick, asking Buildbucket for the build status
[02:21:39.562] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:39.562] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:96:0) after 1m0s
[02:22:39.696] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:96:0)
[02:22:39.696] Timer tick, asking Buildbucket for the build status
[02:22:39.890] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:39.890] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:97:0) after 1m0s
[02:23:39.949] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:97:0)
[02:23:39.949] Timer tick, asking Buildbucket for the build status
[02:23:40.092] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:40.092] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:98:0) after 1m0s
[02:24:40.170] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:98:0)
[02:24:40.170] Timer tick, asking Buildbucket for the build status
[02:24:40.305] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:40.305] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:99:0) after 1m0s
[02:25:40.519] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:99:0)
[02:25:40.519] Timer tick, asking Buildbucket for the build status
[02:25:40.712] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:40.712] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:100:0) after 1m0s
[02:26:40.780] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:100:0)
[02:26:40.780] Timer tick, asking Buildbucket for the build status
[02:26:41.202] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:41.202] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:101:0) after 1m0s
[02:27:41.340] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:101:0)
[02:27:41.340] Timer tick, asking Buildbucket for the build status
[02:27:41.505] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:41.505] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:102:0) after 1m0s
[02:28:41.629] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:102:0)
[02:28:41.629] Timer tick, asking Buildbucket for the build status
[02:28:42.027] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:42.027] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:103:0) after 1m0s
[02:29:42.064] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:103:0)
[02:29:42.064] Timer tick, asking Buildbucket for the build status
[02:29:42.424] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:42.424] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:104:0) after 1m0s
[02:30:42.506] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:104:0)
[02:30:42.506] Timer tick, asking Buildbucket for the build status
[02:30:42.644] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:42.644] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:105:0) after 1m0s
[02:31:42.667] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:105:0)
[02:31:42.667] Timer tick, asking Buildbucket for the build status
[02:31:42.897] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:42.897] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:106:0) after 1m0s
[02:32:42.925] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:106:0)
[02:32:42.925] Timer tick, asking Buildbucket for the build status
[02:32:43.410] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:43.410] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:107:0) after 1m0s
[02:33:43.467] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:107:0)
[02:33:43.467] Timer tick, asking Buildbucket for the build status
[02:33:44.026] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:44.026] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:108:0) after 1m0s
[02:34:44.055] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:108:0)
[02:34:44.055] Timer tick, asking Buildbucket for the build status
[02:34:44.248] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:44.248] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:109:0) after 1m0s
[02:35:44.273] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:109:0)
[02:35:44.273] Timer tick, asking Buildbucket for the build status
[02:35:44.505] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:44.505] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:110:0) after 1m0s
[02:36:44.534] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:110:0)
[02:36:44.534] Timer tick, asking Buildbucket for the build status
[02:36:44.767] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:44.767] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:111:0) after 1m0s
[02:37:44.850] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:111:0)
[02:37:44.850] Timer tick, asking Buildbucket for the build status
[02:37:45.121] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:45.121] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:112:0) after 1m0s
[02:38:45.209] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:112:0)
[02:38:45.209] Timer tick, asking Buildbucket for the build status
[02:38:45.308] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:45.308] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:113:0) after 1m0s
[02:39:45.359] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:113:0)
[02:39:45.359] Timer tick, asking Buildbucket for the build status
[02:39:45.637] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:45.638] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:114:0) after 1m0s
[02:40:45.745] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:114:0)
[02:40:45.745] Timer tick, asking Buildbucket for the build status
[02:40:45.978] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:45.978] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:115:0) after 1m0s
[02:41:46.142] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:115:0)
[02:41:46.142] Timer tick, asking Buildbucket for the build status
[02:41:46.907] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:46.907] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:116:0) after 1m0s
[02:42:46.988] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:116:0)
[02:42:46.988] Timer tick, asking Buildbucket for the build status
[02:42:47.362] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:47.362] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:117:0) after 1m0s
[02:43:47.397] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:117:0)
[02:43:47.397] Timer tick, asking Buildbucket for the build status
[02:43:48.504] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:48.504] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:118:0) after 1m0s
[02:44:48.553] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:118:0)
[02:44:48.553] Timer tick, asking Buildbucket for the build status
[02:44:49.273] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:49.273] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:119:0) after 1m0s
[02:45:49.318] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:119:0)
[02:45:49.318] Timer tick, asking Buildbucket for the build status
[02:45:49.868] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:49.868] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:120:0) after 1m0s
[02:46:50.037] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:120:0)
[02:46:50.037] Timer tick, asking Buildbucket for the build status
[02:46:50.412] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:50.412] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:121:0) after 1m0s
[02:47:50.571] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:121:0)
[02:47:50.571] Timer tick, asking Buildbucket for the build status
[02:47:52.294] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:52.294] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:122:0) after 1m0s
[02:48:52.345] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:122:0)
[02:48:52.345] Timer tick, asking Buildbucket for the build status
[02:48:53.047] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:53.048] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:123:0) after 1m0s
[02:49:53.137] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:123:0)
[02:49:53.138] Timer tick, asking Buildbucket for the build status
[02:49:53.294] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:53.294] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:124:0) after 1m0s
[02:50:53.364] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:124:0)
[02:50:53.364] Timer tick, asking Buildbucket for the build status
[02:50:53.606] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:53.606] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:125:0) after 1m0s
[02:51:53.718] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:125:0)
[02:51:53.718] Timer tick, asking Buildbucket for the build status
[02:51:53.874] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:53.874] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:126:0) after 1m0s
[02:52:53.879] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:126:0)
[02:52:53.879] Timer tick, asking Buildbucket for the build status
[02:52:54.101] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:54.101] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:127:0) after 1m0s
[02:53:54.160] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:127:0)
[02:53:54.160] Timer tick, asking Buildbucket for the build status
[02:53:55.517] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:55.517] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:128:0) after 1m0s
[02:54:55.626] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:128:0)
[02:54:55.626] Timer tick, asking Buildbucket for the build status
[02:54:56.330] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:56.330] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:129:0) after 1m0s
[02:55:56.438] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:129:0)
[02:55:56.439] Timer tick, asking Buildbucket for the build status
[02:55:56.567] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:56.567] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:130:0) after 1m0s
[02:56:56.674] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:130:0)
[02:56:56.674] Timer tick, asking Buildbucket for the build status
[02:56:56.886] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:56.886] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:131:0) after 1m0s
[02:57:57.005] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:131:0)
[02:57:57.005] Timer tick, asking Buildbucket for the build status
[02:57:57.185] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:57.186] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:132:0) after 1m0s
[02:58:57.217] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:132:0)
[02:58:57.217] Timer tick, asking Buildbucket for the build status
[02:58:57.321] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:57.321] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:133:0) after 1m0s
[02:59:57.341] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:133:0)
[02:59:57.341] Timer tick, asking Buildbucket for the build status
[02:59:57.517] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:57.517] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:134:0) after 1m0s
[03:00:57.506] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:134:0)
[03:00:57.506] Timer tick, asking Buildbucket for the build status
[03:00:57.962] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:57.962] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:135:0) after 1m0s
[03:01:58.072] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:135:0)
[03:01:58.072] Timer tick, asking Buildbucket for the build status
[03:01:58.183] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:58.183] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:136:0) after 1m0s
[03:02:58.163] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:136:0)
[03:02:58.163] Timer tick, asking Buildbucket for the build status
[03:02:58.464] Build 8898760105442346128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:58.464] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9064190167796636208:137:0) after 1m0s
[03:03:03.188] Received PubSub notification, asking Buildbucket for the build status
[03:03:03.514] Build 8898760105442346128: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:03:03.514] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"completed_ts": "1571886182053217",
"created_by": "project:emscripten-releases",
"created_ts": "1571878061787804",
"id": "8898760105442346128",
"parameters_json": "{\"builder_name\": \"linux\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"3c4846ffb31107d2e7befd3bba94f1aaf16f1e4c\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@3c4846ffb31107d2e7befd3bba94f1aaf16f1e4c\", \"title\": \"3c4846ffb31107d2e7befd3bba94f1aaf16f1e4c\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/3c4846ffb31107d2e7befd3bba94f1aaf16f1e4c\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"3c4846ffb31107d2e7befd3bba94f1aaf16f1e4c\"}}",
"project": "emscripten-releases",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/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\": \"3c4846ffb31107d2e7befd3bba94f1aaf16f1e4c\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@3c4846ffb31107d2e7befd3bba94f1aaf16f1e4c\", \"title\": \"3c4846ffb31107d2e7befd3bba94f1aaf16f1e4c\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/3c4846ffb31107d2e7befd3bba94f1aaf16f1e4c\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-xenial-0-fa1d\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux\", \"got_revision\": \"3c4846ffb31107d2e7befd3bba94f1aaf16f1e4c\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"3c4846ffb31107d2e7befd3bba94f1aaf16f1e4c\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_461cb3affc6f270af3ac9b28cfd8af8c60e3aebc1d1ae3ebd8f2aa2c00b55fae_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"host_class\": [\"default\"], \"id\": [\"luci-emscripten-releases-ci-xenial-0-fa1d\"], \"image\": [\"chrome-xenial-19102200-47150345821\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.emscripten-releases.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4549-8dc3ae7\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1571881999918148",
"status": "COMPLETED",
"status_changed_ts": "1571886182473716",
"tags": [
"builder:linux",
"buildset:commit/git/3c4846ffb31107d2e7befd3bba94f1aaf16f1e4c",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/3c4846ffb31107d2e7befd3bba94f1aaf16f1e4c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9064190167796636208",
"scheduler_job_id:emscripten-releases/linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/emscripten-releases/buildbucket/cr-buildbucket.appspot.com/8898760105442346128/+/annotations",
"swarming_tag:luci_project:emscripten-releases",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:emscripten_releases",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:48140d944c802c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1571886182483076",
"url": "https://ci.chromium.org/b/8898760105442346128",
"utcnow_ts": "1571886183495881"
}
}
[03:03:03.514] Invocation finished in 2h15m23.356105917s with status SUCCEEDED