[00:28:33.214] New invocation is queued and will start shortly
[00:28:34.356] Starting the invocation (attempt 1)
[00:28:34.388] Popped buildset tag "buildset:commit/gitiles/pigweed.googlesource.com/pigweed/quickstart/bazel/+/a9df6691f229495f3c61f06923b3c4533531eb2a"
[00:28:34.388] Popped gitiles commit info from properties and tags
[00:28:34.388] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:28:34.389] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:28:34.389] Buildbucket request:
{
"requestId": "8901116830949818976",
"builder": {
"project": "pigweed",
"bucket": "quickstart.dev.ci",
"builder": "quickstart-cmake-linux-build"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8901116830949818976",
"job": "pigweed/quickstart.dev.ci-quickstart-cmake-linux-build",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/quickstart/bazel",
"revision": "88cb4b429e83dbbcf5b6b9a4812e15dd59446e1e"
},
"id": "https://pigweed.googlesource.com/pigweed/quickstart/bazel/+/refs/heads/main@88cb4b429e83dbbcf5b6b9a4812e15dd59446e1e",
"title": "88cb4b429e83dbbcf5b6b9a4812e15dd59446e1e",
"url": "https://pigweed.googlesource.com/pigweed/quickstart/bazel/+/88cb4b429e83dbbcf5b6b9a4812e15dd59446e1e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/quickstart/bazel",
"revision": "e74e3b6a8a19cd6650e105e313df4c2d1138e205"
},
"id": "https://pigweed.googlesource.com/pigweed/quickstart/bazel/+/refs/heads/main@e74e3b6a8a19cd6650e105e313df4c2d1138e205",
"title": "e74e3b6a8a19cd6650e105e313df4c2d1138e205",
"url": "https://pigweed.googlesource.com/pigweed/quickstart/bazel/+/e74e3b6a8a19cd6650e105e313df4c2d1138e205"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/quickstart/bazel",
"revision": "b25c4e337dd4305ff3d6301f46f5a8d1be434da5"
},
"id": "https://pigweed.googlesource.com/pigweed/quickstart/bazel/+/refs/heads/main@b25c4e337dd4305ff3d6301f46f5a8d1be434da5",
"title": "b25c4e337dd4305ff3d6301f46f5a8d1be434da5",
"url": "https://pigweed.googlesource.com/pigweed/quickstart/bazel/+/b25c4e337dd4305ff3d6301f46f5a8d1be434da5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/quickstart/bazel",
"revision": "ec5402add285dd9b33c725e8bc7caf53700600ba"
},
"id": "https://pigweed.googlesource.com/pigweed/quickstart/bazel/+/refs/heads/main@ec5402add285dd9b33c725e8bc7caf53700600ba",
"title": "ec5402add285dd9b33c725e8bc7caf53700600ba",
"url": "https://pigweed.googlesource.com/pigweed/quickstart/bazel/+/ec5402add285dd9b33c725e8bc7caf53700600ba"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/quickstart/bazel",
"revision": "af250d0c9d9907f02c0118ebd0bdc152d71c55e7"
},
"id": "https://pigweed.googlesource.com/pigweed/quickstart/bazel/+/refs/heads/main@af250d0c9d9907f02c0118ebd0bdc152d71c55e7",
"title": "af250d0c9d9907f02c0118ebd0bdc152d71c55e7",
"url": "https://pigweed.googlesource.com/pigweed/quickstart/bazel/+/af250d0c9d9907f02c0118ebd0bdc152d71c55e7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/quickstart/bazel",
"revision": "d5a70d3fa6e825d0712b96a3b0ab0ee45321d27c"
},
"id": "https://pigweed.googlesource.com/pigweed/quickstart/bazel/+/refs/heads/main@d5a70d3fa6e825d0712b96a3b0ab0ee45321d27c",
"title": "d5a70d3fa6e825d0712b96a3b0ab0ee45321d27c",
"url": "https://pigweed.googlesource.com/pigweed/quickstart/bazel/+/d5a70d3fa6e825d0712b96a3b0ab0ee45321d27c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/quickstart/bazel",
"revision": "20ffe89175d041480c3728e8d588190f90ffca13"
},
"id": "https://pigweed.googlesource.com/pigweed/quickstart/bazel/+/refs/heads/main@20ffe89175d041480c3728e8d588190f90ffca13",
"title": "20ffe89175d041480c3728e8d588190f90ffca13",
"url": "https://pigweed.googlesource.com/pigweed/quickstart/bazel/+/20ffe89175d041480c3728e8d588190f90ffca13"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/quickstart/bazel",
"revision": "54477e02db8307dbdfe8bedfaec6156983f35236"
},
"id": "https://pigweed.googlesource.com/pigweed/quickstart/bazel/+/refs/heads/main@54477e02db8307dbdfe8bedfaec6156983f35236",
"title": "54477e02db8307dbdfe8bedfaec6156983f35236",
"url": "https://pigweed.googlesource.com/pigweed/quickstart/bazel/+/54477e02db8307dbdfe8bedfaec6156983f35236"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://pigweed.googlesource.com/pigweed/quickstart/bazel",
"revision": "a9df6691f229495f3c61f06923b3c4533531eb2a"
},
"id": "https://pigweed.googlesource.com/pigweed/quickstart/bazel/+/refs/heads/main@a9df6691f229495f3c61f06923b3c4533531eb2a",
"title": "a9df6691f229495f3c61f06923b3c4533531eb2a",
"url": "https://pigweed.googlesource.com/pigweed/quickstart/bazel/+/a9df6691f229495f3c61f06923b3c4533531eb2a"
}
]
}
},
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/quickstart/bazel",
"id": "a9df6691f229495f3c61f06923b3c4533531eb2a",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8901116830949818976"
},
{
"key": "scheduler_job_id",
"value": "pigweed/quickstart.dev.ci-quickstart-cmake-linux-build"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[00:28:34.809] Scheduled build:
{
"id": "8735686768994854001",
"builder": {
"project": "pigweed",
"bucket": "quickstart.dev.ci",
"builder": "quickstart-cmake-linux-build"
},
"createdBy": "project:pigweed",
"createTime": "2024-09-27T00:28:34.447185919Z",
"updateTime": "2024-09-27T00:28:34.447185919Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/quickstart/bazel",
"id": "a9df6691f229495f3c61f06923b3c4533531eb2a",
"ref": "refs/heads/main"
}
}
}
[00:28:34.809] Task URL: https://cr-buildbucket.appspot.com/build/8735686768994854001
[00:28:34.809] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:2:0) after 1m7s
[00:28:35.746] Received PubSub notification, asking Buildbucket for the build status
[00:28:35.782] Build status: SCHEDULED
[00:29:41.826] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:2:0)
[00:29:41.873] Build status: SCHEDULED
[00:29:41.873] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:4:0) after 1m41s
[00:31:22.895] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:4:0)
[00:31:22.920] Build status: SCHEDULED
[00:31:22.920] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:5:0) after 1m12s
[00:32:34.934] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:5:0)
[00:32:34.981] Build status: SCHEDULED
[00:32:34.981] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:6:0) after 6m29s
[00:39:04.071] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:6:0)
[00:39:04.107] Build status: SCHEDULED
[00:39:04.108] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:7:0) after 9m45s
[00:48:49.136] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:7:0)
[00:48:49.173] Build status: SCHEDULED
[00:48:49.173] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:8:0) after 7m28s
[00:56:17.233] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:8:0)
[00:56:17.271] Build status: SCHEDULED
[00:56:17.271] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:9:0) after 9m13s
[01:05:30.337] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:9:0)
[01:05:30.408] Build status: SCHEDULED
[01:05:30.408] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:10:0) after 6m5s
[01:11:35.480] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:10:0)
[01:11:35.505] Build status: SCHEDULED
[01:11:35.505] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:11:0) after 9m30s
[01:21:05.526] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:11:0)
[01:21:05.548] Build status: SCHEDULED
[01:21:05.549] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:12:0) after 4m8s
[01:25:13.621] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:12:0)
[01:25:13.650] Build status: SCHEDULED
[01:25:13.650] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:13:0) after 8m44s
[01:33:57.775] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:13:0)
[01:33:57.804] Build status: SCHEDULED
[01:33:57.804] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:14:0) after 7m41s
[01:41:38.843] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:14:0)
[01:41:38.886] Build status: SCHEDULED
[01:41:38.886] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:15:0) after 6m35s
[01:48:13.928] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:15:0)
[01:48:13.953] Build status: SCHEDULED
[01:48:13.953] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:16:0) after 8m51s
[01:57:04.977] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:16:0)
[01:57:05.006] Build status: SCHEDULED
[01:57:05.006] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:17:0) after 1m16s
[01:58:21.512] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:17:0)
[01:58:21.622] Build status: SCHEDULED
[01:58:21.622] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:18:0) after 7m16s
[02:05:37.681] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:18:0)
[02:05:37.724] Build status: SCHEDULED
[02:05:37.724] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:19:0) after 3m8s
[02:08:45.786] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:19:0)
[02:08:45.804] Build status: SCHEDULED
[02:08:45.805] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:20:0) after 6m9s
[02:14:54.877] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:20:0)
[02:14:54.991] Build status: SCHEDULED
[02:14:54.991] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:21:0) after 3m31s
[02:18:26.098] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:21:0)
[02:18:26.120] Build status: SCHEDULED
[02:18:26.120] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:22:0) after 6m1s
[02:24:27.146] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:22:0)
[02:24:27.193] Build status: SCHEDULED
[02:24:27.193] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:23:0) after 6m10s
[02:30:37.212] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:23:0)
[02:30:37.229] Build status: SCHEDULED
[02:30:37.229] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:24:0) after 1m59s
[02:32:36.284] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:24:0)
[02:32:36.312] Build status: SCHEDULED
[02:32:36.312] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:25:0) after 5m6s
[02:37:42.382] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:25:0)
[02:37:42.418] Build status: SCHEDULED
[02:37:42.418] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:26:0) after 1m40s
[02:39:22.457] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:26:0)
[02:39:22.482] Build status: SCHEDULED
[02:39:22.482] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:27:0) after 8m48s
[02:48:10.509] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:27:0)
[02:48:10.576] Build status: SCHEDULED
[02:48:10.576] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:28:0) after 9m0s
[02:57:10.610] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:28:0)
[02:57:10.637] Build status: SCHEDULED
[02:57:10.637] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:29:0) after 5m59s
[03:03:09.745] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:29:0)
[03:03:09.775] Build status: SCHEDULED
[03:03:09.775] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:30:0) after 3m21s
[03:06:30.792] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:30:0)
[03:06:30.827] Build status: SCHEDULED
[03:06:30.827] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:31:0) after 1m51s
[03:08:21.871] Handling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:31:0)
[03:08:21.899] Build status: SCHEDULED
[03:08:21.899] Scheduling timer "check-buildbucket-build-status" (pigweed/quickstart.dev.ci-quickstart-cmake-linux-build:8901116830949818976:32:0) after 5m47s
[03:11:29.903] Received PubSub notification, asking Buildbucket for the build status
[03:11:29.923] Build status: STARTED
[03:11:43.793] Received PubSub notification, asking Buildbucket for the build status
[03:11:43.816] Build:
{
"id": "8735686768994854001",
"builder": {
"project": "pigweed",
"bucket": "quickstart.dev.ci",
"builder": "quickstart-cmake-linux-build"
},
"createdBy": "project:pigweed",
"createTime": "2024-09-27T00:28:34.447185919Z",
"startTime": "2024-09-27T03:11:29.735801814Z",
"endTime": "2024-09-27T03:11:43.519832019Z",
"updateTime": "2024-09-27T03:11:43.519832019Z",
"status": "INFRA_FAILURE",
"input": {
"gitilesCommit": {
"host": "pigweed.googlesource.com",
"project": "pigweed/quickstart/bazel",
"id": "a9df6691f229495f3c61f06923b3c4533531eb2a",
"ref": "refs/heads/main"
}
}
}
[03:11:43.816] Invocation finished in 2h43m10.617243724s with status FAILED