[23:49:56.625] New invocation is queued and will start shortly
[23:50:00.541] Starting the invocation (attempt 1)
[23:50:00.614] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:50:00.615] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:50:00.615] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9029223370568569584",
"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\":\"bf769b1a95b1ef01a31f87eac1552733e601f3d9\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@bf769b1a95b1ef01a31f87eac1552733e601f3d9\",\"title\":\"bf769b1a95b1ef01a31f87eac1552733e601f3d9\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/bf769b1a95b1ef01a31f87eac1552733e601f3d9\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"bf769b1a95b1ef01a31f87eac1552733e601f3d9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux",
"scheduler_invocation_id:9029223370568569584",
"scheduler_job_id:emscripten-releases/linux",
"user_agent:luci-scheduler",
"buildset:commit/git/bf769b1a95b1ef01a31f87eac1552733e601f3d9",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/bf769b1a95b1ef01a31f87eac1552733e601f3d9",
"gitiles_ref:refs/heads/master"
]
}
[23:50:01.451] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1605225000751311",
"id": "8863793305570718576",
"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\": \"bf769b1a95b1ef01a31f87eac1552733e601f3d9\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@bf769b1a95b1ef01a31f87eac1552733e601f3d9\", \"title\": \"bf769b1a95b1ef01a31f87eac1552733e601f3d9\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/bf769b1a95b1ef01a31f87eac1552733e601f3d9\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"bf769b1a95b1ef01a31f87eac1552733e601f3d9\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605225001212425",
"tags": [
"builder:linux",
"buildset:commit/git/bf769b1a95b1ef01a31f87eac1552733e601f3d9",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/bf769b1a95b1ef01a31f87eac1552733e601f3d9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029223370568569584",
"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/8863793305570718576/+/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": "1605225001213052",
"url": "https://ci.chromium.org/b/8863793305570718576",
"utcnow_ts": "1605225001429481"
}
}
[23:50:01.451] Task URL: https://ci.chromium.org/b/8863793305570718576
[23:50:01.451] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:2:0) after 1m0s
[23:50:27.823] Received PubSub notification, asking Buildbucket for the build status
[23:50:28.029] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:02.239] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:2:0)
[23:51:02.239] Timer tick, asking Buildbucket for the build status
[23:51:02.431] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:02.431] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:4:0) after 1m0s
[23:52:02.657] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:4:0)
[23:52:02.657] Timer tick, asking Buildbucket for the build status
[23:52:03.690] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:03.690] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:5:0) after 1m0s
[23:53:03.716] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:5:0)
[23:53:03.716] Timer tick, asking Buildbucket for the build status
[23:53:03.897] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:03.897] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:6:0) after 1m0s
[23:54:04.011] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:6:0)
[23:54:04.011] Timer tick, asking Buildbucket for the build status
[23:54:04.098] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:04.098] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:7:0) after 1m0s
[23:55:04.138] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:7:0)
[23:55:04.138] Timer tick, asking Buildbucket for the build status
[23:55:04.420] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:04.420] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:8:0) after 1m0s
[23:56:04.410] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:8:0)
[23:56:04.410] Timer tick, asking Buildbucket for the build status
[23:56:04.712] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:04.712] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:9:0) after 1m0s
[23:57:04.770] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:9:0)
[23:57:04.770] Timer tick, asking Buildbucket for the build status
[23:57:05.247] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:05.247] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:10:0) after 1m0s
[23:58:05.253] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:10:0)
[23:58:05.253] Timer tick, asking Buildbucket for the build status
[23:58:05.323] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:05.323] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:11:0) after 1m0s
[23:59:05.389] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:11:0)
[23:59:05.389] Timer tick, asking Buildbucket for the build status
[23:59:05.556] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:05.557] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:12:0) after 1m0s
[00:00:05.626] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:12:0)
[00:00:05.626] Timer tick, asking Buildbucket for the build status
[00:00:05.872] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:05.872] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:13:0) after 1m0s
[00:01:05.934] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:13:0)
[00:01:05.934] Timer tick, asking Buildbucket for the build status
[00:01:05.988] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:05.988] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:14:0) after 1m0s
[00:02:06.084] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:14:0)
[00:02:06.084] Timer tick, asking Buildbucket for the build status
[00:02:06.190] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:06.190] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:15:0) after 1m0s
[00:03:06.271] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:15:0)
[00:03:06.271] Timer tick, asking Buildbucket for the build status
[00:03:06.357] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:06.357] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:16:0) after 1m0s
[00:04:06.407] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:16:0)
[00:04:06.408] Timer tick, asking Buildbucket for the build status
[00:04:07.353] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:07.354] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:17:0) after 1m0s
[00:05:07.430] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:17:0)
[00:05:07.430] Timer tick, asking Buildbucket for the build status
[00:05:07.534] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:07.534] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:18:0) after 1m0s
[00:06:07.558] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:18:0)
[00:06:07.558] Timer tick, asking Buildbucket for the build status
[00:06:07.717] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:07.717] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:19:0) after 1m0s
[00:07:07.716] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:19:0)
[00:07:07.716] Timer tick, asking Buildbucket for the build status
[00:07:08.182] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:08.182] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:20:0) after 1m0s
[00:08:08.235] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:20:0)
[00:08:08.235] Timer tick, asking Buildbucket for the build status
[00:08:08.309] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:08.309] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:21:0) after 1m0s
[00:09:08.387] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:21:0)
[00:09:08.387] Timer tick, asking Buildbucket for the build status
[00:09:08.537] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:08.537] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:22:0) after 1m0s
[00:10:08.566] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:22:0)
[00:10:08.566] Timer tick, asking Buildbucket for the build status
[00:10:08.926] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:08.927] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:23:0) after 1m0s
[00:11:08.985] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:23:0)
[00:11:08.985] Timer tick, asking Buildbucket for the build status
[00:11:09.353] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:09.356] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:24:0) after 1m0s
[00:12:09.427] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:24:0)
[00:12:09.427] Timer tick, asking Buildbucket for the build status
[00:12:09.943] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:09.943] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:25:0) after 1m0s
[00:13:09.993] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:25:0)
[00:13:09.993] Timer tick, asking Buildbucket for the build status
[00:13:10.386] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:10.386] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:26:0) after 1m0s
[00:14:10.461] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:26:0)
[00:14:10.461] Timer tick, asking Buildbucket for the build status
[00:14:11.098] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:11.098] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:27:0) after 1m0s
[00:15:11.222] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:27:0)
[00:15:11.223] Timer tick, asking Buildbucket for the build status
[00:15:11.497] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:11.497] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:28:0) after 1m0s
[00:16:11.678] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:28:0)
[00:16:11.678] Timer tick, asking Buildbucket for the build status
[00:16:12.064] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:12.064] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:29:0) after 1m0s
[00:17:12.145] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:29:0)
[00:17:12.145] Timer tick, asking Buildbucket for the build status
[00:17:12.313] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:12.313] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:30:0) after 1m0s
[00:18:12.420] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:30:0)
[00:18:12.420] Timer tick, asking Buildbucket for the build status
[00:18:12.547] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:12.547] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:31:0) after 1m0s
[00:19:12.568] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:31:0)
[00:19:12.568] Timer tick, asking Buildbucket for the build status
[00:19:12.656] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:12.656] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:32:0) after 1m0s
[00:20:12.693] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:32:0)
[00:20:12.693] Timer tick, asking Buildbucket for the build status
[00:20:12.810] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:12.810] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:33:0) after 1m0s
[00:21:12.886] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:33:0)
[00:21:12.886] Timer tick, asking Buildbucket for the build status
[00:21:13.103] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:13.104] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:34:0) after 1m0s
[00:22:13.185] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:34:0)
[00:22:13.185] Timer tick, asking Buildbucket for the build status
[00:22:13.320] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:13.320] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:35:0) after 1m0s
[00:23:13.346] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:35:0)
[00:23:13.346] Timer tick, asking Buildbucket for the build status
[00:23:13.425] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:13.425] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:36:0) after 1m0s
[00:24:13.493] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:36:0)
[00:24:13.493] Timer tick, asking Buildbucket for the build status
[00:24:13.642] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:13.642] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:37:0) after 1m0s
[00:25:13.665] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:37:0)
[00:25:13.665] Timer tick, asking Buildbucket for the build status
[00:25:13.933] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:13.933] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:38:0) after 1m0s
[00:26:14.057] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:38:0)
[00:26:14.057] Timer tick, asking Buildbucket for the build status
[00:26:14.118] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:14.118] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:39:0) after 1m0s
[00:27:14.499] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:39:0)
[00:27:14.499] Timer tick, asking Buildbucket for the build status
[00:27:15.304] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:15.304] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:40:0) after 1m0s
[00:28:15.327] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:40:0)
[00:28:15.327] Timer tick, asking Buildbucket for the build status
[00:28:15.722] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:15.722] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:41:0) after 1m0s
[00:29:15.800] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:41:0)
[00:29:15.800] Timer tick, asking Buildbucket for the build status
[00:29:15.877] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:15.877] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:42:0) after 1m0s
[00:30:15.909] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:42:0)
[00:30:15.909] Timer tick, asking Buildbucket for the build status
[00:30:16.205] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:16.205] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:43:0) after 1m0s
[00:31:16.258] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:43:0)
[00:31:16.258] Timer tick, asking Buildbucket for the build status
[00:31:16.544] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:16.544] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:44:0) after 1m0s
[00:32:16.913] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:44:0)
[00:32:16.913] Timer tick, asking Buildbucket for the build status
[00:32:17.463] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:17.463] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:45:0) after 1m0s
[00:33:17.585] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:45:0)
[00:33:17.585] Timer tick, asking Buildbucket for the build status
[00:33:17.651] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:17.651] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:46:0) after 1m0s
[00:34:17.732] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:46:0)
[00:34:17.732] Timer tick, asking Buildbucket for the build status
[00:34:18.338] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:18.338] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:47:0) after 1m0s
[00:35:18.414] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:47:0)
[00:35:18.414] Timer tick, asking Buildbucket for the build status
[00:35:18.953] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:18.953] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:48:0) after 1m0s
[00:36:19.026] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:48:0)
[00:36:19.026] Timer tick, asking Buildbucket for the build status
[00:36:19.112] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:19.112] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:49:0) after 1m0s
[00:37:19.146] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:49:0)
[00:37:19.146] Timer tick, asking Buildbucket for the build status
[00:37:19.258] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:19.258] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:50:0) after 1m0s
[00:38:19.291] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:50:0)
[00:38:19.291] Timer tick, asking Buildbucket for the build status
[00:38:19.377] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:19.377] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:51:0) after 1m0s
[00:39:19.398] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:51:0)
[00:39:19.398] Timer tick, asking Buildbucket for the build status
[00:39:19.486] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:19.486] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:52:0) after 1m0s
[00:40:19.554] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:52:0)
[00:40:19.554] Timer tick, asking Buildbucket for the build status
[00:40:19.727] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:19.727] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:53:0) after 1m0s
[00:41:19.778] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:53:0)
[00:41:19.778] Timer tick, asking Buildbucket for the build status
[00:41:19.861] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:19.861] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:54:0) after 1m0s
[00:42:19.957] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:54:0)
[00:42:19.957] Timer tick, asking Buildbucket for the build status
[00:42:20.037] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:20.037] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:55:0) after 1m0s
[00:43:20.134] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:55:0)
[00:43:20.134] Timer tick, asking Buildbucket for the build status
[00:43:20.248] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:20.248] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:56:0) after 1m0s
[00:44:20.315] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:56:0)
[00:44:20.315] Timer tick, asking Buildbucket for the build status
[00:44:20.421] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:20.421] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:57:0) after 1m0s
[00:45:20.475] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:57:0)
[00:45:20.475] Timer tick, asking Buildbucket for the build status
[00:45:20.573] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:20.573] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:58:0) after 1m0s
[00:46:20.652] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:58:0)
[00:46:20.652] Timer tick, asking Buildbucket for the build status
[00:46:20.737] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:20.737] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:59:0) after 1m0s
[00:47:20.834] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:59:0)
[00:47:20.834] Timer tick, asking Buildbucket for the build status
[00:47:20.980] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:20.980] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:60:0) after 1m0s
[00:48:21.042] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:60:0)
[00:48:21.042] Timer tick, asking Buildbucket for the build status
[00:48:22.591] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:22.591] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:61:0) after 1m0s
[00:49:22.576] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:61:0)
[00:49:22.576] Timer tick, asking Buildbucket for the build status
[00:49:22.646] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:22.646] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:62:0) after 1m0s
[00:50:22.736] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:62:0)
[00:50:22.736] Timer tick, asking Buildbucket for the build status
[00:50:22.958] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:22.958] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:63:0) after 1m0s
[00:51:22.972] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:63:0)
[00:51:22.972] Timer tick, asking Buildbucket for the build status
[00:51:23.042] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:23.042] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:64:0) after 1m0s
[00:52:23.097] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:64:0)
[00:52:23.097] Timer tick, asking Buildbucket for the build status
[00:52:23.166] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:23.166] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:65:0) after 1m0s
[00:53:23.244] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:65:0)
[00:53:23.244] Timer tick, asking Buildbucket for the build status
[00:53:23.382] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:23.382] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:66:0) after 1m0s
[00:54:23.486] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:66:0)
[00:54:23.486] Timer tick, asking Buildbucket for the build status
[00:54:23.833] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:23.833] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:67:0) after 1m0s
[00:55:23.938] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:67:0)
[00:55:23.938] Timer tick, asking Buildbucket for the build status
[00:55:24.098] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:24.098] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:68:0) after 1m0s
[00:56:24.171] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:68:0)
[00:56:24.171] Timer tick, asking Buildbucket for the build status
[00:56:24.237] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:24.237] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:69:0) after 1m0s
[00:57:24.257] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:69:0)
[00:57:24.257] Timer tick, asking Buildbucket for the build status
[00:57:24.508] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:24.508] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:70:0) after 1m0s
[00:58:24.619] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:70:0)
[00:58:24.619] Timer tick, asking Buildbucket for the build status
[00:58:24.742] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:24.742] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:71:0) after 1m0s
[00:59:24.771] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:71:0)
[00:59:24.771] Timer tick, asking Buildbucket for the build status
[00:59:25.753] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:25.753] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:72:0) after 1m0s
[01:00:25.802] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:72:0)
[01:00:25.802] Timer tick, asking Buildbucket for the build status
[01:00:26.006] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:26.006] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:73:0) after 1m0s
[01:01:26.110] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:73:0)
[01:01:26.110] Timer tick, asking Buildbucket for the build status
[01:01:26.192] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:26.192] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:74:0) after 1m0s
[01:02:26.208] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:74:0)
[01:02:26.208] Timer tick, asking Buildbucket for the build status
[01:02:26.506] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:26.506] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:75:0) after 1m0s
[01:03:26.608] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:75:0)
[01:03:26.608] Timer tick, asking Buildbucket for the build status
[01:03:26.731] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:26.731] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:76:0) after 1m0s
[01:04:26.776] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:76:0)
[01:04:26.776] Timer tick, asking Buildbucket for the build status
[01:04:26.852] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:26.852] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:77:0) after 1m0s
[01:05:26.931] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:77:0)
[01:05:26.931] Timer tick, asking Buildbucket for the build status
[01:05:27.329] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:27.329] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:78:0) after 1m0s
[01:06:27.391] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:78:0)
[01:06:27.391] Timer tick, asking Buildbucket for the build status
[01:06:27.495] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:27.495] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:79:0) after 1m0s
[01:07:27.586] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:79:0)
[01:07:27.586] Timer tick, asking Buildbucket for the build status
[01:07:27.675] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:27.675] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:80:0) after 1m0s
[01:08:27.703] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:80:0)
[01:08:27.703] Timer tick, asking Buildbucket for the build status
[01:08:27.792] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:27.792] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:81:0) after 1m0s
[01:09:27.816] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:81:0)
[01:09:27.817] Timer tick, asking Buildbucket for the build status
[01:09:28.033] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:28.033] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:82:0) after 1m0s
[01:10:28.055] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:82:0)
[01:10:28.055] Timer tick, asking Buildbucket for the build status
[01:10:28.222] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:28.222] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:83:0) after 1m0s
[01:11:28.312] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:83:0)
[01:11:28.312] Timer tick, asking Buildbucket for the build status
[01:11:28.385] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:28.385] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:84:0) after 1m0s
[01:12:28.412] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:84:0)
[01:12:28.412] Timer tick, asking Buildbucket for the build status
[01:12:28.486] Build 8863793305570718576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:28.486] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux:9029223370568569584:85:0) after 1m0s
[01:13:26.630] Received PubSub notification, asking Buildbucket for the build status
[01:13:26.717] Build 8863793305570718576: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:13:26.717] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"completed_ts": "1605230005711447",
"created_by": "project:emscripten-releases",
"created_ts": "1605225000751311",
"id": "8863793305570718576",
"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\": \"bf769b1a95b1ef01a31f87eac1552733e601f3d9\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@bf769b1a95b1ef01a31f87eac1552733e601f3d9\", \"title\": \"bf769b1a95b1ef01a31f87eac1552733e601f3d9\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/bf769b1a95b1ef01a31f87eac1552733e601f3d9\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"bf769b1a95b1ef01a31f87eac1552733e601f3d9\"}}",
"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\": \"bf769b1a95b1ef01a31f87eac1552733e601f3d9\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@bf769b1a95b1ef01a31f87eac1552733e601f3d9\", \"title\": \"bf769b1a95b1ef01a31f87eac1552733e601f3d9\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/bf769b1a95b1ef01a31f87eac1552733e601f3d9\"}]}, \"bot_id\": \"luci-emscripten-releases-ci-xenial-1-2qjs\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux\", \"got_revision\": \"bf769b1a95b1ef01a31f87eac1552733e601f3d9\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"bf769b1a95b1ef01a31f87eac1552733e601f3d9\"}, \"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-2qjs\"], \"image\": [\"chrome-xenial-20110800-08efb743065\"], \"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\": [\"5626-39642e9\"], \"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": "1605225026681556",
"status": "COMPLETED",
"status_changed_ts": "1605230006133371",
"tags": [
"builder:linux",
"buildset:commit/git/bf769b1a95b1ef01a31f87eac1552733e601f3d9",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/bf769b1a95b1ef01a31f87eac1552733e601f3d9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029223370568569584",
"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/8863793305570718576/+/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:4fd7af3fe42eed10",
"user_agent:luci-scheduler"
],
"updated_ts": "1605230006144141",
"url": "https://ci.chromium.org/b/8863793305570718576",
"utcnow_ts": "1605230006702947"
}
}
[01:13:26.717] Invocation finished in 1h23m30.116063219s with status SUCCEEDED