[19:36:53.412] New invocation is queued and will start shortly
[19:36:55.141] Starting the invocation (attempt 1)
[19:36:55.308] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:36:55.309] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:36:55.309] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9043734805948525280",
"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\":\"3262c9eaa705d3bfb8fe46824104a86b23e3a07f\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@3262c9eaa705d3bfb8fe46824104a86b23e3a07f\",\"title\":\"3262c9eaa705d3bfb8fe46824104a86b23e3a07f\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/3262c9eaa705d3bfb8fe46824104a86b23e3a07f\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"3262c9eaa705d3bfb8fe46824104a86b23e3a07f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux",
"scheduler_invocation_id:9043734805948525280",
"scheduler_job_id:emscripten-releases/linux",
"user_agent:luci-scheduler",
"buildset:commit/git/3262c9eaa705d3bfb8fe46824104a86b23e3a07f",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/3262c9eaa705d3bfb8fe46824104a86b23e3a07f",
"gitiles_ref:refs/heads/master"
]
}
[19:36:56.026] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1591385815406603",
"id": "8878304743183485504",
"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\": \"3262c9eaa705d3bfb8fe46824104a86b23e3a07f\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@3262c9eaa705d3bfb8fe46824104a86b23e3a07f\", \"title\": \"3262c9eaa705d3bfb8fe46824104a86b23e3a07f\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/3262c9eaa705d3bfb8fe46824104a86b23e3a07f\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"3262c9eaa705d3bfb8fe46824104a86b23e3a07f\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1591385815726049",
"tags": [
"builder:linux",
"buildset:commit/git/3262c9eaa705d3bfb8fe46824104a86b23e3a07f",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/3262c9eaa705d3bfb8fe46824104a86b23e3a07f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9043734805948525280",
"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/8878304743183485504/+/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": "1591385815726178",
"url": "https://ci.chromium.org/b/8878304743183485504",
"utcnow_ts": "1591385816016299"
}
}
[19:36:56.026] Task URL: https://ci.chromium.org/b/8878304743183485504
[19:36:56.026] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:2:0) after 1m0s
[19:37:43.829] Received PubSub notification, asking Buildbucket for the build status
[19:37:44.095] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:56.339] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:2:0)
[19:37:56.339] Timer tick, asking Buildbucket for the build status
[19:37:56.479] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:56.479] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:4:0) after 1m0s
[19:38:56.565] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:4:0)
[19:38:56.565] Timer tick, asking Buildbucket for the build status
[19:38:57.202] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:57.202] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:5:0) after 1m0s
[19:39:57.222] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:5:0)
[19:39:57.222] Timer tick, asking Buildbucket for the build status
[19:39:57.402] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:57.402] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:6:0) after 1m0s
[19:40:57.534] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:6:0)
[19:40:57.534] Timer tick, asking Buildbucket for the build status
[19:40:58.356] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:58.356] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:7:0) after 1m0s
[19:41:58.378] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:7:0)
[19:41:58.378] Timer tick, asking Buildbucket for the build status
[19:41:58.677] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:58.678] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:8:0) after 1m0s
[19:42:58.709] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:8:0)
[19:42:58.709] Timer tick, asking Buildbucket for the build status
[19:42:59.248] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:59.248] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:9:0) after 1m0s
[19:43:59.272] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:9:0)
[19:43:59.272] Timer tick, asking Buildbucket for the build status
[19:43:59.444] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:59.444] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:10:0) after 1m0s
[19:44:59.464] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:10:0)
[19:44:59.464] Timer tick, asking Buildbucket for the build status
[19:44:59.652] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:59.652] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:11:0) after 1m0s
[19:45:59.678] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:11:0)
[19:45:59.678] Timer tick, asking Buildbucket for the build status
[19:45:59.972] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:59.972] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:12:0) after 1m0s
[19:47:00.028] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:12:0)
[19:47:00.028] Timer tick, asking Buildbucket for the build status
[19:47:00.618] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:00.618] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:13:0) after 1m0s
[19:48:00.714] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:13:0)
[19:48:00.714] Timer tick, asking Buildbucket for the build status
[19:48:01.055] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:01.055] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:14:0) after 1m0s
[19:49:01.197] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:14:0)
[19:49:01.198] Timer tick, asking Buildbucket for the build status
[19:49:01.741] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:01.741] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:15:0) after 1m0s
[19:50:01.764] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:15:0)
[19:50:01.764] Timer tick, asking Buildbucket for the build status
[19:50:02.076] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:02.076] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:16:0) after 1m0s
[19:51:03.630] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:16:0)
[19:51:03.630] Timer tick, asking Buildbucket for the build status
[19:51:04.443] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:04.443] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:17:0) after 1m0s
[19:52:04.685] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:17:0)
[19:52:04.685] Timer tick, asking Buildbucket for the build status
[19:52:05.333] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:05.333] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:18:0) after 1m0s
[19:53:05.406] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:18:0)
[19:53:05.406] Timer tick, asking Buildbucket for the build status
[19:53:05.878] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:05.878] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:19:0) after 1m0s
[19:54:06.172] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:19:0)
[19:54:06.172] Timer tick, asking Buildbucket for the build status
[19:54:06.438] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:06.438] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:20:0) after 1m0s
[19:55:06.616] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:20:0)
[19:55:06.616] Timer tick, asking Buildbucket for the build status
[19:55:07.187] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:07.187] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:21:0) after 1m0s
[19:56:07.327] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:21:0)
[19:56:07.327] Timer tick, asking Buildbucket for the build status
[19:56:07.783] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:07.783] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:22:0) after 1m0s
[19:57:07.904] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:22:0)
[19:57:07.904] Timer tick, asking Buildbucket for the build status
[19:57:08.125] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:08.125] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:23:0) after 1m0s
[19:58:08.335] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:23:0)
[19:58:08.335] Timer tick, asking Buildbucket for the build status
[19:58:08.921] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:08.921] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:24:0) after 1m0s
[19:59:09.071] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:24:0)
[19:59:09.071] Timer tick, asking Buildbucket for the build status
[19:59:09.176] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:09.176] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:25:0) after 1m0s
[20:00:09.224] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:25:0)
[20:00:09.224] Timer tick, asking Buildbucket for the build status
[20:00:14.907] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:14.907] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:26:0) after 1m0s
[20:01:15.017] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:26:0)
[20:01:15.017] Timer tick, asking Buildbucket for the build status
[20:01:15.388] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:15.388] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:27:0) after 1m0s
[20:02:15.450] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:27:0)
[20:02:15.450] Timer tick, asking Buildbucket for the build status
[20:02:15.877] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:15.877] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:28:0) after 1m0s
[20:03:15.936] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:28:0)
[20:03:15.936] Timer tick, asking Buildbucket for the build status
[20:03:16.397] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:16.397] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:29:0) after 1m0s
[20:04:16.424] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:29:0)
[20:04:16.424] Timer tick, asking Buildbucket for the build status
[20:04:16.903] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:16.903] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:30:0) after 1m0s
[20:05:16.958] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:30:0)
[20:05:16.958] Timer tick, asking Buildbucket for the build status
[20:05:17.462] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:17.462] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:31:0) after 1m0s
[20:06:17.688] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:31:0)
[20:06:17.688] Timer tick, asking Buildbucket for the build status
[20:06:17.892] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:17.892] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:32:0) after 1m0s
[20:07:17.970] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:32:0)
[20:07:17.970] Timer tick, asking Buildbucket for the build status
[20:07:18.267] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:18.267] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:33:0) after 1m0s
[20:08:19.481] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:33:0)
[20:08:19.481] Timer tick, asking Buildbucket for the build status
[20:08:20.067] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:20.067] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:34:0) after 1m0s
[20:09:20.118] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:34:0)
[20:09:20.118] Timer tick, asking Buildbucket for the build status
[20:09:20.245] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:20.245] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:35:0) after 1m0s
[20:10:20.353] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:35:0)
[20:10:20.353] Timer tick, asking Buildbucket for the build status
[20:10:20.645] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:20.645] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:36:0) after 1m0s
[20:11:20.674] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:36:0)
[20:11:20.674] Timer tick, asking Buildbucket for the build status
[20:11:21.373] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:21.373] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:37:0) after 1m0s
[20:12:21.417] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:37:0)
[20:12:21.417] Timer tick, asking Buildbucket for the build status
[20:12:21.619] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:21.619] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:38:0) after 1m0s
[20:13:21.656] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:38:0)
[20:13:21.656] Timer tick, asking Buildbucket for the build status
[20:13:21.930] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:21.930] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:39:0) after 1m0s
[20:14:22.075] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:39:0)
[20:14:22.075] Timer tick, asking Buildbucket for the build status
[20:14:22.207] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:22.207] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:40:0) after 1m0s
[20:15:22.290] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:40:0)
[20:15:22.290] Timer tick, asking Buildbucket for the build status
[20:15:22.489] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:22.489] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:41:0) after 1m0s
[20:16:22.599] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:41:0)
[20:16:22.599] Timer tick, asking Buildbucket for the build status
[20:16:22.788] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:22.788] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:42:0) after 1m0s
[20:17:22.863] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:42:0)
[20:17:22.863] Timer tick, asking Buildbucket for the build status
[20:17:23.092] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:23.092] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:43:0) after 1m0s
[20:18:23.183] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:43:0)
[20:18:23.183] Timer tick, asking Buildbucket for the build status
[20:18:23.642] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:23.642] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:44:0) after 1m0s
[20:19:23.699] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:44:0)
[20:19:23.699] Timer tick, asking Buildbucket for the build status
[20:19:24.036] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:24.036] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:45:0) after 1m0s
[20:20:24.093] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:45:0)
[20:20:24.093] Timer tick, asking Buildbucket for the build status
[20:20:24.999] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:24.999] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:46:0) after 1m0s
[20:21:25.072] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:46:0)
[20:21:25.072] Timer tick, asking Buildbucket for the build status
[20:21:25.224] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:25.224] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:47:0) after 1m0s
[20:22:26.499] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:47:0)
[20:22:26.499] Timer tick, asking Buildbucket for the build status
[20:22:26.708] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:26.708] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:48:0) after 1m0s
[20:23:26.794] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:48:0)
[20:23:26.794] Timer tick, asking Buildbucket for the build status
[20:23:27.362] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:27.362] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:49:0) after 1m0s
[20:24:27.432] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:49:0)
[20:24:27.432] Timer tick, asking Buildbucket for the build status
[20:24:27.632] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:27.632] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:50:0) after 1m0s
[20:25:27.711] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:50:0)
[20:25:27.711] Timer tick, asking Buildbucket for the build status
[20:25:28.057] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:28.057] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:51:0) after 1m0s
[20:26:28.159] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:51:0)
[20:26:28.159] Timer tick, asking Buildbucket for the build status
[20:26:28.570] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:28.570] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:52:0) after 1m0s
[20:27:28.740] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:52:0)
[20:27:28.740] Timer tick, asking Buildbucket for the build status
[20:27:28.888] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:28.888] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:53:0) after 1m0s
[20:28:28.986] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:53:0)
[20:28:28.986] Timer tick, asking Buildbucket for the build status
[20:28:29.139] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:29.139] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:54:0) after 1m0s
[20:29:29.187] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:54:0)
[20:29:29.187] Timer tick, asking Buildbucket for the build status
[20:29:29.361] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:29.361] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:55:0) after 1m0s
[20:30:29.426] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:55:0)
[20:30:29.426] Timer tick, asking Buildbucket for the build status
[20:30:29.540] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:29.540] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:56:0) after 1m0s
[20:31:29.621] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:56:0)
[20:31:29.621] Timer tick, asking Buildbucket for the build status
[20:31:29.785] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:29.785] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:57:0) after 1m0s
[20:32:29.862] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:57:0)
[20:32:29.862] Timer tick, asking Buildbucket for the build status
[20:32:30.254] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:30.254] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:58:0) after 1m0s
[20:33:30.289] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:58:0)
[20:33:30.289] Timer tick, asking Buildbucket for the build status
[20:33:30.447] Build 8878304743183485504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:30.447] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9043734805948525280:59:0) after 1m0s
[20:34:28.076] Received PubSub notification, asking Buildbucket for the build status
[20:34:28.268] Build 8878304743183485504: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:34:28.268] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"completed_ts": "1591389266966223",
"created_by": "project:emscripten-releases",
"created_ts": "1591385815406603",
"id": "8878304743183485504",
"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\": \"3262c9eaa705d3bfb8fe46824104a86b23e3a07f\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@3262c9eaa705d3bfb8fe46824104a86b23e3a07f\", \"title\": \"3262c9eaa705d3bfb8fe46824104a86b23e3a07f\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/3262c9eaa705d3bfb8fe46824104a86b23e3a07f\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"3262c9eaa705d3bfb8fe46824104a86b23e3a07f\"}}",
"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\": \"3262c9eaa705d3bfb8fe46824104a86b23e3a07f\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@3262c9eaa705d3bfb8fe46824104a86b23e3a07f\", \"title\": \"3262c9eaa705d3bfb8fe46824104a86b23e3a07f\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/3262c9eaa705d3bfb8fe46824104a86b23e3a07f\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-xenial-1-wo0y\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux\", \"got_revision\": \"3262c9eaa705d3bfb8fe46824104a86b23e3a07f\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"3262c9eaa705d3bfb8fe46824104a86b23e3a07f\"}, \"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-wo0y\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"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\": [\"5168-d212e19\"], \"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": "1591385862865578",
"status": "COMPLETED",
"status_changed_ts": "1591389267656583",
"tags": [
"builder:linux",
"buildset:commit/git/3262c9eaa705d3bfb8fe46824104a86b23e3a07f",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/3262c9eaa705d3bfb8fe46824104a86b23e3a07f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9043734805948525280",
"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/8878304743183485504/+/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:4c9ece0471850d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1591389267754535",
"url": "https://ci.chromium.org/b/8878304743183485504",
"utcnow_ts": "1591389268253913"
}
}
[20:34:28.268] Invocation finished in 57m34.882878525s with status SUCCEEDED