[01:44:12.764] New invocation is queued and will start shortly
[01:44:14.492] Starting the invocation (attempt 1)
[01:44:14.522] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:44:14.522] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:44:14.522] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9051684229045073136",
"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\":\"4b9dbb8106c50d1d0a89a5d3262d4e771bd0ace2\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@4b9dbb8106c50d1d0a89a5d3262d4e771bd0ace2\",\"title\":\"4b9dbb8106c50d1d0a89a5d3262d4e771bd0ace2\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/4b9dbb8106c50d1d0a89a5d3262d4e771bd0ace2\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"4b9dbb8106c50d1d0a89a5d3262d4e771bd0ace2\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux",
"scheduler_invocation_id:9051684229045073136",
"scheduler_job_id:emscripten-releases/linux",
"user_agent:luci-scheduler",
"buildset:commit/git/4b9dbb8106c50d1d0a89a5d3262d4e771bd0ace2",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/4b9dbb8106c50d1d0a89a5d3262d4e771bd0ace2",
"gitiles_ref:refs/heads/master"
]
}
[01:44:15.125] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1583804654600444",
"id": "8886254166456073744",
"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\": \"4b9dbb8106c50d1d0a89a5d3262d4e771bd0ace2\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@4b9dbb8106c50d1d0a89a5d3262d4e771bd0ace2\", \"title\": \"4b9dbb8106c50d1d0a89a5d3262d4e771bd0ace2\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/4b9dbb8106c50d1d0a89a5d3262d4e771bd0ace2\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"4b9dbb8106c50d1d0a89a5d3262d4e771bd0ace2\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1583804654860574",
"tags": [
"builder:linux",
"buildset:commit/git/4b9dbb8106c50d1d0a89a5d3262d4e771bd0ace2",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/4b9dbb8106c50d1d0a89a5d3262d4e771bd0ace2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9051684229045073136",
"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/8886254166456073744/+/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": "1583804654860774",
"url": "https://ci.chromium.org/b/8886254166456073744",
"utcnow_ts": "1583804655118823"
}
}
[01:44:15.125] Task URL: https://ci.chromium.org/b/8886254166456073744
[01:44:15.125] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:2:0) after 1m0s
[01:44:35.213] Received PubSub notification, asking Buildbucket for the build status
[01:44:35.369] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:15.145] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:2:0)
[01:45:15.145] Timer tick, asking Buildbucket for the build status
[01:45:15.248] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:15.248] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:4:0) after 1m0s
[01:46:15.350] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:4:0)
[01:46:15.350] Timer tick, asking Buildbucket for the build status
[01:46:15.472] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:15.472] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:5:0) after 1m0s
[01:47:15.514] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:5:0)
[01:47:15.514] Timer tick, asking Buildbucket for the build status
[01:47:15.684] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:15.684] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:6:0) after 1m0s
[01:48:15.682] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:6:0)
[01:48:15.682] Timer tick, asking Buildbucket for the build status
[01:48:15.815] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:15.815] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:7:0) after 1m0s
[01:49:15.863] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:7:0)
[01:49:15.863] Timer tick, asking Buildbucket for the build status
[01:49:15.964] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:15.964] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:8:0) after 1m0s
[01:50:16.002] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:8:0)
[01:50:16.002] Timer tick, asking Buildbucket for the build status
[01:50:16.419] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:16.419] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:9:0) after 1m0s
[01:51:16.438] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:9:0)
[01:51:16.438] Timer tick, asking Buildbucket for the build status
[01:51:16.540] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:16.540] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:10:0) after 1m0s
[01:52:16.554] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:10:0)
[01:52:16.554] Timer tick, asking Buildbucket for the build status
[01:52:16.742] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:16.742] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:11:0) after 1m0s
[01:53:16.764] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:11:0)
[01:53:16.764] Timer tick, asking Buildbucket for the build status
[01:53:16.863] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:16.863] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:12:0) after 1m0s
[01:54:16.886] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:12:0)
[01:54:16.886] Timer tick, asking Buildbucket for the build status
[01:54:17.184] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:17.184] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:13:0) after 1m0s
[01:55:17.239] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:13:0)
[01:55:17.239] Timer tick, asking Buildbucket for the build status
[01:55:17.427] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:17.427] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:14:0) after 1m0s
[01:56:17.480] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:14:0)
[01:56:17.480] Timer tick, asking Buildbucket for the build status
[01:56:18.076] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:18.076] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:15:0) after 1m0s
[01:57:18.085] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:15:0)
[01:57:18.085] Timer tick, asking Buildbucket for the build status
[01:57:18.216] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:18.216] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:16:0) after 1m0s
[01:58:18.286] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:16:0)
[01:58:18.286] Timer tick, asking Buildbucket for the build status
[01:58:18.416] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:18.416] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:17:0) after 1m0s
[01:59:18.470] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:17:0)
[01:59:18.470] Timer tick, asking Buildbucket for the build status
[01:59:19.100] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:19.100] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:18:0) after 1m0s
[02:00:19.149] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:18:0)
[02:00:19.149] Timer tick, asking Buildbucket for the build status
[02:00:19.280] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:19.280] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:19:0) after 1m0s
[02:01:19.337] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:19:0)
[02:01:19.337] Timer tick, asking Buildbucket for the build status
[02:01:19.470] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:19.470] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:20:0) after 1m0s
[02:02:19.464] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:20:0)
[02:02:19.464] Timer tick, asking Buildbucket for the build status
[02:02:19.591] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:19.591] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:21:0) after 1m0s
[02:03:19.610] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:21:0)
[02:03:19.610] Timer tick, asking Buildbucket for the build status
[02:03:20.067] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:20.067] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:22:0) after 1m0s
[02:04:20.100] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:22:0)
[02:04:20.100] Timer tick, asking Buildbucket for the build status
[02:04:20.232] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:20.232] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:23:0) after 1m0s
[02:05:20.354] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:23:0)
[02:05:20.354] Timer tick, asking Buildbucket for the build status
[02:05:20.521] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:20.521] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:24:0) after 1m0s
[02:06:20.571] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:24:0)
[02:06:20.571] Timer tick, asking Buildbucket for the build status
[02:06:20.947] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:20.947] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:25:0) after 1m0s
[02:07:20.923] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:25:0)
[02:07:20.923] Timer tick, asking Buildbucket for the build status
[02:07:21.081] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:21.081] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:26:0) after 1m0s
[02:08:21.099] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:26:0)
[02:08:21.099] Timer tick, asking Buildbucket for the build status
[02:08:21.222] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:21.222] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:27:0) after 1m0s
[02:09:21.260] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:27:0)
[02:09:21.260] Timer tick, asking Buildbucket for the build status
[02:09:21.391] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:21.391] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:28:0) after 1m0s
[02:10:21.485] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:28:0)
[02:10:21.485] Timer tick, asking Buildbucket for the build status
[02:10:21.617] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:21.617] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:29:0) after 1m0s
[02:11:21.681] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:29:0)
[02:11:21.681] Timer tick, asking Buildbucket for the build status
[02:11:21.835] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:21.835] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:30:0) after 1m0s
[02:12:21.859] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:30:0)
[02:12:21.859] Timer tick, asking Buildbucket for the build status
[02:12:21.995] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:21.995] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:31:0) after 1m0s
[02:13:22.039] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:31:0)
[02:13:22.039] Timer tick, asking Buildbucket for the build status
[02:13:22.170] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:22.170] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:32:0) after 1m0s
[02:14:22.289] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:32:0)
[02:14:22.289] Timer tick, asking Buildbucket for the build status
[02:14:22.649] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:22.649] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:33:0) after 1m0s
[02:15:22.668] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:33:0)
[02:15:22.668] Timer tick, asking Buildbucket for the build status
[02:15:22.764] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:22.764] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:34:0) after 1m0s
[02:16:22.818] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:34:0)
[02:16:22.818] Timer tick, asking Buildbucket for the build status
[02:16:22.988] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:22.988] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:35:0) after 1m0s
[02:17:23.035] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:35:0)
[02:17:23.035] Timer tick, asking Buildbucket for the build status
[02:17:23.170] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:23.170] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:36:0) after 1m0s
[02:18:23.187] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:36:0)
[02:18:23.187] Timer tick, asking Buildbucket for the build status
[02:18:23.286] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:23.286] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:37:0) after 1m0s
[02:19:23.308] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:37:0)
[02:19:23.308] Timer tick, asking Buildbucket for the build status
[02:19:25.147] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:25.147] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:38:0) after 1m0s
[02:20:25.170] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:38:0)
[02:20:25.170] Timer tick, asking Buildbucket for the build status
[02:20:25.310] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:25.310] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:39:0) after 1m0s
[02:21:25.340] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:39:0)
[02:21:25.340] Timer tick, asking Buildbucket for the build status
[02:21:25.453] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:25.453] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:40:0) after 1m0s
[02:22:25.538] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:40:0)
[02:22:25.538] Timer tick, asking Buildbucket for the build status
[02:22:25.893] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:25.893] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:41:0) after 1m0s
[02:23:25.889] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:41:0)
[02:23:25.889] Timer tick, asking Buildbucket for the build status
[02:23:26.045] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:26.045] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:42:0) after 1m0s
[02:24:26.021] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:42:0)
[02:24:26.021] Timer tick, asking Buildbucket for the build status
[02:24:26.433] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:26.433] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:43:0) after 1m0s
[02:25:26.556] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:43:0)
[02:25:26.556] Timer tick, asking Buildbucket for the build status
[02:25:26.643] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:26.643] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:44:0) after 1m0s
[02:26:26.703] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:44:0)
[02:26:26.706] Timer tick, asking Buildbucket for the build status
[02:26:26.835] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:26.835] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:45:0) after 1m0s
[02:27:26.846] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:45:0)
[02:27:26.846] Timer tick, asking Buildbucket for the build status
[02:27:26.962] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:26.962] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:46:0) after 1m0s
[02:28:27.001] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:46:0)
[02:28:27.001] Timer tick, asking Buildbucket for the build status
[02:28:27.339] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:27.340] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:47:0) after 1m0s
[02:29:27.461] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:47:0)
[02:29:27.461] Timer tick, asking Buildbucket for the build status
[02:29:27.576] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:27.576] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:48:0) after 1m0s
[02:30:27.613] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:48:0)
[02:30:27.613] Timer tick, asking Buildbucket for the build status
[02:30:27.891] Build 8886254166456073744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:27.891] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9051684229045073136:49:0) after 1m0s
[02:30:30.786] Received PubSub notification, asking Buildbucket for the build status
[02:30:30.958] Build 8886254166456073744: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:30:30.958] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"completed_ts": "1583807430052732",
"created_by": "project:emscripten-releases",
"created_ts": "1583804654600444",
"id": "8886254166456073744",
"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\": \"4b9dbb8106c50d1d0a89a5d3262d4e771bd0ace2\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@4b9dbb8106c50d1d0a89a5d3262d4e771bd0ace2\", \"title\": \"4b9dbb8106c50d1d0a89a5d3262d4e771bd0ace2\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/4b9dbb8106c50d1d0a89a5d3262d4e771bd0ace2\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"4b9dbb8106c50d1d0a89a5d3262d4e771bd0ace2\"}}",
"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\": \"4b9dbb8106c50d1d0a89a5d3262d4e771bd0ace2\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@4b9dbb8106c50d1d0a89a5d3262d4e771bd0ace2\", \"title\": \"4b9dbb8106c50d1d0a89a5d3262d4e771bd0ace2\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/4b9dbb8106c50d1d0a89a5d3262d4e771bd0ace2\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-xenial-1-mx5m\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux\", \"got_revision\": \"4b9dbb8106c50d1d0a89a5d3262d4e771bd0ace2\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"4b9dbb8106c50d1d0a89a5d3262d4e771bd0ace2\"}, \"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\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"host_class\": [\"default\"], \"id\": [\"luci-emscripten-releases-ci-xenial-1-mx5m\"], \"image\": [\"chrome-xenial-20030800-300841f894e\"], \"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\": [\"4851-268d16b\"], \"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": "1583804674442167",
"status": "COMPLETED",
"status_changed_ts": "1583807430501852",
"tags": [
"builder:linux",
"buildset:commit/git/4b9dbb8106c50d1d0a89a5d3262d4e771bd0ace2",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/4b9dbb8106c50d1d0a89a5d3262d4e771bd0ace2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9051684229045073136",
"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/8886254166456073744/+/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:4adaeeae306de210",
"user_agent:luci-scheduler"
],
"updated_ts": "1583807430509673",
"url": "https://ci.chromium.org/b/8886254166456073744",
"utcnow_ts": "1583807430949887"
}
}
[02:30:30.958] Invocation finished in 46m18.209689406s with status SUCCEEDED