[23:22:22.098] New invocation is queued and will start shortly
[23:22:23.260] Starting the invocation (attempt 1)
[23:22:23.299] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:22:23.300] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:22:23.300] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9028772120626118624",
"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\":\"7719aeda7f45d908f2dcf91b613813b61ea4bd21\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@7719aeda7f45d908f2dcf91b613813b61ea4bd21\",\"title\":\"7719aeda7f45d908f2dcf91b613813b61ea4bd21\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/7719aeda7f45d908f2dcf91b613813b61ea4bd21\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"7719aeda7f45d908f2dcf91b613813b61ea4bd21\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux",
"scheduler_invocation_id:9028772120626118624",
"scheduler_job_id:emscripten-releases/linux",
"user_agent:luci-scheduler",
"buildset:commit/git/7719aeda7f45d908f2dcf91b613813b61ea4bd21",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/7719aeda7f45d908f2dcf91b613813b61ea4bd21",
"gitiles_ref:refs/heads/master"
]
}
[23:22:23.838] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1605655343439231",
"id": "8863342058556398864",
"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\": \"7719aeda7f45d908f2dcf91b613813b61ea4bd21\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@7719aeda7f45d908f2dcf91b613813b61ea4bd21\", \"title\": \"7719aeda7f45d908f2dcf91b613813b61ea4bd21\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/7719aeda7f45d908f2dcf91b613813b61ea4bd21\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"7719aeda7f45d908f2dcf91b613813b61ea4bd21\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605655343700484",
"tags": [
"builder:linux",
"buildset:commit/git/7719aeda7f45d908f2dcf91b613813b61ea4bd21",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/7719aeda7f45d908f2dcf91b613813b61ea4bd21",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028772120626118624",
"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/8863342058556398864/+/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": "1605655343700590",
"url": "https://ci.chromium.org/b/8863342058556398864",
"utcnow_ts": "1605655343829620"
}
}
[23:22:23.838] Task URL: https://ci.chromium.org/b/8863342058556398864
[23:22:23.838] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:2:0) after 1m0s
[23:22:51.843] Received PubSub notification, asking Buildbucket for the build status
[23:22:51.932] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:23.934] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:2:0)
[23:23:23.934] Timer tick, asking Buildbucket for the build status
[23:23:24.433] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:24.433] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:4:0) after 1m0s
[23:24:24.478] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:4:0)
[23:24:24.478] Timer tick, asking Buildbucket for the build status
[23:24:24.594] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:24.594] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:5:0) after 1m0s
[23:25:24.692] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:5:0)
[23:25:24.692] Timer tick, asking Buildbucket for the build status
[23:25:24.803] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:24.803] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:6:0) after 1m0s
[23:26:24.909] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:6:0)
[23:26:24.909] Timer tick, asking Buildbucket for the build status
[23:26:25.052] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:25.052] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:7:0) after 1m0s
[23:27:25.138] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:7:0)
[23:27:25.138] Timer tick, asking Buildbucket for the build status
[23:27:25.194] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:25.194] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:8:0) after 1m0s
[23:28:25.225] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:8:0)
[23:28:25.225] Timer tick, asking Buildbucket for the build status
[23:28:25.337] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:25.337] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:9:0) after 1m0s
[23:29:25.380] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:9:0)
[23:29:25.380] Timer tick, asking Buildbucket for the build status
[23:29:25.444] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:25.444] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:10:0) after 1m0s
[23:30:25.632] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:10:0)
[23:30:25.632] Timer tick, asking Buildbucket for the build status
[23:30:25.718] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:25.718] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:11:0) after 1m0s
[23:31:26.225] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:11:0)
[23:31:26.225] Timer tick, asking Buildbucket for the build status
[23:31:26.288] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:26.288] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:12:0) after 1m0s
[23:32:26.447] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:12:0)
[23:32:26.447] Timer tick, asking Buildbucket for the build status
[23:32:26.534] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:26.534] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:13:0) after 1m0s
[23:33:26.615] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:13:0)
[23:33:26.615] Timer tick, asking Buildbucket for the build status
[23:33:26.751] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:26.751] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:14:0) after 1m0s
[23:34:26.882] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:14:0)
[23:34:26.882] Timer tick, asking Buildbucket for the build status
[23:34:26.947] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:26.947] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:15:0) after 1m0s
[23:35:27.024] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:15:0)
[23:35:27.024] Timer tick, asking Buildbucket for the build status
[23:35:27.156] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:27.156] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:16:0) after 1m0s
[23:36:27.310] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:16:0)
[23:36:27.310] Timer tick, asking Buildbucket for the build status
[23:36:27.394] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:27.394] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:17:0) after 1m0s
[23:37:27.415] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:17:0)
[23:37:27.415] Timer tick, asking Buildbucket for the build status
[23:37:27.565] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:27.565] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:18:0) after 1m0s
[23:38:27.758] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:18:0)
[23:38:27.758] Timer tick, asking Buildbucket for the build status
[23:38:27.836] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:27.836] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:19:0) after 1m0s
[23:39:27.932] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:19:0)
[23:39:27.932] Timer tick, asking Buildbucket for the build status
[23:39:28.024] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:28.024] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:20:0) after 1m0s
[23:40:28.103] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:20:0)
[23:40:28.103] Timer tick, asking Buildbucket for the build status
[23:40:28.179] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:28.180] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:21:0) after 1m0s
[23:41:28.211] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:21:0)
[23:41:28.211] Timer tick, asking Buildbucket for the build status
[23:41:28.674] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:28.674] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:22:0) after 1m0s
[23:42:28.876] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:22:0)
[23:42:28.876] Timer tick, asking Buildbucket for the build status
[23:42:28.992] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:28.992] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:23:0) after 1m0s
[23:43:28.987] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:23:0)
[23:43:28.987] Timer tick, asking Buildbucket for the build status
[23:43:29.077] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:29.077] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:24:0) after 1m0s
[23:44:29.203] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:24:0)
[23:44:29.203] Timer tick, asking Buildbucket for the build status
[23:44:29.403] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:29.403] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:25:0) after 1m0s
[23:45:29.424] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:25:0)
[23:45:29.424] Timer tick, asking Buildbucket for the build status
[23:45:29.538] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:29.538] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:26:0) after 1m0s
[23:46:29.707] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:26:0)
[23:46:29.707] Timer tick, asking Buildbucket for the build status
[23:46:29.766] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:29.766] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:27:0) after 1m0s
[23:47:29.774] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:27:0)
[23:47:29.774] Timer tick, asking Buildbucket for the build status
[23:47:29.905] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:29.905] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:28:0) after 1m0s
[23:48:29.939] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:28:0)
[23:48:29.939] Timer tick, asking Buildbucket for the build status
[23:48:29.993] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:29.993] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:29:0) after 1m0s
[23:49:30.224] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:29:0)
[23:49:30.224] Timer tick, asking Buildbucket for the build status
[23:49:30.554] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:30.554] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:30:0) after 1m0s
[23:50:30.673] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:30:0)
[23:50:30.673] Timer tick, asking Buildbucket for the build status
[23:50:30.728] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:30.728] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:31:0) after 1m0s
[23:51:30.828] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:31:0)
[23:51:30.828] Timer tick, asking Buildbucket for the build status
[23:51:30.944] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:30.944] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:32:0) after 1m0s
[23:52:31.023] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:32:0)
[23:52:31.024] Timer tick, asking Buildbucket for the build status
[23:52:31.307] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:31.307] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:33:0) after 1m0s
[23:53:31.437] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:33:0)
[23:53:31.437] Timer tick, asking Buildbucket for the build status
[23:53:31.606] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:31.606] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:34:0) after 1m0s
[23:54:31.704] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:34:0)
[23:54:31.704] Timer tick, asking Buildbucket for the build status
[23:54:31.807] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:31.807] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:35:0) after 1m0s
[23:55:31.810] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:35:0)
[23:55:31.810] Timer tick, asking Buildbucket for the build status
[23:55:31.902] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:31.902] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:36:0) after 1m0s
[23:56:32.015] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:36:0)
[23:56:32.015] Timer tick, asking Buildbucket for the build status
[23:56:32.220] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:32.220] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:37:0) after 1m0s
[23:57:32.348] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:37:0)
[23:57:32.348] Timer tick, asking Buildbucket for the build status
[23:57:32.480] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:32.480] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:38:0) after 1m0s
[23:58:32.524] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:38:0)
[23:58:32.524] Timer tick, asking Buildbucket for the build status
[23:58:33.154] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:33.154] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:39:0) after 1m0s
[23:59:33.806] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:39:0)
[23:59:33.806] Timer tick, asking Buildbucket for the build status
[23:59:33.908] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:33.908] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:40:0) after 1m0s
[00:00:34.068] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:40:0)
[00:00:34.068] Timer tick, asking Buildbucket for the build status
[00:00:34.319] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:34.320] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:41:0) after 1m0s
[00:01:34.378] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:41:0)
[00:01:34.378] Timer tick, asking Buildbucket for the build status
[00:01:34.513] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:34.513] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:42:0) after 1m0s
[00:02:34.531] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:42:0)
[00:02:34.531] Timer tick, asking Buildbucket for the build status
[00:02:34.683] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:34.683] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:43:0) after 1m0s
[00:03:34.864] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:43:0)
[00:03:34.864] Timer tick, asking Buildbucket for the build status
[00:03:35.149] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:35.149] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:44:0) after 1m0s
[00:04:35.183] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:44:0)
[00:04:35.183] Timer tick, asking Buildbucket for the build status
[00:04:35.730] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:35.730] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:45:0) after 1m0s
[00:05:35.773] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:45:0)
[00:05:35.773] Timer tick, asking Buildbucket for the build status
[00:05:35.858] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:35.858] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:46:0) after 1m0s
[00:06:36.028] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:46:0)
[00:06:36.028] Timer tick, asking Buildbucket for the build status
[00:06:36.104] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:36.104] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:47:0) after 1m0s
[00:07:36.264] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:47:0)
[00:07:36.264] Timer tick, asking Buildbucket for the build status
[00:07:36.441] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:36.441] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:48:0) after 1m0s
[00:08:36.549] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:48:0)
[00:08:36.549] Timer tick, asking Buildbucket for the build status
[00:08:36.625] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:36.625] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:49:0) after 1m0s
[00:09:36.629] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:49:0)
[00:09:36.629] Timer tick, asking Buildbucket for the build status
[00:09:37.576] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:37.576] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:50:0) after 1m0s
[00:10:37.732] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:50:0)
[00:10:37.732] Timer tick, asking Buildbucket for the build status
[00:10:37.911] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:37.911] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:51:0) after 1m0s
[00:11:37.964] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:51:0)
[00:11:37.964] Timer tick, asking Buildbucket for the build status
[00:11:38.132] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:38.132] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:52:0) after 1m0s
[00:12:38.284] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:52:0)
[00:12:38.284] Timer tick, asking Buildbucket for the build status
[00:12:38.397] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:38.397] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:53:0) after 1m0s
[00:13:38.491] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:53:0)
[00:13:38.491] Timer tick, asking Buildbucket for the build status
[00:13:38.570] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:38.570] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:54:0) after 1m0s
[00:14:38.705] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:54:0)
[00:14:38.705] Timer tick, asking Buildbucket for the build status
[00:14:39.236] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:39.236] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:55:0) after 1m0s
[00:15:39.338] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:55:0)
[00:15:39.338] Timer tick, asking Buildbucket for the build status
[00:15:39.833] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:39.833] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:56:0) after 1m0s
[00:16:39.939] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:56:0)
[00:16:39.939] Timer tick, asking Buildbucket for the build status
[00:16:40.006] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:40.006] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:57:0) after 1m0s
[00:17:40.151] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:57:0)
[00:17:40.151] Timer tick, asking Buildbucket for the build status
[00:17:40.274] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:40.274] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:58:0) after 1m0s
[00:18:40.318] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:58:0)
[00:18:40.318] Timer tick, asking Buildbucket for the build status
[00:18:40.390] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:40.390] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:59:0) after 1m0s
[00:19:40.454] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:59:0)
[00:19:40.454] Timer tick, asking Buildbucket for the build status
[00:19:40.543] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:40.543] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:60:0) after 1m0s
[00:20:40.568] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:60:0)
[00:20:40.568] Timer tick, asking Buildbucket for the build status
[00:20:40.707] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:40.707] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:61:0) after 1m0s
[00:21:40.820] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:61:0)
[00:21:40.820] Timer tick, asking Buildbucket for the build status
[00:21:40.893] Build 8863342058556398864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:40.893] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9028772120626118624:62:0) after 1m0s
[00:22:10.183] Received PubSub notification, asking Buildbucket for the build status
[00:22:10.264] Build 8863342058556398864: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:22:10.264] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"completed_ts": "1605658929428203",
"created_by": "project:emscripten-releases",
"created_ts": "1605655343439231",
"id": "8863342058556398864",
"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\": \"7719aeda7f45d908f2dcf91b613813b61ea4bd21\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@7719aeda7f45d908f2dcf91b613813b61ea4bd21\", \"title\": \"7719aeda7f45d908f2dcf91b613813b61ea4bd21\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/7719aeda7f45d908f2dcf91b613813b61ea4bd21\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"7719aeda7f45d908f2dcf91b613813b61ea4bd21\"}}",
"project": "emscripten-releases",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/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\": \"7719aeda7f45d908f2dcf91b613813b61ea4bd21\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@7719aeda7f45d908f2dcf91b613813b61ea4bd21\", \"title\": \"7719aeda7f45d908f2dcf91b613813b61ea4bd21\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/7719aeda7f45d908f2dcf91b613813b61ea4bd21\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-xenial-1-p87g\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux\", \"got_revision\": \"7719aeda7f45d908f2dcf91b613813b61ea4bd21\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"7719aeda7f45d908f2dcf91b613813b61ea4bd21\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_461cb3affc6f270af3ac9b28cfd8af8c60e3aebc1d1ae3ebd8f2aa2c00b55fae_v2\", \"builder_e437bc7da551d62da6a64b09ca05a66344db3b0846e125cb83052108c473fa36_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-p87g\"], \"image\": [\"chrome-xenial-20111600-a937a23cefb\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.emscripten-releases.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5632-2e614e1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605655370949857",
"status": "COMPLETED",
"status_changed_ts": "1605658929860527",
"tags": [
"builder:linux",
"buildset:commit/git/7719aeda7f45d908f2dcf91b613813b61ea4bd21",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/7719aeda7f45d908f2dcf91b613813b61ea4bd21",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028772120626118624",
"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/8863342058556398864/+/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:4ff155bca0f16810",
"user_agent:luci-scheduler"
],
"updated_ts": "1605658929871772",
"url": "https://ci.chromium.org/b/8863342058556398864",
"utcnow_ts": "1605658930254119"
}
}
[00:22:10.264] Invocation finished in 59m48.181438533s with status SUCCEEDED